builder: larch_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1464408257.83 results: success (0) buildid: 20160527183007 builduid: 470d12ba9aba4cda86b95b05deeb1e75 revision: 39dcfacc4b5b91b0d0c66ecc144aacf00fca7c2a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 21:04:17.825466) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 21:04:17.826154) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 21:04:17.826433) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 21:04:17.868481) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 21:04:17.868753) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 21:04:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-05-27 21:04:18 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128328 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 21:04:18.011622) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 21:04:18.011924) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018410 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 21:04:18.060956) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 21:04:18.061265) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 39dcfacc4b5b91b0d0c66ecc144aacf00fca7c2a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 39dcfacc4b5b91b0d0c66ecc144aacf00fca7c2a --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=a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 21:04:18,398 truncating revision to first 12 chars 2016-05-27 21:04:18,398 Setting DEBUG logging. 2016-05-27 21:04:18,398 attempt 1/10 2016-05-27 21:04:18,398 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/39dcfacc4b5b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 21:04:19,229 unpacking tar archive at: larch-39dcfacc4b5b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.178776 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 21:04:19.254168) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 21:04:19.254442) ========= script_repo_revision: 39dcfacc4b5b91b0d0c66ecc144aacf00fca7c2a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 21:04:19.254823) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 21:04:19.255091) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 21:04:19.264118) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-27 21:04:19.264393) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 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', 'Larch', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] 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=a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:04:19 INFO - MultiFileLogger online at 20160527 21:04:19 in /builds/slave/test 21:04:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 21:04:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:04:19 INFO - {'append_to_log': False, 21:04:19 INFO - 'base_work_dir': '/builds/slave/test', 21:04:19 INFO - 'blob_upload_branch': 'Larch', 21:04:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:04:19 INFO - 'branch': 'Larch', 21:04:19 INFO - 'buildbot_json_path': 'buildprops.json', 21:04:19 INFO - 'config_files': ('talos/linux_config.py',), 21:04:19 INFO - 'default_actions': ('clobber', 21:04:19 INFO - 'read-buildbot-config', 21:04:19 INFO - 'download-and-extract', 21:04:19 INFO - 'populate-webroot', 21:04:19 INFO - 'create-virtualenv', 21:04:19 INFO - 'install', 21:04:19 INFO - 'run-tests'), 21:04:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:04:19 INFO - 'download_minidump_stackwalk': True, 21:04:19 INFO - 'download_symbols': 'ondemand', 21:04:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:04:19 INFO - 'tooltool.py': '/tools/tooltool.py', 21:04:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:04:19 INFO - '/tools/misc-python/virtualenv.py')}, 21:04:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:04:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:04:19 INFO - 'installer_path': 'installer.exe', 21:04:19 INFO - 'log_level': 'info', 21:04:19 INFO - 'log_name': 'talos', 21:04:19 INFO - 'log_to_console': True, 21:04:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:04:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:04:19 INFO - 'opt_config_files': (), 21:04:19 INFO - 'pip_index': False, 21:04:19 INFO - 'sps_profile': False, 21:04:19 INFO - 'sps_profile_interval': 0, 21:04:19 INFO - 'suite': 'dromaeojs-e10s', 21:04:19 INFO - 'system_bits': '32', 21:04:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:04:19 INFO - 'title': 'talos-linux64-ix-064', 21:04:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:04:19 INFO - 'use_talos_json': True, 21:04:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:04:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:04:19 INFO - 'work_dir': 'build'} 21:04:19 INFO - ##### 21:04:19 INFO - ##### Running clobber step. 21:04:19 INFO - ##### 21:04:19 INFO - Running pre-action listener: _resource_record_pre_action 21:04:19 INFO - Running main action method: clobber 21:04:19 INFO - rmtree: /builds/slave/test/build 21:04:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:04:20 INFO - Running post-action listener: _resource_record_post_action 21:04:20 INFO - ##### 21:04:20 INFO - ##### Finished clobber step (success) 21:04:20 INFO - ##### 21:04:20 INFO - ##### 21:04:20 INFO - ##### Running read-buildbot-config step. 21:04:20 INFO - ##### 21:04:20 INFO - Running pre-action listener: _resource_record_pre_action 21:04:20 INFO - Running main action method: read_buildbot_config 21:04:20 INFO - Using buildbot properties: 21:04:20 INFO - { 21:04:20 INFO - "project": "", 21:04:20 INFO - "product": "firefox", 21:04:20 INFO - "script_repo_revision": "production", 21:04:20 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs-e10s", 21:04:20 INFO - "repository": "", 21:04:20 INFO - "buildername": "Ubuntu HW 12.04 x64 larch pgo talos dromaeojs-e10s", 21:04:20 INFO - "buildid": "20160527183007", 21:04:20 INFO - "pgo_build": "True", 21:04:20 INFO - "basedir": "/builds/slave/test", 21:04:20 INFO - "buildnumber": 3, 21:04:20 INFO - "slavename": "talos-linux64-ix-064", 21:04:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:04:20 INFO - "platform": "ubuntu64_hw", 21:04:20 INFO - "scheduler": "tests-larch-linux64-pgo-talos", 21:04:20 INFO - "branch": "larch", 21:04:20 INFO - "repo_path": "projects/larch", 21:04:20 INFO - "revision": "39dcfacc4b5b91b0d0c66ecc144aacf00fca7c2a", 21:04:20 INFO - "stage_platform": "linux64-pgo", 21:04:20 INFO - "builduid": "470d12ba9aba4cda86b95b05deeb1e75", 21:04:20 INFO - "slavebuilddir": "test" 21:04:20 INFO - } 21:04:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/D5gSrQTDT427sXIo4JJOaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 21:04:20 INFO - Running post-action listener: _resource_record_post_action 21:04:20 INFO - ##### 21:04:20 INFO - ##### Finished read-buildbot-config step (success) 21:04:20 INFO - ##### 21:04:20 INFO - ##### 21:04:20 INFO - ##### Running download-and-extract step. 21:04:20 INFO - ##### 21:04:20 INFO - Running pre-action listener: _resource_record_pre_action 21:04:20 INFO - Running main action method: download_and_extract 21:04:20 INFO - mkdir: /builds/slave/test/build/tests 21:04:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:04:20 INFO - https://queue.taskcluster.net/v1/task/D5gSrQTDT427sXIo4JJOaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:04:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5gSrQTDT427sXIo4JJOaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:04:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5gSrQTDT427sXIo4JJOaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:04:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5gSrQTDT427sXIo4JJOaw/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 21:04:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5gSrQTDT427sXIo4JJOaw/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 21:04:26 INFO - Downloaded 1361 bytes. 21:04:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:04:26 INFO - Using the following test package requirements: 21:04:26 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 21:04:26 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:04:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:04:26 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:04:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:04:26 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:04:26 INFO - u'jsshell-linux-x86_64.zip'], 21:04:26 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:04:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:04:26 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 21:04:26 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:04:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:04:26 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:04:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:04:26 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:04:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:04:26 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:04:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:04:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:04:26 INFO - https://queue.taskcluster.net/v1/task/D5gSrQTDT427sXIo4JJOaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:04:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5gSrQTDT427sXIo4JJOaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:04:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5gSrQTDT427sXIo4JJOaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:04:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5gSrQTDT427sXIo4JJOaw/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 21:04:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5gSrQTDT427sXIo4JJOaw/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 21:04:27 INFO - Downloaded 24420677 bytes. 21:04:27 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'] 21:04:27 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 21:04:29 INFO - Return code: 0 21:04:29 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 21:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:04:29 INFO - https://queue.taskcluster.net/v1/task/D5gSrQTDT427sXIo4JJOaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:04:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5gSrQTDT427sXIo4JJOaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:04:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5gSrQTDT427sXIo4JJOaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:04:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5gSrQTDT427sXIo4JJOaw/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 21:04:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5gSrQTDT427sXIo4JJOaw/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 21:04:31 INFO - Downloaded 24420677 bytes. 21:04:31 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'] 21:04:31 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 21:04:32 INFO - Return code: 0 21:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:04:32 INFO - https://queue.taskcluster.net/v1/task/D5gSrQTDT427sXIo4JJOaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:04:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5gSrQTDT427sXIo4JJOaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 21:04:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5gSrQTDT427sXIo4JJOaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 21:04:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5gSrQTDT427sXIo4JJOaw/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 21:04:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5gSrQTDT427sXIo4JJOaw/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 21:04:33 INFO - Downloaded 10834042 bytes. 21:04:33 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'] 21:04:33 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 21:04:33 INFO - Return code: 0 21:04:33 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')]} 21:04:33 INFO - https://queue.taskcluster.net/v1/task/D5gSrQTDT427sXIo4JJOaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:04:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5gSrQTDT427sXIo4JJOaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:04:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5gSrQTDT427sXIo4JJOaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:04:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5gSrQTDT427sXIo4JJOaw/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 21:04:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5gSrQTDT427sXIo4JJOaw/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 21:04:35 INFO - Downloaded 58837513 bytes. 21:04:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D5gSrQTDT427sXIo4JJOaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:04:35 INFO - mkdir: /builds/slave/test/properties 21:04:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:04:35 INFO - Writing to file /builds/slave/test/properties/build_url 21:04:35 INFO - Contents: 21:04:35 INFO - build_url:https://queue.taskcluster.net/v1/task/D5gSrQTDT427sXIo4JJOaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:04:35 INFO - Running post-action listener: _resource_record_post_action 21:04:35 INFO - Running post-action listener: set_extra_try_arguments 21:04:35 INFO - ##### 21:04:35 INFO - ##### Finished download-and-extract step (success) 21:04:35 INFO - ##### 21:04:35 INFO - ##### 21:04:35 INFO - ##### Running populate-webroot step. 21:04:35 INFO - ##### 21:04:35 INFO - Running pre-action listener: _resource_record_pre_action 21:04:35 INFO - Running main action method: populate_webroot 21:04:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:04:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:04:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:04:35 INFO - '--tppagecycles', 21:04:35 INFO - '7'], 21:04:35 INFO - 'tests': ['tsvgm']}}, 21:04:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:04:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:04:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:04:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:04:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:04:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:04:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:35 INFO - 'talos_options': ['--disable-e10s'], 21:04:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:04:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:04:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:35 INFO - 'talos_options': ['--disable-e10s'], 21:04:35 INFO - 'tests': ['damp', 'tps']}, 21:04:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:35 INFO - 'tests': ['damp', 'tps']}, 21:04:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:04:35 INFO - 'tests': ['dromaeo_dom']}, 21:04:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:04:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:04:35 INFO - 'tests': ['a11yr', 21:04:35 INFO - 'ts_paint', 21:04:35 INFO - 'tpaint', 21:04:35 INFO - 'sessionrestore', 21:04:35 INFO - 'sessionrestore_no_auto_restore', 21:04:35 INFO - 'tabpaint']}, 21:04:35 INFO - 'other-e10s': {'tests': ['a11yr', 21:04:35 INFO - 'ts_paint', 21:04:35 INFO - 'tpaint', 21:04:35 INFO - 'sessionrestore', 21:04:35 INFO - 'sessionrestore_no_auto_restore', 21:04:35 INFO - 'tabpaint']}, 21:04:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:04:35 INFO - 'ts_paint', 21:04:35 INFO - 'tpaint', 21:04:35 INFO - 'sessionrestore', 21:04:35 INFO - 'sessionrestore_no_auto_restore', 21:04:35 INFO - 'tabpaint']}, 21:04:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:04:35 INFO - 'ts_paint', 21:04:35 INFO - 'tpaint', 21:04:35 INFO - 'sessionrestore', 21:04:35 INFO - 'sessionrestore_no_auto_restore', 21:04:35 INFO - 'tabpaint']}, 21:04:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:04:35 INFO - 'tests': ['a11yr', 21:04:35 INFO - 'ts_paint', 21:04:35 INFO - 'tpaint', 21:04:35 INFO - 'sessionrestore', 21:04:35 INFO - 'sessionrestore_no_auto_restore', 21:04:35 INFO - 'tabpaint']}, 21:04:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:04:35 INFO - 'tests': ['a11yr', 21:04:35 INFO - 'ts_paint', 21:04:35 INFO - 'tpaint', 21:04:35 INFO - 'sessionrestore', 21:04:35 INFO - 'sessionrestore_no_auto_restore', 21:04:35 INFO - 'tabpaint']}, 21:04:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:04:35 INFO - 'tests': ['tsvgx', 21:04:35 INFO - 'tsvgr_opacity', 21:04:35 INFO - 'tart', 21:04:35 INFO - 'tscrollx', 21:04:35 INFO - 'cart']}, 21:04:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:04:35 INFO - 'tsvgr_opacity', 21:04:35 INFO - 'tart', 21:04:35 INFO - 'tscrollx', 21:04:35 INFO - 'cart']}, 21:04:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:35 INFO - 'talos_options': ['--disable-e10s'], 21:04:35 INFO - 'tests': ['tp5o']}, 21:04:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:35 INFO - 'tests': ['tp5o']}, 21:04:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:35 INFO - 'talos_options': ['--disable-e10s', 21:04:35 INFO - '--xperf_path', 21:04:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:04:35 INFO - 'tests': ['tp5n']}, 21:04:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:35 INFO - 'talos_options': ['--xperf_path', 21:04:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:04:35 INFO - 'tests': ['tp5n']}}, 21:04:35 INFO - 'talos.zip': {'path': '', 21:04:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:04:35 INFO - Running post-action listener: _resource_record_post_action 21:04:35 INFO - ##### 21:04:35 INFO - ##### Finished populate-webroot step (success) 21:04:35 INFO - ##### 21:04:35 INFO - ##### 21:04:35 INFO - ##### Running create-virtualenv step. 21:04:35 INFO - ##### 21:04:35 INFO - Running pre-action listener: _resource_record_pre_action 21:04:35 INFO - Running main action method: create_virtualenv 21:04:35 INFO - Creating virtualenv /builds/slave/test/build/venv 21:04:35 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 21:04:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:04:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:04:35 INFO - Using real prefix '/usr' 21:04:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:04:36 INFO - Installing distribute.............................................................................................................................................................................................done. 21:04:38 INFO - Installing pip.................done. 21:04:38 INFO - Return code: 0 21:04:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:04: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')]} 21:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04: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')]} 21:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2374faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d95770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e249c0>, '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 0x1e258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e25d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850', '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 21:04:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:04:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:04:38 INFO - Using env: {'DISPLAY': ':0', 21:04:38 INFO - 'HOME': '/home/cltbld', 21:04:38 INFO - 'LANG': 'en_US.UTF-8', 21:04:38 INFO - 'LANGUAGE': 'en_US:en', 21:04:38 INFO - 'LOGNAME': 'cltbld', 21:04:38 INFO - 'MAIL': '/var/mail/cltbld', 21:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:38 INFO - 'MOZ_NO_REMOTE': '1', 21:04:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:38 INFO - 'NO_EM_RESTART': '1', 21:04:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:38 INFO - 'PWD': '/builds/slave/test', 21:04:38 INFO - 'SHELL': '/bin/bash', 21:04:38 INFO - 'SHLVL': '1', 21:04:38 INFO - 'TERM': 'linux', 21:04:38 INFO - 'TMOUT': '86400', 21:04:38 INFO - 'USER': 'cltbld', 21:04:38 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850', 21:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:38 INFO - '_': '/tools/buildbot/bin/python'} 21:04:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:38 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 21:04:38 INFO - Cleaning up... 21:04:38 INFO - Return code: 0 21:04:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:04: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')]} 21:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04: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')]} 21:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb2374faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d95770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e249c0>, '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 0x1e258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e25d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850', '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 21:04:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:04:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:04:38 INFO - Using env: {'DISPLAY': ':0', 21:04:38 INFO - 'HOME': '/home/cltbld', 21:04:38 INFO - 'LANG': 'en_US.UTF-8', 21:04:38 INFO - 'LANGUAGE': 'en_US:en', 21:04:38 INFO - 'LOGNAME': 'cltbld', 21:04:38 INFO - 'MAIL': '/var/mail/cltbld', 21:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:38 INFO - 'MOZ_NO_REMOTE': '1', 21:04:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:38 INFO - 'NO_EM_RESTART': '1', 21:04:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:38 INFO - 'PWD': '/builds/slave/test', 21:04:38 INFO - 'SHELL': '/bin/bash', 21:04:38 INFO - 'SHLVL': '1', 21:04:38 INFO - 'TERM': 'linux', 21:04:38 INFO - 'TMOUT': '86400', 21:04:38 INFO - 'USER': 'cltbld', 21:04:38 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850', 21:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:38 INFO - '_': '/tools/buildbot/bin/python'} 21:04:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:38 INFO - Downloading/unpacking psutil>=3.1.1 21:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:04:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:04:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:04:40 INFO - Installing collected packages: psutil 21:04:40 INFO - Running setup.py install for psutil 21:04:41 INFO - building 'psutil._psutil_linux' extension 21:04:41 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 21:04:41 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 21:04:41 INFO - building 'psutil._psutil_posix' extension 21:04:41 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 21:04:41 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 21:04:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:04:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:04:41 INFO - Successfully installed psutil 21:04:41 INFO - Cleaning up... 21:04:41 INFO - Return code: 0 21:04:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:04:41 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')]} 21:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:41 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')]} 21:04:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:41 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 0x7fb2374faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d95770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e249c0>, '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 0x1e258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e25d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850', '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 21:04:41 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 21:04:41 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 21:04:41 INFO - Using env: {'DISPLAY': ':0', 21:04:41 INFO - 'HOME': '/home/cltbld', 21:04:41 INFO - 'LANG': 'en_US.UTF-8', 21:04:41 INFO - 'LANGUAGE': 'en_US:en', 21:04:41 INFO - 'LOGNAME': 'cltbld', 21:04:41 INFO - 'MAIL': '/var/mail/cltbld', 21:04:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:41 INFO - 'MOZ_NO_REMOTE': '1', 21:04:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:41 INFO - 'NO_EM_RESTART': '1', 21:04:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:41 INFO - 'PWD': '/builds/slave/test', 21:04:41 INFO - 'SHELL': '/bin/bash', 21:04:41 INFO - 'SHLVL': '1', 21:04:41 INFO - 'TERM': 'linux', 21:04:41 INFO - 'TMOUT': '86400', 21:04:41 INFO - 'USER': 'cltbld', 21:04:41 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850', 21:04:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:41 INFO - '_': '/tools/buildbot/bin/python'} 21:04:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:04:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:04:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:04:43 INFO - Installing collected packages: mozsystemmonitor 21:04:43 INFO - Running setup.py install for mozsystemmonitor 21:04:43 INFO - Successfully installed mozsystemmonitor 21:04:43 INFO - Cleaning up... 21:04:43 INFO - Return code: 0 21:04:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:04:43 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')]} 21:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:43 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')]} 21:04:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:43 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 0x7fb2374faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d95770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e249c0>, '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 0x1e258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e25d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850', '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 21:04:43 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 21:04:43 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 21:04:43 INFO - Using env: {'DISPLAY': ':0', 21:04:43 INFO - 'HOME': '/home/cltbld', 21:04:43 INFO - 'LANG': 'en_US.UTF-8', 21:04:43 INFO - 'LANGUAGE': 'en_US:en', 21:04:43 INFO - 'LOGNAME': 'cltbld', 21:04:43 INFO - 'MAIL': '/var/mail/cltbld', 21:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:43 INFO - 'MOZ_NO_REMOTE': '1', 21:04:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:43 INFO - 'NO_EM_RESTART': '1', 21:04:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:43 INFO - 'PWD': '/builds/slave/test', 21:04:43 INFO - 'SHELL': '/bin/bash', 21:04:43 INFO - 'SHLVL': '1', 21:04:43 INFO - 'TERM': 'linux', 21:04:43 INFO - 'TMOUT': '86400', 21:04:43 INFO - 'USER': 'cltbld', 21:04:43 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850', 21:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:43 INFO - '_': '/tools/buildbot/bin/python'} 21:04:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:43 INFO - Downloading/unpacking blobuploader==1.2.4 21:04:43 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 21:04:43 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 21:04:43 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 21:04:43 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 21:04:43 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 21:04:43 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 21:04:45 INFO - Downloading blobuploader-1.2.4.tar.gz 21:04:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:04:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:04:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:04:46 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 21:04:46 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 21:04:46 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 21:04:46 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 21:04:46 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 21:04:46 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 21:04:46 INFO - Downloading docopt-0.6.1.tar.gz 21:04:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:04:46 INFO - Installing collected packages: blobuploader, requests, docopt 21:04:46 INFO - Running setup.py install for blobuploader 21:04:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:04:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:04:46 INFO - Running setup.py install for requests 21:04:47 INFO - Running setup.py install for docopt 21:04:47 INFO - Successfully installed blobuploader requests docopt 21:04:47 INFO - Cleaning up... 21:04:47 INFO - Return code: 0 21:04:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:04: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')]} 21:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04: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')]} 21:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:47 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 0x7fb2374faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d95770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e249c0>, '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 0x1e258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e25d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850', '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 21:04:47 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 21:04:47 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 21:04:47 INFO - Using env: {'DISPLAY': ':0', 21:04:47 INFO - 'HOME': '/home/cltbld', 21:04:47 INFO - 'LANG': 'en_US.UTF-8', 21:04:47 INFO - 'LANGUAGE': 'en_US:en', 21:04:47 INFO - 'LOGNAME': 'cltbld', 21:04:47 INFO - 'MAIL': '/var/mail/cltbld', 21:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:47 INFO - 'MOZ_NO_REMOTE': '1', 21:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:47 INFO - 'NO_EM_RESTART': '1', 21:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:47 INFO - 'PWD': '/builds/slave/test', 21:04:47 INFO - 'SHELL': '/bin/bash', 21:04:47 INFO - 'SHLVL': '1', 21:04:47 INFO - 'TERM': 'linux', 21:04:47 INFO - 'TMOUT': '86400', 21:04:47 INFO - 'USER': 'cltbld', 21:04:47 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850', 21:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:47 INFO - '_': '/tools/buildbot/bin/python'} 21:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:04:47 INFO - Running setup.py (path:/tmp/pip-5bcL9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:04:47 INFO - Running setup.py (path:/tmp/pip-qF1she-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:04:47 INFO - Running setup.py (path:/tmp/pip-RX41WF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:04:47 INFO - Running setup.py (path:/tmp/pip-o9AzRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:04:47 INFO - Running setup.py (path:/tmp/pip-I1EsPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:04:47 INFO - Running setup.py (path:/tmp/pip-YLloGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:04:47 INFO - Running setup.py (path:/tmp/pip-9S0ndf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:04:47 INFO - Running setup.py (path:/tmp/pip-C_Ll3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:04:48 INFO - Running setup.py (path:/tmp/pip-iQ9Dkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:04:48 INFO - Running setup.py (path:/tmp/pip-SlWTMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:04:48 INFO - Running setup.py (path:/tmp/pip-XzlFRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:04:48 INFO - Running setup.py (path:/tmp/pip-jvan1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:04:48 INFO - Running setup.py (path:/tmp/pip-OBBmX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:04:48 INFO - Running setup.py (path:/tmp/pip-Lke72r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:04:48 INFO - Running setup.py (path:/tmp/pip-v5ogBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:04:48 INFO - Running setup.py (path:/tmp/pip-3wGCCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:04:48 INFO - Running setup.py (path:/tmp/pip-CqPVVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:04:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:04:48 INFO - Running setup.py install for manifestparser 21:04:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:04:48 INFO - Running setup.py install for mozcrash 21:04:48 INFO - Running setup.py install for mozdebug 21:04:48 INFO - Running setup.py install for mozdevice 21:04:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:04:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:04:49 INFO - Running setup.py install for mozfile 21:04:49 INFO - Running setup.py install for mozhttpd 21:04:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:04:49 INFO - Running setup.py install for mozinfo 21:04:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:04:49 INFO - Running setup.py install for mozInstall 21:04:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:04:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:04:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:04:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:04:49 INFO - Running setup.py install for mozleak 21:04:49 INFO - Running setup.py install for mozlog 21:04:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:04:49 INFO - Running setup.py install for moznetwork 21:04:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:04:49 INFO - Running setup.py install for mozprocess 21:04:49 INFO - Running setup.py install for mozprofile 21:04:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:04:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:04:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:04:50 INFO - Running setup.py install for mozrunner 21:04:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:04:50 INFO - Running setup.py install for mozscreenshot 21:04:50 INFO - Running setup.py install for moztest 21:04:50 INFO - Running setup.py install for mozversion 21:04:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:04:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:04:50 INFO - Cleaning up... 21:04:50 INFO - Return code: 0 21:04:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:50 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 0x7fb2374faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d95770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e249c0>, '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 0x1e258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e25d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850', '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 21:04:50 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 21:04:50 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 21:04:50 INFO - Using env: {'DISPLAY': ':0', 21:04:50 INFO - 'HOME': '/home/cltbld', 21:04:50 INFO - 'LANG': 'en_US.UTF-8', 21:04:50 INFO - 'LANGUAGE': 'en_US:en', 21:04:50 INFO - 'LOGNAME': 'cltbld', 21:04:50 INFO - 'MAIL': '/var/mail/cltbld', 21:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:50 INFO - 'MOZ_NO_REMOTE': '1', 21:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:50 INFO - 'NO_EM_RESTART': '1', 21:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:50 INFO - 'PWD': '/builds/slave/test', 21:04:50 INFO - 'SHELL': '/bin/bash', 21:04:50 INFO - 'SHLVL': '1', 21:04:50 INFO - 'TERM': 'linux', 21:04:50 INFO - 'TMOUT': '86400', 21:04:50 INFO - 'USER': 'cltbld', 21:04:50 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850', 21:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:50 INFO - '_': '/tools/buildbot/bin/python'} 21:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:04:50 INFO - Running setup.py (path:/tmp/pip-pnzN6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:04:50 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)) 21:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:04:50 INFO - Running setup.py (path:/tmp/pip-ord9wF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:04:50 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)) 21:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:04:50 INFO - Running setup.py (path:/tmp/pip-GBwQFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:04:50 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)) 21:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:04:50 INFO - Running setup.py (path:/tmp/pip-3HoTQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:04:50 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)) 21:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:04:50 INFO - Running setup.py (path:/tmp/pip-UhvrBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:04:51 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)) 21:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:04:51 INFO - Running setup.py (path:/tmp/pip-s_D2fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:04:51 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)) 21:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:04:51 INFO - Running setup.py (path:/tmp/pip-Rx4jzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:04:51 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)) 21:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:04:51 INFO - Running setup.py (path:/tmp/pip-WrbXRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:04:51 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)) 21:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:04:51 INFO - Running setup.py (path:/tmp/pip-ofiOse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:04:51 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)) 21:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:04:51 INFO - Running setup.py (path:/tmp/pip-2wkP79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:04:51 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)) 21:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:04:51 INFO - Running setup.py (path:/tmp/pip-NKJgmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:04:51 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)) 21:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:04:51 INFO - Running setup.py (path:/tmp/pip-QEhhsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:04:51 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)) 21:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:04:51 INFO - Running setup.py (path:/tmp/pip-Dn4dwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:04:51 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)) 21:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:04:51 INFO - Running setup.py (path:/tmp/pip-nJ1Xvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:04:51 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)) 21:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:04:51 INFO - Running setup.py (path:/tmp/pip-FxlsLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:04:51 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)) 21:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:04:51 INFO - Running setup.py (path:/tmp/pip-3AeIwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:04:51 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)) 21:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:04:51 INFO - Running setup.py (path:/tmp/pip-mxbK9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:04:51 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)) 21:04:51 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)) 21:04:51 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)) 21:04:51 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)) 21:04:51 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)) 21:04:51 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)) 21:04:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:04:51 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 21:04:51 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 21:04:51 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 21:04:51 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 21:04:51 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 21:04:51 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 21:04:53 INFO - Downloading blessings-1.6.tar.gz 21:04:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:04:53 INFO - Installing collected packages: blessings 21:04:53 INFO - Running setup.py install for blessings 21:04:54 INFO - Successfully installed blessings 21:04:54 INFO - Cleaning up... 21:04:54 INFO - Return code: 0 21:04:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:04:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:04:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:04:54 INFO - Reading from file tmpfile_stdout 21:04:54 INFO - Current package versions: 21:04:54 INFO - argparse == 1.2.1 21:04:54 INFO - blessings == 1.6 21:04:54 INFO - blobuploader == 1.2.4 21:04:54 INFO - docopt == 0.6.1 21:04:54 INFO - manifestparser == 1.1 21:04:54 INFO - mozInstall == 1.12 21:04:54 INFO - mozcrash == 0.17 21:04:54 INFO - mozdebug == 0.1 21:04:54 INFO - mozdevice == 0.48 21:04:54 INFO - mozfile == 1.2 21:04:54 INFO - mozhttpd == 0.7 21:04:54 INFO - mozinfo == 0.9 21:04:54 INFO - mozleak == 0.1 21:04:54 INFO - mozlog == 3.2 21:04:54 INFO - moznetwork == 0.27 21:04:54 INFO - mozprocess == 0.22 21:04:54 INFO - mozprofile == 0.28 21:04:54 INFO - mozrunner == 6.11 21:04:54 INFO - mozscreenshot == 0.1 21:04:54 INFO - mozsystemmonitor == 0.3 21:04:54 INFO - moztest == 0.7 21:04:54 INFO - mozversion == 1.4 21:04:54 INFO - psutil == 3.1.1 21:04:54 INFO - requests == 1.2.3 21:04:54 INFO - wsgiref == 0.1.2 21:04:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:54 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 0x7fb2374faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d95770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e249c0>, '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 0x1e258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e25d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850', '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 21:04:54 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 21:04:54 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 21:04:54 INFO - Using env: {'DISPLAY': ':0', 21:04:54 INFO - 'HOME': '/home/cltbld', 21:04:54 INFO - 'LANG': 'en_US.UTF-8', 21:04:54 INFO - 'LANGUAGE': 'en_US:en', 21:04:54 INFO - 'LOGNAME': 'cltbld', 21:04:54 INFO - 'MAIL': '/var/mail/cltbld', 21:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:54 INFO - 'MOZ_NO_REMOTE': '1', 21:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:54 INFO - 'NO_EM_RESTART': '1', 21:04:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:54 INFO - 'PWD': '/builds/slave/test', 21:04:54 INFO - 'SHELL': '/bin/bash', 21:04:54 INFO - 'SHLVL': '1', 21:04:54 INFO - 'TERM': 'linux', 21:04:54 INFO - 'TMOUT': '86400', 21:04:54 INFO - 'USER': 'cltbld', 21:04:54 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850', 21:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:54 INFO - '_': '/tools/buildbot/bin/python'} 21:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:54 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)) 21:04:54 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)) 21:04:54 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)) 21:04:54 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)) 21:04:54 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)) 21:04:54 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)) 21:04:54 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)) 21:04:54 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)) 21:04:54 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)) 21:04:54 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)) 21:04:54 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)) 21:04:54 INFO - Cleaning up... 21:04:54 INFO - Return code: 0 21:04:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2374faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d95770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e249c0>, '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 0x1e258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e25d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850', '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 21:04:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:04:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:04:54 INFO - Using env: {'DISPLAY': ':0', 21:04:54 INFO - 'HOME': '/home/cltbld', 21:04:54 INFO - 'LANG': 'en_US.UTF-8', 21:04:54 INFO - 'LANGUAGE': 'en_US:en', 21:04:54 INFO - 'LOGNAME': 'cltbld', 21:04:54 INFO - 'MAIL': '/var/mail/cltbld', 21:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:54 INFO - 'MOZ_NO_REMOTE': '1', 21:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:54 INFO - 'NO_EM_RESTART': '1', 21:04:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:54 INFO - 'PWD': '/builds/slave/test', 21:04:54 INFO - 'SHELL': '/bin/bash', 21:04:54 INFO - 'SHLVL': '1', 21:04:54 INFO - 'TERM': 'linux', 21:04:54 INFO - 'TMOUT': '86400', 21:04:54 INFO - 'USER': 'cltbld', 21:04:54 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850', 21:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:54 INFO - '_': '/tools/buildbot/bin/python'} 21:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:54 INFO - Downloading/unpacking jsonschema 21:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:04:56 INFO - Downloading/unpacking functools32 (from jsonschema) 21:04:56 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 21:04:56 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 21:04:56 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 21:04:56 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 21:04:56 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 21:04:56 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 21:04:56 INFO - Downloading functools32-3.2.3-2.tar.gz 21:04:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:04:56 INFO - warning: no files found matching '*.txt' 21:04:56 INFO - no previously-included directories found matching 'build' 21:04:56 INFO - no previously-included directories found matching 'dist' 21:04:56 INFO - no previously-included directories found matching '.git*' 21:04:56 INFO - Installing collected packages: jsonschema, functools32 21:04:56 INFO - Running setup.py install for functools32 21:04:57 INFO - warning: no files found matching '*.txt' 21:04:57 INFO - no previously-included directories found matching 'build' 21:04:57 INFO - no previously-included directories found matching 'dist' 21:04:57 INFO - no previously-included directories found matching '.git*' 21:04:57 INFO - Successfully installed jsonschema functools32 21:04:57 INFO - Cleaning up... 21:04:57 INFO - Return code: 0 21:04:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:04: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')]} 21:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04: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')]} 21:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2374faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d95770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e249c0>, '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 0x1e258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e25d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850', '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 21:04: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', 'flake8'] in /builds/slave/test/build 21:04: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 flake8 21:04:57 INFO - Using env: {'DISPLAY': ':0', 21:04:57 INFO - 'HOME': '/home/cltbld', 21:04:57 INFO - 'LANG': 'en_US.UTF-8', 21:04:57 INFO - 'LANGUAGE': 'en_US:en', 21:04:57 INFO - 'LOGNAME': 'cltbld', 21:04:57 INFO - 'MAIL': '/var/mail/cltbld', 21:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:57 INFO - 'MOZ_NO_REMOTE': '1', 21:04:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:57 INFO - 'NO_EM_RESTART': '1', 21:04:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:57 INFO - 'PWD': '/builds/slave/test', 21:04:57 INFO - 'SHELL': '/bin/bash', 21:04:57 INFO - 'SHLVL': '1', 21:04:57 INFO - 'TERM': 'linux', 21:04:57 INFO - 'TMOUT': '86400', 21:04:57 INFO - 'USER': 'cltbld', 21:04:57 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850', 21:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:57 INFO - '_': '/tools/buildbot/bin/python'} 21:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:57 INFO - Downloading/unpacking flake8 21:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:04:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:04: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 21:04: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 21:04: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 21:04: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 21:04: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 21:04: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 21:04:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:04:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:04: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 21:04: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 21:04: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 21:04: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 21:04: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 21:04: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 21:04:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:04: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 21:04: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 21:04: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 21:04: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 21:04: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 21:04: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 21:04:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:04:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:04:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:04:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:04:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:04:59 INFO - no previously-included directories found matching 'docs/_build' 21:04:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:04:59 INFO - Running setup.py install for pep8 21:05:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:05:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:05:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:05:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:05:00 INFO - no previously-included directories found matching 'docs/_build' 21:05:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:05:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:05:00 INFO - Cleaning up... 21:05:00 INFO - Return code: 0 21:05:00 INFO - Running post-action listener: _resource_record_post_action 21:05:00 INFO - Running post-action listener: _start_resource_monitoring 21:05:00 INFO - Starting resource monitoring. 21:05:00 INFO - ##### 21:05:00 INFO - ##### Finished create-virtualenv step (success) 21:05:00 INFO - ##### 21:05:00 INFO - ##### 21:05:00 INFO - ##### Running install step. 21:05:00 INFO - ##### 21:05:00 INFO - Running pre-action listener: _resource_record_pre_action 21:05:00 INFO - Running main action method: install 21:05:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:05:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:05:00 INFO - Reading from file tmpfile_stdout 21:05:00 INFO - Detecting whether we're running mozinstall >=1.0... 21:05:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:05:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:05:00 INFO - Reading from file tmpfile_stdout 21:05:00 INFO - Output received: 21:05:00 INFO - Usage: mozinstall [options] installer 21:05:00 INFO - Options: 21:05:00 INFO - -h, --help show this help message and exit 21:05:00 INFO - -d DEST, --destination=DEST 21:05:00 INFO - Directory to install application into. [default: 21:05:00 INFO - "/builds/slave/test"] 21:05:00 INFO - --app=APP Application being installed. [default: firefox] 21:05:00 INFO - mkdir: /builds/slave/test/build/application 21:05:00 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'] 21:05:00 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 21:05:17 INFO - Reading from file tmpfile_stdout 21:05:17 INFO - Output received: 21:05:17 INFO - /builds/slave/test/build/application/firefox/firefox 21:05:17 INFO - Running post-action listener: _resource_record_post_action 21:05:17 INFO - ##### 21:05:17 INFO - ##### Finished install step (success) 21:05:17 INFO - ##### 21:05:17 INFO - ##### 21:05:17 INFO - ##### Running run-tests step. 21:05:17 INFO - ##### 21:05:17 INFO - Running pre-action listener: _resource_record_pre_action 21:05:17 INFO - Running main action method: run_tests 21:05:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:05:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:05:17 INFO - Python 2.7.3 21:05:17 INFO - Return code: 0 21:05:17 INFO - grabbing minidump binary from tooltool 21:05:17 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')]} 21:05:17 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 0x1e249c0>, '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 0x1e258c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e25d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:05:17 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 21:05:17 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 21:05:17 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 21:05:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:05:17 INFO - Return code: 0 21:05:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:05:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:05:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:05:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:05:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:05:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:05:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:05:18 INFO - Return code: 0 21:05:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D5gSrQTDT427sXIo4JJOaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 21:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D5gSrQTDT427sXIo4JJOaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 21:05:18 INFO - Using env: {'DISPLAY': ':0', 21:05:18 INFO - 'HOME': '/home/cltbld', 21:05:18 INFO - 'LANG': 'en_US.UTF-8', 21:05:18 INFO - 'LANGUAGE': 'en_US:en', 21:05:18 INFO - 'LOGNAME': 'cltbld', 21:05:18 INFO - 'MAIL': '/var/mail/cltbld', 21:05:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:05:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:05:18 INFO - 'MOZ_NO_REMOTE': '1', 21:05:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:05:18 INFO - 'NO_EM_RESTART': '1', 21:05:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:05:18 INFO - 'PWD': '/builds/slave/test', 21:05:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:05:18 INFO - 'SHELL': '/bin/bash', 21:05:18 INFO - 'SHLVL': '1', 21:05:18 INFO - 'TERM': 'linux', 21:05:18 INFO - 'TMOUT': '86400', 21:05:18 INFO - 'USER': 'cltbld', 21:05:18 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850', 21:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:05:18 INFO - '_': '/tools/buildbot/bin/python'} 21:05:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D5gSrQTDT427sXIo4JJOaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 21:05:18 INFO - mozversion application_buildid: 20160527183007 21:05:18 INFO - mozversion application_changeset: 39dcfacc4b5b91b0d0c66ecc144aacf00fca7c2a 21:05:18 INFO - mozversion application_display_name: Nightly 21:05:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:05:18 INFO - mozversion application_name: Firefox 21:05:18 INFO - mozversion application_remotingname: firefox 21:05:18 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 21:05:18 INFO - mozversion application_vendor: Mozilla 21:05:18 INFO - mozversion application_version: 49.0a1 21:05:18 INFO - mozversion platform_buildid: 20160527183007 21:05:18 INFO - mozversion platform_changeset: 39dcfacc4b5b91b0d0c66ecc144aacf00fca7c2a 21:05:18 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 21:05:18 INFO - mozversion platform_version: 49.0a1 21:05:18 INFO - using testdate: 1464408318 21:05:18 INFO - actual date: 1464408318 21:05:18 INFO - starting webserver on 'localhost:42173' 21:05:18 INFO - SUITE-START | Running 2 tests 21:05:18 INFO - TEST-START | dromaeo_css 21:05:18 INFO - operating with platform_type : linux_ 21:05:18 INFO - Initialising browser for dromaeo_css test... 21:05:18 INFO - TEST-INFO | started process 16408 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm0JpWJ/profile http://localhost:42173/getInfo.html) 21:05:22 INFO - PROCESS | 16408 | 21:05:22 INFO - PROCESS | 16408 | (process:16479): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:05:23 INFO - PROCESS | 16408 | __metrics Screen width/height:1600/1200 21:05:23 INFO - PROCESS | 16408 | colorDepth:24 21:05:23 INFO - PROCESS | 16408 | Browser inner width/height: 1024/697 21:05:23 INFO - PROCESS | 16408 | __metrics 21:05:24 ERROR - PROCESS | 16408 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 21:05:25 INFO - TEST-INFO | 16408: exit 0 21:05:25 INFO - Browser initialized. 21:05:25 INFO - Running cycle 1/1 for dromaeo_css test... 21:05:25 INFO - TEST-INFO | started process 16530 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm0JpWJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:05:26 INFO - PROCESS | 16530 | 21:05:26 INFO - PROCESS | 16530 | (process:16591): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:05:36 INFO - PROCESS | 16530 | RSS: Main: 165662720 21:05:36 INFO - PROCESS | 16530 | 21:06:26 INFO - PROCESS | 16530 | 1464408386516 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] 21:08:33 INFO - PROCESS | 16530 | Cycle 1(1): loaded http://localhost:42173/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42173/tests/dromaeo/cssquery-ext.html) 21:08:34 INFO - PROCESS | 16530 | RSS: Main: 170688512 21:08:34 INFO - PROCESS | 16530 | 21:11:36 INFO - PROCESS | 16530 | Cycle 1(1): loaded http://localhost:42173/tests/dromaeo/cssquery-ext.html (next: http://localhost:42173/tests/dromaeo/cssquery-jquery.html) 21:11:37 INFO - PROCESS | 16530 | RSS: Main: 169476096 21:11:37 INFO - PROCESS | 16530 | 21:14:39 INFO - PROCESS | 16530 | Cycle 1(1): loaded http://localhost:42173/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42173/tests/dromaeo/cssquery-mootools.html) 21:14:39 INFO - PROCESS | 16530 | RSS: Main: 170483712 21:14:39 INFO - PROCESS | 16530 | 21:17:41 INFO - PROCESS | 16530 | Cycle 1(1): loaded http://localhost:42173/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42173/tests/dromaeo/cssquery-prototype.html) 21:17:42 INFO - PROCESS | 16530 | RSS: Main: 167845888 21:17:42 INFO - PROCESS | 16530 | 21:20:44 INFO - PROCESS | 16530 | Cycle 1(1): loaded http://localhost:42173/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42173/tests/dromaeo/cssquery-yui.html) 21:20:45 INFO - PROCESS | 16530 | RSS: Main: 169525248 21:20:45 INFO - PROCESS | 16530 | 21:23:48 INFO - PROCESS | 16530 | Cycle 1(1): loaded http://localhost:42173/tests/dromaeo/cssquery-yui.html (next: http://localhost:42173/tests/dromaeo/cssquery-dojo.html) 21:23:48 INFO - PROCESS | 16530 | RSS: Main: 171839488 21:23:48 INFO - PROCESS | 16530 | 21:23:48 INFO - PROCESS | 16530 | __start_tp_report 21:23:48 INFO - PROCESS | 16530 | _x_x_mozilla_page_load 21:23:48 INFO - PROCESS | 16530 | _x_x_mozilla_page_load_details 21:23:48 INFO - PROCESS | 16530 | |i|pagename|runs| 21:23:48 INFO - PROCESS | 16530 | |0;dojo.html;3088.2125058110178;3112.1752735525106;3114.501679731242;3124.953125703114;3146.8741250350004;5351.25082488452;5369.892602147955;5389.24550562921;5445.156000819869;5449;5398.541124004454;5489.149181876805;5506.256655351526;5510.338759348884;5570.6657600543995;4903.239997800338;4939.061578300111;5052.317937078484;5066.670666406671;5111.335526381566;735.1828226695787;4915.9262611060685;5067.467915868836;5111.948880511184;5139.15203991341;4993.700377977315;5002.824901128443;5013.298138260629;5028.748562571856;5049.469805670388;4832.492588278251;5028.270900719412;5040.445550989388;5042.949570504321;5050.520200580939;4853.975730121362;4870.318155458239;4871.512848715136;4892.315075889378;4913.26301054841;5306.283651707047;5335.466453354672;5343.412224655285;5367.838964831061;5413.188021796723;5693.316801983747;5802.65184088956;5804.65172089676;5859.7656093756195;5860.355360910296;5960.552958528127;5993.670348130851;5998.820035398945;6000.519958403317;6032.788852390189;5583.274174357348;5589.74846131925;5592.720363981784;5600.4959553640365;5605.57958153136;5848.883022339614;6008.188894499274;6064.757409703562;6074.42292982166;6095.420935011167;5828.76684932598;5833.300003999462;5839.416058394211;5848.502877255481;5861.501772349398;5927.140564618193;5940.108983652487;5950.9107363389585;5954.761809527657;5964.8807023860145;5604.551635869121;5821.941780582225;5862.413758624189;5864.47219750216;5905.645661260338;5639.210510528447;5768.884622307531;5772.2207501986695;5778.422157784272;5919.408059194132;4419.270820314677;4426.712263702913;4433.379326894237;4435.3125265583885;4461.732296062247;3903.0437542802197;3957.3470377387985;3962.3264045111823;4002.4996875390575;4014.598540145962;5716.456936591017;5725.3988331225455;5727.914081288784;5732.799352022743;5738.971305143447;5748.540116790647;5959.433853783884;6004.579679422486;6030.969845150747;6049;5548.528375088163;5599.412061733459;5603;5622.156676498558;5642.238297829823;5010;5081.923771143436;5084.161113416245;5089.720065396439;5142.87142821425;5930.8813823723285;6032.065029920369;6088.6042407243385;6095.085737139376;6117.724702388403;5902.793402230901;5979.282486101695;5984.730687119003;5998.850028749316;6026.668533230627;6121.234845644294;6147.692615369303;6158.384161583985;6161.815145545641;6170.413810688157;5692.715364231854;5779.219805326227;5797.246357973437;5857.092150716646;5880.470757631662;5934;5944.346121926498;5954.702264886825;5958.374370691015;5973.1338955852025;5717.914231286617;5732.656040637575;5747.36778954323;5785.132230165509;5787.623804452697;5498.642588231752;5713.114467257582;5717.22817419643;5760.423957604206;5791.53667706574;5498.147787093007;5503.3395992481155;5552.97223513896;5577.860553486195;5597.160425935979;5702.173184888251;5754.8849023018465;5764.106563482667;5767.596268261182;5843.912341314799;5666.603337766317;5668.631538949955;5669.177969194526;5670.347909990404;5697.57268204878 21:23:48 INFO - PROCESS | 16530 | |1;ext.html;549.5521150262535;599.0804115682429;610.4140025575448;630.2657404124199;659.9538032337738;38181;42210.577894221045;42310.36534451986;42338.15323693524;42386.788066059664;44385.556144438546;45156;45170.548294517044;45181.7740911295;45209.321860172124;8740.737777866674;8865.778355541132;8907.619319005564;8945.373823832335;8976.192142707156;8904.376693631448;8991.550422478882;8998.280137588978;9011.143941325563;9014.729558113268;9014.774630634254;9062.637494500212;9067.36528443006;9082.59128339223;9084.59119339628;8967.910320896804;9021.594028268679;9024.639014439415;9032.18710316068;9077.773055673628;8862.291016718647;8914.732558023205;8923.375363724543;8945.64217431302;8973;40835.591644083775;40909.590904090874;41243.38134927949;41314.1737165258;41638.375424368656;3629.818509074562;3648.981755091234;3702.7037836973245;3810.5236845394325;4188.162367526476;32208.677913221036;32737.672623273702;33009.50485742716;33084.834575826964;33102.50346244808;4211.831526738927;4329.458817647794;4339.674524410681;4362.738235705868;4398.8900277493;329521;331774;332237;332856;334694.99999999756;35085.82457087749;35709.28581428357;35772.82113589467;59263.70368148132;59571.70214148902;37163.25673486569;37193.070173245884;37201.44197837035;37267.25465490675;37396.25207495835;15398.384064637288;15533.844661553467;15534;15579.221038948008;15626.531204063896;13017.284049377375;13024.283664398548;13088.345582721016;13098;13110.868891310965;8256.174382561696;8293.585320733939;8363.330933525303;8382.203690649378;8420.4947703138;3223.38755636433;3249.8700051997657;3258.120307516957;3259.9674003259665;3266.5426840242385;1032.8915463876335;1053.1837825685154;1069.2141276162015;1087.7389426537732;1145.0667705819897;31773.52339714906;32140.517892231634;32403.837980809945;32851.67148328486;32865.342693146005;1125.8480105185859;1132.1715429581332;1137.5222406589253;1180.4156942313439;1228.3121451986915;16095.597610059607;16727.749083763752;16803.327866885433;16855.241514131892;17072.743908841378;599376;608423;611103;612049;612929;57087;58377.70811145917;58590.70704646449;58861.41138588645;58874;1352.3035636647135;1361.1900918953404;1370.4860677246033;1378.2832926878168;1410.661441254112;30500.542491863085;31932.201694957814;32175;32268;32311;49474.25788613246;49610.25584616161;49782.75108624434;49843;49893.501064988886;505012;507800;508462;509301;512381;28227.294317642223;28286.57570136491;28357.291067723472;28669.713302866705;28711.42577148487;47683;47824.760876195396;48821.511784881695;49136;50061.24908126308;41409;42039.7898010508;42525.36211956885;42556;42783.572164279205;41638;41668.37497437601;41840;42036.3694544576;42745.57254427416;36688.26623467569;41832.79083604563;42143;42146.57853421426;42495.78752106219;36813;37463.81268093642;37726.811365942995;38059;38351;28518.230102632115;28631.570526442538;29015.56476652894;29022.564661529672;29028.27429314284 21:23:48 INFO - PROCESS | 16530 | |2;jquery.html;381.2299155705477;381.62044210180204;385.60475512599584;397.1560434077585;399.12193175014977;17403.912980435096;20138.496537586532;20196;20265.290714825;20319.695204571944;18838.71741923872;18903.432897013077;19625.803741962576;19655;19706.21175152992;5615.382307946123;5674.063779476382;5781.103928891029;5785.508231800302;5910.527157827385;3926.7447615905016;6163.568550201488;6450.290468048511;6462.741490340404;6598.934010659904;6318.589291696025;6382.808515744535;6524.93475065248;6524.967375163142;6526.6736663166885;6344.111824344595;6360.745570177188;6376.936230637681;6403.967980160116;6425.357464253584;5489.4236105209175;5561.165825126223;5575.972120139414;5651.378348381675;5659.5755318351285;22696.319110426713;23221.76778232213;23461.13471632092;23522.411939701473;23703.644445333335;2444.792192663626;2477.826552141351;2490.8256422050463;2491.6636254105647;2711.4034912319457;9577.712668619952;10209.89790102097;14427.278636068155;15038.097714137186;15288.847111528854;1623.2370785730807;1675.656490419461;1858.1359667754423;1879.6146789908037;1911.9197653325966;86858.56570717169;89874.55062724644;90525.54737226338;91504.54247728719;92783.07216927812;10746.462676866126;10796.244262901679;10898.727531811768;10985.231033827715;11479.655610331703;14786.186759728103;14959.551213463614;14976;14977.400903963937;14996.175210363317;7501.66242519088;7588.241175882478;8058.597070146469;8207.179282071746;8223;7758.107817600935;7831.490953088031;7947.125816160218;8065.274125328631;8148.877766833502;4105.835766569364;4441.955580444154;4652.930206046912;4672.570263462981;4828.758562071883;1777.6533575952824;1854.1656254685445;1897.4497395755352;1905.3236101184157;1957.2366776956999;933.2953620016843;1029.0275689473376;1045.3169799299183;1076.1498416251075;1130.9547618095185;18947.90526047361;19329.130189141524;19619.509512262306;19661.311854085037;19689.60620787576;1018.271935566059;1065.5524679634573;1076.2573824061374;1076.838474228872;1086.5708045322053;10601.363918164934;11098.223124381377;11133.665990020312;11143.554257829757;11233.494492747846;383697;386167;391561;473986.4104756317;487058;60392;86740;89167;92813;93263.53368233115;1004.9849252261222;1041.4792603698152;1042.7341028037802;1052.5053224984244;1072.9463526823627;17692.11539422998;17801.376951807142;18258.45224643263;18446;18578.535536611693;42207.788961055;43002;43465.78267108644;43784.343234850865;44041.339379909965;57844.421555783905;58996.70501647464;60129.69935150296;60609.39390606214;60749.39250607437;8177.4684645497855;8319.667213311399;8487.363447741567;8594;8622.870656940277;9415.62337506492;12642.747145057232;13083.345832708135;13162.341882906008;13329.400176991865;11519.53921843117;11538.94230528842;11854.466549005143;11979.580714674945;12016.218945768496;11425.14311426663;11525.135614829089;11729.558807393674;11831.881681183078;11943.402829858645;11588.362640054878;11987.820182697093;12000.759984800081;12038.699032524257;12080.154389192672;8547.487150770974;8578.099299573705;8583;8641.438306510308;8670.089640587648;10892.346459212473;11537.942310288396;11803.645890623295;11836.881631183922;11933.343666098448 21:23:48 INFO - PROCESS | 16530 | |3;mootools.html;1480.88893333;1516.5829396915851;1684;1800.216905646044;1817.2095138614711;7705.499142555744;8138.308243799277;8368.121347258526;8548.102449242826;8561.828763424735;8397.49615023099;8671.479711217316;8729.432586881863;8738.956305218466;8752.212300892917;2347.80043696286;2355.0579768092816;2356.7643235676464;2375.049980008002;2379.4051487128218;2345.566070277004;2359.976400235993;2380.0360853854218;2380.8928598213033;2385.988070059656;2373.6914201153913;2383.0467812874904;2391.246757271454;2400.411899084727;2409.0363854458183;2314.2131675230335;2355.2580937004786;2358.209999650128;2366.1245339224597;2366.4438856868624;2252.718410198725;2291.7509957073266;2302.4243939015246;2302.873341966191;2306.1582522379376;8551.401401901869;8620.956895215546;8623.13768623139;8624.698135565288;8646.870296945488;5196.506331898464;5214.217867319932;5343.251944727741;5369.087255166631;5400.945990540084;3420.521127042216;3421.1447138215444;3495.353359628477;3518.683318501347;3623.202895363016;1163.720707030315;1167.6030149749126;1177.5584155941522;1186.952521899123;1191.356667399603;11567.363794991272;11660.416979151008;11735.765284694344;11769.64691059261;11780.705482362924;4332.740035597874;4337.479502459725;4454.309582014793;4455.287154055401;4525.298578720303;9411.341206115507;9417.858732119024;9422.434653920787;9439.292053096045;9452.149306562442;5229.111051121318;5232.110541208004;5261.552768014762;5265.52610265078;5266.578673706171;4413.536578659195;4694.624430045588;4747.715137091785;4793.976030119827;4813.470518242991;3759;3774.7168962327937;3857.9035524112123;3888.902777430587;3920.941185882214;1128.306091753582;1166.311875993168;1182.645206438065;1185.7984142695761;1188.5127097889824;920.4891285336703;1033.6278939581744;1039.2465462539749;1050.075933178813;1052.9894701052892;6061.605995610359;6077.24034495688;6138.171346868205;6218.253809542884;6482.67586620667;967.1827305926481;976.2531663277598;988.461288597716;1039.750459889621;1047.5914393386586;4104.179164167179;4288.635465985426;4361.760103194291;4419.248727716296;4427.800748966304;10621.946890265499;10891.455427228608;10952.288101273392;10953.890461095287;10981.780364392667;10593.410988351654;10647.14822814173;10725.624603138853;10860.72848178786;10873.130149588014;8064.193580641889;8139.918600814034;8172.387070969582;8203.58982050895;8242.381821363302;6039.486643635164;6069.817905462844;6136.018237082046;6161.876762464815;6268.404501572343;9889.357191782512;10084;10147.18822494184;10150.086492215441;10178.033086856736;10120.797584048425;10199.439030853375;10214.489275536342;10267.435291059064;10296.17630589536;7234.493585448968;7301.415886729155;7333.669984850588;7418;7437.479376443597;8289;8298.460600061218;8323.6670533178;8365.36875309309;8379.916200837913;7468.663910123949;7770.494917830323;7775.105862825847;7856.960715196387;7902.328302094386;7579.5073320234005;7672.5012874163;7702.229777022477;7728.072631284057;7762.961185194264;7009.088818453569;7079.327463890922;7177.138743350832;7178.5692858428665;7196.0285361475535;5198.116320225495;5221.216817477409;5228.581713462838;5233.215017747216;5271.841844744664;5267.394249661338;5278.920816187837;5307.310049693515;5309.070912590204;5438.918416223839 21:23:48 INFO - PROCESS | 16530 | |4;prototype.html;327.6919695486244;330.4959936097451;337.9290349026705;339.57213910472814;344.3663658867683;5501.229827824108;5572.359178694452;5578.191162281471;5632.943670563298;5657.603967722261;5550.2507161533185;5571.693556854381;5574.57848248696;5624.493795558399;5624.521915637166;4373.38184871598;4375.0812329410865;4380.145871555048;4384.561543845622;4404.251277282861;4052.3921411788174;4265.914681706364;4286.464191976003;4393.934090988621;4403.691741578091;4216.304309788881;4228.809703563347;4233.534311225778;4256.21260066887;4263.957360426387;4234.788260586989;4236.724612900167;4251.213525497793;4252.532221455637;4273.7008409411355;3549.432090865449;3687.502187204747;3697.7781333120097;3720.962790372089;3730.496382988289;5370.91943620846;5392.649477783971;5395.870395170791;5423.647462914898;5434.429384914567;4905.23968784839;4927.556519913225;4941.160002799533;4944.431390390115;4953.628477864175;5489.945100549024;5802.883942321172;5836.649801011953;5842.328132264802;5866.794662186803;4102.651274641659;4129.174165166979;4129.97935010326;4161.83352665893;4165.437665915093;6047.518358002274;6059.363766804466;6069.15031895535;6101.450869421773;6107.358727333655;4035.2333056719717;4137.606927341898;4144.647704945053;4160.335865653763;4187.267228235047;4210.2842516772225;4224.2185195738275;4240.321548552217;4251.744895306291;4258.339957306623;4883.536064073907;4887.169181239198;4887.535684110004;4890.437599676012;4892.651527266932;5731.885362292731;5873.941260587425;5918.408159184047;5926.895951937;5939.851503712442;1461.2693653173412;1470.5514817980404;1471.8446019874348;1472.749632562467;1472.8158980127484;876.9649214031367;904.2404380320562;914.8719179314901;915.4187091197138;924.824283386168;5095.566876815512;5110.642255042111;5110.642255042186;5208.739563021833;5224.660397074254;5217;5306.575473962073;5313.937212557426;5358.115910874662;5358.223057656618;5103.7192954387865;5112.616553758483;5148.172398798448;5332.466753324714;5839.737211825478;3212.437823380899;3217.501287300472;3231.4829627259523;3241.5299781531544;3246.8376581170846;6125.571210015256;6221.9377806222265;6257.624542527372;6273;6290.811275661737;6146.078088286793;6164.229471316085;6180.505559555225;6185.536084793568;6188.2883468400805;6225.439710426083;6230.875382492415;6236.445226221101;6259.372563133618;6302.8424289392215;5834.27071616048;6015.639061656315;6045.969770151121;6080.361562035922;6119.816405507842;5901.167439628916;5989.341172470938;6011.308699499614;6025.6083354581815;6035.36628653985;6027.427394397525;6245.812625621239;6253.6861361296615;6291.842703932438;6349.238091429058;4212.178625168062;4222.704410691345;4223.72545784523;4237.237297286518;4238.237117318912;6030.819075427744;6057;6069.2110025696375;6085.574009819447;6136.32500424944;5722.141678748221;5851.736671849691;5881.970590147193;5896.734646940812;5940.346561878104;5815.331236907809;5830.62100963436;5888.705564721832;5894.233749612523;5921.259842519685;5526.171074338881;5728.484436400744;5790.826275211751;5796.94203057964;5800.694843660142;5902.881942361043;5926.273913999608;5938.6436813791315;5946.859130713026;5953.821385358447;5703.515201207943;5712.971435142797;5730.541556675539;5770.596058276048;5797.942020579909 21:23:48 INFO - PROCESS | 16530 | |5;yui.html;766.865798485265;855.9486430814152;867.3104881619112;876.4784952952995;885.3094586222749;14982.625434364132;15738.055716656994;15883.761743573856;15933.442329518455;15934.442294519695;14363.425462981468;14412.927935360334;14415.207163605997;14422.92788536056;14436.27818609068;670.7149461478876;793.7420338390017;825.6532256452274;827.5655280977475;828.4408024583412;789.0925435748877;795.610151025996;799.5522507395877;800.0918956983807;805.7099444200113;860.0195776814437;860.0754189246554;864.412199704204;868.7828042989253;869.5782545465444;857.9013413457438;860.0324634785866;860.1828263150032;864.1401805203831;866.8093019535723;621.9409156130206;626.3329554024949;626.4236902050079;627.0343670747089;629.1694962649304;14334.784978225334;14439.711205775826;14475.493357732534;14485.56543303692;14516.27418629075;14774.409023639042;14929.626759330995;14973.700525989529;14977.700445991128;15257.313420896086;11972.880271197264;12093.093018023683;12117.939410302892;12136.57521986735;12669.493220271179;3855.2096820152083;3882.864099756523;4035.031592417828;4075.0219947212754;4092.324766413568;53833.46166538363;61564.38435615631;62229.37770622326;62332.68833655848;62406.687966560334;11116.666500005012;11264.155188360906;11439.199256051996;11767.588134415426;11777.695988222378;20316.796832031785;20318.390448286576;20318.492037699176;20332.69500957487;20334.288299909433;8717.607707653171;8756.474611523328;8793.824123517494;8880.333974951904;8943.597538110671;4848.878778030577;4895.975520122448;4922.975385123052;4960.553550180501;5003.2995380646735;3264.6735326467638;3362.596488421405;3363.9327213455595;3368.14112401341;3370.646082161387;625.7872323410062;632.2318383164477;640.5932233031965;644.4940721533667;647.779754883342;578.9884202316015;621.9160413344141;633.566007285002;684.2849222562435;772.2007722007695;10314.27800053989;10374.27380083387;10408.791824163474;10424.113950314308;10548.894511054945;684.1653183116689;765.5215490318551;785.7956931197815;805.1143741883881;810.0481933727846;4617.515160908123;4732.594041319656;4804.567588917014;4814.566688998007;4878.853634390974;67744.6612766933;69709.65145174242;70071.64964175147;70071.64964175147;70085.64957175283;54917.72541137349;56082;63848.68075659592;64181;66205.66897165483;58634;59329.70335148297;59698;59874;60858;9911.851322230317;9987.434680282327;9990.950045249727;9996.800063998533;10023.448710321003;39026.804865975486;39143.02142446462;39214.21571568496;39420.211595768495;39686.60313396829;47561.76219118882;51330.23004654858;52056.73971630118;52375.47624523706;53076;12626.36868156607;12679.683007924876;13024.674383140497;13226.933865330611;13363.799543007057;13659.317034148451;13758.243296618783;13782.586522404345;13790.357103746239;13852.376643050886;12575.353147587097;12715.491380344683;12718.682032949251;12913.548025819051;13370.866291336963;12451.875481245072;13287.867121329049;13361;13813.51652692151;14199.219042952736;11855.34795586251;12535.811962820748;12578.245305281713;12791.616251512469;13167.60497185086;10920.126389888948;11053.557857685602;11167.162462815159;11260.718482038015;11486.081113510732;11675.941620291844;11764.176507644725;11912.523499060288;12245.387730613611;12376.443060062498 21:23:48 INFO - PROCESS | 16530 | __end_tp_report 21:23:48 INFO - PROCESS | 16530 | __start_cc_report 21:23:48 INFO - PROCESS | 16530 | _x_x_mozilla_cycle_collect,344 21:23:48 INFO - PROCESS | 16530 | __end_cc_report 21:23:48 INFO - PROCESS | 16530 | __startTimestamp1464409428340__endTimestamp 21:23:48 INFO - PROCESS | 16530 | 21:23:48 INFO - PROCESS | 16530 | ------- Summary: start ------- 21:23:48 INFO - PROCESS | 16530 | Number of tests: 6 21:23:48 INFO - PROCESS | 16530 | 21:23:48 INFO - PROCESS | 16530 | [#0] dojo.html Cycles:165 Average:5436.75 Median:5693.32 stddev:740.31 (13.0%) stddev-sans-first:719.29 21:23:48 INFO - PROCESS | 16530 | Values: 3088.2 3112.2 3114.5 3125.0 3146.9 5351.3 5369.9 5389.2 5445.2 5449.0 5398.5 5489.1 5506.3 5510.3 5570.7 4903.2 4939.1 5052.3 5066.7 5111.3 735.2 4915.9 5067.5 5111.9 5139.2 4993.7 5002.8 5013.3 5028.7 5049.5 4832.5 5028.3 5040.4 5042.9 5050.5 4854.0 4870.3 4871.5 4892.3 4913.3 5306.3 5335.5 5343.4 5367.8 5413.2 5693.3 5802.7 5804.7 5859.8 5860.4 5960.6 5993.7 5998.8 6000.5 6032.8 5583.3 5589.7 5592.7 5600.5 5605.6 5848.9 6008.2 6064.8 6074.4 6095.4 5828.8 5833.3 5839.4 5848.5 5861.5 5927.1 5940.1 5950.9 5954.8 5964.9 5604.6 5821.9 5862.4 5864.5 5905.6 5639.2 5768.9 5772.2 5778.4 5919.4 4419.3 4426.7 4433.4 4435.3 4461.7 3903.0 3957.3 3962.3 4002.5 4014.6 5716.5 5725.4 5727.9 5732.8 5739.0 5748.5 5959.4 6004.6 6031.0 6049.0 5548.5 5599.4 5603.0 5622.2 5642.2 5010.0 5081.9 5084.2 5089.7 5142.9 5930.9 6032.1 6088.6 6095.1 6117.7 5902.8 5979.3 5984.7 5998.9 6026.7 6121.2 6147.7 6158.4 6161.8 6170.4 5692.7 5779.2 5797.2 5857.1 5880.5 5934.0 5944.3 5954.7 5958.4 5973.1 5717.9 5732.7 5747.4 5785.1 5787.6 5498.6 5713.1 5717.2 5760.4 5791.5 5498.1 5503.3 5553.0 5577.9 5597.2 5702.2 5754.9 5764.1 5767.6 5843.9 5666.6 5668.6 5669.2 5670.3 5697.6 21:23:48 INFO - PROCESS | 16530 | 21:23:48 INFO - PROCESS | 16530 | [#1] ext.html Cycles:180 Average:62441.21 Median:41653.38 stddev:132574.96 (318.3%) stddev-sans-first:132865.43 21:23:48 INFO - PROCESS | 16530 | Values: 549.6 599.1 610.4 630.3 660.0 38181.0 42210.6 42310.4 42338.2 42386.8 44385.6 45156.0 45170.5 45181.8 45209.3 8740.7 8865.8 8907.6 8945.4 8976.2 8904.4 8991.6 8998.3 9011.1 9014.7 9014.8 9062.6 9067.4 9082.6 9084.6 8967.9 9021.6 9024.6 9032.2 9077.8 8862.3 8914.7 8923.4 8945.6 8973.0 40835.6 40909.6 41243.4 41314.2 41638.4 3629.8 3649.0 3702.7 3810.5 4188.2 32208.7 32737.7 33009.5 33084.8 33102.5 4211.8 4329.5 4339.7 4362.7 4398.9 329521.0 331774.0 332237.0 332856.0 334695.0 35085.8 35709.3 35772.8 59263.7 59571.7 37163.3 37193.1 37201.4 37267.3 37396.3 15398.4 15533.8 15534.0 15579.2 15626.5 13017.3 13024.3 13088.3 13098.0 13110.9 8256.2 8293.6 8363.3 8382.2 8420.5 3223.4 3249.9 3258.1 3260.0 3266.5 1032.9 1053.2 1069.2 1087.7 1145.1 31773.5 32140.5 32403.8 32851.7 32865.3 1125.8 1132.2 1137.5 1180.4 1228.3 16095.6 16727.7 16803.3 16855.2 17072.7 599376.0 608423.0 611103.0 612049.0 612929.0 57087.0 58377.7 58590.7 58861.4 58874.0 1352.3 1361.2 1370.5 1378.3 1410.7 30500.5 31932.2 32175.0 32268.0 32311.0 49474.3 49610.3 49782.8 49843.0 49893.5 505012.0 507800.0 508462.0 509301.0 512381.0 28227.3 28286.6 28357.3 28669.7 28711.4 47683.0 47824.8 48821.5 49136.0 50061.2 41409.0 42039.8 42525.4 42556.0 42783.6 41638.0 41668.4 41840.0 42036.4 42745.6 36688.3 41832.8 42143.0 42146.6 42495.8 36813.0 37463.8 37726.8 38059.0 38351.0 28518.2 28631.6 29015.6 29022.6 29028.3 21:23:48 INFO - PROCESS | 16530 | 21:23:48 INFO - PROCESS | 16530 | [#2] jquery.html Cycles:180 Average:27463.10 Median:23613.03 stddev:70887.03 (300.2%) stddev-sans-first:71056.72 21:23:48 INFO - PROCESS | 16530 | Values: 381.2 381.6 385.6 397.2 399.1 17403.9 20138.5 20196.0 20265.3 20319.7 18838.7 18903.4 19625.8 19655.0 19706.2 5615.4 5674.1 5781.1 5785.5 5910.5 3926.7 6163.6 6450.3 6462.7 6598.9 6318.6 6382.8 6524.9 6525.0 6526.7 6344.1 6360.7 6376.9 6404.0 6425.4 5489.4 5561.2 5576.0 5651.4 5659.6 22696.3 23221.8 23461.1 23522.4 23703.6 2444.8 2477.8 2490.8 2491.7 2711.4 9577.7 10209.9 14427.3 15038.1 15288.8 1623.2 1675.7 1858.1 1879.6 1911.9 86858.6 89874.6 90525.5 91504.5 92783.1 10746.5 10796.2 10898.7 10985.2 11479.7 14786.2 14959.6 14976.0 14977.4 14996.2 7501.7 7588.2 8058.6 8207.2 8223.0 7758.1 7831.5 7947.1 8065.3 8148.9 4105.8 4442.0 4652.9 4672.6 4828.8 1777.7 1854.2 1897.4 1905.3 1957.2 933.3 1029.0 1045.3 1076.1 1131.0 18947.9 19329.1 19619.5 19661.3 19689.6 1018.3 1065.6 1076.3 1076.8 1086.6 10601.4 11098.2 11133.7 11143.6 11233.5 383697.0 386167.0 391561.0 473986.4 487058.0 60392.0 86740.0 89167.0 92813.0 93263.5 1005.0 1041.5 1042.7 1052.5 1072.9 17692.1 17801.4 18258.5 18446.0 18578.5 42207.8 43002.0 43465.8 43784.3 44041.3 57844.4 58996.7 60129.7 60609.4 60749.4 8177.5 8319.7 8487.4 8594.0 8622.9 9415.6 12642.7 13083.3 13162.3 13329.4 11519.5 11538.9 11854.5 11979.6 12016.2 11425.1 11525.1 11729.6 11831.9 11943.4 11588.4 11987.8 12000.8 12038.7 12080.2 8547.5 8578.1 8583.0 8641.4 8670.1 10892.3 11537.9 11803.6 11836.9 11933.3 21:23:48 INFO - PROCESS | 16530 | 21:23:48 INFO - PROCESS | 16530 | [#3] mootools.html Cycles:180 Average:5750.43 Median:4609.96 stddev:3184.84 (69.1%) stddev-sans-first:3177.61 21:23:48 INFO - PROCESS | 16530 | Values: 1480.9 1516.6 1684.0 1800.2 1817.2 7705.5 8138.3 8368.1 8548.1 8561.8 8397.5 8671.5 8729.4 8739.0 8752.2 2347.8 2355.1 2356.8 2375.0 2379.4 2345.6 2360.0 2380.0 2380.9 2386.0 2373.7 2383.0 2391.2 2400.4 2409.0 2314.2 2355.3 2358.2 2366.1 2366.4 2252.7 2291.8 2302.4 2302.9 2306.2 8551.4 8621.0 8623.1 8624.7 8646.9 5196.5 5214.2 5343.3 5369.1 5400.9 3420.5 3421.1 3495.4 3518.7 3623.2 1163.7 1167.6 1177.6 1187.0 1191.4 11567.4 11660.4 11735.8 11769.6 11780.7 4332.7 4337.5 4454.3 4455.3 4525.3 9411.3 9417.9 9422.4 9439.3 9452.1 5229.1 5232.1 5261.6 5265.5 5266.6 4413.5 4694.6 4747.7 4794.0 4813.5 3759.0 3774.7 3857.9 3888.9 3920.9 1128.3 1166.3 1182.6 1185.8 1188.5 920.5 1033.6 1039.2 1050.1 1053.0 6061.6 6077.2 6138.2 6218.3 6482.7 967.2 976.3 988.5 1039.8 1047.6 4104.2 4288.6 4361.8 4419.2 4427.8 10621.9 10891.5 10952.3 10953.9 10981.8 10593.4 10647.1 10725.6 10860.7 10873.1 8064.2 8139.9 8172.4 8203.6 8242.4 6039.5 6069.8 6136.0 6161.9 6268.4 9889.4 10084.0 10147.2 10150.1 10178.0 10120.8 10199.4 10214.5 10267.4 10296.2 7234.5 7301.4 7333.7 7418.0 7437.5 8289.0 8298.5 8323.7 8365.4 8379.9 7468.7 7770.5 7775.1 7857.0 7902.3 7579.5 7672.5 7702.2 7728.1 7763.0 7009.1 7079.3 7177.1 7178.6 7196.0 5198.1 5221.2 5228.6 5233.2 5271.8 5267.4 5278.9 5307.3 5309.1 5438.9 21:23:48 INFO - PROCESS | 16530 | 21:23:48 INFO - PROCESS | 16530 | [#4] prototype.html Cycles:180 Average:4875.45 Median:5513.70 stddev:1460.98 (26.5%) stddev-sans-first:1424.65 21:23:48 INFO - PROCESS | 16530 | Values: 327.7 330.5 337.9 339.6 344.4 5501.2 5572.4 5578.2 5632.9 5657.6 5550.3 5571.7 5574.6 5624.5 5624.5 4373.4 4375.1 4380.1 4384.6 4404.3 4052.4 4265.9 4286.5 4393.9 4403.7 4216.3 4228.8 4233.5 4256.2 4264.0 4234.8 4236.7 4251.2 4252.5 4273.7 3549.4 3687.5 3697.8 3721.0 3730.5 5370.9 5392.6 5395.9 5423.6 5434.4 4905.2 4927.6 4941.2 4944.4 4953.6 5489.9 5802.9 5836.6 5842.3 5866.8 4102.7 4129.2 4130.0 4161.8 4165.4 6047.5 6059.4 6069.2 6101.5 6107.4 4035.2 4137.6 4144.6 4160.3 4187.3 4210.3 4224.2 4240.3 4251.7 4258.3 4883.5 4887.2 4887.5 4890.4 4892.7 5731.9 5873.9 5918.4 5926.9 5939.9 1461.3 1470.6 1471.8 1472.7 1472.8 877.0 904.2 914.9 915.4 924.8 5095.6 5110.6 5110.6 5208.7 5224.7 5217.0 5306.6 5313.9 5358.1 5358.2 5103.7 5112.6 5148.2 5332.5 5839.7 3212.4 3217.5 3231.5 3241.5 3246.8 6125.6 6221.9 6257.6 6273.0 6290.8 6146.1 6164.2 6180.5 6185.5 6188.3 6225.4 6230.9 6236.4 6259.4 6302.8 5834.3 6015.6 6046.0 6080.4 6119.8 5901.2 5989.3 6011.3 6025.6 6035.4 6027.4 6245.8 6253.7 6291.8 6349.2 4212.2 4222.7 4223.7 4237.2 4238.2 6030.8 6057.0 6069.2 6085.6 6136.3 5722.1 5851.7 5882.0 5896.7 5940.3 5815.3 5830.6 5888.7 5894.2 5921.3 5526.2 5728.5 5790.8 5796.9 5800.7 5902.9 5926.3 5938.6 5946.9 5953.8 5703.5 5713.0 5730.5 5770.6 5797.9 21:23:48 INFO - PROCESS | 16530 | 21:23:48 INFO - PROCESS | 16530 | [#5] yui.html Cycles:180 Average:16298.35 Median:4354.92 stddev:19424.26 (446.0%) stddev-sans-first:19443.73 21:23:48 INFO - PROCESS | 16530 | Values: 766.9 855.9 867.3 876.5 885.3 14982.6 15738.1 15883.8 15933.4 15934.4 14363.4 14412.9 14415.2 14422.9 14436.3 670.7 793.7 825.7 827.6 828.4 789.1 795.6 799.6 800.1 805.7 860.0 860.1 864.4 868.8 869.6 857.9 860.0 860.2 864.1 866.8 621.9 626.3 626.4 627.0 629.2 14334.8 14439.7 14475.5 14485.6 14516.3 14774.4 14929.6 14973.7 14977.7 15257.3 11972.9 12093.1 12117.9 12136.6 12669.5 3855.2 3882.9 4035.0 4075.0 4092.3 53833.5 61564.4 62229.4 62332.7 62406.7 11116.7 11264.2 11439.2 11767.6 11777.7 20316.8 20318.4 20318.5 20332.7 20334.3 8717.6 8756.5 8793.8 8880.3 8943.6 4848.9 4896.0 4923.0 4960.6 5003.3 3264.7 3362.6 3363.9 3368.1 3370.6 625.8 632.2 640.6 644.5 647.8 579.0 621.9 633.6 684.3 772.2 10314.3 10374.3 10408.8 10424.1 10548.9 684.2 765.5 785.8 805.1 810.0 4617.5 4732.6 4804.6 4814.6 4878.9 67744.7 69709.7 70071.6 70071.6 70085.6 54917.7 56082.0 63848.7 64181.0 66205.7 58634.0 59329.7 59698.0 59874.0 60858.0 9911.9 9987.4 9991.0 9996.8 10023.4 39026.8 39143.0 39214.2 39420.2 39686.6 47561.8 51330.2 52056.7 52375.5 53076.0 12626.4 12679.7 13024.7 13226.9 13363.8 13659.3 13758.2 13782.6 13790.4 13852.4 12575.4 12715.5 12718.7 12913.5 13370.9 12451.9 13287.9 13361.0 13813.5 14199.2 11855.3 12535.8 12578.2 12791.6 13167.6 10920.1 11053.6 11167.2 11260.7 11486.1 11675.9 11764.2 11912.5 12245.4 12376.4 21:23:48 INFO - PROCESS | 16530 | -------- Summary: end -------- 21:23:48 INFO - PROCESS | 16530 | 21:23:49 INFO - TEST-INFO | 16530: exit 0 21:23:49 INFO - TEST-OK | dromaeo_css | took 1110652ms 21:23:49 INFO - TEST-START | kraken 21:23:49 INFO - operating with platform_type : linux_ 21:23:49 INFO - Initialising browser for kraken test... 21:23:49 INFO - TEST-INFO | started process 16766 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO1xhjz/profile http://localhost:42173/getInfo.html) 21:23:53 INFO - PROCESS | 16766 | 21:23:53 INFO - PROCESS | 16766 | (process:16838): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:23:54 INFO - PROCESS | 16766 | __metrics Screen width/height:1600/1200 21:23:54 INFO - PROCESS | 16766 | colorDepth:24 21:23:54 INFO - PROCESS | 16766 | Browser inner width/height: 1024/697 21:23:54 INFO - PROCESS | 16766 | __metrics 21:23:54 ERROR - PROCESS | 16766 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 21:23:55 INFO - TEST-INFO | 16766: exit 0 21:23:55 INFO - Browser initialized. 21:23:55 INFO - Running cycle 1/1 for kraken test... 21:23:55 INFO - TEST-INFO | started process 16890 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO1xhjz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:23:57 INFO - PROCESS | 16890 | 21:23:57 INFO - PROCESS | 16890 | (process:16951): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:24:07 INFO - PROCESS | 16890 | RSS: Main: 165941248 21:24:07 INFO - PROCESS | 16890 | 21:24:10 INFO - PROCESS | 16890 | Cycle 1(1): loaded http://localhost:42173/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42173/tests/kraken/driver.html?testName=audio-beat-detection) 21:24:10 INFO - PROCESS | 16890 | RSS: Main: 170758144 21:24:10 INFO - PROCESS | 16890 | 21:24:13 INFO - PROCESS | 16890 | Cycle 1(1): loaded http://localhost:42173/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42173/tests/kraken/driver.html?testName=audio-dft) 21:24:14 INFO - PROCESS | 16890 | RSS: Main: 170967040 21:24:14 INFO - PROCESS | 16890 | 21:24:17 INFO - PROCESS | 16890 | Cycle 1(1): loaded http://localhost:42173/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42173/tests/kraken/driver.html?testName=audio-fft) 21:24:17 INFO - PROCESS | 16890 | RSS: Main: 165945344 21:24:17 INFO - PROCESS | 16890 | 21:24:19 INFO - PROCESS | 16890 | Cycle 1(1): loaded http://localhost:42173/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42173/tests/kraken/driver.html?testName=audio-oscillator) 21:24:20 INFO - PROCESS | 16890 | RSS: Main: 166182912 21:24:20 INFO - PROCESS | 16890 | 21:24:22 INFO - PROCESS | 16890 | Cycle 1(1): loaded http://localhost:42173/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42173/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:24:23 INFO - PROCESS | 16890 | RSS: Main: 166457344 21:24:23 INFO - PROCESS | 16890 | 21:24:26 INFO - PROCESS | 16890 | Cycle 1(1): loaded http://localhost:42173/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42173/tests/kraken/driver.html?testName=imaging-darkroom) 21:24:26 INFO - PROCESS | 16890 | RSS: Main: 166322176 21:24:26 INFO - PROCESS | 16890 | 21:24:30 INFO - PROCESS | 16890 | Cycle 1(1): loaded http://localhost:42173/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42173/tests/kraken/driver.html?testName=imaging-desaturate) 21:24:30 INFO - PROCESS | 16890 | RSS: Main: 166649856 21:24:30 INFO - PROCESS | 16890 | 21:24:33 INFO - PROCESS | 16890 | Cycle 1(1): loaded http://localhost:42173/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42173/tests/kraken/driver.html?testName=json-parse-financial) 21:24:34 INFO - PROCESS | 16890 | RSS: Main: 167374848 21:24:34 INFO - PROCESS | 16890 | 21:24:36 INFO - PROCESS | 16890 | Cycle 1(1): loaded http://localhost:42173/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42173/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:24:36 INFO - PROCESS | 16890 | RSS: Main: 166854656 21:24:36 INFO - PROCESS | 16890 | 21:24:38 INFO - PROCESS | 16890 | Cycle 1(1): loaded http://localhost:42173/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42173/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:24:39 INFO - PROCESS | 16890 | RSS: Main: 167141376 21:24:39 INFO - PROCESS | 16890 | 21:24:41 INFO - PROCESS | 16890 | Cycle 1(1): loaded http://localhost:42173/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42173/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:24:41 INFO - PROCESS | 16890 | RSS: Main: 167563264 21:24:41 INFO - PROCESS | 16890 | 21:24:44 INFO - PROCESS | 16890 | Cycle 1(1): loaded http://localhost:42173/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42173/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:24:45 INFO - PROCESS | 16890 | RSS: Main: 167862272 21:24:45 INFO - PROCESS | 16890 | 21:24:47 INFO - PROCESS | 16890 | Cycle 1(1): loaded http://localhost:42173/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42173/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:24:48 INFO - PROCESS | 16890 | RSS: Main: 167591936 21:24:48 INFO - PROCESS | 16890 | 21:24:50 INFO - PROCESS | 16890 | Cycle 1(1): loaded http://localhost:42173/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42173/tests/kraken/driver.html?testName=ai-astar) 21:24:50 INFO - PROCESS | 16890 | RSS: Main: 169054208 21:24:50 INFO - PROCESS | 16890 | 21:24:50 INFO - PROCESS | 16890 | __start_tp_report 21:24:50 INFO - PROCESS | 16890 | _x_x_mozilla_page_load 21:24:50 INFO - PROCESS | 16890 | _x_x_mozilla_page_load_details 21:24:50 INFO - PROCESS | 16890 | |i|pagename|runs| 21:24:50 INFO - PROCESS | 16890 | |0;ai-astar;111;104;111;110;112;110;111;111;111;111 21:24:50 INFO - PROCESS | 16890 | |1;audio-beat-detection;154;124;153;175;127;163;161;132;180;128 21:24:50 INFO - PROCESS | 16890 | |2;audio-dft;162;163;162;167;161;164;171;165;162;162 21:24:50 INFO - PROCESS | 16890 | |3;audio-fft;75;74;76;167;75;75;74;73;159;75 21:24:50 INFO - PROCESS | 16890 | |4;audio-oscillator;82;84;137;82;84;84;135;84;83;151 21:24:50 INFO - PROCESS | 16890 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;117;117;118 21:24:50 INFO - PROCESS | 16890 | |6;imaging-darkroom;145;146;147;147;146;148;147;146;146;147 21:24:50 INFO - PROCESS | 16890 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;95 21:24:50 INFO - PROCESS | 16890 | |8;json-parse-financial;56;55;57;54;58;54;56;83;52;53 21:24:50 INFO - PROCESS | 16890 | |9;json-stringify-tinderbox;63;68;63;63;63;64;63;63;64;63 21:24:50 INFO - PROCESS | 16890 | |10;stanford-crypto-aes;80;84;81;80;82;86;82;82;82;81 21:24:50 INFO - PROCESS | 16890 | |11;stanford-crypto-ccm;130;128;127;122;137;122;128;122;174;124 21:24:50 INFO - PROCESS | 16890 | |12;stanford-crypto-pbkdf2;166;158;159;164;163;160;163;163;162;161 21:24:50 INFO - PROCESS | 16890 | |13;stanford-crypto-sha256-iterative;67;63;66;63;65;65;65;61;68;61 21:24:50 INFO - PROCESS | 16890 | __end_tp_report 21:24:50 INFO - PROCESS | 16890 | __start_cc_report 21:24:50 INFO - PROCESS | 16890 | _x_x_mozilla_cycle_collect,867 21:24:50 INFO - PROCESS | 16890 | __end_cc_report 21:24:50 INFO - PROCESS | 16890 | __startTimestamp1464409490346__endTimestamp 21:24:50 INFO - PROCESS | 16890 | 21:24:50 INFO - PROCESS | 16890 | ------- Summary: start ------- 21:24:50 INFO - PROCESS | 16890 | Number of tests: 14 21:24:50 INFO - PROCESS | 16890 | 21:24:50 INFO - PROCESS | 16890 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.25 (2.0%) stddev-sans-first:2.37 21:24:50 INFO - PROCESS | 16890 | Values: 111.0 104.0 111.0 110.0 112.0 110.0 111.0 111.0 111.0 111.0 21:24:50 INFO - PROCESS | 16890 | 21:24:50 INFO - PROCESS | 16890 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:157.50 stddev:20.69 (13.1%) stddev-sans-first:21.88 21:24:50 INFO - PROCESS | 16890 | Values: 154.0 124.0 153.0 175.0 127.0 163.0 161.0 132.0 180.0 128.0 21:24:50 INFO - PROCESS | 16890 | 21:24:50 INFO - PROCESS | 16890 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:3.07 (1.9%) stddev-sans-first:3.18 21:24:50 INFO - PROCESS | 16890 | Values: 162.0 163.0 162.0 167.0 161.0 164.0 171.0 165.0 162.0 162.0 21:24:50 INFO - PROCESS | 16890 | 21:24:50 INFO - PROCESS | 16890 | [#3] audio-fft Cycles:10 Average:92.30 Median:75.00 stddev:37.32 (49.8%) stddev-sans-first:39.05 21:24:50 INFO - PROCESS | 16890 | Values: 75.0 74.0 76.0 167.0 75.0 75.0 74.0 73.0 159.0 75.0 21:24:50 INFO - PROCESS | 16890 | 21:24:50 INFO - PROCESS | 16890 | [#4] audio-oscillator Cycles:10 Average:100.60 Median:83.50 stddev:28.19 (33.8%) stddev-sans-first:29.09 21:24:50 INFO - PROCESS | 16890 | Values: 82.0 84.0 137.0 82.0 84.0 84.0 135.0 84.0 83.0 151.0 21:24:50 INFO - PROCESS | 16890 | 21:24:50 INFO - PROCESS | 16890 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 21:24:50 INFO - PROCESS | 16890 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 21:24:50 INFO - PROCESS | 16890 | 21:24:50 INFO - PROCESS | 16890 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.85 (0.6%) stddev-sans-first:0.71 21:24:50 INFO - PROCESS | 16890 | Values: 145.0 146.0 147.0 147.0 146.0 148.0 147.0 146.0 146.0 147.0 21:24:50 INFO - PROCESS | 16890 | 21:24:50 INFO - PROCESS | 16890 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 21:24:50 INFO - PROCESS | 16890 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 21:24:50 INFO - PROCESS | 16890 | 21:24:50 INFO - PROCESS | 16890 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:56.00 stddev:9.04 (16.1%) stddev-sans-first:9.57 21:24:50 INFO - PROCESS | 16890 | Values: 56.0 55.0 57.0 54.0 58.0 54.0 56.0 83.0 52.0 53.0 21:24:50 INFO - PROCESS | 16890 | 21:24:50 INFO - PROCESS | 16890 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:63.00 stddev:1.57 (2.5%) stddev-sans-first:1.64 21:24:50 INFO - PROCESS | 16890 | Values: 63.0 68.0 63.0 63.0 63.0 64.0 63.0 63.0 64.0 63.0 21:24:50 INFO - PROCESS | 16890 | 21:24:50 INFO - PROCESS | 16890 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:1.83 (2.2%) stddev-sans-first:1.79 21:24:50 INFO - PROCESS | 16890 | Values: 80.0 84.0 81.0 80.0 82.0 86.0 82.0 82.0 82.0 81.0 21:24:50 INFO - PROCESS | 16890 | 21:24:50 INFO - PROCESS | 16890 | [#11] stanford-crypto-ccm Cycles:10 Average:131.40 Median:128.00 stddev:15.67 (12.2%) stddev-sans-first:16.61 21:24:50 INFO - PROCESS | 16890 | Values: 130.0 128.0 127.0 122.0 137.0 122.0 128.0 122.0 174.0 124.0 21:24:50 INFO - PROCESS | 16890 | 21:24:50 INFO - PROCESS | 16890 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:163.00 stddev:2.42 (1.5%) stddev-sans-first:2.07 21:24:50 INFO - PROCESS | 16890 | Values: 166.0 158.0 159.0 164.0 163.0 160.0 163.0 163.0 162.0 161.0 21:24:50 INFO - PROCESS | 16890 | 21:24:50 INFO - PROCESS | 16890 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:65.00 stddev:2.37 (3.6%) stddev-sans-first:2.32 21:24:50 INFO - PROCESS | 16890 | Values: 67.0 63.0 66.0 63.0 65.0 65.0 65.0 61.0 68.0 61.0 21:24:50 INFO - PROCESS | 16890 | -------- Summary: end -------- 21:24:50 INFO - PROCESS | 16890 | 21:24:51 INFO - TEST-INFO | 16890: exit 0 21:24:51 INFO - TEST-OK | kraken | took 62314ms 21:24:51 INFO - SUITE-END | took 1172s 21:24:51 INFO - Completed test suite (00:19:33) 21:24:51 INFO - javascript benchmark 21:24:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7210.431884360122, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3088.2125058110178, 3112.1752735525106, 3114.501679731242, 3124.953125703114, 3146.8741250350004, 5351.25082488452, 5369.892602147955, 5389.24550562921, 5445.156000819869, 5449.0, 5398.541124004454, 5489.149181876805, 5506.256655351526, 5510.338759348884, 5570.6657600543995, 4903.239997800338, 4939.061578300111, 5052.317937078484, 5066.670666406671, 5111.335526381566, 735.1828226695787, 4915.9262611060685, 5067.467915868836, 5111.948880511184, 5139.15203991341, 4993.700377977315, 5002.824901128443, 5013.298138260629, 5028.748562571856, 5049.469805670388, 4832.492588278251, 5028.270900719412, 5040.445550989388, 5042.949570504321, 5050.520200580939, 4853.975730121362, 4870.318155458239, 4871.512848715136, 4892.315075889378, 4913.26301054841, 5306.283651707047, 5335.466453354672, 5343.412224655285, 5367.838964831061, 5413.188021796723, 5693.316801983747, 5802.65184088956, 5804.65172089676, 5859.7656093756195, 5860.355360910296, 5960.552958528127, 5993.670348130851, 5998.820035398945, 6000.519958403317, 6032.788852390189, 5583.274174357348, 5589.74846131925, 5592.720363981784, 5600.4959553640365, 5605.57958153136, 5848.883022339614, 6008.188894499274, 6064.757409703562, 6074.42292982166, 6095.420935011167, 5828.76684932598, 5833.300003999462, 5839.416058394211, 5848.502877255481, 5861.501772349398, 5927.140564618193, 5940.108983652487, 5950.9107363389585, 5954.761809527657, 5964.8807023860145, 5604.551635869121, 5821.941780582225, 5862.413758624189, 5864.47219750216, 5905.645661260338, 5639.210510528447, 5768.884622307531, 5772.2207501986695, 5778.422157784272, 5919.408059194132, 4419.270820314677, 4426.712263702913, 4433.379326894237, 4435.3125265583885, 4461.732296062247, 3903.0437542802197, 3957.3470377387985, 3962.3264045111823, 4002.4996875390575, 4014.598540145962, 5716.456936591017, 5725.3988331225455, 5727.914081288784, 5732.799352022743, 5738.971305143447, 5748.540116790647, 5959.433853783884, 6004.579679422486, 6030.969845150747, 6049.0, 5548.528375088163, 5599.412061733459, 5603.0, 5622.156676498558, 5642.238297829823, 5010.0, 5081.923771143436, 5084.161113416245, 5089.720065396439, 5142.87142821425, 5930.8813823723285, 6032.065029920369, 6088.6042407243385, 6095.085737139376, 6117.724702388403, 5902.793402230901, 5979.282486101695, 5984.730687119003, 5998.850028749316, 6026.668533230627, 6121.234845644294, 6147.692615369303, 6158.384161583985, 6161.815145545641, 6170.413810688157, 5692.715364231854, 5779.219805326227, 5797.246357973437, 5857.092150716646, 5880.470757631662, 5934.0, 5944.346121926498, 5954.702264886825, 5958.374370691015, 5973.1338955852025, 5717.914231286617, 5732.656040637575, 5747.36778954323, 5785.132230165509, 5787.623804452697, 5498.642588231752, 5713.114467257582, 5717.22817419643, 5760.423957604206, 5791.53667706574, 5498.147787093007, 5503.3395992481155, 5552.97223513896, 5577.860553486195, 5597.160425935979, 5702.173184888251, 5754.8849023018465, 5764.106563482667, 5767.596268261182, 5843.912341314799, 5666.603337766317, 5668.631538949955, 5669.177969194526, 5670.347909990404, 5697.57268204878], "value": 5387.046399581583, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.5521150262535, 599.0804115682429, 610.4140025575448, 630.2657404124199, 659.9538032337738, 38181.0, 42210.577894221045, 42310.36534451986, 42338.15323693524, 42386.788066059664, 44385.556144438546, 45156.0, 45170.548294517044, 45181.7740911295, 45209.321860172124, 8740.737777866674, 8865.778355541132, 8907.619319005564, 8945.373823832335, 8976.192142707156, 8904.376693631448, 8991.550422478882, 8998.280137588978, 9011.143941325563, 9014.729558113268, 9014.774630634254, 9062.637494500212, 9067.36528443006, 9082.59128339223, 9084.59119339628, 8967.910320896804, 9021.594028268679, 9024.639014439415, 9032.18710316068, 9077.773055673628, 8862.291016718647, 8914.732558023205, 8923.375363724543, 8945.64217431302, 8973.0, 40835.591644083775, 40909.590904090874, 41243.38134927949, 41314.1737165258, 41638.375424368656, 3629.818509074562, 3648.981755091234, 3702.7037836973245, 3810.5236845394325, 4188.162367526476, 32208.677913221036, 32737.672623273702, 33009.50485742716, 33084.834575826964, 33102.50346244808, 4211.831526738927, 4329.458817647794, 4339.674524410681, 4362.738235705868, 4398.8900277493, 329521.0, 331774.0, 332237.0, 332856.0, 334694.99999999756, 35085.82457087749, 35709.28581428357, 35772.82113589467, 59263.70368148132, 59571.70214148902, 37163.25673486569, 37193.070173245884, 37201.44197837035, 37267.25465490675, 37396.25207495835, 15398.384064637288, 15533.844661553467, 15534.0, 15579.221038948008, 15626.531204063896, 13017.284049377375, 13024.283664398548, 13088.345582721016, 13098.0, 13110.868891310965, 8256.174382561696, 8293.585320733939, 8363.330933525303, 8382.203690649378, 8420.4947703138, 3223.38755636433, 3249.8700051997657, 3258.120307516957, 3259.9674003259665, 3266.5426840242385, 1032.8915463876335, 1053.1837825685154, 1069.2141276162015, 1087.7389426537732, 1145.0667705819897, 31773.52339714906, 32140.517892231634, 32403.837980809945, 32851.67148328486, 32865.342693146005, 1125.8480105185859, 1132.1715429581332, 1137.5222406589253, 1180.4156942313439, 1228.3121451986915, 16095.597610059607, 16727.749083763752, 16803.327866885433, 16855.241514131892, 17072.743908841378, 599376.0, 608423.0, 611103.0, 612049.0, 612929.0, 57087.0, 58377.70811145917, 58590.70704646449, 58861.41138588645, 58874.0, 1352.3035636647135, 1361.1900918953404, 1370.4860677246033, 1378.2832926878168, 1410.661441254112, 30500.542491863085, 31932.201694957814, 32175.0, 32268.0, 32311.0, 49474.25788613246, 49610.25584616161, 49782.75108624434, 49843.0, 49893.501064988886, 505012.0, 507800.0, 508462.0, 509301.0, 512381.0, 28227.294317642223, 28286.57570136491, 28357.291067723472, 28669.713302866705, 28711.42577148487, 47683.0, 47824.760876195396, 48821.511784881695, 49136.0, 50061.24908126308, 41409.0, 42039.7898010508, 42525.36211956885, 42556.0, 42783.572164279205, 41638.0, 41668.37497437601, 41840.0, 42036.3694544576, 42745.57254427416, 36688.26623467569, 41832.79083604563, 42143.0, 42146.57853421426, 42495.78752106219, 36813.0, 37463.81268093642, 37726.811365942995, 38059.0, 38351.0, 28518.230102632115, 28631.570526442538, 29015.56476652894, 29022.564661529672, 29028.27429314284], "value": 19108.05197555751, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.2299155705477, 381.62044210180204, 385.60475512599584, 397.1560434077585, 399.12193175014977, 17403.912980435096, 20138.496537586532, 20196.0, 20265.290714825, 20319.695204571944, 18838.71741923872, 18903.432897013077, 19625.803741962576, 19655.0, 19706.21175152992, 5615.382307946123, 5674.063779476382, 5781.103928891029, 5785.508231800302, 5910.527157827385, 3926.7447615905016, 6163.568550201488, 6450.290468048511, 6462.741490340404, 6598.934010659904, 6318.589291696025, 6382.808515744535, 6524.93475065248, 6524.967375163142, 6526.6736663166885, 6344.111824344595, 6360.745570177188, 6376.936230637681, 6403.967980160116, 6425.357464253584, 5489.4236105209175, 5561.165825126223, 5575.972120139414, 5651.378348381675, 5659.5755318351285, 22696.319110426713, 23221.76778232213, 23461.13471632092, 23522.411939701473, 23703.644445333335, 2444.792192663626, 2477.826552141351, 2490.8256422050463, 2491.6636254105647, 2711.4034912319457, 9577.712668619952, 10209.89790102097, 14427.278636068155, 15038.097714137186, 15288.847111528854, 1623.2370785730807, 1675.656490419461, 1858.1359667754423, 1879.6146789908037, 1911.9197653325966, 86858.56570717169, 89874.55062724644, 90525.54737226338, 91504.54247728719, 92783.07216927812, 10746.462676866126, 10796.244262901679, 10898.727531811768, 10985.231033827715, 11479.655610331703, 14786.186759728103, 14959.551213463614, 14976.0, 14977.400903963937, 14996.175210363317, 7501.66242519088, 7588.241175882478, 8058.597070146469, 8207.179282071746, 8223.0, 7758.107817600935, 7831.490953088031, 7947.125816160218, 8065.274125328631, 8148.877766833502, 4105.835766569364, 4441.955580444154, 4652.930206046912, 4672.570263462981, 4828.758562071883, 1777.6533575952824, 1854.1656254685445, 1897.4497395755352, 1905.3236101184157, 1957.2366776956999, 933.2953620016843, 1029.0275689473376, 1045.3169799299183, 1076.1498416251075, 1130.9547618095185, 18947.90526047361, 19329.130189141524, 19619.509512262306, 19661.311854085037, 19689.60620787576, 1018.271935566059, 1065.5524679634573, 1076.2573824061374, 1076.838474228872, 1086.5708045322053, 10601.363918164934, 11098.223124381377, 11133.665990020312, 11143.554257829757, 11233.494492747846, 383697.0, 386167.0, 391561.0, 473986.4104756317, 487058.0, 60392.0, 86740.0, 89167.0, 92813.0, 93263.53368233115, 1004.9849252261222, 1041.4792603698152, 1042.7341028037802, 1052.5053224984244, 1072.9463526823627, 17692.11539422998, 17801.376951807142, 18258.45224643263, 18446.0, 18578.535536611693, 42207.788961055, 43002.0, 43465.78267108644, 43784.343234850865, 44041.339379909965, 57844.421555783905, 58996.70501647464, 60129.69935150296, 60609.39390606214, 60749.39250607437, 8177.4684645497855, 8319.667213311399, 8487.363447741567, 8594.0, 8622.870656940277, 9415.62337506492, 12642.747145057232, 13083.345832708135, 13162.341882906008, 13329.400176991865, 11519.53921843117, 11538.94230528842, 11854.466549005143, 11979.580714674945, 12016.218945768496, 11425.14311426663, 11525.135614829089, 11729.558807393674, 11831.881681183078, 11943.402829858645, 11588.362640054878, 11987.820182697093, 12000.759984800081, 12038.699032524257, 12080.154389192672, 8547.487150770974, 8578.099299573705, 8583.0, 8641.438306510308, 8670.089640587648, 10892.346459212473, 11537.942310288396, 11803.645890623295, 11836.881631183922, 11933.343666098448], "value": 9353.33960695808, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1480.88893333, 1516.5829396915851, 1684.0, 1800.216905646044, 1817.2095138614711, 7705.499142555744, 8138.308243799277, 8368.121347258526, 8548.102449242826, 8561.828763424735, 8397.49615023099, 8671.479711217316, 8729.432586881863, 8738.956305218466, 8752.212300892917, 2347.80043696286, 2355.0579768092816, 2356.7643235676464, 2375.049980008002, 2379.4051487128218, 2345.566070277004, 2359.976400235993, 2380.0360853854218, 2380.8928598213033, 2385.988070059656, 2373.6914201153913, 2383.0467812874904, 2391.246757271454, 2400.411899084727, 2409.0363854458183, 2314.2131675230335, 2355.2580937004786, 2358.209999650128, 2366.1245339224597, 2366.4438856868624, 2252.718410198725, 2291.7509957073266, 2302.4243939015246, 2302.873341966191, 2306.1582522379376, 8551.401401901869, 8620.956895215546, 8623.13768623139, 8624.698135565288, 8646.870296945488, 5196.506331898464, 5214.217867319932, 5343.251944727741, 5369.087255166631, 5400.945990540084, 3420.521127042216, 3421.1447138215444, 3495.353359628477, 3518.683318501347, 3623.202895363016, 1163.720707030315, 1167.6030149749126, 1177.5584155941522, 1186.952521899123, 1191.356667399603, 11567.363794991272, 11660.416979151008, 11735.765284694344, 11769.64691059261, 11780.705482362924, 4332.740035597874, 4337.479502459725, 4454.309582014793, 4455.287154055401, 4525.298578720303, 9411.341206115507, 9417.858732119024, 9422.434653920787, 9439.292053096045, 9452.149306562442, 5229.111051121318, 5232.110541208004, 5261.552768014762, 5265.52610265078, 5266.578673706171, 4413.536578659195, 4694.624430045588, 4747.715137091785, 4793.976030119827, 4813.470518242991, 3759.0, 3774.7168962327937, 3857.9035524112123, 3888.902777430587, 3920.941185882214, 1128.306091753582, 1166.311875993168, 1182.645206438065, 1185.7984142695761, 1188.5127097889824, 920.4891285336703, 1033.6278939581744, 1039.2465462539749, 1050.075933178813, 1052.9894701052892, 6061.605995610359, 6077.24034495688, 6138.171346868205, 6218.253809542884, 6482.67586620667, 967.1827305926481, 976.2531663277598, 988.461288597716, 1039.750459889621, 1047.5914393386586, 4104.179164167179, 4288.635465985426, 4361.760103194291, 4419.248727716296, 4427.800748966304, 10621.946890265499, 10891.455427228608, 10952.288101273392, 10953.890461095287, 10981.780364392667, 10593.410988351654, 10647.14822814173, 10725.624603138853, 10860.72848178786, 10873.130149588014, 8064.193580641889, 8139.918600814034, 8172.387070969582, 8203.58982050895, 8242.381821363302, 6039.486643635164, 6069.817905462844, 6136.018237082046, 6161.876762464815, 6268.404501572343, 9889.357191782512, 10084.0, 10147.18822494184, 10150.086492215441, 10178.033086856736, 10120.797584048425, 10199.439030853375, 10214.489275536342, 10267.435291059064, 10296.17630589536, 7234.493585448968, 7301.415886729155, 7333.669984850588, 7418.0, 7437.479376443597, 8289.0, 8298.460600061218, 8323.6670533178, 8365.36875309309, 8379.916200837913, 7468.663910123949, 7770.494917830323, 7775.105862825847, 7856.960715196387, 7902.328302094386, 7579.5073320234005, 7672.5012874163, 7702.229777022477, 7728.072631284057, 7762.961185194264, 7009.088818453569, 7079.327463890922, 7177.138743350832, 7178.5692858428665, 7196.0285361475535, 5198.116320225495, 5221.216817477409, 5228.581713462838, 5233.215017747216, 5271.841844744664, 5267.394249661338, 5278.920816187837, 5307.310049693515, 5309.070912590204, 5438.918416223839], "value": 4647.252040139298, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.6919695486244, 330.4959936097451, 337.9290349026705, 339.57213910472814, 344.3663658867683, 5501.229827824108, 5572.359178694452, 5578.191162281471, 5632.943670563298, 5657.603967722261, 5550.2507161533185, 5571.693556854381, 5574.57848248696, 5624.493795558399, 5624.521915637166, 4373.38184871598, 4375.0812329410865, 4380.145871555048, 4384.561543845622, 4404.251277282861, 4052.3921411788174, 4265.914681706364, 4286.464191976003, 4393.934090988621, 4403.691741578091, 4216.304309788881, 4228.809703563347, 4233.534311225778, 4256.21260066887, 4263.957360426387, 4234.788260586989, 4236.724612900167, 4251.213525497793, 4252.532221455637, 4273.7008409411355, 3549.432090865449, 3687.502187204747, 3697.7781333120097, 3720.962790372089, 3730.496382988289, 5370.91943620846, 5392.649477783971, 5395.870395170791, 5423.647462914898, 5434.429384914567, 4905.23968784839, 4927.556519913225, 4941.160002799533, 4944.431390390115, 4953.628477864175, 5489.945100549024, 5802.883942321172, 5836.649801011953, 5842.328132264802, 5866.794662186803, 4102.651274641659, 4129.174165166979, 4129.97935010326, 4161.83352665893, 4165.437665915093, 6047.518358002274, 6059.363766804466, 6069.15031895535, 6101.450869421773, 6107.358727333655, 4035.2333056719717, 4137.606927341898, 4144.647704945053, 4160.335865653763, 4187.267228235047, 4210.2842516772225, 4224.2185195738275, 4240.321548552217, 4251.744895306291, 4258.339957306623, 4883.536064073907, 4887.169181239198, 4887.535684110004, 4890.437599676012, 4892.651527266932, 5731.885362292731, 5873.941260587425, 5918.408159184047, 5926.895951937, 5939.851503712442, 1461.2693653173412, 1470.5514817980404, 1471.8446019874348, 1472.749632562467, 1472.8158980127484, 876.9649214031367, 904.2404380320562, 914.8719179314901, 915.4187091197138, 924.824283386168, 5095.566876815512, 5110.642255042111, 5110.642255042186, 5208.739563021833, 5224.660397074254, 5217.0, 5306.575473962073, 5313.937212557426, 5358.115910874662, 5358.223057656618, 5103.7192954387865, 5112.616553758483, 5148.172398798448, 5332.466753324714, 5839.737211825478, 3212.437823380899, 3217.501287300472, 3231.4829627259523, 3241.5299781531544, 3246.8376581170846, 6125.571210015256, 6221.9377806222265, 6257.624542527372, 6273.0, 6290.811275661737, 6146.078088286793, 6164.229471316085, 6180.505559555225, 6185.536084793568, 6188.2883468400805, 6225.439710426083, 6230.875382492415, 6236.445226221101, 6259.372563133618, 6302.8424289392215, 5834.27071616048, 6015.639061656315, 6045.969770151121, 6080.361562035922, 6119.816405507842, 5901.167439628916, 5989.341172470938, 6011.308699499614, 6025.6083354581815, 6035.36628653985, 6027.427394397525, 6245.812625621239, 6253.6861361296615, 6291.842703932438, 6349.238091429058, 4212.178625168062, 4222.704410691345, 4223.72545784523, 4237.237297286518, 4238.237117318912, 6030.819075427744, 6057.0, 6069.2110025696375, 6085.574009819447, 6136.32500424944, 5722.141678748221, 5851.736671849691, 5881.970590147193, 5896.734646940812, 5940.346561878104, 5815.331236907809, 5830.62100963436, 5888.705564721832, 5894.233749612523, 5921.259842519685, 5526.171074338881, 5728.484436400744, 5790.826275211751, 5796.94203057964, 5800.694843660142, 5902.881942361043, 5926.273913999608, 5938.6436813791315, 5946.859130713026, 5953.821385358447, 5703.515201207943, 5712.971435142797, 5730.541556675539, 5770.596058276048, 5797.942020579909], "value": 4402.074308007749, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.865798485265, 855.9486430814152, 867.3104881619112, 876.4784952952995, 885.3094586222749, 14982.625434364132, 15738.055716656994, 15883.761743573856, 15933.442329518455, 15934.442294519695, 14363.425462981468, 14412.927935360334, 14415.207163605997, 14422.92788536056, 14436.27818609068, 670.7149461478876, 793.7420338390017, 825.6532256452274, 827.5655280977475, 828.4408024583412, 789.0925435748877, 795.610151025996, 799.5522507395877, 800.0918956983807, 805.7099444200113, 860.0195776814437, 860.0754189246554, 864.412199704204, 868.7828042989253, 869.5782545465444, 857.9013413457438, 860.0324634785866, 860.1828263150032, 864.1401805203831, 866.8093019535723, 621.9409156130206, 626.3329554024949, 626.4236902050079, 627.0343670747089, 629.1694962649304, 14334.784978225334, 14439.711205775826, 14475.493357732534, 14485.56543303692, 14516.27418629075, 14774.409023639042, 14929.626759330995, 14973.700525989529, 14977.700445991128, 15257.313420896086, 11972.880271197264, 12093.093018023683, 12117.939410302892, 12136.57521986735, 12669.493220271179, 3855.2096820152083, 3882.864099756523, 4035.031592417828, 4075.0219947212754, 4092.324766413568, 53833.46166538363, 61564.38435615631, 62229.37770622326, 62332.68833655848, 62406.687966560334, 11116.666500005012, 11264.155188360906, 11439.199256051996, 11767.588134415426, 11777.695988222378, 20316.796832031785, 20318.390448286576, 20318.492037699176, 20332.69500957487, 20334.288299909433, 8717.607707653171, 8756.474611523328, 8793.824123517494, 8880.333974951904, 8943.597538110671, 4848.878778030577, 4895.975520122448, 4922.975385123052, 4960.553550180501, 5003.2995380646735, 3264.6735326467638, 3362.596488421405, 3363.9327213455595, 3368.14112401341, 3370.646082161387, 625.7872323410062, 632.2318383164477, 640.5932233031965, 644.4940721533667, 647.779754883342, 578.9884202316015, 621.9160413344141, 633.566007285002, 684.2849222562435, 772.2007722007695, 10314.27800053989, 10374.27380083387, 10408.791824163474, 10424.113950314308, 10548.894511054945, 684.1653183116689, 765.5215490318551, 785.7956931197815, 805.1143741883881, 810.0481933727846, 4617.515160908123, 4732.594041319656, 4804.567588917014, 4814.566688998007, 4878.853634390974, 67744.6612766933, 69709.65145174242, 70071.64964175147, 70071.64964175147, 70085.64957175283, 54917.72541137349, 56082.0, 63848.68075659592, 64181.0, 66205.66897165483, 58634.0, 59329.70335148297, 59698.0, 59874.0, 60858.0, 9911.851322230317, 9987.434680282327, 9990.950045249727, 9996.800063998533, 10023.448710321003, 39026.804865975486, 39143.02142446462, 39214.21571568496, 39420.211595768495, 39686.60313396829, 47561.76219118882, 51330.23004654858, 52056.73971630118, 52375.47624523706, 53076.0, 12626.36868156607, 12679.683007924876, 13024.674383140497, 13226.933865330611, 13363.799543007057, 13659.317034148451, 13758.243296618783, 13782.586522404345, 13790.357103746239, 13852.376643050886, 12575.353147587097, 12715.491380344683, 12718.682032949251, 12913.548025819051, 13370.866291336963, 12451.875481245072, 13287.867121329049, 13361.0, 13813.51652692151, 14199.219042952736, 11855.34795586251, 12535.811962820748, 12578.245305281713, 12791.616251512469, 13167.60497185086, 10920.126389888948, 11053.557857685602, 11167.162462815159, 11260.718482038015, 11486.081113510732, 11675.941620291844, 11764.176507644725, 11912.523499060288, 12245.387730613611, 12376.443060062498], "value": 7134.094828803832, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 111.0, 110.0, 112.0, 110.0, 111.0, 111.0, 111.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 124.0, 153.0, 175.0, 127.0, 163.0, 161.0, 132.0, 180.0, 128.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 167.0, 161.0, 164.0, 171.0, 165.0, 162.0, 162.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 167.0, 75.0, 75.0, 74.0, 73.0, 159.0, 75.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 137.0, 82.0, 84.0, 84.0, 135.0, 84.0, 83.0, 151.0], "value": 100.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 147.0, 146.0, 148.0, 147.0, 146.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 57.0, 54.0, 58.0, 54.0, 56.0, 83.0, 52.0, 53.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 68.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 64.0, 63.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 81.0, 80.0, 82.0, 86.0, 82.0, 82.0, 82.0, 81.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 128.0, 127.0, 122.0, 137.0, 122.0, 128.0, 122.0, 174.0, 124.0], "value": 131.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 158.0, 159.0, 164.0, 163.0, 160.0, 163.0, 163.0, 162.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 66.0, 63.0, 65.0, 65.0, 65.0, 61.0, 68.0, 61.0], "value": 64.4, "unit": "score"}]}]} 21:24:51 INFO - Return code: 0 21:24:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:24:51 ERROR - # TBPL SUCCESS # 21:24:51 INFO - Running post-action listener: _resource_record_post_action 21:24:51 INFO - ##### 21:24:51 INFO - ##### Finished run-tests step (success) 21:24:51 INFO - ##### 21:24:51 INFO - Running post-run listener: _resource_record_post_run 21:24:51 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538017792; Read time: 12; Write time: 445068 21:24:51 INFO - TinderboxPrint: CPU usage
13.5% 21:24:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 21:24:51 INFO - TinderboxPrint: I/O write bytes / time
538,017,792 / 445,068 21:24:51 INFO - TinderboxPrint: CPU idle
8,221.3 (86.5%) 21:24:51 INFO - TinderboxPrint: CPU user
1,223.8 (12.9%) 21:24:51 INFO - TinderboxPrint: Swap in / out
0 / 0 21:24:51 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247373824; Read time: 0; Write time: 241756 21:24:51 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290643968; Read time: 12; Write time: 203312 21:24:52 INFO - Running post-run listener: _upload_blobber_files 21:24:52 INFO - Blob upload gear active. 21:24:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:24:52 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 21:24:52 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', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:24:52 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 Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:24:52 INFO - (blobuploader) - INFO - Open directory for files ... 21:24:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:24:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:24:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:24:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:24:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:24:53 INFO - (blobuploader) - INFO - Done attempting. 21:24:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:24:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:24:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:24:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:24:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:24:58 INFO - (blobuploader) - INFO - Done attempting. 21:24:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:24:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:24:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:24:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:24:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:24:59 INFO - (blobuploader) - INFO - Done attempting. 21:24:59 INFO - (blobuploader) - INFO - Iteration through files over. 21:24:59 INFO - Return code: 0 21:24:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:24:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:24:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/8fdf8a7215daa58f73831a3c8ae99306a1ff97e5b87bb0dd279baff104bd8da8cd730ec33f4e56a6fdfd965a47db032089b89172ee606ea20ea8365cb8567dc0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/f7f4b7b3382f8187887d9f5948135ef5a16232f399be1507b6a44f1a252b8157b1c0ddb349729c0acb7a08f7768fbfe5fc109081ed73f023a0bc5854d2c19c03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/7e751572c0ac620d8f6b1815bfbb49996d17183b9dd78f9de1a3052b1d0d0cadecc4ce51275fb883c1b75635d3bbc7e7b0ba3029c3d6743a41d61c1d8f315e8f"} 21:24:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:24:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:24:59 INFO - Contents: 21:24:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/8fdf8a7215daa58f73831a3c8ae99306a1ff97e5b87bb0dd279baff104bd8da8cd730ec33f4e56a6fdfd965a47db032089b89172ee606ea20ea8365cb8567dc0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/f7f4b7b3382f8187887d9f5948135ef5a16232f399be1507b6a44f1a252b8157b1c0ddb349729c0acb7a08f7768fbfe5fc109081ed73f023a0bc5854d2c19c03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/7e751572c0ac620d8f6b1815bfbb49996d17183b9dd78f9de1a3052b1d0d0cadecc4ce51275fb883c1b75635d3bbc7e7b0ba3029c3d6743a41d61c1d8f315e8f"} 21:24:59 INFO - Running post-run listener: copy_logs_to_upload_dir 21:24:59 INFO - Copying logs to upload dir... 21:24:59 INFO - mkdir: /builds/slave/test/build/upload/logs 21:24:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.817698 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-27 21:24:59.074447) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 21:24:59.079975) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850 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/Larch/sha512/8fdf8a7215daa58f73831a3c8ae99306a1ff97e5b87bb0dd279baff104bd8da8cd730ec33f4e56a6fdfd965a47db032089b89172ee606ea20ea8365cb8567dc0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/f7f4b7b3382f8187887d9f5948135ef5a16232f399be1507b6a44f1a252b8157b1c0ddb349729c0acb7a08f7768fbfe5fc109081ed73f023a0bc5854d2c19c03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/7e751572c0ac620d8f6b1815bfbb49996d17183b9dd78f9de1a3052b1d0d0cadecc4ce51275fb883c1b75635d3bbc7e7b0ba3029c3d6743a41d61c1d8f315e8f"} build_url:https://queue.taskcluster.net/v1/task/D5gSrQTDT427sXIo4JJOaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011329 build_url: 'https://queue.taskcluster.net/v1/task/D5gSrQTDT427sXIo4JJOaw/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/Larch/sha512/8fdf8a7215daa58f73831a3c8ae99306a1ff97e5b87bb0dd279baff104bd8da8cd730ec33f4e56a6fdfd965a47db032089b89172ee606ea20ea8365cb8567dc0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/f7f4b7b3382f8187887d9f5948135ef5a16232f399be1507b6a44f1a252b8157b1c0ddb349729c0acb7a08f7768fbfe5fc109081ed73f023a0bc5854d2c19c03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/7e751572c0ac620d8f6b1815bfbb49996d17183b9dd78f9de1a3052b1d0d0cadecc4ce51275fb883c1b75635d3bbc7e7b0ba3029c3d6743a41d61c1d8f315e8f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 21:24:59.105424) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 21:24:59.105773) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1464407994.927976-1780349850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 21:24:59.187515) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 21:24:59.188031) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 21:24:59.188354) ========= ========= Total master_lag: 0.14 =========