builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1463576738.47 results: success (0) buildid: 20160518030234 builduid: f769d09b003647779edb2f3bf3073c37 revision: f3f2fa1d7eed5a8262f6401ef18ff8117a3ce43e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 06:05:38.465936) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 06:05:38.466417) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 06:05:38.466715) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 06:05:38.507765) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 06:05:38.508156) ========= 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=31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-18 06:05:38-- 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% 226M=0s 2016-05-18 06:05:38 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.152055 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 06:05:38.695630) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 06:05:38.696022) ========= 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=31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.081714 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 06:05:38.789463) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 06:05:38.789840) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f3f2fa1d7eed5a8262f6401ef18ff8117a3ce43e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f3f2fa1d7eed5a8262f6401ef18ff8117a3ce43e --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=31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-18 06:05:38,786 truncating revision to first 12 chars 2016-05-18 06:05:38,786 Setting DEBUG logging. 2016-05-18 06:05:38,786 attempt 1/10 2016-05-18 06:05:38,786 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f3f2fa1d7eed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-18 06:05:39,061 unpacking tar archive at: mozilla-central-f3f2fa1d7eed/testing/mozharness/ program finished with exit code 0 elapsedTime=0.597215 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 06:05:39.399704) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 06:05:39.400051) ========= script_repo_revision: f3f2fa1d7eed5a8262f6401ef18ff8117a3ce43e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 06:05:39.400497) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 06:05:39.400767) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 06:05:39.410422) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-05-18 06:05:39.410832) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:05:39 INFO - MultiFileLogger online at 20160518 06:05:39 in /builds/slave/test 06:05:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:05:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:05:39 INFO - {'append_to_log': False, 06:05:39 INFO - 'base_work_dir': '/builds/slave/test', 06:05:39 INFO - 'blob_upload_branch': 'Firefox', 06:05:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:05:39 INFO - 'branch': 'Firefox', 06:05:39 INFO - 'buildbot_json_path': 'buildprops.json', 06:05:39 INFO - 'config_files': ('talos/linux_config.py',), 06:05:39 INFO - 'default_actions': ('clobber', 06:05:39 INFO - 'read-buildbot-config', 06:05:39 INFO - 'download-and-extract', 06:05:39 INFO - 'populate-webroot', 06:05:39 INFO - 'create-virtualenv', 06:05:39 INFO - 'install', 06:05:39 INFO - 'run-tests'), 06:05:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:05:39 INFO - 'download_minidump_stackwalk': True, 06:05:39 INFO - 'download_symbols': 'ondemand', 06:05:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:05:39 INFO - 'tooltool.py': '/tools/tooltool.py', 06:05:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:05:39 INFO - '/tools/misc-python/virtualenv.py')}, 06:05:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:05:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:05:39 INFO - 'installer_path': 'installer.exe', 06:05:39 INFO - 'log_level': 'info', 06:05:39 INFO - 'log_name': 'talos', 06:05:39 INFO - 'log_to_console': True, 06:05:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:05:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:05:39 INFO - 'opt_config_files': (), 06:05:39 INFO - 'pip_index': False, 06:05:39 INFO - 'sps_profile': False, 06:05:39 INFO - 'sps_profile_interval': 0, 06:05:39 INFO - 'suite': 'dromaeojs', 06:05:39 INFO - 'system_bits': '32', 06:05:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:05:39 INFO - 'title': 'talos-linux64-ix-014', 06:05:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:05:39 INFO - 'use_talos_json': True, 06:05:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:05:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:05:39 INFO - 'work_dir': 'build'} 06:05:39 INFO - ##### 06:05:39 INFO - ##### Running clobber step. 06:05:39 INFO - ##### 06:05:39 INFO - Running pre-action listener: _resource_record_pre_action 06:05:39 INFO - Running main action method: clobber 06:05:39 INFO - rmtree: /builds/slave/test/build 06:05:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:05:41 INFO - Running post-action listener: _resource_record_post_action 06:05:41 INFO - ##### 06:05:41 INFO - ##### Finished clobber step (success) 06:05:41 INFO - ##### 06:05:41 INFO - ##### 06:05:41 INFO - ##### Running read-buildbot-config step. 06:05:41 INFO - ##### 06:05:41 INFO - Running pre-action listener: _resource_record_pre_action 06:05:41 INFO - Running main action method: read_buildbot_config 06:05:41 INFO - Using buildbot properties: 06:05:41 INFO - { 06:05:41 INFO - "project": "", 06:05:41 INFO - "product": "firefox", 06:05:41 INFO - "script_repo_revision": "production", 06:05:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:05:41 INFO - "repository": "", 06:05:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:05:41 INFO - "buildid": "20160518030234", 06:05:41 INFO - "stage_platform": "linux64-pgo", 06:05:41 INFO - "basedir": "/builds/slave/test", 06:05:41 INFO - "nightly_build": "True", 06:05:41 INFO - "buildnumber": 445, 06:05:41 INFO - "slavename": "talos-linux64-ix-014", 06:05:41 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:05:41 INFO - "platform": "ubuntu64_hw", 06:05:41 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:05:41 INFO - "branch": "mozilla-central", 06:05:41 INFO - "repo_path": "mozilla-central", 06:05:41 INFO - "revision": "f3f2fa1d7eed5a8262f6401ef18ff8117a3ce43e", 06:05:41 INFO - "pgo_build": "True", 06:05:41 INFO - "builduid": "f769d09b003647779edb2f3bf3073c37", 06:05:41 INFO - "slavebuilddir": "test" 06:05:41 INFO - } 06:05:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/T0UFJSF6T52cwSuOBNS8vQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:05:41 INFO - Running post-action listener: _resource_record_post_action 06:05:41 INFO - ##### 06:05:41 INFO - ##### Finished read-buildbot-config step (success) 06:05:41 INFO - ##### 06:05:41 INFO - ##### 06:05:41 INFO - ##### Running download-and-extract step. 06:05:41 INFO - ##### 06:05:41 INFO - Running pre-action listener: _resource_record_pre_action 06:05:41 INFO - Running main action method: download_and_extract 06:05:41 INFO - mkdir: /builds/slave/test/build/tests 06:05: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')]} 06:05:41 INFO - https://queue.taskcluster.net/v1/task/T0UFJSF6T52cwSuOBNS8vQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:05:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0UFJSF6T52cwSuOBNS8vQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:05:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0UFJSF6T52cwSuOBNS8vQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:05:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0UFJSF6T52cwSuOBNS8vQ/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 06:05:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0UFJSF6T52cwSuOBNS8vQ/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 06:05:43 INFO - Downloaded 1361 bytes. 06:05:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:05:43 INFO - Using the following test package requirements: 06:05:43 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:05:43 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:05:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:05:43 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:05:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:05:43 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:05:43 INFO - u'jsshell-linux-x86_64.zip'], 06:05:43 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:05:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:05:43 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:05:43 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:05:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:05:43 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:05:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:05:43 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:05:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:05:43 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:05:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:05:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:05: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')]} 06:05:43 INFO - https://queue.taskcluster.net/v1/task/T0UFJSF6T52cwSuOBNS8vQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:05:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0UFJSF6T52cwSuOBNS8vQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:05:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0UFJSF6T52cwSuOBNS8vQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:05:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0UFJSF6T52cwSuOBNS8vQ/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 06:05:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0UFJSF6T52cwSuOBNS8vQ/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 06:05:54 INFO - Downloaded 24024743 bytes. 06:05:54 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'] 06:05:54 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 06:05:56 INFO - Return code: 0 06:05:56 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 06:05:56 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')]} 06:05:56 INFO - https://queue.taskcluster.net/v1/task/T0UFJSF6T52cwSuOBNS8vQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:05:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0UFJSF6T52cwSuOBNS8vQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:05:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0UFJSF6T52cwSuOBNS8vQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:05:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0UFJSF6T52cwSuOBNS8vQ/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 06:05:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0UFJSF6T52cwSuOBNS8vQ/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 06:05:58 INFO - Downloaded 24024743 bytes. 06:05:58 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'] 06:05:58 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 06:06:00 INFO - Return code: 0 06:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:06:00 INFO - https://queue.taskcluster.net/v1/task/T0UFJSF6T52cwSuOBNS8vQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:06:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0UFJSF6T52cwSuOBNS8vQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:06:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0UFJSF6T52cwSuOBNS8vQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:06:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0UFJSF6T52cwSuOBNS8vQ/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 06:06:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0UFJSF6T52cwSuOBNS8vQ/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 06:06:01 INFO - Downloaded 10840194 bytes. 06:06:01 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'] 06:06:01 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 06:06:01 INFO - Return code: 0 06:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:06:01 INFO - https://queue.taskcluster.net/v1/task/T0UFJSF6T52cwSuOBNS8vQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:06:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0UFJSF6T52cwSuOBNS8vQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:06:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0UFJSF6T52cwSuOBNS8vQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:06:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0UFJSF6T52cwSuOBNS8vQ/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 06:06:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0UFJSF6T52cwSuOBNS8vQ/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 06:06:02 INFO - Downloaded 58416892 bytes. 06:06:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T0UFJSF6T52cwSuOBNS8vQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:06:02 INFO - mkdir: /builds/slave/test/properties 06:06:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:06:02 INFO - Writing to file /builds/slave/test/properties/build_url 06:06:02 INFO - Contents: 06:06:02 INFO - build_url:https://queue.taskcluster.net/v1/task/T0UFJSF6T52cwSuOBNS8vQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:06:03 INFO - Running post-action listener: _resource_record_post_action 06:06:03 INFO - Running post-action listener: set_extra_try_arguments 06:06:03 INFO - ##### 06:06:03 INFO - ##### Finished download-and-extract step (success) 06:06:03 INFO - ##### 06:06:03 INFO - ##### 06:06:03 INFO - ##### Running populate-webroot step. 06:06:03 INFO - ##### 06:06:03 INFO - Running pre-action listener: _resource_record_pre_action 06:06:03 INFO - Running main action method: populate_webroot 06:06:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:06:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:06:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:06:03 INFO - '--tppagecycles', 06:06:03 INFO - '7'], 06:06:03 INFO - 'tests': ['tsvgm']}}, 06:06:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:06:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:06:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:06:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:06:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:06:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:06:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:06:03 INFO - 'talos_options': ['--disable-e10s'], 06:06:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:06:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:06:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:06:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:06:03 INFO - 'talos_options': ['--disable-e10s'], 06:06:03 INFO - 'tests': ['damp', 'tps']}, 06:06:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:06:03 INFO - 'tests': ['damp', 'tps']}, 06:06:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:06:03 INFO - 'tests': ['dromaeo_dom']}, 06:06:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:06:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:06:03 INFO - 'tests': ['a11yr', 06:06:03 INFO - 'ts_paint', 06:06:03 INFO - 'tpaint', 06:06:03 INFO - 'sessionrestore', 06:06:03 INFO - 'sessionrestore_no_auto_restore', 06:06:03 INFO - 'tabpaint']}, 06:06:03 INFO - 'other-e10s': {'tests': ['a11yr', 06:06:03 INFO - 'ts_paint', 06:06:03 INFO - 'tpaint', 06:06:03 INFO - 'sessionrestore', 06:06:03 INFO - 'sessionrestore_no_auto_restore', 06:06:03 INFO - 'tabpaint']}, 06:06:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:06:03 INFO - 'ts_paint', 06:06:03 INFO - 'tpaint', 06:06:03 INFO - 'sessionrestore', 06:06:03 INFO - 'sessionrestore_no_auto_restore', 06:06:03 INFO - 'tabpaint']}, 06:06:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:06:03 INFO - 'ts_paint', 06:06:03 INFO - 'tpaint', 06:06:03 INFO - 'sessionrestore', 06:06:03 INFO - 'sessionrestore_no_auto_restore', 06:06:03 INFO - 'tabpaint']}, 06:06:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:06:03 INFO - 'tests': ['a11yr', 06:06:03 INFO - 'ts_paint', 06:06:03 INFO - 'tpaint', 06:06:03 INFO - 'sessionrestore', 06:06:03 INFO - 'sessionrestore_no_auto_restore', 06:06:03 INFO - 'tabpaint']}, 06:06:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:06:03 INFO - 'tests': ['a11yr', 06:06:03 INFO - 'ts_paint', 06:06:03 INFO - 'tpaint', 06:06:03 INFO - 'sessionrestore', 06:06:03 INFO - 'sessionrestore_no_auto_restore', 06:06:03 INFO - 'tabpaint']}, 06:06:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:06:03 INFO - 'tests': ['tsvgx', 06:06:03 INFO - 'tsvgr_opacity', 06:06:03 INFO - 'tart', 06:06:03 INFO - 'tscrollx', 06:06:03 INFO - 'cart']}, 06:06:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:06:03 INFO - 'tsvgr_opacity', 06:06:03 INFO - 'tart', 06:06:03 INFO - 'tscrollx', 06:06:03 INFO - 'cart']}, 06:06:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:06:03 INFO - 'talos_options': ['--disable-e10s'], 06:06:03 INFO - 'tests': ['tp5o']}, 06:06:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:06:03 INFO - 'tests': ['tp5o']}, 06:06:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:06:03 INFO - 'talos_options': ['--disable-e10s', 06:06:03 INFO - '--xperf_path', 06:06:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:06:03 INFO - 'tests': ['tp5n']}, 06:06:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:06:03 INFO - 'talos_options': ['--xperf_path', 06:06:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:06:03 INFO - 'tests': ['tp5n']}}, 06:06:03 INFO - 'talos.zip': {'path': '', 06:06:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:06:03 INFO - Running post-action listener: _resource_record_post_action 06:06:03 INFO - ##### 06:06:03 INFO - ##### Finished populate-webroot step (success) 06:06:03 INFO - ##### 06:06:03 INFO - ##### 06:06:03 INFO - ##### Running create-virtualenv step. 06:06:03 INFO - ##### 06:06:03 INFO - Running pre-action listener: _resource_record_pre_action 06:06:03 INFO - Running main action method: create_virtualenv 06:06:03 INFO - Creating virtualenv /builds/slave/test/build/venv 06:06:03 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 06:06:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:06:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:06:03 INFO - Using real prefix '/usr' 06:06:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:06:05 INFO - Installing distribute.............................................................................................................................................................................................done. 06:06:07 INFO - Installing pip.................done. 06:06:07 INFO - Return code: 0 06:06:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:06:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:06:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:07 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 0x7f998894ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce39c0>, '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 0x2ce48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce4d50>, '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': '31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834', '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 06:06:07 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 06:06:07 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 06:06:07 INFO - Using env: {'DISPLAY': ':0', 06:06:07 INFO - 'HOME': '/home/cltbld', 06:06:07 INFO - 'LANG': 'en_US.UTF-8', 06:06:07 INFO - 'LANGUAGE': 'en_US:en', 06:06:07 INFO - 'LOGNAME': 'cltbld', 06:06:07 INFO - 'MAIL': '/var/mail/cltbld', 06:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:07 INFO - 'MOZ_NO_REMOTE': '1', 06:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:07 INFO - 'NO_EM_RESTART': '1', 06:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:07 INFO - 'PWD': '/builds/slave/test', 06:06:07 INFO - 'SHELL': '/bin/bash', 06:06:07 INFO - 'SHLVL': '1', 06:06:07 INFO - 'TERM': 'linux', 06:06:07 INFO - 'TMOUT': '86400', 06:06:07 INFO - 'USER': 'cltbld', 06:06:07 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834', 06:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:07 INFO - '_': '/tools/buildbot/bin/python'} 06:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:06:08 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 06:06:08 INFO - Cleaning up... 06:06:08 INFO - Return code: 0 06:06:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:06:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:06:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f998894ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce39c0>, '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 0x2ce48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce4d50>, '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': '31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834', '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 06:06:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:06:08 INFO - Using env: {'DISPLAY': ':0', 06:06:08 INFO - 'HOME': '/home/cltbld', 06:06:08 INFO - 'LANG': 'en_US.UTF-8', 06:06:08 INFO - 'LANGUAGE': 'en_US:en', 06:06:08 INFO - 'LOGNAME': 'cltbld', 06:06:08 INFO - 'MAIL': '/var/mail/cltbld', 06:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:08 INFO - 'MOZ_NO_REMOTE': '1', 06:06:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:08 INFO - 'NO_EM_RESTART': '1', 06:06:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:08 INFO - 'PWD': '/builds/slave/test', 06:06:08 INFO - 'SHELL': '/bin/bash', 06:06:08 INFO - 'SHLVL': '1', 06:06:08 INFO - 'TERM': 'linux', 06:06:08 INFO - 'TMOUT': '86400', 06:06:08 INFO - 'USER': 'cltbld', 06:06:08 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834', 06:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:08 INFO - '_': '/tools/buildbot/bin/python'} 06:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:06:08 INFO - Downloading/unpacking psutil>=3.1.1 06:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:06:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:06:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:06:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:06:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:06:10 INFO - Installing collected packages: psutil 06:06:10 INFO - Running setup.py install for psutil 06:06:10 INFO - building 'psutil._psutil_linux' extension 06:06:10 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 06:06:11 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 06:06:11 INFO - building 'psutil._psutil_posix' extension 06:06:11 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 06:06:12 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 06:06:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:06:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:06:12 INFO - Successfully installed psutil 06:06:12 INFO - Cleaning up... 06:06:12 INFO - Return code: 0 06:06:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:06:12 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')]} 06:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:06:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:12 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')]} 06:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:06:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:12 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 0x7f998894ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce39c0>, '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 0x2ce48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce4d50>, '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': '31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834', '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 06:06:12 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 06:06:12 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 06:06:12 INFO - Using env: {'DISPLAY': ':0', 06:06:12 INFO - 'HOME': '/home/cltbld', 06:06:12 INFO - 'LANG': 'en_US.UTF-8', 06:06:12 INFO - 'LANGUAGE': 'en_US:en', 06:06:12 INFO - 'LOGNAME': 'cltbld', 06:06:12 INFO - 'MAIL': '/var/mail/cltbld', 06:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:12 INFO - 'MOZ_NO_REMOTE': '1', 06:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:12 INFO - 'NO_EM_RESTART': '1', 06:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:12 INFO - 'PWD': '/builds/slave/test', 06:06:12 INFO - 'SHELL': '/bin/bash', 06:06:12 INFO - 'SHLVL': '1', 06:06:12 INFO - 'TERM': 'linux', 06:06:12 INFO - 'TMOUT': '86400', 06:06:12 INFO - 'USER': 'cltbld', 06:06:12 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834', 06:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:12 INFO - '_': '/tools/buildbot/bin/python'} 06:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:06:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:06:12 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 06:06:12 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 06:06:12 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 06:06:12 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 06:06:12 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 06:06:12 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 06:06:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:06:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:06:14 INFO - Installing collected packages: mozsystemmonitor 06:06:14 INFO - Running setup.py install for mozsystemmonitor 06:06:14 INFO - Successfully installed mozsystemmonitor 06:06:14 INFO - Cleaning up... 06:06:14 INFO - Return code: 0 06:06:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:06:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:06:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:06:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f998894ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce39c0>, '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 0x2ce48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce4d50>, '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': '31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834', '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 06:06:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:06:14 INFO - Using env: {'DISPLAY': ':0', 06:06:14 INFO - 'HOME': '/home/cltbld', 06:06:14 INFO - 'LANG': 'en_US.UTF-8', 06:06:14 INFO - 'LANGUAGE': 'en_US:en', 06:06:14 INFO - 'LOGNAME': 'cltbld', 06:06:14 INFO - 'MAIL': '/var/mail/cltbld', 06:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:14 INFO - 'MOZ_NO_REMOTE': '1', 06:06:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:14 INFO - 'NO_EM_RESTART': '1', 06:06:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:14 INFO - 'PWD': '/builds/slave/test', 06:06:14 INFO - 'SHELL': '/bin/bash', 06:06:14 INFO - 'SHLVL': '1', 06:06:14 INFO - 'TERM': 'linux', 06:06:14 INFO - 'TMOUT': '86400', 06:06:14 INFO - 'USER': 'cltbld', 06:06:14 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834', 06:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:14 INFO - '_': '/tools/buildbot/bin/python'} 06:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:06:14 INFO - Downloading/unpacking blobuploader==1.2.4 06:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:06:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:06:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:06:16 INFO - Downloading blobuploader-1.2.4.tar.gz 06:06:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:06:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:06:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:06:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:06:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:06:17 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 06:06:17 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 06:06:17 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 06:06:17 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 06:06:17 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 06:06:17 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 06:06:17 INFO - Downloading docopt-0.6.1.tar.gz 06:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:06:17 INFO - Installing collected packages: blobuploader, requests, docopt 06:06:17 INFO - Running setup.py install for blobuploader 06:06:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:06:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:06:17 INFO - Running setup.py install for requests 06:06:18 INFO - Running setup.py install for docopt 06:06:18 INFO - Successfully installed blobuploader requests docopt 06:06:18 INFO - Cleaning up... 06:06:18 INFO - Return code: 0 06:06:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:06:18 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')]} 06:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:18 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')]} 06:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:18 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 0x7f998894ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce39c0>, '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 0x2ce48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce4d50>, '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': '31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834', '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 06:06:18 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 06:06:18 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 06:06:18 INFO - Using env: {'DISPLAY': ':0', 06:06:18 INFO - 'HOME': '/home/cltbld', 06:06:18 INFO - 'LANG': 'en_US.UTF-8', 06:06:18 INFO - 'LANGUAGE': 'en_US:en', 06:06:18 INFO - 'LOGNAME': 'cltbld', 06:06:18 INFO - 'MAIL': '/var/mail/cltbld', 06:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:18 INFO - 'MOZ_NO_REMOTE': '1', 06:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:18 INFO - 'NO_EM_RESTART': '1', 06:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:18 INFO - 'PWD': '/builds/slave/test', 06:06:18 INFO - 'SHELL': '/bin/bash', 06:06:18 INFO - 'SHLVL': '1', 06:06:18 INFO - 'TERM': 'linux', 06:06:18 INFO - 'TMOUT': '86400', 06:06:18 INFO - 'USER': 'cltbld', 06:06:18 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834', 06:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:18 INFO - '_': '/tools/buildbot/bin/python'} 06:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:06:18 INFO - Running setup.py (path:/tmp/pip-nTWSs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:06:18 INFO - Running setup.py (path:/tmp/pip-I_iay1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:06:18 INFO - Running setup.py (path:/tmp/pip-f8wviz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:06:18 INFO - Running setup.py (path:/tmp/pip-ETuZiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:06:18 INFO - Running setup.py (path:/tmp/pip-LdL1xD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:06:18 INFO - Running setup.py (path:/tmp/pip-b0Je0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:06:18 INFO - Running setup.py (path:/tmp/pip-LZJvF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:06:18 INFO - Running setup.py (path:/tmp/pip-yheFqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:06:18 INFO - Running setup.py (path:/tmp/pip-RdN1ad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:06:19 INFO - Running setup.py (path:/tmp/pip-9wE4_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:06:19 INFO - Running setup.py (path:/tmp/pip-HeXkqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:06:19 INFO - Running setup.py (path:/tmp/pip-mFbuzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:06:19 INFO - Running setup.py (path:/tmp/pip-QjglIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:06:19 INFO - Running setup.py (path:/tmp/pip-XqppZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:06:19 INFO - Running setup.py (path:/tmp/pip-V8DByr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:06:19 INFO - Running setup.py (path:/tmp/pip-R6Cboi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:06:19 INFO - Running setup.py (path:/tmp/pip-4u_bcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:06:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:06:19 INFO - Running setup.py install for manifestparser 06:06:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:06:19 INFO - Running setup.py install for mozcrash 06:06:19 INFO - Running setup.py install for mozdebug 06:06:19 INFO - Running setup.py install for mozdevice 06:06:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:06:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:06:20 INFO - Running setup.py install for mozfile 06:06:20 INFO - Running setup.py install for mozhttpd 06:06:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:06:20 INFO - Running setup.py install for mozinfo 06:06:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:06:20 INFO - Running setup.py install for mozInstall 06:06:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:06:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:06:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:06:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:06:20 INFO - Running setup.py install for mozleak 06:06:20 INFO - Running setup.py install for mozlog 06:06:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:06:20 INFO - Running setup.py install for moznetwork 06:06:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:06:20 INFO - Running setup.py install for mozprocess 06:06:20 INFO - Running setup.py install for mozprofile 06:06:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:06:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:06:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:06:20 INFO - Running setup.py install for mozrunner 06:06:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:06:21 INFO - Running setup.py install for mozscreenshot 06:06:21 INFO - Running setup.py install for moztest 06:06:21 INFO - Running setup.py install for mozversion 06:06:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:06:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:06:21 INFO - Cleaning up... 06:06:21 INFO - Return code: 0 06:06:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:06:21 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')]} 06:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:06:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:21 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')]} 06:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:06:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:21 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 0x7f998894ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce39c0>, '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 0x2ce48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce4d50>, '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': '31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834', '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 06:06:21 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 06:06:21 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 06:06:21 INFO - Using env: {'DISPLAY': ':0', 06:06:21 INFO - 'HOME': '/home/cltbld', 06:06:21 INFO - 'LANG': 'en_US.UTF-8', 06:06:21 INFO - 'LANGUAGE': 'en_US:en', 06:06:21 INFO - 'LOGNAME': 'cltbld', 06:06:21 INFO - 'MAIL': '/var/mail/cltbld', 06:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:21 INFO - 'MOZ_NO_REMOTE': '1', 06:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:21 INFO - 'NO_EM_RESTART': '1', 06:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:21 INFO - 'PWD': '/builds/slave/test', 06:06:21 INFO - 'SHELL': '/bin/bash', 06:06:21 INFO - 'SHLVL': '1', 06:06:21 INFO - 'TERM': 'linux', 06:06:21 INFO - 'TMOUT': '86400', 06:06:21 INFO - 'USER': 'cltbld', 06:06:21 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834', 06:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:21 INFO - '_': '/tools/buildbot/bin/python'} 06:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:06:21 INFO - Running setup.py (path:/tmp/pip-y8ocgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:06:21 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)) 06:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:06:21 INFO - Running setup.py (path:/tmp/pip-JCnMts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:06:21 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)) 06:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:06:21 INFO - Running setup.py (path:/tmp/pip-QmcQdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:06:21 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)) 06:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:06:21 INFO - Running setup.py (path:/tmp/pip-SVRn8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:06:21 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)) 06:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:06:21 INFO - Running setup.py (path:/tmp/pip-UJhKVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:06:22 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)) 06:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:06:22 INFO - Running setup.py (path:/tmp/pip-2vlY_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:06:22 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)) 06:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:06:22 INFO - Running setup.py (path:/tmp/pip-kfsXy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:06:22 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)) 06:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:06:22 INFO - Running setup.py (path:/tmp/pip-S7W_FF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:06:22 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)) 06:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:06:22 INFO - Running setup.py (path:/tmp/pip-6N0KNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:06:22 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)) 06:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:06:22 INFO - Running setup.py (path:/tmp/pip-TcQqkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:06:22 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)) 06:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:06:22 INFO - Running setup.py (path:/tmp/pip-r9cWS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:06:22 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)) 06:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:06:22 INFO - Running setup.py (path:/tmp/pip-6UNncg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:06:22 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)) 06:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:06:22 INFO - Running setup.py (path:/tmp/pip-iu5Q7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:06:22 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)) 06:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:06:22 INFO - Running setup.py (path:/tmp/pip-5dQHg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:06:22 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)) 06:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:06:22 INFO - Running setup.py (path:/tmp/pip-EpQcj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:06:22 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)) 06:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:06:22 INFO - Running setup.py (path:/tmp/pip-Ppwi6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:06:22 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)) 06:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:06:22 INFO - Running setup.py (path:/tmp/pip-VhY0VG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:06:22 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)) 06:06:22 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)) 06:06:22 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)) 06:06:22 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)) 06:06:22 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)) 06:06:22 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)) 06:06:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:06:22 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 06:06:22 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 06:06:22 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 06:06:22 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 06:06:22 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 06:06:22 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 06:06:24 INFO - Downloading blessings-1.6.tar.gz 06:06:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:06:24 INFO - Installing collected packages: blessings 06:06:24 INFO - Running setup.py install for blessings 06:06:24 INFO - Successfully installed blessings 06:06:24 INFO - Cleaning up... 06:06:25 INFO - Return code: 0 06:06:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:06:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:06:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:06:25 INFO - Reading from file tmpfile_stdout 06:06:25 INFO - Current package versions: 06:06:25 INFO - argparse == 1.2.1 06:06:25 INFO - blessings == 1.6 06:06:25 INFO - blobuploader == 1.2.4 06:06:25 INFO - docopt == 0.6.1 06:06:25 INFO - manifestparser == 1.1 06:06:25 INFO - mozInstall == 1.12 06:06:25 INFO - mozcrash == 0.17 06:06:25 INFO - mozdebug == 0.1 06:06:25 INFO - mozdevice == 0.48 06:06:25 INFO - mozfile == 1.2 06:06:25 INFO - mozhttpd == 0.7 06:06:25 INFO - mozinfo == 0.9 06:06:25 INFO - mozleak == 0.1 06:06:25 INFO - mozlog == 3.2 06:06:25 INFO - moznetwork == 0.27 06:06:25 INFO - mozprocess == 0.22 06:06:25 INFO - mozprofile == 0.28 06:06:25 INFO - mozrunner == 6.11 06:06:25 INFO - mozscreenshot == 0.1 06:06:25 INFO - mozsystemmonitor == 0.3 06:06:25 INFO - moztest == 0.7 06:06:25 INFO - mozversion == 1.4 06:06:25 INFO - psutil == 3.1.1 06:06:25 INFO - requests == 1.2.3 06:06:25 INFO - wsgiref == 0.1.2 06:06:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:25 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 0x7f998894ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce39c0>, '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 0x2ce48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce4d50>, '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': '31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834', '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 06:06:25 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 06:06:25 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 06:06:25 INFO - Using env: {'DISPLAY': ':0', 06:06:25 INFO - 'HOME': '/home/cltbld', 06:06:25 INFO - 'LANG': 'en_US.UTF-8', 06:06:25 INFO - 'LANGUAGE': 'en_US:en', 06:06:25 INFO - 'LOGNAME': 'cltbld', 06:06:25 INFO - 'MAIL': '/var/mail/cltbld', 06:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:25 INFO - 'MOZ_NO_REMOTE': '1', 06:06:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:25 INFO - 'NO_EM_RESTART': '1', 06:06:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:25 INFO - 'PWD': '/builds/slave/test', 06:06:25 INFO - 'SHELL': '/bin/bash', 06:06:25 INFO - 'SHLVL': '1', 06:06:25 INFO - 'TERM': 'linux', 06:06:25 INFO - 'TMOUT': '86400', 06:06:25 INFO - 'USER': 'cltbld', 06:06:25 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834', 06:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:25 INFO - '_': '/tools/buildbot/bin/python'} 06:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:06:25 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)) 06:06:25 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)) 06:06:25 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)) 06:06:25 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)) 06:06:25 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)) 06:06:25 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)) 06:06:25 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)) 06:06:25 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)) 06:06:25 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)) 06:06:25 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)) 06:06:25 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)) 06:06:25 INFO - Cleaning up... 06:06:25 INFO - Return code: 0 06:06:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f998894ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce39c0>, '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 0x2ce48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce4d50>, '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': '31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834', '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 06:06:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:06:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:06:25 INFO - Using env: {'DISPLAY': ':0', 06:06:25 INFO - 'HOME': '/home/cltbld', 06:06:25 INFO - 'LANG': 'en_US.UTF-8', 06:06:25 INFO - 'LANGUAGE': 'en_US:en', 06:06:25 INFO - 'LOGNAME': 'cltbld', 06:06:25 INFO - 'MAIL': '/var/mail/cltbld', 06:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:25 INFO - 'MOZ_NO_REMOTE': '1', 06:06:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:25 INFO - 'NO_EM_RESTART': '1', 06:06:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:25 INFO - 'PWD': '/builds/slave/test', 06:06:25 INFO - 'SHELL': '/bin/bash', 06:06:25 INFO - 'SHLVL': '1', 06:06:25 INFO - 'TERM': 'linux', 06:06:25 INFO - 'TMOUT': '86400', 06:06:25 INFO - 'USER': 'cltbld', 06:06:25 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834', 06:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:25 INFO - '_': '/tools/buildbot/bin/python'} 06:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:06:25 INFO - Downloading/unpacking jsonschema 06:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:06:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:06:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:06:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:06:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:06:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:06:27 INFO - Downloading/unpacking functools32 (from jsonschema) 06:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:06:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:06:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:06:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:06:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:06:27 INFO - Downloading functools32-3.2.3-2.tar.gz 06:06:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:06:28 INFO - warning: no files found matching '*.txt' 06:06:28 INFO - no previously-included directories found matching 'build' 06:06:28 INFO - no previously-included directories found matching 'dist' 06:06:28 INFO - no previously-included directories found matching '.git*' 06:06:28 INFO - Installing collected packages: jsonschema, functools32 06:06:28 INFO - Running setup.py install for functools32 06:06:28 INFO - warning: no files found matching '*.txt' 06:06:28 INFO - no previously-included directories found matching 'build' 06:06:28 INFO - no previously-included directories found matching 'dist' 06:06:28 INFO - no previously-included directories found matching '.git*' 06:06:28 INFO - Successfully installed jsonschema functools32 06:06:28 INFO - Cleaning up... 06:06:28 INFO - Return code: 0 06:06:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:28 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 0x7f998894ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce39c0>, '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 0x2ce48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce4d50>, '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': '31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834', '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 06:06:28 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 06:06:28 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 06:06:28 INFO - Using env: {'DISPLAY': ':0', 06:06:28 INFO - 'HOME': '/home/cltbld', 06:06:28 INFO - 'LANG': 'en_US.UTF-8', 06:06:28 INFO - 'LANGUAGE': 'en_US:en', 06:06:28 INFO - 'LOGNAME': 'cltbld', 06:06:28 INFO - 'MAIL': '/var/mail/cltbld', 06:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:28 INFO - 'MOZ_NO_REMOTE': '1', 06:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:28 INFO - 'NO_EM_RESTART': '1', 06:06:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:28 INFO - 'PWD': '/builds/slave/test', 06:06:28 INFO - 'SHELL': '/bin/bash', 06:06:28 INFO - 'SHLVL': '1', 06:06:28 INFO - 'TERM': 'linux', 06:06:28 INFO - 'TMOUT': '86400', 06:06:28 INFO - 'USER': 'cltbld', 06:06:28 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834', 06:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:28 INFO - '_': '/tools/buildbot/bin/python'} 06:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:06:28 INFO - Downloading/unpacking flake8 06:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:06:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:06:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:06:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:06:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:06:30 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 06:06:30 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 06:06:30 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 06:06:30 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 06:06:30 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 06:06:30 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 06:06:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:06:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:06:30 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 06:06:30 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 06:06:30 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 06:06:30 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 06:06:30 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 06:06:30 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 06:06:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:06:30 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 06:06:30 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 06:06:30 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 06:06:30 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 06:06:30 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 06:06:30 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 06:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:06:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:06:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:06:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:06:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:06:31 INFO - no previously-included directories found matching 'docs/_build' 06:06:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:06:31 INFO - Running setup.py install for pep8 06:06:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:06:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:06:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:06:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:06:31 INFO - no previously-included directories found matching 'docs/_build' 06:06:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:06:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:06:31 INFO - Cleaning up... 06:06:31 INFO - Return code: 0 06:06:31 INFO - Running post-action listener: _resource_record_post_action 06:06:31 INFO - Running post-action listener: _start_resource_monitoring 06:06:31 INFO - Starting resource monitoring. 06:06:31 INFO - ##### 06:06:31 INFO - ##### Finished create-virtualenv step (success) 06:06:31 INFO - ##### 06:06:31 INFO - ##### 06:06:31 INFO - ##### Running install step. 06:06:31 INFO - ##### 06:06:31 INFO - Running pre-action listener: _resource_record_pre_action 06:06:31 INFO - Running main action method: install 06:06:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:06:31 INFO - Reading from file tmpfile_stdout 06:06:31 INFO - Detecting whether we're running mozinstall >=1.0... 06:06:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:06:31 INFO - Reading from file tmpfile_stdout 06:06:31 INFO - Output received: 06:06:31 INFO - Usage: mozinstall [options] installer 06:06:31 INFO - Options: 06:06:31 INFO - -h, --help show this help message and exit 06:06:31 INFO - -d DEST, --destination=DEST 06:06:31 INFO - Directory to install application into. [default: 06:06:31 INFO - "/builds/slave/test"] 06:06:31 INFO - --app=APP Application being installed. [default: firefox] 06:06:31 INFO - mkdir: /builds/slave/test/build/application 06:06:31 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'] 06:06:31 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 06:06:48 INFO - Reading from file tmpfile_stdout 06:06:48 INFO - Output received: 06:06:48 INFO - /builds/slave/test/build/application/firefox/firefox 06:06:48 INFO - Running post-action listener: _resource_record_post_action 06:06:48 INFO - ##### 06:06:48 INFO - ##### Finished install step (success) 06:06:48 INFO - ##### 06:06:48 INFO - ##### 06:06:48 INFO - ##### Running run-tests step. 06:06:48 INFO - ##### 06:06:48 INFO - Running pre-action listener: _resource_record_pre_action 06:06:48 INFO - Running main action method: run_tests 06:06:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:06:48 INFO - Python 2.7.3 06:06:48 INFO - Return code: 0 06:06:48 INFO - grabbing minidump binary from tooltool 06:06:48 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')]} 06:06:48 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 0x2ce39c0>, '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 0x2ce48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce4d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:06:48 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 06:06:48 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 06:06:48 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 06:06:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:06:48 INFO - Return code: 0 06:06:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:06:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:06:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:06:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:06:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:06:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:06:49 INFO - Return code: 0 06:06:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T0UFJSF6T52cwSuOBNS8vQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T0UFJSF6T52cwSuOBNS8vQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:06:49 INFO - Using env: {'DISPLAY': ':0', 06:06:49 INFO - 'HOME': '/home/cltbld', 06:06:49 INFO - 'LANG': 'en_US.UTF-8', 06:06:49 INFO - 'LANGUAGE': 'en_US:en', 06:06:49 INFO - 'LOGNAME': 'cltbld', 06:06:49 INFO - 'MAIL': '/var/mail/cltbld', 06:06:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:06:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:49 INFO - 'MOZ_NO_REMOTE': '1', 06:06:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:06:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:49 INFO - 'NO_EM_RESTART': '1', 06:06:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:49 INFO - 'PWD': '/builds/slave/test', 06:06:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:06:49 INFO - 'SHELL': '/bin/bash', 06:06:49 INFO - 'SHLVL': '1', 06:06:49 INFO - 'TERM': 'linux', 06:06:49 INFO - 'TMOUT': '86400', 06:06:49 INFO - 'USER': 'cltbld', 06:06:49 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834', 06:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:49 INFO - '_': '/tools/buildbot/bin/python'} 06:06:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T0UFJSF6T52cwSuOBNS8vQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:06:49 INFO - mozversion application_buildid: 20160518030234 06:06:49 INFO - mozversion application_changeset: f3f2fa1d7eed5a8262f6401ef18ff8117a3ce43e 06:06:49 INFO - mozversion application_display_name: Nightly 06:06:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:06:49 INFO - mozversion application_name: Firefox 06:06:49 INFO - mozversion application_remotingname: firefox 06:06:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:06:49 INFO - mozversion application_vendor: Mozilla 06:06:49 INFO - mozversion application_version: 49.0a1 06:06:49 INFO - mozversion platform_buildid: 20160518030234 06:06:49 INFO - mozversion platform_changeset: f3f2fa1d7eed5a8262f6401ef18ff8117a3ce43e 06:06:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:06:49 INFO - mozversion platform_version: 49.0a1 06:06:49 INFO - using testdate: 1463576809 06:06:49 INFO - actual date: 1463576809 06:06:49 INFO - starting webserver on 'localhost:55972' 06:06:49 INFO - SUITE-START | Running 2 tests 06:06:49 INFO - TEST-START | dromaeo_css 06:06:49 INFO - operating with platform_type : linux_ 06:06:49 INFO - Initialising browser for dromaeo_css test... 06:06:49 INFO - TEST-INFO | started process 3339 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptKByOM/profile http://localhost:55972/getInfo.html) 06:06:55 INFO - PROCESS | 3339 | __metrics Screen width/height:1600/1200 06:06:55 INFO - PROCESS | 3339 | colorDepth:24 06:06:55 INFO - PROCESS | 3339 | Browser inner width/height: 1024/697 06:06:55 INFO - PROCESS | 3339 | __metrics 06:06:56 ERROR - PROCESS | 3339 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:06:57 INFO - TEST-INFO | 3339: exit 0 06:06:57 INFO - Browser initialized. 06:06:57 INFO - Running cycle 1/1 for dromaeo_css test... 06:06:57 INFO - TEST-INFO | started process 3420 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptKByOM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:07:09 INFO - PROCESS | 3420 | RSS: Main: 152182784 06:07:09 INFO - PROCESS | 3420 | 06:08:00 INFO - PROCESS | 3420 | 1463576880574 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] 06:10:09 INFO - PROCESS | 3420 | Cycle 1(1): loaded http://localhost:55972/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55972/tests/dromaeo/cssquery-ext.html) 06:10:10 INFO - PROCESS | 3420 | RSS: Main: 256933888 06:10:10 INFO - PROCESS | 3420 | 06:13:12 INFO - PROCESS | 3420 | Cycle 1(1): loaded http://localhost:55972/tests/dromaeo/cssquery-ext.html (next: http://localhost:55972/tests/dromaeo/cssquery-jquery.html) 06:13:13 INFO - PROCESS | 3420 | RSS: Main: 238907392 06:13:13 INFO - PROCESS | 3420 | 06:16:14 INFO - PROCESS | 3420 | Cycle 1(1): loaded http://localhost:55972/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55972/tests/dromaeo/cssquery-mootools.html) 06:16:15 INFO - PROCESS | 3420 | RSS: Main: 238751744 06:16:15 INFO - PROCESS | 3420 | 06:19:17 INFO - PROCESS | 3420 | Cycle 1(1): loaded http://localhost:55972/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55972/tests/dromaeo/cssquery-prototype.html) 06:19:17 INFO - PROCESS | 3420 | RSS: Main: 233078784 06:19:17 INFO - PROCESS | 3420 | 06:22:20 INFO - PROCESS | 3420 | Cycle 1(1): loaded http://localhost:55972/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55972/tests/dromaeo/cssquery-yui.html) 06:22:21 INFO - PROCESS | 3420 | RSS: Main: 211984384 06:22:21 INFO - PROCESS | 3420 | 06:25:23 INFO - PROCESS | 3420 | Cycle 1(1): loaded http://localhost:55972/tests/dromaeo/cssquery-yui.html (next: http://localhost:55972/tests/dromaeo/cssquery-dojo.html) 06:25:24 INFO - PROCESS | 3420 | RSS: Main: 293482496 06:25:24 INFO - PROCESS | 3420 | 06:25:24 INFO - PROCESS | 3420 | __start_tp_report 06:25:24 INFO - PROCESS | 3420 | _x_x_mozilla_page_load 06:25:24 INFO - PROCESS | 3420 | _x_x_mozilla_page_load_details 06:25:24 INFO - PROCESS | 3420 | |i|pagename|runs| 06:25:24 INFO - PROCESS | 3420 | |0;dojo.html;3197.392495425869;3204.2470019545417;3219.0021093461037;3235.611726592809;3254.1376535218174;5524.309461317335;5538.529225015878;5575.2473416088815;5689.118186681066;5714.771409143629;5562.471565201309;5567.777288908439;5573.693446860421;5660.858478538028;5661.1508273758955;4994.150994330954;5072.923906141411;5085.720285384303;5101.260317253996;5275.788968441258;5155.81954631588;5167.870803229912;5205.401378841444;5222.686638801665;5226.346706661668;4933.506649335073;5035.295058691786;5076.822311219108;5115.590752739772;5143.202803565416;5045.318881950926;5055.69665820052;5058.747062646889;5097.46476619957;5180.352455943007;5079.263506791532;5107.284980102789;5110.718910459923;5118.309028281172;5123.205903085028;5305.310309659758;5488.4237155098535;5525.281713377275;5534.308211473566;5668.801591944303;6057.263249952819;6074.370697984842;6076.088586711984;6093.451589356935;6131.080337949299;5795.594308398414;5957.463828255478;6069.862932180179;6089.247751838949;6094.54834069152;5583.916241256385;5674.262345895048;5675.687837168995;5694.174344720034;5699.116636921284;6187.752489900444;6208.658523781235;6214.2542894852;6218.22272215973;6224.813255602339;5730.885382292331;5881.206037185011;5923.526117910556;5941.376155503696;6020.488258498077;6050.939540447625;6066.059760737005;6074.03194180428;6100.389961003864;6120.265568131853;6009.1587177795145;6016.458518733335;6026.9095963560585;6032.095185722177;6036.849078773066;5857.47282744555;5927.703614819242;5973.701314934236;5987.520998320124;6035.78874739382;4504;4531.229690952546;4542.409486766699;4547.113312903952;4569.771511424416;4021.3364794809113;4046.838126474908;4052.473178486837;4053.5135783706146;4109.753414795122;5462.481064298885;5526.751296191681;5610.214569960209;5670.06443936754;5681.744321505542;6017.759289628453;6067.453929146398;6076.422739839708;6101.176341193971;6103.115048317969;5674.602777805597;5693.373728889819;5693.68684722336;5700.771969121189;5701.144828275709;5011.5489605935645;5129.846104616868;5160.612954028463;5161.509656582619;5175.4565770593545;6247.9062814057825;6253.5622506424115;6254.968725156254;6261.217347831521;6268.717907694165;5799.449052340021;6052.636841789506;6092.2689277285235;6092.7867524638195;6097.908531372122;6138.1738283688655;6162.506999439945;6171.6297022178815;6208.317085120723;6271.43557079865;5933.199018132669;5945.554083443845;5950.315713692808;5953.404659534185;5968.46283834457;5887.58786884931;6010.098485227076;6018.307894592002;6075.939240607714;6077.20996270482;5875.059990401515;5925.466707996301;5926.436988486087;5933.406659334032;5979.282486101695;5909.468147866713;5917.822465326047;5920;5923.348431672599;5931.3178984417345;5573.749181286771;5738.139279108167;5757.136429535603;5833.737481813244;5842.211301474416;6000.189974353407;6009.188759517584;6038.879222415615;6040.577159598786;6043.758249669964;5816.796412125555;5855.2095467113095;5858.9121163181735;5859.179714839841;5862.267216597926 06:25:24 INFO - PROCESS | 3420 | |1;ext.html;605.1255935173673;647.5952529668954;655.6262930129826;660.6168422315058;664.5979182594532;33660.831695841516;37145.07137321565;46490.53509464904;47686;47735.283970740464;45906.08187836241;46005.7699711501;46133.76933115338;46268;46369.30446043312;8641.52471614061;8774.780630484225;8783.34124940632;8785.780355491132;8787.384883058188;8807.471551706918;8903.020667726545;8910.554472276393;8914.86627700585;8918.108189181095;8955;8969.551522423886;8989.685361012365;9003.369764116514;9004.774880628003;8925.910740892605;8940.508272045035;8946.418482798597;8954.149355811187;8965.865512017292;8840.248578870804;8892.59983300753;8910.287177025823;8913.420627659181;8919.331050171199;42142.367864482054;42482;42525;42566.148677026285;42585;3569.428891377367;3676.1544844685873;3692.058525076115;3743.850245990157;4121;32599.83700081508;32668.509972350435;32707.83646081778;33080.669193308;33595.496067559005;4075.673946084306;4108.91782164355;4142.813573389175;4175.853845115406;4327.307630779092;368261;373698.99999999726;374588;376054.99999999726;376533;35315.293694126485;36177.819110904275;62150.68924655348;63224;63235.36764632295;37823.24353512914;37921.81039094787;37952.240955181296;38017.42973855395;38036.04909877275;15519.224038798015;15648.765268520981;15660.843391566166;15666.295016724274;15667.686646267011;12368.381580920917;12385.318807465675;12391.070669699808;12434.564790232298;12470.251784892935;8639;8649.481031138152;8664.220220180088;8723.563821808884;8731.825363492695;3311.4701647736247;3324.2852786650988;3325.983370083134;3349.514320423525;3380.0704806178496;1098.357460885391;1121.9495122719497;1180.698921774942;1232.1498166265249;1257.1137348169518;33163.3367332652;33585.664143358255;33849;33961.49057764136;34604.307913841585;1120.6638008597552;1225.724212052281;1260.710036691566;1269.149669721289;1324.3312127375614;17149.765694473557;17750.37873674415;17853.28586856537;17915.05714328534;17929.164212932857;578122;581386;582168;582296;582649;59374.10938835921;59795.70102149461;59845.40154598485;60042;60177.69911150416;1316.6839958409912;1354.5597680753795;1399.195462609004;1410;1456.9490067847787;30981.45092745399;33779.66220337765;34295.485567717005;34427.31145377128;34505.82747086249;50015.49984500254;50398;50652.49347506625;50879.49120508748;51032.74483627558;406018;407701;408347;408639;409262;25538.48923021492;27350.179494615193;27814;28010.579841302806;28206.717932820407;48652.51347486622;48776;48998.75500622474;49481.80224560585;49839.50160498349;40500;41158.382624261256;41449.171016580105;41545.376819347126;41601.1679766409;40718.38922416225;40988.385174223;41620.791896040326;41813;42204.36693449662;42072.789636051624;42080.15839683251;42762.35856462093;42835.357469637354;43399.34900976425;36882.8155859219;38076.23847523089;38309.808450957564;38746.41880371853;39208.60791392164;29055.85472072626;29392.412151756416;29438.558421623264;29683.554746678386;29740.256493586967 06:25:24 INFO - PROCESS | 3420 | |2;jquery.html;406.8027006901653;411.75500577156583;415.2421830159955;415.42256263793325;429.61120186231454;14767.852321476783;18184.272629094838;19817.50456238593;19823;20075;14878.925605371958;18406.07969601521;18924;18946.905265473688;19213.42359729207;5749.166370876231;5777.335606405275;5824.009918313896;5927.792527261547;5955.1960485334575;5807.186993820868;5849.444302791228;5865.325487568942;5891.970540147315;5894.440028197336;4167.3332266837315;4330.437043184397;6116.694165291718;6425.807225783211;6429.678516074177;6418.326075762071;6486.3513648635235;6502.252240992299;6537.869242615145;6557.213134423876;5568.777248910039;5637.774489020434;5681;5698.116791897221;5709.74306156224;23369.182078627335;23781.405464863343;23808.523829523485;24443.144489942944;24448.266552003468;2432.744561821001;2433.7809597136165;2524.3310522711495;2530.9240722778345;2573.98327660573;13068.346582670923;13881.097728647606;14463.13221206731;14988.400463981428;15726.764098538531;1980.5741765520481;2043.7343145391153;2106.1259577275414;2117.110813458351;2117.4494631395946;84320.57839710762;84914.15085849186;85479.14520854774;85783.57108214482;86458.56770716106;10620.309679870783;10823.945880270549;11088.390138542296;11129.499172537255;11191.216614837045;15307.234638268043;15430.459933902484;15480.458183963507;15481.071135731892;15503.224838758017;8052.315553178046;8113.959430202811;8180.713675021346;8307.543085130255;8367.330613550901;7438.702451901863;7856.332211762065;7919.049714034353;8027.357811375076;8048.315893149031;6056.66688332146;6413.358664133642;6695.765648202289;6796.728130874809;6838.760643377458;1973.2008536542724;2013.104168644939;2032.8068833460798;2033.3594917600908;2041.5610643711673;986.921046316293;1080.1304949515559;1115.7935781880378;1128.920975531705;1192.9045676345872;19667.409977700692;20423.183072677224;20535.178592856417;20552.691709624367;20583.691244631344;1101.1411099342527;1121.4168632311316;1129.9774004519863;1164.2781475485253;1171.1145056459095;11075.833862492069;11584.47869845859;11753.88246117545;11790.351530665725;11809.586664466702;452291;454569;455549;456408;471344;81207.59396202982;81737;82059.17940820634;82125;82355;1062.95216715248;1079.8002369561657;1092;1092.322759888874;1109.622728272375;17856.910715446338;17895.463136105936;18026.36907708224;18228.635427291647;18521.907390462962;28002;37722.81138594289;38168.61831381762;39040.46236994586;39835.80082099571;51756;51980.48019519756;52711.736441317546;52939.73530132325;53942.19086713624;8603.698870539502;8915.598798054232;9002;9005.729828105168;9206.539673016456;13477.528286509925;13743.793843092162;14025.228612426006;14198.29008549589;14371.496997605034;12049.939750301193;12071.094667899766;12318.81521777192;12430.875691242973;12465.439055242718;8826.602802873758;11783.646490605295;11917.463714133059;11948.34284114382;11992.520299188283;12426.192297500633;12441.564545240873;12488;12513.061520385825;12876.35618219104;7866.410019248465;7938.801529961797;8655.221030107321;8722.345824063093;8761.824763504821;11786.292822430682;11842.703932401415;11880.76238475243;12394.194377365442;12589.055820813659 06:25:24 INFO - PROCESS | 3420 | |3;mootools.html;1430.4135304525146;1544.0426935300113;1582.5647946814624;1750.4311098892856;1879.0416887387428;8763.737087887366;9091.090890910906;9105.49919754414;9428.764280892981;9481.43111413314;9223;9418.62325506979;9424.528773561311;9442.575084121214;9443.716688499338;2330.2892617751536;2359.917402890899;2361.7756313150308;2366.325597204797;2367.360812580602;2437.878575855109;2491.17791128927;2492.140211626986;2496.138832102931;2515.434027343851;2425.721042080157;2434.172381390327;2452.6075827867544;2465.2111324376206;2468.0744720729726;2364.326167042393;2372.406898275431;2381.404648837791;2394.820388470863;2418.5525677749674;2345.425370784169;2387.140629373424;2390.1156572068444;2391.7129944406784;2394.042383046778;8107.310878575328;8332.50004999702;9339.859902101405;9428.387154834982;9436.811263774754;4969.751512424365;5111.05445492585;5349.786008559692;5504.146857237135;5504.559635229172;3420.8973730788116;3459.187091033605;3495.860165593373;3570.8750193743094;3595.1012246938267;1079.6760971708534;1103.61925135828;1120.2606279855256;1138.9943050284778;1142.5544037825255;13003.934980325037;13148.211107333591;13156.210627362294;13172.407241674147;13194.208347499085;4812.855614331575;4874.122657921537;4939.753012349368;4954.777035033432;4979.3277907482025;10980.341179529254;11024.889751102546;11042.447877606088;11059.115270778479;11065.446727663584;5520.503154716095;5537.363203231599;5563.527100196528;5575.33096028471;5578.944210557843;4928;4952.5542701157065;5026.472220416877;5116.232565115262;5127.461616530285;3999.980000100039;4052.5339585947404;4071.531773845986;4118.217538667644;4166.6250037496775;1297.9480820767253;1324.2054767139832;1329.9335033248299;1333.7665908465979;1346.6904259195526;919.8068405634758;1037.3983089807894;1063.3088492479794;1065.5418170186895;1070.71626019105;6205.472534834499;6324.177856878577;6333.429991300805;6463.48292136628;6539.411452969255;434.4482507215818;441.56946976697463;442.2967481704106;446.75651769785543;448.9169503641771;4372.912541749147;4413.7793110344355;4429.778511074498;4445.26653102241;4456.68803183774;10751.40867252293;11030.834537481944;11061.391623460626;11068.612598559012;11074.114070874311;10802.351858888493;10899.29154604948;10923;10923.781524369468;10946.069584085282;8221.725632526968;8317.085120636724;8546.273566746897;8547.188017138486;8803.207711305886;6292.370762923671;6494.2856285807575;6527.934720652733;6579.276279609144;6590.319468535493;10557.785854626816;10720.463976801284;10828.675139745821;10860.728481788019;10977.725556861142;10866.67399978002;10973.61592344296;10976.560937562408;11006.174536909924;11103.33449982509;8260.752177434686;8389.748307550783;8428.367872409717;8434.536100514531;8437.87343189865;8971.865422018805;9000.63997440095;9078.500682462529;9117.726468205965;9126.817463650823;7794.571298578406;8183.754487365389;8297.170282971654;8364.121767214356;8491.448055876348;7803.375729941705;8148.388870834592;8179.345652347917;8346.415750897622;8384.496930184208;7167.104111986002;7249.891251631335;7250.528715633467;7257;7259.12890453149;5459;5537.861553461195;5562.9721851392105;5569.275994120739;5617.634853734494;5248.160294352885;5292.311999440049;5366.6779993200535;5377.462253774591;5526.530244929226 06:25:24 INFO - PROCESS | 3420 | |4;prototype.html;337.9324135172964;345.61981819998;349.263054954047;359.2402069622747;359.8722453528999;5409.729513524323;5489.451054894508;5566.526845218162;5574.60977731559;5575.386707462186;5449.427810079934;5451.71884607117;5459.918101228484;5466.371367292752;5473.2063850741615;4070.3080476319096;4278.828846846122;4281.443412356405;4288.69979101463;4303.634191093761;3897.337452633059;4241.321388577828;4267.167902259061;4267.615914567688;4279.636230920375;4179.916401671965;4197.328427451608;4208.0531880326835;4213.747175169499;4224.61978421942;4031.455753473273;4199.29928379007;4216.64158546524;4221.9101544735395;4224.831006759741;3761.6238376162437;3811.5807261201244;3819.694424446038;3844.192719528902;3860.247251785903;5292.1003429416705;5301.231321458406;5301.277084947369;5334.3598768147685;5362.517373436371;4958.305837182797;4968.602511799084;4969.378827646544;4975.651704380694;4981.9252711209365;5717.799877004285;5734.598578099534;5747.189635264878;5769.278840144982;5820.214271073393;3996.8800935971967;4124.773137477438;4133.669306455507;4134.9118695059105;4247;5734.168545560912;5814.592978491507;5952.1964534787685;5970.253718285215;5986.533299341646;4262.296721040993;4313.805878735402;4328.350747387854;4329.874232699521;4330.198913201068;4200.584663818256;4382.649388048949;4399.38408622793;4400.295952647561;4416.183006143874;4883.387387747538;4906.975465122723;4913.582345500672;4923.113839508923;4926.75366231687;5686.175504551817;5693.259876216148;5716.542281718135;5722.656640601577;5740.856478588069;1466.413434626158;1514.7576387777904;1516.3176570543299;1524.2835867142426;1524.420720126367;980.6567701304486;997.1972562087589;998.4408731110601;1009.0867764672983;1015.918726501878;4932.90134197314;4937.851864444073;4940.159408340219;4962.826301079445;4968.254761785761;5160.9872149861585;5175.663581867167;5209.947900521022;5220.92168617471;5229.424763276036;4566.292224705176;4813.735244561512;4898.632602554822;4910.919597688503;4975.502449755068;2778.2359851041124;2779.3746407058657;2832.362718388346;2841.9147425577266;2852.301186209392;5478.561715062785;5481.643693159932;5495.313085864267;5502.779888804403;5517.36550296713;5427.511523962862;5431.402545719968;5693.373728889902;5966.49284810796;6089.451949324582;6024.734805690854;6079.270487541435;6090.786822461193;6122.20411346531;6139.386061394003;5568.49883510486;5719.8570035749435;5792.82621521355;5971.731272092853;5977.5217982560425;5721.941440833459;5758.309002919509;5765.8558536036935;5766.913496297643;5780.971095144498;5863.794767183128;6020.789272375446;6058.727357269022;6122.234720659918;6127.479164270909;4184.539700632867;4189.664826813909;4193.7903104845245;4196.958030419779;4200.537940826568;5922.437368449991;5936.257967754031;5940.811837632405;5982.49148822355;5988.760449581968;5609.915851262316;5725.541956643375;5767.106098554731;5792.21805056312;5852.707364631666;5548.833534993957;5673.432656734293;5733.283339582552;5769.07694768835;5793.478586927196;5573.331200255995;5623.522000629992;5674.921764864663;5675.517581005661;5731.656100633975;5560.221568980265;5762.510186634183;5820.621659592113;5824.621399609012;5833.220867635412;5644.742103158769;5684.602077854676;5709.486146246858;5719.113537401709;5725.112607545837 06:25:24 INFO - PROCESS | 3420 | |5;yui.html;775.1473379282788;829.1169904052184;837.443100338275;875.9717191935907;878.95605219739;14491.492797752067;15346.232688365593;15349.923250383761;15366.923165384185;15407.07557546548;14302.141871487718;14303.213323267217;14336.211508367061;14340.354684039217;14343.64140896478;680.2755065854849;784.8665726826454;792.4967645545063;793.2345286798238;793.7420338390046;789.8025493626593;793.9801504962364;794.047143427886;794.4756460735915;794.7854079398559;840.0549381945311;851.4125253575045;852.0329426101389;854.4318028511063;856.015582080606;719.8416348403343;828.9917100828975;835.1731785532279;848.5672307123381;848.9872651910226;621.3786213786213;623.5728525959732;624.0327492386782;624.9375062493759;625.4746013348808;14474.276286185754;14482.42070317186;14553.927230363886;14566.271686415743;14567.562973110824;13737.656558586015;13803.51687690926;13871.861281387159;13949.790753138712;13971.720565588734;12233.877661223452;12420.689482762913;12459.252444853248;12508.624741257685;12605.810912836314;4454.799534020977;4529.728216307032;4535.4234084454165;4536.441120194797;4646.4888862225125;57072.714636426965;57967;57989.420105798825;58245.126323105185;59898;10992.890071099346;11011.229213954946;11016.339019658846;11222.438878056228;11417.31496110236;20651.896740516502;20710;20720.48198795042;20802.58394832095;20849.68725469119;8391.706290279933;8555;8593.65625374978;8650.351223658125;8839.823203535892;4442.222611043055;4548.067646132535;4623.283391074388;4624.167649822997;4831.855044348676;3256.7883087599703;3336.4494858348585;3342.699157075875;3345.1135449106005;3345.765796394278;547.3349879895866;612.4732729852324;622.9875402491925;627.9905801412891;632.0109029369023;677.4275737002225;786.5791801386231;787.6455594982281;797.4896066517433;800.3912136605464;10194.694159175237;10525.631602894015;10679.359238445562;10694.144468442506;10694.465276736131;760.3119177144692;777.6345117794627;812.6911773526141;814.4990830639233;833.5248908122434;4906.411230652345;4987.925181122286;5058.367704036996;5080.77136528857;5150.948490515122;70190;71065;73993.63003184949;75523.62238188773;75910.62044689852;63513.72972540523;64297.35702643007;65265.67367163134;66549.66725166343;67102.32897671059;49886.750566246934;53201.2019819703;54008.45991540113;54042.45957540453;58303.708481457325;9891.208703303862;10148.441835698812;10202.540885660312;10259.179265658879;10382.584696612052;37849.810750947174;37943.62056379511;38319;38568.80715596404;38848.6115138845;46790;47492.52507474881;48010.75994620004;48238.5176148234;49023.50976490189;12216.755664886474;12391.070669699628;12908.8063679043;13111.803322949972;13211.207327560378;14163.221022843842;14573.854261457249;14816.40734370613;15001.924990374979;15002.099874007594;13714.51999180024;13798.724025519634;14140.50508232207;14201.644958876112;14581;13994.650133746738;14077.718445630826;14224.928875355557;14309.284535772962;14435.494757683431;12922.483100675867;13230.338483076;13356;13467.3939672713;13793.931030344784;11423.543058277575;11630.53477860876;11876.703082423008;11950.940245298718;12229.021678265539;11653.708657283636;11878.821817672915;11918.40407979615;11959.461824217757;12166.635000949986 06:25:24 INFO - PROCESS | 3420 | __end_tp_report 06:25:24 INFO - PROCESS | 3420 | __start_cc_report 06:25:24 INFO - PROCESS | 3420 | _x_x_mozilla_cycle_collect,865 06:25:24 INFO - PROCESS | 3420 | __end_cc_report 06:25:24 INFO - PROCESS | 3420 | __startTimestamp1463577924147__endTimestamp 06:25:24 INFO - PROCESS | 3420 | 06:25:24 INFO - PROCESS | 3420 | ------- Summary: start ------- 06:25:24 INFO - PROCESS | 3420 | Number of tests: 6 06:25:24 INFO - PROCESS | 3420 | 06:25:24 INFO - PROCESS | 3420 | [#0] dojo.html Cycles:165 Average:5588.39 Median:5833.74 stddev:655.12 (11.2%) stddev-sans-first:629.71 06:25:24 INFO - PROCESS | 3420 | Values: 3197.4 3204.2 3219.0 3235.6 3254.1 5524.3 5538.5 5575.2 5689.1 5714.8 5562.5 5567.8 5573.7 5660.9 5661.2 4994.2 5072.9 5085.7 5101.3 5275.8 5155.8 5167.9 5205.4 5222.7 5226.3 4933.5 5035.3 5076.8 5115.6 5143.2 5045.3 5055.7 5058.7 5097.5 5180.4 5079.3 5107.3 5110.7 5118.3 5123.2 5305.3 5488.4 5525.3 5534.3 5668.8 6057.3 6074.4 6076.1 6093.5 6131.1 5795.6 5957.5 6069.9 6089.2 6094.5 5583.9 5674.3 5675.7 5694.2 5699.1 6187.8 6208.7 6214.3 6218.2 6224.8 5730.9 5881.2 5923.5 5941.4 6020.5 6050.9 6066.1 6074.0 6100.4 6120.3 6009.2 6016.5 6026.9 6032.1 6036.8 5857.5 5927.7 5973.7 5987.5 6035.8 4504.0 4531.2 4542.4 4547.1 4569.8 4021.3 4046.8 4052.5 4053.5 4109.8 5462.5 5526.8 5610.2 5670.1 5681.7 6017.8 6067.5 6076.4 6101.2 6103.1 5674.6 5693.4 5693.7 5700.8 5701.1 5011.5 5129.8 5160.6 5161.5 5175.5 6247.9 6253.6 6255.0 6261.2 6268.7 5799.4 6052.6 6092.3 6092.8 6097.9 6138.2 6162.5 6171.6 6208.3 6271.4 5933.2 5945.6 5950.3 5953.4 5968.5 5887.6 6010.1 6018.3 6075.9 6077.2 5875.1 5925.5 5926.4 5933.4 5979.3 5909.5 5917.8 5920.0 5923.3 5931.3 5573.7 5738.1 5757.1 5833.7 5842.2 6000.2 6009.2 6038.9 6040.6 6043.8 5816.8 5855.2 5858.9 5859.2 5862.3 06:25:24 INFO - PROCESS | 3420 | 06:25:24 INFO - PROCESS | 3420 | [#1] ext.html Cycles:180 Average:60535.63 Median:225125.19 stddev:123247.76 (54.7%) stddev-sans-first:123511.36 06:25:24 INFO - PROCESS | 3420 | Values: 605.1 647.6 655.6 660.6 664.6 33660.8 37145.1 46490.5 47686.0 47735.3 45906.1 46005.8 46133.8 46268.0 46369.3 8641.5 8774.8 8783.3 8785.8 8787.4 8807.5 8903.0 8910.6 8914.9 8918.1 8955.0 8969.6 8989.7 9003.4 9004.8 8925.9 8940.5 8946.4 8954.1 8965.9 8840.2 8892.6 8910.3 8913.4 8919.3 42142.4 42482.0 42525.0 42566.1 42585.0 3569.4 3676.2 3692.1 3743.9 4121.0 32599.8 32668.5 32707.8 33080.7 33595.5 4075.7 4108.9 4142.8 4175.9 4327.3 368261.0 373699.0 374588.0 376055.0 376533.0 35315.3 36177.8 62150.7 63224.0 63235.4 37823.2 37921.8 37952.2 38017.4 38036.0 15519.2 15648.8 15660.8 15666.3 15667.7 12368.4 12385.3 12391.1 12434.6 12470.3 8639.0 8649.5 8664.2 8723.6 8731.8 3311.5 3324.3 3326.0 3349.5 3380.1 1098.4 1121.9 1180.7 1232.1 1257.1 33163.3 33585.7 33849.0 33961.5 34604.3 1120.7 1225.7 1260.7 1269.1 1324.3 17149.8 17750.4 17853.3 17915.1 17929.2 578122.0 581386.0 582168.0 582296.0 582649.0 59374.1 59795.7 59845.4 60042.0 60177.7 1316.7 1354.6 1399.2 1410.0 1456.9 30981.5 33779.7 34295.5 34427.3 34505.8 50015.5 50398.0 50652.5 50879.5 51032.7 406018.0 407701.0 408347.0 408639.0 409262.0 25538.5 27350.2 27814.0 28010.6 28206.7 48652.5 48776.0 48998.8 49481.8 49839.5 40500.0 41158.4 41449.2 41545.4 41601.2 40718.4 40988.4 41620.8 41813.0 42204.4 42072.8 42080.2 42762.4 42835.4 43399.3 36882.8 38076.2 38309.8 38746.4 39208.6 29055.9 29392.4 29438.6 29683.6 29740.3 06:25:24 INFO - PROCESS | 3420 | 06:25:24 INFO - PROCESS | 3420 | [#2] jquery.html Cycles:180 Average:27995.55 Median:13120.63 stddev:75439.80 (575.0%) stddev-sans-first:75622.99 06:25:24 INFO - PROCESS | 3420 | Values: 406.8 411.8 415.2 415.4 429.6 14767.9 18184.3 19817.5 19823.0 20075.0 14878.9 18406.1 18924.0 18946.9 19213.4 5749.2 5777.3 5824.0 5927.8 5955.2 5807.2 5849.4 5865.3 5892.0 5894.4 4167.3 4330.4 6116.7 6425.8 6429.7 6418.3 6486.4 6502.3 6537.9 6557.2 5568.8 5637.8 5681.0 5698.1 5709.7 23369.2 23781.4 23808.5 24443.1 24448.3 2432.7 2433.8 2524.3 2530.9 2574.0 13068.3 13881.1 14463.1 14988.4 15726.8 1980.6 2043.7 2106.1 2117.1 2117.4 84320.6 84914.2 85479.1 85783.6 86458.6 10620.3 10823.9 11088.4 11129.5 11191.2 15307.2 15430.5 15480.5 15481.1 15503.2 8052.3 8114.0 8180.7 8307.5 8367.3 7438.7 7856.3 7919.0 8027.4 8048.3 6056.7 6413.4 6695.8 6796.7 6838.8 1973.2 2013.1 2032.8 2033.4 2041.6 986.9 1080.1 1115.8 1128.9 1192.9 19667.4 20423.2 20535.2 20552.7 20583.7 1101.1 1121.4 1130.0 1164.3 1171.1 11075.8 11584.5 11753.9 11790.4 11809.6 452291.0 454569.0 455549.0 456408.0 471344.0 81207.6 81737.0 82059.2 82125.0 82355.0 1063.0 1079.8 1092.0 1092.3 1109.6 17856.9 17895.5 18026.4 18228.6 18521.9 28002.0 37722.8 38168.6 39040.5 39835.8 51756.0 51980.5 52711.7 52939.7 53942.2 8603.7 8915.6 9002.0 9005.7 9206.5 13477.5 13743.8 14025.2 14198.3 14371.5 12049.9 12071.1 12318.8 12430.9 12465.4 8826.6 11783.6 11917.5 11948.3 11992.5 12426.2 12441.6 12488.0 12513.1 12876.4 7866.4 7938.8 8655.2 8722.3 8761.8 11786.3 11842.7 11880.8 12394.2 12589.1 06:25:24 INFO - PROCESS | 3420 | 06:25:24 INFO - PROCESS | 3420 | [#3] mootools.html Cycles:180 Average:6086.16 Median:4450.98 stddev:3493.68 (78.5%) stddev-sans-first:3485.96 06:25:24 INFO - PROCESS | 3420 | Values: 1430.4 1544.0 1582.6 1750.4 1879.0 8763.7 9091.1 9105.5 9428.8 9481.4 9223.0 9418.6 9424.5 9442.6 9443.7 2330.3 2359.9 2361.8 2366.3 2367.4 2437.9 2491.2 2492.1 2496.1 2515.4 2425.7 2434.2 2452.6 2465.2 2468.1 2364.3 2372.4 2381.4 2394.8 2418.6 2345.4 2387.1 2390.1 2391.7 2394.0 8107.3 8332.5 9339.9 9428.4 9436.8 4969.8 5111.1 5349.8 5504.1 5504.6 3420.9 3459.2 3495.9 3570.9 3595.1 1079.7 1103.6 1120.3 1139.0 1142.6 13003.9 13148.2 13156.2 13172.4 13194.2 4812.9 4874.1 4939.8 4954.8 4979.3 10980.3 11024.9 11042.4 11059.1 11065.4 5520.5 5537.4 5563.5 5575.3 5578.9 4928.0 4952.6 5026.5 5116.2 5127.5 4000.0 4052.5 4071.5 4118.2 4166.6 1297.9 1324.2 1329.9 1333.8 1346.7 919.8 1037.4 1063.3 1065.5 1070.7 6205.5 6324.2 6333.4 6463.5 6539.4 434.4 441.6 442.3 446.8 448.9 4372.9 4413.8 4429.8 4445.3 4456.7 10751.4 11030.8 11061.4 11068.6 11074.1 10802.4 10899.3 10923.0 10923.8 10946.1 8221.7 8317.1 8546.3 8547.2 8803.2 6292.4 6494.3 6527.9 6579.3 6590.3 10557.8 10720.5 10828.7 10860.7 10977.7 10866.7 10973.6 10976.6 11006.2 11103.3 8260.8 8389.7 8428.4 8434.5 8437.9 8971.9 9000.6 9078.5 9117.7 9126.8 7794.6 8183.8 8297.2 8364.1 8491.4 7803.4 8148.4 8179.3 8346.4 8384.5 7167.1 7249.9 7250.5 7257.0 7259.1 5459.0 5537.9 5563.0 5569.3 5617.6 5248.2 5292.3 5366.7 5377.5 5526.5 06:25:24 INFO - PROCESS | 3420 | 06:25:24 INFO - PROCESS | 3420 | [#4] prototype.html Cycles:180 Average:4757.36 Median:5348.44 stddev:1389.91 (26.0%) stddev-sans-first:1353.65 06:25:24 INFO - PROCESS | 3420 | Values: 337.9 345.6 349.3 359.2 359.9 5409.7 5489.5 5566.5 5574.6 5575.4 5449.4 5451.7 5459.9 5466.4 5473.2 4070.3 4278.8 4281.4 4288.7 4303.6 3897.3 4241.3 4267.2 4267.6 4279.6 4179.9 4197.3 4208.1 4213.7 4224.6 4031.5 4199.3 4216.6 4221.9 4224.8 3761.6 3811.6 3819.7 3844.2 3860.2 5292.1 5301.2 5301.3 5334.4 5362.5 4958.3 4968.6 4969.4 4975.7 4981.9 5717.8 5734.6 5747.2 5769.3 5820.2 3996.9 4124.8 4133.7 4134.9 4247.0 5734.2 5814.6 5952.2 5970.3 5986.5 4262.3 4313.8 4328.4 4329.9 4330.2 4200.6 4382.6 4399.4 4400.3 4416.2 4883.4 4907.0 4913.6 4923.1 4926.8 5686.2 5693.3 5716.5 5722.7 5740.9 1466.4 1514.8 1516.3 1524.3 1524.4 980.7 997.2 998.4 1009.1 1015.9 4932.9 4937.9 4940.2 4962.8 4968.3 5161.0 5175.7 5209.9 5220.9 5229.4 4566.3 4813.7 4898.6 4910.9 4975.5 2778.2 2779.4 2832.4 2841.9 2852.3 5478.6 5481.6 5495.3 5502.8 5517.4 5427.5 5431.4 5693.4 5966.5 6089.5 6024.7 6079.3 6090.8 6122.2 6139.4 5568.5 5719.9 5792.8 5971.7 5977.5 5721.9 5758.3 5765.9 5766.9 5781.0 5863.8 6020.8 6058.7 6122.2 6127.5 4184.5 4189.7 4193.8 4197.0 4200.5 5922.4 5936.3 5940.8 5982.5 5988.8 5609.9 5725.5 5767.1 5792.2 5852.7 5548.8 5673.4 5733.3 5769.1 5793.5 5573.3 5623.5 5674.9 5675.5 5731.7 5560.2 5762.5 5820.6 5824.6 5833.2 5644.7 5684.6 5709.5 5719.1 5725.1 06:25:24 INFO - PROCESS | 3420 | 06:25:24 INFO - PROCESS | 3420 | [#5] yui.html Cycles:180 Average:16273.75 Median:4492.26 stddev:19310.99 (429.9%) stddev-sans-first:19330.09 06:25:24 INFO - PROCESS | 3420 | Values: 775.1 829.1 837.4 876.0 879.0 14491.5 15346.2 15349.9 15366.9 15407.1 14302.1 14303.2 14336.2 14340.4 14343.6 680.3 784.9 792.5 793.2 793.7 789.8 794.0 794.0 794.5 794.8 840.1 851.4 852.0 854.4 856.0 719.8 829.0 835.2 848.6 849.0 621.4 623.6 624.0 624.9 625.5 14474.3 14482.4 14553.9 14566.3 14567.6 13737.7 13803.5 13871.9 13949.8 13971.7 12233.9 12420.7 12459.3 12508.6 12605.8 4454.8 4529.7 4535.4 4536.4 4646.5 57072.7 57967.0 57989.4 58245.1 59898.0 10992.9 11011.2 11016.3 11222.4 11417.3 20651.9 20710.0 20720.5 20802.6 20849.7 8391.7 8555.0 8593.7 8650.4 8839.8 4442.2 4548.1 4623.3 4624.2 4831.9 3256.8 3336.4 3342.7 3345.1 3345.8 547.3 612.5 623.0 628.0 632.0 677.4 786.6 787.6 797.5 800.4 10194.7 10525.6 10679.4 10694.1 10694.5 760.3 777.6 812.7 814.5 833.5 4906.4 4987.9 5058.4 5080.8 5150.9 70190.0 71065.0 73993.6 75523.6 75910.6 63513.7 64297.4 65265.7 66549.7 67102.3 49886.8 53201.2 54008.5 54042.5 58303.7 9891.2 10148.4 10202.5 10259.2 10382.6 37849.8 37943.6 38319.0 38568.8 38848.6 46790.0 47492.5 48010.8 48238.5 49023.5 12216.8 12391.1 12908.8 13111.8 13211.2 14163.2 14573.9 14816.4 15001.9 15002.1 13714.5 13798.7 14140.5 14201.6 14581.0 13994.7 14077.7 14224.9 14309.3 14435.5 12922.5 13230.3 13356.0 13467.4 13793.9 11423.5 11630.5 11876.7 11950.9 12229.0 11653.7 11878.8 11918.4 11959.5 12166.6 06:25:24 INFO - PROCESS | 3420 | -------- Summary: end -------- 06:25:24 INFO - PROCESS | 3420 | 06:25:24 INFO - TEST-INFO | 3420: exit 0 06:25:24 INFO - TEST-OK | dromaeo_css | took 1115285ms 06:25:24 INFO - TEST-START | kraken 06:25:24 INFO - operating with platform_type : linux_ 06:25:24 INFO - Initialising browser for kraken test... 06:25:24 INFO - TEST-INFO | started process 3603 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWXQdJC/profile http://localhost:55972/getInfo.html) 06:25:29 INFO - PROCESS | 3603 | __metrics Screen width/height:1600/1200 06:25:29 INFO - PROCESS | 3603 | colorDepth:24 06:25:29 INFO - PROCESS | 3603 | Browser inner width/height: 1024/697 06:25:29 INFO - PROCESS | 3603 | __metrics 06:25:30 ERROR - PROCESS | 3603 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:25:30 INFO - TEST-INFO | 3603: exit 0 06:25:30 INFO - Browser initialized. 06:25:30 INFO - Running cycle 1/1 for kraken test... 06:25:30 INFO - TEST-INFO | started process 3681 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWXQdJC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:25:42 INFO - PROCESS | 3681 | RSS: Main: 152457216 06:25:42 INFO - PROCESS | 3681 | 06:25:45 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55972/tests/kraken/driver.html?testName=audio-beat-detection) 06:25:46 INFO - PROCESS | 3681 | RSS: Main: 208781312 06:25:46 INFO - PROCESS | 3681 | 06:25:48 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55972/tests/kraken/driver.html?testName=audio-dft) 06:25:49 INFO - PROCESS | 3681 | RSS: Main: 197730304 06:25:49 INFO - PROCESS | 3681 | 06:25:52 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55972/tests/kraken/driver.html?testName=audio-fft) 06:25:53 INFO - PROCESS | 3681 | RSS: Main: 265670656 06:25:53 INFO - PROCESS | 3681 | 06:25:55 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55972/tests/kraken/driver.html?testName=audio-oscillator) 06:25:56 INFO - PROCESS | 3681 | RSS: Main: 174866432 06:25:56 INFO - PROCESS | 3681 | 06:25:58 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55972/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:25:58 INFO - PROCESS | 3681 | RSS: Main: 178466816 06:25:58 INFO - PROCESS | 3681 | 06:26:02 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55972/tests/kraken/driver.html?testName=imaging-darkroom) 06:26:02 INFO - PROCESS | 3681 | RSS: Main: 214913024 06:26:02 INFO - PROCESS | 3681 | 06:26:06 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55972/tests/kraken/driver.html?testName=imaging-desaturate) 06:26:07 INFO - PROCESS | 3681 | RSS: Main: 213090304 06:26:07 INFO - PROCESS | 3681 | 06:26:10 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55972/tests/kraken/driver.html?testName=json-parse-financial) 06:26:10 INFO - PROCESS | 3681 | RSS: Main: 214106112 06:26:10 INFO - PROCESS | 3681 | 06:26:12 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55972/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:26:12 INFO - PROCESS | 3681 | RSS: Main: 203345920 06:26:12 INFO - PROCESS | 3681 | 06:26:14 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55972/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:26:15 INFO - PROCESS | 3681 | RSS: Main: 206086144 06:26:15 INFO - PROCESS | 3681 | 06:26:17 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55972/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:26:18 INFO - PROCESS | 3681 | RSS: Main: 215453696 06:26:18 INFO - PROCESS | 3681 | 06:26:20 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55972/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:26:21 INFO - PROCESS | 3681 | RSS: Main: 223662080 06:26:21 INFO - PROCESS | 3681 | 06:26:24 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55972/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:26:24 INFO - PROCESS | 3681 | RSS: Main: 220327936 06:26:24 INFO - PROCESS | 3681 | 06:26:26 INFO - PROCESS | 3681 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55972/tests/kraken/driver.html?testName=ai-astar) 06:26:26 INFO - PROCESS | 3681 | RSS: Main: 265015296 06:26:26 INFO - PROCESS | 3681 | 06:26:26 INFO - PROCESS | 3681 | __start_tp_report 06:26:26 INFO - PROCESS | 3681 | _x_x_mozilla_page_load 06:26:26 INFO - PROCESS | 3681 | _x_x_mozilla_page_load_details 06:26:26 INFO - PROCESS | 3681 | |i|pagename|runs| 06:26:26 INFO - PROCESS | 3681 | |0;ai-astar;112;105;109;108;108;110;108;108;109;110 06:26:26 INFO - PROCESS | 3681 | |1;audio-beat-detection;151;124;162;216;124;148;150;124;192;131 06:26:26 INFO - PROCESS | 3681 | |2;audio-dft;161;161;160;162;160;159;160;162;162;162 06:26:26 INFO - PROCESS | 3681 | |3;audio-fft;75;75;75;158;75;74;75;74;130;74 06:26:26 INFO - PROCESS | 3681 | |4;audio-oscillator;91;91;145;92;91;92;126;91;92;126 06:26:26 INFO - PROCESS | 3681 | |5;imaging-gaussian-blur;116;116;117;116;116;117;116;116;116;116 06:26:26 INFO - PROCESS | 3681 | |6;imaging-darkroom;145;146;145;145;145;145;146;145;145;145 06:26:26 INFO - PROCESS | 3681 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;95;95 06:26:26 INFO - PROCESS | 3681 | |8;json-parse-financial;55;55;56;54;55;61;55;107;51;52 06:26:26 INFO - PROCESS | 3681 | |9;json-stringify-tinderbox;59;60;60;60;60;59;60;59;58;60 06:26:26 INFO - PROCESS | 3681 | |10;stanford-crypto-aes;84;78;78;77;78;77;78;82;78;78 06:26:26 INFO - PROCESS | 3681 | |11;stanford-crypto-ccm;118;118;135;119;117;126;119;121;199;124 06:26:26 INFO - PROCESS | 3681 | |12;stanford-crypto-pbkdf2;159;161;156;153;155;155;156;158;154;154 06:26:26 INFO - PROCESS | 3681 | |13;stanford-crypto-sha256-iterative;64;62;65;62;65;61;61;61;61;61 06:26:26 INFO - PROCESS | 3681 | __end_tp_report 06:26:26 INFO - PROCESS | 3681 | __start_cc_report 06:26:26 INFO - PROCESS | 3681 | _x_x_mozilla_cycle_collect,1862 06:26:26 INFO - PROCESS | 3681 | __end_cc_report 06:26:26 INFO - PROCESS | 3681 | __startTimestamp1463577986602__endTimestamp 06:26:26 INFO - PROCESS | 3681 | 06:26:26 INFO - PROCESS | 3681 | ------- Summary: start ------- 06:26:26 INFO - PROCESS | 3681 | Number of tests: 14 06:26:26 INFO - PROCESS | 3681 | 06:26:26 INFO - PROCESS | 3681 | [#0] ai-astar Cycles:10 Average:108.70 Median:109.00 stddev:1.83 (1.7%) stddev-sans-first:1.50 06:26:26 INFO - PROCESS | 3681 | Values: 112.0 105.0 109.0 108.0 108.0 110.0 108.0 108.0 109.0 110.0 06:26:26 INFO - PROCESS | 3681 | 06:26:26 INFO - PROCESS | 3681 | [#1] audio-beat-detection Cycles:10 Average:152.20 Median:150.50 stddev:30.93 (20.6%) stddev-sans-first:32.80 06:26:26 INFO - PROCESS | 3681 | Values: 151.0 124.0 162.0 216.0 124.0 148.0 150.0 124.0 192.0 131.0 06:26:26 INFO - PROCESS | 3681 | 06:26:26 INFO - PROCESS | 3681 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.50 stddev:1.10 (0.7%) stddev-sans-first:1.17 06:26:26 INFO - PROCESS | 3681 | Values: 161.0 161.0 160.0 162.0 160.0 159.0 160.0 162.0 162.0 162.0 06:26:26 INFO - PROCESS | 3681 | 06:26:26 INFO - PROCESS | 3681 | [#3] audio-fft Cycles:10 Average:88.50 Median:75.00 stddev:29.99 (40.0%) stddev-sans-first:31.41 06:26:26 INFO - PROCESS | 3681 | Values: 75.0 75.0 75.0 158.0 75.0 74.0 75.0 74.0 130.0 74.0 06:26:26 INFO - PROCESS | 3681 | 06:26:26 INFO - PROCESS | 3681 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:91.00 stddev:20.43 (22.4%) stddev-sans-first:21.15 06:26:26 INFO - PROCESS | 3681 | Values: 91.0 91.0 145.0 92.0 91.0 92.0 126.0 91.0 92.0 126.0 06:26:26 INFO - PROCESS | 3681 | 06:26:26 INFO - PROCESS | 3681 | [#5] imaging-gaussian-blur Cycles:10 Average:116.20 Median:116.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:26:26 INFO - PROCESS | 3681 | Values: 116.0 116.0 117.0 116.0 116.0 117.0 116.0 116.0 116.0 116.0 06:26:26 INFO - PROCESS | 3681 | 06:26:26 INFO - PROCESS | 3681 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 06:26:26 INFO - PROCESS | 3681 | Values: 145.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 06:26:26 INFO - PROCESS | 3681 | 06:26:26 INFO - PROCESS | 3681 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:26:26 INFO - PROCESS | 3681 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 06:26:26 INFO - PROCESS | 3681 | 06:26:26 INFO - PROCESS | 3681 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:55.00 stddev:16.69 (30.3%) stddev-sans-first:17.60 06:26:26 INFO - PROCESS | 3681 | Values: 55.0 55.0 56.0 54.0 55.0 61.0 55.0 107.0 51.0 52.0 06:26:26 INFO - PROCESS | 3681 | 06:26:26 INFO - PROCESS | 3681 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:60.00 stddev:0.71 (1.2%) stddev-sans-first:0.73 06:26:26 INFO - PROCESS | 3681 | Values: 59.0 60.0 60.0 60.0 60.0 59.0 60.0 59.0 58.0 60.0 06:26:26 INFO - PROCESS | 3681 | 06:26:26 INFO - PROCESS | 3681 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.00 stddev:2.30 (2.9%) stddev-sans-first:1.48 06:26:26 INFO - PROCESS | 3681 | Values: 84.0 78.0 78.0 77.0 78.0 77.0 78.0 82.0 78.0 78.0 06:26:26 INFO - PROCESS | 3681 | 06:26:26 INFO - PROCESS | 3681 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:122.50 stddev:24.98 (20.4%) stddev-sans-first:26.14 06:26:26 INFO - PROCESS | 3681 | Values: 118.0 118.0 135.0 119.0 117.0 126.0 119.0 121.0 199.0 124.0 06:26:26 INFO - PROCESS | 3681 | 06:26:26 INFO - PROCESS | 3681 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.10 Median:156.00 stddev:2.51 (1.6%) stddev-sans-first:2.44 06:26:26 INFO - PROCESS | 3681 | Values: 159.0 161.0 156.0 153.0 155.0 155.0 156.0 158.0 154.0 154.0 06:26:26 INFO - PROCESS | 3681 | 06:26:26 INFO - PROCESS | 3681 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.00 stddev:1.70 (2.7%) stddev-sans-first:1.69 06:26:26 INFO - PROCESS | 3681 | Values: 64.0 62.0 65.0 62.0 65.0 61.0 61.0 61.0 61.0 61.0 06:26:26 INFO - PROCESS | 3681 | -------- Summary: end -------- 06:26:26 INFO - PROCESS | 3681 | 06:26:27 INFO - TEST-INFO | 3681: exit 0 06:26:27 INFO - TEST-OK | kraken | took 62719ms 06:26:27 INFO - SUITE-END | took 1178s 06:26:27 INFO - Completed test suite (00:19:38) 06:26:27 INFO - javascript benchmark 06:26:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3197.392495425869, 3204.2470019545417, 3219.0021093461037, 3235.611726592809, 3254.1376535218174, 5524.309461317335, 5538.529225015878, 5575.2473416088815, 5689.118186681066, 5714.771409143629, 5562.471565201309, 5567.777288908439, 5573.693446860421, 5660.858478538028, 5661.1508273758955, 4994.150994330954, 5072.923906141411, 5085.720285384303, 5101.260317253996, 5275.788968441258, 5155.81954631588, 5167.870803229912, 5205.401378841444, 5222.686638801665, 5226.346706661668, 4933.506649335073, 5035.295058691786, 5076.822311219108, 5115.590752739772, 5143.202803565416, 5045.318881950926, 5055.69665820052, 5058.747062646889, 5097.46476619957, 5180.352455943007, 5079.263506791532, 5107.284980102789, 5110.718910459923, 5118.309028281172, 5123.205903085028, 5305.310309659758, 5488.4237155098535, 5525.281713377275, 5534.308211473566, 5668.801591944303, 6057.263249952819, 6074.370697984842, 6076.088586711984, 6093.451589356935, 6131.080337949299, 5795.594308398414, 5957.463828255478, 6069.862932180179, 6089.247751838949, 6094.54834069152, 5583.916241256385, 5674.262345895048, 5675.687837168995, 5694.174344720034, 5699.116636921284, 6187.752489900444, 6208.658523781235, 6214.2542894852, 6218.22272215973, 6224.813255602339, 5730.885382292331, 5881.206037185011, 5923.526117910556, 5941.376155503696, 6020.488258498077, 6050.939540447625, 6066.059760737005, 6074.03194180428, 6100.389961003864, 6120.265568131853, 6009.1587177795145, 6016.458518733335, 6026.9095963560585, 6032.095185722177, 6036.849078773066, 5857.47282744555, 5927.703614819242, 5973.701314934236, 5987.520998320124, 6035.78874739382, 4504.0, 4531.229690952546, 4542.409486766699, 4547.113312903952, 4569.771511424416, 4021.3364794809113, 4046.838126474908, 4052.473178486837, 4053.5135783706146, 4109.753414795122, 5462.481064298885, 5526.751296191681, 5610.214569960209, 5670.06443936754, 5681.744321505542, 6017.759289628453, 6067.453929146398, 6076.422739839708, 6101.176341193971, 6103.115048317969, 5674.602777805597, 5693.373728889819, 5693.68684722336, 5700.771969121189, 5701.144828275709, 5011.5489605935645, 5129.846104616868, 5160.612954028463, 5161.509656582619, 5175.4565770593545, 6247.9062814057825, 6253.5622506424115, 6254.968725156254, 6261.217347831521, 6268.717907694165, 5799.449052340021, 6052.636841789506, 6092.2689277285235, 6092.7867524638195, 6097.908531372122, 6138.1738283688655, 6162.506999439945, 6171.6297022178815, 6208.317085120723, 6271.43557079865, 5933.199018132669, 5945.554083443845, 5950.315713692808, 5953.404659534185, 5968.46283834457, 5887.58786884931, 6010.098485227076, 6018.307894592002, 6075.939240607714, 6077.20996270482, 5875.059990401515, 5925.466707996301, 5926.436988486087, 5933.406659334032, 5979.282486101695, 5909.468147866713, 5917.822465326047, 5920.0, 5923.348431672599, 5931.3178984417345, 5573.749181286771, 5738.139279108167, 5757.136429535603, 5833.737481813244, 5842.211301474416, 6000.189974353407, 6009.188759517584, 6038.879222415615, 6040.577159598786, 6043.758249669964, 5816.796412125555, 5855.2095467113095, 5858.9121163181735, 5859.179714839841, 5862.267216597926], "value": 5542.764064596124, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.1255935173673, 647.5952529668954, 655.6262930129826, 660.6168422315058, 664.5979182594532, 33660.831695841516, 37145.07137321565, 46490.53509464904, 47686.0, 47735.283970740464, 45906.08187836241, 46005.7699711501, 46133.76933115338, 46268.0, 46369.30446043312, 8641.52471614061, 8774.780630484225, 8783.34124940632, 8785.780355491132, 8787.384883058188, 8807.471551706918, 8903.020667726545, 8910.554472276393, 8914.86627700585, 8918.108189181095, 8955.0, 8969.551522423886, 8989.685361012365, 9003.369764116514, 9004.774880628003, 8925.910740892605, 8940.508272045035, 8946.418482798597, 8954.149355811187, 8965.865512017292, 8840.248578870804, 8892.59983300753, 8910.287177025823, 8913.420627659181, 8919.331050171199, 42142.367864482054, 42482.0, 42525.0, 42566.148677026285, 42585.0, 3569.428891377367, 3676.1544844685873, 3692.058525076115, 3743.850245990157, 4121.0, 32599.83700081508, 32668.509972350435, 32707.83646081778, 33080.669193308, 33595.496067559005, 4075.673946084306, 4108.91782164355, 4142.813573389175, 4175.853845115406, 4327.307630779092, 368261.0, 373698.99999999726, 374588.0, 376054.99999999726, 376533.0, 35315.293694126485, 36177.819110904275, 62150.68924655348, 63224.0, 63235.36764632295, 37823.24353512914, 37921.81039094787, 37952.240955181296, 38017.42973855395, 38036.04909877275, 15519.224038798015, 15648.765268520981, 15660.843391566166, 15666.295016724274, 15667.686646267011, 12368.381580920917, 12385.318807465675, 12391.070669699808, 12434.564790232298, 12470.251784892935, 8639.0, 8649.481031138152, 8664.220220180088, 8723.563821808884, 8731.825363492695, 3311.4701647736247, 3324.2852786650988, 3325.983370083134, 3349.514320423525, 3380.0704806178496, 1098.357460885391, 1121.9495122719497, 1180.698921774942, 1232.1498166265249, 1257.1137348169518, 33163.3367332652, 33585.664143358255, 33849.0, 33961.49057764136, 34604.307913841585, 1120.6638008597552, 1225.724212052281, 1260.710036691566, 1269.149669721289, 1324.3312127375614, 17149.765694473557, 17750.37873674415, 17853.28586856537, 17915.05714328534, 17929.164212932857, 578122.0, 581386.0, 582168.0, 582296.0, 582649.0, 59374.10938835921, 59795.70102149461, 59845.40154598485, 60042.0, 60177.69911150416, 1316.6839958409912, 1354.5597680753795, 1399.195462609004, 1410.0, 1456.9490067847787, 30981.45092745399, 33779.66220337765, 34295.485567717005, 34427.31145377128, 34505.82747086249, 50015.49984500254, 50398.0, 50652.49347506625, 50879.49120508748, 51032.74483627558, 406018.0, 407701.0, 408347.0, 408639.0, 409262.0, 25538.48923021492, 27350.179494615193, 27814.0, 28010.579841302806, 28206.717932820407, 48652.51347486622, 48776.0, 48998.75500622474, 49481.80224560585, 49839.50160498349, 40500.0, 41158.382624261256, 41449.171016580105, 41545.376819347126, 41601.1679766409, 40718.38922416225, 40988.385174223, 41620.791896040326, 41813.0, 42204.36693449662, 42072.789636051624, 42080.15839683251, 42762.35856462093, 42835.357469637354, 43399.34900976425, 36882.8155859219, 38076.23847523089, 38309.808450957564, 38746.41880371853, 39208.60791392164, 29055.85472072626, 29392.412151756416, 29438.558421623264, 29683.554746678386, 29740.256493586967], "value": 19349.769996771745, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.8027006901653, 411.75500577156583, 415.2421830159955, 415.42256263793325, 429.61120186231454, 14767.852321476783, 18184.272629094838, 19817.50456238593, 19823.0, 20075.0, 14878.925605371958, 18406.07969601521, 18924.0, 18946.905265473688, 19213.42359729207, 5749.166370876231, 5777.335606405275, 5824.009918313896, 5927.792527261547, 5955.1960485334575, 5807.186993820868, 5849.444302791228, 5865.325487568942, 5891.970540147315, 5894.440028197336, 4167.3332266837315, 4330.437043184397, 6116.694165291718, 6425.807225783211, 6429.678516074177, 6418.326075762071, 6486.3513648635235, 6502.252240992299, 6537.869242615145, 6557.213134423876, 5568.777248910039, 5637.774489020434, 5681.0, 5698.116791897221, 5709.74306156224, 23369.182078627335, 23781.405464863343, 23808.523829523485, 24443.144489942944, 24448.266552003468, 2432.744561821001, 2433.7809597136165, 2524.3310522711495, 2530.9240722778345, 2573.98327660573, 13068.346582670923, 13881.097728647606, 14463.13221206731, 14988.400463981428, 15726.764098538531, 1980.5741765520481, 2043.7343145391153, 2106.1259577275414, 2117.110813458351, 2117.4494631395946, 84320.57839710762, 84914.15085849186, 85479.14520854774, 85783.57108214482, 86458.56770716106, 10620.309679870783, 10823.945880270549, 11088.390138542296, 11129.499172537255, 11191.216614837045, 15307.234638268043, 15430.459933902484, 15480.458183963507, 15481.071135731892, 15503.224838758017, 8052.315553178046, 8113.959430202811, 8180.713675021346, 8307.543085130255, 8367.330613550901, 7438.702451901863, 7856.332211762065, 7919.049714034353, 8027.357811375076, 8048.315893149031, 6056.66688332146, 6413.358664133642, 6695.765648202289, 6796.728130874809, 6838.760643377458, 1973.2008536542724, 2013.104168644939, 2032.8068833460798, 2033.3594917600908, 2041.5610643711673, 986.921046316293, 1080.1304949515559, 1115.7935781880378, 1128.920975531705, 1192.9045676345872, 19667.409977700692, 20423.183072677224, 20535.178592856417, 20552.691709624367, 20583.691244631344, 1101.1411099342527, 1121.4168632311316, 1129.9774004519863, 1164.2781475485253, 1171.1145056459095, 11075.833862492069, 11584.47869845859, 11753.88246117545, 11790.351530665725, 11809.586664466702, 452291.0, 454569.0, 455549.0, 456408.0, 471344.0, 81207.59396202982, 81737.0, 82059.17940820634, 82125.0, 82355.0, 1062.95216715248, 1079.8002369561657, 1092.0, 1092.322759888874, 1109.622728272375, 17856.910715446338, 17895.463136105936, 18026.36907708224, 18228.635427291647, 18521.907390462962, 28002.0, 37722.81138594289, 38168.61831381762, 39040.46236994586, 39835.80082099571, 51756.0, 51980.48019519756, 52711.736441317546, 52939.73530132325, 53942.19086713624, 8603.698870539502, 8915.598798054232, 9002.0, 9005.729828105168, 9206.539673016456, 13477.528286509925, 13743.793843092162, 14025.228612426006, 14198.29008549589, 14371.496997605034, 12049.939750301193, 12071.094667899766, 12318.81521777192, 12430.875691242973, 12465.439055242718, 8826.602802873758, 11783.646490605295, 11917.463714133059, 11948.34284114382, 11992.520299188283, 12426.192297500633, 12441.564545240873, 12488.0, 12513.061520385825, 12876.35618219104, 7866.410019248465, 7938.801529961797, 8655.221030107321, 8722.345824063093, 8761.824763504821, 11786.292822430682, 11842.703932401415, 11880.76238475243, 12394.194377365442, 12589.055820813659], "value": 9561.257409472752, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.4135304525146, 1544.0426935300113, 1582.5647946814624, 1750.4311098892856, 1879.0416887387428, 8763.737087887366, 9091.090890910906, 9105.49919754414, 9428.764280892981, 9481.43111413314, 9223.0, 9418.62325506979, 9424.528773561311, 9442.575084121214, 9443.716688499338, 2330.2892617751536, 2359.917402890899, 2361.7756313150308, 2366.325597204797, 2367.360812580602, 2437.878575855109, 2491.17791128927, 2492.140211626986, 2496.138832102931, 2515.434027343851, 2425.721042080157, 2434.172381390327, 2452.6075827867544, 2465.2111324376206, 2468.0744720729726, 2364.326167042393, 2372.406898275431, 2381.404648837791, 2394.820388470863, 2418.5525677749674, 2345.425370784169, 2387.140629373424, 2390.1156572068444, 2391.7129944406784, 2394.042383046778, 8107.310878575328, 8332.50004999702, 9339.859902101405, 9428.387154834982, 9436.811263774754, 4969.751512424365, 5111.05445492585, 5349.786008559692, 5504.146857237135, 5504.559635229172, 3420.8973730788116, 3459.187091033605, 3495.860165593373, 3570.8750193743094, 3595.1012246938267, 1079.6760971708534, 1103.61925135828, 1120.2606279855256, 1138.9943050284778, 1142.5544037825255, 13003.934980325037, 13148.211107333591, 13156.210627362294, 13172.407241674147, 13194.208347499085, 4812.855614331575, 4874.122657921537, 4939.753012349368, 4954.777035033432, 4979.3277907482025, 10980.341179529254, 11024.889751102546, 11042.447877606088, 11059.115270778479, 11065.446727663584, 5520.503154716095, 5537.363203231599, 5563.527100196528, 5575.33096028471, 5578.944210557843, 4928.0, 4952.5542701157065, 5026.472220416877, 5116.232565115262, 5127.461616530285, 3999.980000100039, 4052.5339585947404, 4071.531773845986, 4118.217538667644, 4166.6250037496775, 1297.9480820767253, 1324.2054767139832, 1329.9335033248299, 1333.7665908465979, 1346.6904259195526, 919.8068405634758, 1037.3983089807894, 1063.3088492479794, 1065.5418170186895, 1070.71626019105, 6205.472534834499, 6324.177856878577, 6333.429991300805, 6463.48292136628, 6539.411452969255, 434.4482507215818, 441.56946976697463, 442.2967481704106, 446.75651769785543, 448.9169503641771, 4372.912541749147, 4413.7793110344355, 4429.778511074498, 4445.26653102241, 4456.68803183774, 10751.40867252293, 11030.834537481944, 11061.391623460626, 11068.612598559012, 11074.114070874311, 10802.351858888493, 10899.29154604948, 10923.0, 10923.781524369468, 10946.069584085282, 8221.725632526968, 8317.085120636724, 8546.273566746897, 8547.188017138486, 8803.207711305886, 6292.370762923671, 6494.2856285807575, 6527.934720652733, 6579.276279609144, 6590.319468535493, 10557.785854626816, 10720.463976801284, 10828.675139745821, 10860.728481788019, 10977.725556861142, 10866.67399978002, 10973.61592344296, 10976.560937562408, 11006.174536909924, 11103.33449982509, 8260.752177434686, 8389.748307550783, 8428.367872409717, 8434.536100514531, 8437.87343189865, 8971.865422018805, 9000.63997440095, 9078.500682462529, 9117.726468205965, 9126.817463650823, 7794.571298578406, 8183.754487365389, 8297.170282971654, 8364.121767214356, 8491.448055876348, 7803.375729941705, 8148.388870834592, 8179.345652347917, 8346.415750897622, 8384.496930184208, 7167.104111986002, 7249.891251631335, 7250.528715633467, 7257.0, 7259.12890453149, 5459.0, 5537.861553461195, 5562.9721851392105, 5569.275994120739, 5617.634853734494, 5248.160294352885, 5292.311999440049, 5366.6779993200535, 5377.462253774591, 5526.530244929226], "value": 4764.125271942208, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.9324135172964, 345.61981819998, 349.263054954047, 359.2402069622747, 359.8722453528999, 5409.729513524323, 5489.451054894508, 5566.526845218162, 5574.60977731559, 5575.386707462186, 5449.427810079934, 5451.71884607117, 5459.918101228484, 5466.371367292752, 5473.2063850741615, 4070.3080476319096, 4278.828846846122, 4281.443412356405, 4288.69979101463, 4303.634191093761, 3897.337452633059, 4241.321388577828, 4267.167902259061, 4267.615914567688, 4279.636230920375, 4179.916401671965, 4197.328427451608, 4208.0531880326835, 4213.747175169499, 4224.61978421942, 4031.455753473273, 4199.29928379007, 4216.64158546524, 4221.9101544735395, 4224.831006759741, 3761.6238376162437, 3811.5807261201244, 3819.694424446038, 3844.192719528902, 3860.247251785903, 5292.1003429416705, 5301.231321458406, 5301.277084947369, 5334.3598768147685, 5362.517373436371, 4958.305837182797, 4968.602511799084, 4969.378827646544, 4975.651704380694, 4981.9252711209365, 5717.799877004285, 5734.598578099534, 5747.189635264878, 5769.278840144982, 5820.214271073393, 3996.8800935971967, 4124.773137477438, 4133.669306455507, 4134.9118695059105, 4247.0, 5734.168545560912, 5814.592978491507, 5952.1964534787685, 5970.253718285215, 5986.533299341646, 4262.296721040993, 4313.805878735402, 4328.350747387854, 4329.874232699521, 4330.198913201068, 4200.584663818256, 4382.649388048949, 4399.38408622793, 4400.295952647561, 4416.183006143874, 4883.387387747538, 4906.975465122723, 4913.582345500672, 4923.113839508923, 4926.75366231687, 5686.175504551817, 5693.259876216148, 5716.542281718135, 5722.656640601577, 5740.856478588069, 1466.413434626158, 1514.7576387777904, 1516.3176570543299, 1524.2835867142426, 1524.420720126367, 980.6567701304486, 997.1972562087589, 998.4408731110601, 1009.0867764672983, 1015.918726501878, 4932.90134197314, 4937.851864444073, 4940.159408340219, 4962.826301079445, 4968.254761785761, 5160.9872149861585, 5175.663581867167, 5209.947900521022, 5220.92168617471, 5229.424763276036, 4566.292224705176, 4813.735244561512, 4898.632602554822, 4910.919597688503, 4975.502449755068, 2778.2359851041124, 2779.3746407058657, 2832.362718388346, 2841.9147425577266, 2852.301186209392, 5478.561715062785, 5481.643693159932, 5495.313085864267, 5502.779888804403, 5517.36550296713, 5427.511523962862, 5431.402545719968, 5693.373728889902, 5966.49284810796, 6089.451949324582, 6024.734805690854, 6079.270487541435, 6090.786822461193, 6122.20411346531, 6139.386061394003, 5568.49883510486, 5719.8570035749435, 5792.82621521355, 5971.731272092853, 5977.5217982560425, 5721.941440833459, 5758.309002919509, 5765.8558536036935, 5766.913496297643, 5780.971095144498, 5863.794767183128, 6020.789272375446, 6058.727357269022, 6122.234720659918, 6127.479164270909, 4184.539700632867, 4189.664826813909, 4193.7903104845245, 4196.958030419779, 4200.537940826568, 5922.437368449991, 5936.257967754031, 5940.811837632405, 5982.49148822355, 5988.760449581968, 5609.915851262316, 5725.541956643375, 5767.106098554731, 5792.21805056312, 5852.707364631666, 5548.833534993957, 5673.432656734293, 5733.283339582552, 5769.07694768835, 5793.478586927196, 5573.331200255995, 5623.522000629992, 5674.921764864663, 5675.517581005661, 5731.656100633975, 5560.221568980265, 5762.510186634183, 5820.621659592113, 5824.621399609012, 5833.220867635412, 5644.742103158769, 5684.602077854676, 5709.486146246858, 5719.113537401709, 5725.112607545837], "value": 4322.075853208328, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.1473379282788, 829.1169904052184, 837.443100338275, 875.9717191935907, 878.95605219739, 14491.492797752067, 15346.232688365593, 15349.923250383761, 15366.923165384185, 15407.07557546548, 14302.141871487718, 14303.213323267217, 14336.211508367061, 14340.354684039217, 14343.64140896478, 680.2755065854849, 784.8665726826454, 792.4967645545063, 793.2345286798238, 793.7420338390046, 789.8025493626593, 793.9801504962364, 794.047143427886, 794.4756460735915, 794.7854079398559, 840.0549381945311, 851.4125253575045, 852.0329426101389, 854.4318028511063, 856.015582080606, 719.8416348403343, 828.9917100828975, 835.1731785532279, 848.5672307123381, 848.9872651910226, 621.3786213786213, 623.5728525959732, 624.0327492386782, 624.9375062493759, 625.4746013348808, 14474.276286185754, 14482.42070317186, 14553.927230363886, 14566.271686415743, 14567.562973110824, 13737.656558586015, 13803.51687690926, 13871.861281387159, 13949.790753138712, 13971.720565588734, 12233.877661223452, 12420.689482762913, 12459.252444853248, 12508.624741257685, 12605.810912836314, 4454.799534020977, 4529.728216307032, 4535.4234084454165, 4536.441120194797, 4646.4888862225125, 57072.714636426965, 57967.0, 57989.420105798825, 58245.126323105185, 59898.0, 10992.890071099346, 11011.229213954946, 11016.339019658846, 11222.438878056228, 11417.31496110236, 20651.896740516502, 20710.0, 20720.48198795042, 20802.58394832095, 20849.68725469119, 8391.706290279933, 8555.0, 8593.65625374978, 8650.351223658125, 8839.823203535892, 4442.222611043055, 4548.067646132535, 4623.283391074388, 4624.167649822997, 4831.855044348676, 3256.7883087599703, 3336.4494858348585, 3342.699157075875, 3345.1135449106005, 3345.765796394278, 547.3349879895866, 612.4732729852324, 622.9875402491925, 627.9905801412891, 632.0109029369023, 677.4275737002225, 786.5791801386231, 787.6455594982281, 797.4896066517433, 800.3912136605464, 10194.694159175237, 10525.631602894015, 10679.359238445562, 10694.144468442506, 10694.465276736131, 760.3119177144692, 777.6345117794627, 812.6911773526141, 814.4990830639233, 833.5248908122434, 4906.411230652345, 4987.925181122286, 5058.367704036996, 5080.77136528857, 5150.948490515122, 70190.0, 71065.0, 73993.63003184949, 75523.62238188773, 75910.62044689852, 63513.72972540523, 64297.35702643007, 65265.67367163134, 66549.66725166343, 67102.32897671059, 49886.750566246934, 53201.2019819703, 54008.45991540113, 54042.45957540453, 58303.708481457325, 9891.208703303862, 10148.441835698812, 10202.540885660312, 10259.179265658879, 10382.584696612052, 37849.810750947174, 37943.62056379511, 38319.0, 38568.80715596404, 38848.6115138845, 46790.0, 47492.52507474881, 48010.75994620004, 48238.5176148234, 49023.50976490189, 12216.755664886474, 12391.070669699628, 12908.8063679043, 13111.803322949972, 13211.207327560378, 14163.221022843842, 14573.854261457249, 14816.40734370613, 15001.924990374979, 15002.099874007594, 13714.51999180024, 13798.724025519634, 14140.50508232207, 14201.644958876112, 14581.0, 13994.650133746738, 14077.718445630826, 14224.928875355557, 14309.284535772962, 14435.494757683431, 12922.483100675867, 13230.338483076, 13356.0, 13467.3939672713, 13793.931030344784, 11423.543058277575, 11630.53477860876, 11876.703082423008, 11950.940245298718, 12229.021678265539, 11653.708657283636, 11878.821817672915, 11918.40407979615, 11959.461824217757, 12166.635000949986], "value": 7182.515786183596, "unit": "score"}], "name": "dromaeo_css", "value": 7302.728286257384, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 109.0, 108.0, 108.0, 110.0, 108.0, 108.0, 109.0, 110.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 162.0, 216.0, 124.0, 148.0, 150.0, 124.0, 192.0, 131.0], "value": 152.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 162.0, 160.0, 159.0, 160.0, 162.0, 162.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 158.0, 75.0, 74.0, 75.0, 74.0, 130.0, 74.0], "value": 88.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 145.0, 92.0, 91.0, 92.0, 126.0, 91.0, 92.0, 126.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 116.0, 116.0, 116.0], "value": 116.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 54.0, 55.0, 61.0, 55.0, 107.0, 51.0, 52.0], "value": 60.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 60.0, 59.0, 60.0, 59.0, 58.0, 60.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 78.0, 78.0, 77.0, 78.0, 77.0, 78.0, 82.0, 78.0, 78.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 135.0, 119.0, 117.0, 126.0, 119.0, 121.0, 199.0, 124.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 156.0, 153.0, 155.0, 155.0, 156.0, 158.0, 154.0, 154.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 65.0, 62.0, 65.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1516.8999999999999, "alertThreshold": 2.0}]} 06:26:27 INFO - Return code: 0 06:26:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:26:27 ERROR - # TBPL SUCCESS # 06:26:27 INFO - Running post-action listener: _resource_record_post_action 06:26:27 INFO - ##### 06:26:27 INFO - ##### Finished run-tests step (success) 06:26:27 INFO - ##### 06:26:27 INFO - Running post-run listener: _resource_record_post_run 06:26:27 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 7839744; Write bytes: 431812608; Read time: 1600; Write time: 358664 06:26:27 INFO - TinderboxPrint: CPU usage
13.1% 06:26:27 INFO - TinderboxPrint: I/O read bytes / time
7,839,744 / 1,600 06:26:27 INFO - TinderboxPrint: I/O write bytes / time
431,812,608 / 358,664 06:26:27 INFO - TinderboxPrint: CPU idle
8,292.4 (86.9%) 06:26:27 INFO - TinderboxPrint: CPU user
1,206.8 (12.6%) 06:26:27 INFO - TinderboxPrint: Swap in / out
0 / 0 06:26:27 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 97157120; Read time: 56; Write time: 69408 06:26:28 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 6098944; Write bytes: 334655488; Read time: 1508; Write time: 289256 06:26:28 INFO - Running post-run listener: _upload_blobber_files 06:26:28 INFO - Blob upload gear active. 06:26:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:26:28 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 06:26:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:26:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:26:28 INFO - (blobuploader) - INFO - Open directory for files ... 06:26:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:26:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:26:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:26:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:26:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:26:29 INFO - (blobuploader) - INFO - Done attempting. 06:26:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:26:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:26:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:26:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:26:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:26:33 INFO - (blobuploader) - INFO - Done attempting. 06:26:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:26:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:26:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:26:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:26:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:26:34 INFO - (blobuploader) - INFO - Done attempting. 06:26:34 INFO - (blobuploader) - INFO - Iteration through files over. 06:26:34 INFO - Return code: 0 06:26:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:26:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:26:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a81c5d57339d5ea55bd54dc493abf1ff25ba8717f809ac87c44bbfddf7fe01598177938445af42c67eca3b7daaaa11f44c509357d1d1c2d4ccc06b8ab024f1c1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/def1c6b13e03a92ad4a510b5ed0c76bc1b9f4c4ecb5af663d95fd194348071e561c779ef4c35627ded32dcb58f887f6ab5366780f05015af4fad7a93a8859f85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fa1e8a640c3f05d57e7090841a9fb7a36d89ed6bc49808d5bdada311083a1fe58d368b544b37c168ceeebd9da1c406f5ff2d3b04dbd0d90318c9865cb0a6535"} 06:26:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:26:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:26:34 INFO - Contents: 06:26:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a81c5d57339d5ea55bd54dc493abf1ff25ba8717f809ac87c44bbfddf7fe01598177938445af42c67eca3b7daaaa11f44c509357d1d1c2d4ccc06b8ab024f1c1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/def1c6b13e03a92ad4a510b5ed0c76bc1b9f4c4ecb5af663d95fd194348071e561c779ef4c35627ded32dcb58f887f6ab5366780f05015af4fad7a93a8859f85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fa1e8a640c3f05d57e7090841a9fb7a36d89ed6bc49808d5bdada311083a1fe58d368b544b37c168ceeebd9da1c406f5ff2d3b04dbd0d90318c9865cb0a6535"} 06:26:34 INFO - Running post-run listener: copy_logs_to_upload_dir 06:26:34 INFO - Copying logs to upload dir... 06:26:34 INFO - mkdir: /builds/slave/test/build/upload/logs 06:26:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.962250 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-05-18 06:26:34.387033) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 06:26:34.390847) ========= 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=31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a81c5d57339d5ea55bd54dc493abf1ff25ba8717f809ac87c44bbfddf7fe01598177938445af42c67eca3b7daaaa11f44c509357d1d1c2d4ccc06b8ab024f1c1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/def1c6b13e03a92ad4a510b5ed0c76bc1b9f4c4ecb5af663d95fd194348071e561c779ef4c35627ded32dcb58f887f6ab5366780f05015af4fad7a93a8859f85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fa1e8a640c3f05d57e7090841a9fb7a36d89ed6bc49808d5bdada311083a1fe58d368b544b37c168ceeebd9da1c406f5ff2d3b04dbd0d90318c9865cb0a6535"} build_url:https://queue.taskcluster.net/v1/task/T0UFJSF6T52cwSuOBNS8vQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011119 build_url: 'https://queue.taskcluster.net/v1/task/T0UFJSF6T52cwSuOBNS8vQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a81c5d57339d5ea55bd54dc493abf1ff25ba8717f809ac87c44bbfddf7fe01598177938445af42c67eca3b7daaaa11f44c509357d1d1c2d4ccc06b8ab024f1c1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/def1c6b13e03a92ad4a510b5ed0c76bc1b9f4c4ecb5af663d95fd194348071e561c779ef4c35627ded32dcb58f887f6ab5366780f05015af4fad7a93a8859f85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fa1e8a640c3f05d57e7090841a9fb7a36d89ed6bc49808d5bdada311083a1fe58d368b544b37c168ceeebd9da1c406f5ff2d3b04dbd0d90318c9865cb0a6535"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 06:26:34.415054) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 06:26:34.415336) ========= 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=31acecf42b6a79ec49471d4a000001bb-1463576075.200753-352776834 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004376 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 06:26:34.497040) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 06:26:34.497392) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 06:26:34.497673) ========= ========= Total master_lag: 0.16 =========