builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-003 starttime: 1463680220.0 results: success (0) buildid: 20160519094747 builduid: 3add65188c5d44a6aefafbc796a7a97c revision: 1806d405c8715949b39fa3a4fc142d14a60df590 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 10:50:19.998342) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 10:50:19.998845) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 10:50:19.999176) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 10:50:20.013240) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 10:50:20.013761) ========= 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=7de08804244eb36560b44971000001c3-1463679007.640604-271538148 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 10:50:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 75.0M=0s 2016-05-19 10:50:20 (75.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126836 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 10:50:20.156449) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 10:50:20.156841) ========= 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=7de08804244eb36560b44971000001c3-1463679007.640604-271538148 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023056 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 10:50:20.210562) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 10:50:20.210964) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1806d405c8715949b39fa3a4fc142d14a60df590 --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 1806d405c8715949b39fa3a4fc142d14a60df590 --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=7de08804244eb36560b44971000001c3-1463679007.640604-271538148 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 10:50:20,721 truncating revision to first 12 chars 2016-05-19 10:50:20,721 Setting DEBUG logging. 2016-05-19 10:50:20,721 attempt 1/10 2016-05-19 10:50:20,721 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1806d405c871?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 10:50:20,989 unpacking tar archive at: mozilla-central-1806d405c871/testing/mozharness/ program finished with exit code 0 elapsedTime=0.620252 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 10:50:20.845456) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 10:50:20.845829) ========= script_repo_revision: 1806d405c8715949b39fa3a4fc142d14a60df590 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 10:50:20.846342) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 10:50:20.846674) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 10:50:20.861797) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 52 secs) (at 2016-05-19 10:50:20.862108) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1463679007.640604-271538148 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:50:21 INFO - MultiFileLogger online at 20160519 10:50:21 in /builds/slave/test 10:50:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 10:50:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:50:21 INFO - {'append_to_log': False, 10:50:21 INFO - 'base_work_dir': '/builds/slave/test', 10:50:21 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 10:50:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:50:21 INFO - 'branch': 'Firefox-Non-PGO', 10:50:21 INFO - 'buildbot_json_path': 'buildprops.json', 10:50:21 INFO - 'config_files': ('talos/linux_config.py',), 10:50:21 INFO - 'default_actions': ('clobber', 10:50:21 INFO - 'read-buildbot-config', 10:50:21 INFO - 'download-and-extract', 10:50:21 INFO - 'populate-webroot', 10:50:21 INFO - 'create-virtualenv', 10:50:21 INFO - 'install', 10:50:21 INFO - 'run-tests'), 10:50:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:50:21 INFO - 'download_minidump_stackwalk': True, 10:50:21 INFO - 'download_symbols': 'ondemand', 10:50:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:50:21 INFO - 'tooltool.py': '/tools/tooltool.py', 10:50:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:50:21 INFO - '/tools/misc-python/virtualenv.py')}, 10:50:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:50:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:50:21 INFO - 'installer_path': 'installer.exe', 10:50:21 INFO - 'log_level': 'info', 10:50:21 INFO - 'log_name': 'talos', 10:50:21 INFO - 'log_to_console': True, 10:50:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:50:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:50:21 INFO - 'opt_config_files': (), 10:50:21 INFO - 'pip_index': False, 10:50:21 INFO - 'sps_profile': False, 10:50:21 INFO - 'sps_profile_interval': 0, 10:50:21 INFO - 'suite': 'dromaeojs', 10:50:21 INFO - 'system_bits': '32', 10:50:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:50:21 INFO - 'title': 'talos-linux64-ix-003', 10:50:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:50:21 INFO - 'use_talos_json': True, 10:50:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:50:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:50:21 INFO - 'work_dir': 'build'} 10:50:21 INFO - ##### 10:50:21 INFO - ##### Running clobber step. 10:50:21 INFO - ##### 10:50:21 INFO - Running pre-action listener: _resource_record_pre_action 10:50:21 INFO - Running main action method: clobber 10:50:21 INFO - rmtree: /builds/slave/test/build 10:50:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:50:21 INFO - Running post-action listener: _resource_record_post_action 10:50:21 INFO - ##### 10:50:21 INFO - ##### Finished clobber step (success) 10:50:21 INFO - ##### 10:50:21 INFO - ##### 10:50:21 INFO - ##### Running read-buildbot-config step. 10:50:21 INFO - ##### 10:50:21 INFO - Running pre-action listener: _resource_record_pre_action 10:50:21 INFO - Running main action method: read_buildbot_config 10:50:21 INFO - Using buildbot properties: 10:50:21 INFO - { 10:50:21 INFO - "project": "", 10:50:21 INFO - "product": "firefox", 10:50:21 INFO - "script_repo_revision": "production", 10:50:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:50:21 INFO - "repository": "", 10:50:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 10:50:21 INFO - "buildid": "20160519094747", 10:50:21 INFO - "pgo_build": "False", 10:50:21 INFO - "basedir": "/builds/slave/test", 10:50:21 INFO - "buildnumber": 87, 10:50:21 INFO - "slavename": "talos-linux64-ix-003", 10:50:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:50:21 INFO - "platform": "ubuntu64_hw", 10:50:21 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 10:50:21 INFO - "branch": "mozilla-central", 10:50:21 INFO - "repo_path": "mozilla-central", 10:50:21 INFO - "revision": "1806d405c8715949b39fa3a4fc142d14a60df590", 10:50:21 INFO - "stage_platform": "linux64", 10:50:21 INFO - "builduid": "3add65188c5d44a6aefafbc796a7a97c", 10:50:21 INFO - "slavebuilddir": "test" 10:50:21 INFO - } 10:50:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:50:21 INFO - Running post-action listener: _resource_record_post_action 10:50:21 INFO - ##### 10:50:21 INFO - ##### Finished read-buildbot-config step (success) 10:50:21 INFO - ##### 10:50:21 INFO - ##### 10:50:21 INFO - ##### Running download-and-extract step. 10:50:21 INFO - ##### 10:50:21 INFO - Running pre-action listener: _resource_record_pre_action 10:50:21 INFO - Running main action method: download_and_extract 10:50:21 INFO - mkdir: /builds/slave/test/build/tests 10:50: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')]} 10:50:21 INFO - https://queue.taskcluster.net/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:50:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:50:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:50:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:50:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:50:28 INFO - Downloaded 1361 bytes. 10:50:28 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:50:28 INFO - Using the following test package requirements: 10:50:28 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:50:28 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:50:28 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:50:28 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:28 INFO - u'jsshell-linux-x86_64.zip'], 10:50:28 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:50:28 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:50:28 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:50:28 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:50:28 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:50:28 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:50:28 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:28 INFO - https://queue.taskcluster.net/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:50:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:50:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:50:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:50:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:50:34 INFO - Downloaded 22813679 bytes. 10:50:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:50:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:50:36 INFO - Return code: 0 10:50:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:36 INFO - https://queue.taskcluster.net/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:50:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:50:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:50:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:50:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:50:38 INFO - Downloaded 22813679 bytes. 10:50:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:50:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:50:40 INFO - Return code: 0 10:50:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:40 INFO - https://queue.taskcluster.net/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:50:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:50:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:50:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:50:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:53:35 INFO - Downloaded 10840359 bytes. 10:53:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:53:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:53:35 INFO - Return code: 0 10:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:35 INFO - https://queue.taskcluster.net/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:53:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:53:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:53:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:53:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:53:39 INFO - Downloaded 54810282 bytes. 10:53:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:53:39 INFO - mkdir: /builds/slave/test/properties 10:53:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:53:39 INFO - Writing to file /builds/slave/test/properties/build_url 10:53:39 INFO - Contents: 10:53:39 INFO - build_url:https://queue.taskcluster.net/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:53:40 INFO - Running post-action listener: _resource_record_post_action 10:53:40 INFO - Running post-action listener: set_extra_try_arguments 10:53:40 INFO - ##### 10:53:40 INFO - ##### Finished download-and-extract step (success) 10:53:40 INFO - ##### 10:53:40 INFO - ##### 10:53:40 INFO - ##### Running populate-webroot step. 10:53:40 INFO - ##### 10:53:40 INFO - Running pre-action listener: _resource_record_pre_action 10:53:40 INFO - Running main action method: populate_webroot 10:53:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:53:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:53:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:53:40 INFO - '--tppagecycles', 10:53:40 INFO - '7'], 10:53:40 INFO - 'tests': ['tsvgm']}}, 10:53:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:53:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:53:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:53:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:53:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:53:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:53:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:40 INFO - 'talos_options': ['--disable-e10s'], 10:53:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:40 INFO - 'talos_options': ['--disable-e10s'], 10:53:40 INFO - 'tests': ['damp', 'tps']}, 10:53:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:40 INFO - 'tests': ['damp', 'tps']}, 10:53:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:53:40 INFO - 'tests': ['dromaeo_dom']}, 10:53:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:53:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:53:40 INFO - 'tests': ['a11yr', 10:53:40 INFO - 'ts_paint', 10:53:40 INFO - 'tpaint', 10:53:40 INFO - 'sessionrestore', 10:53:40 INFO - 'sessionrestore_no_auto_restore', 10:53:40 INFO - 'tabpaint']}, 10:53:40 INFO - 'other-e10s': {'tests': ['a11yr', 10:53:40 INFO - 'ts_paint', 10:53:40 INFO - 'tpaint', 10:53:40 INFO - 'sessionrestore', 10:53:40 INFO - 'sessionrestore_no_auto_restore', 10:53:40 INFO - 'tabpaint']}, 10:53:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:53:40 INFO - 'ts_paint', 10:53:40 INFO - 'tpaint', 10:53:40 INFO - 'sessionrestore', 10:53:40 INFO - 'sessionrestore_no_auto_restore', 10:53:40 INFO - 'tabpaint']}, 10:53:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:53:40 INFO - 'ts_paint', 10:53:40 INFO - 'tpaint', 10:53:40 INFO - 'sessionrestore', 10:53:40 INFO - 'sessionrestore_no_auto_restore', 10:53:40 INFO - 'tabpaint']}, 10:53:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:53:40 INFO - 'tests': ['a11yr', 10:53:40 INFO - 'ts_paint', 10:53:40 INFO - 'tpaint', 10:53:40 INFO - 'sessionrestore', 10:53:40 INFO - 'sessionrestore_no_auto_restore', 10:53:40 INFO - 'tabpaint']}, 10:53:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:53:40 INFO - 'tests': ['a11yr', 10:53:40 INFO - 'ts_paint', 10:53:40 INFO - 'tpaint', 10:53:40 INFO - 'sessionrestore', 10:53:40 INFO - 'sessionrestore_no_auto_restore', 10:53:40 INFO - 'tabpaint']}, 10:53:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:53:40 INFO - 'tests': ['tsvgx', 10:53:40 INFO - 'tsvgr_opacity', 10:53:40 INFO - 'tart', 10:53:40 INFO - 'tscrollx', 10:53:40 INFO - 'cart']}, 10:53:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:53:40 INFO - 'tsvgr_opacity', 10:53:40 INFO - 'tart', 10:53:40 INFO - 'tscrollx', 10:53:40 INFO - 'cart']}, 10:53:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:40 INFO - 'talos_options': ['--disable-e10s'], 10:53:40 INFO - 'tests': ['tp5o']}, 10:53:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:40 INFO - 'tests': ['tp5o']}, 10:53:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:40 INFO - 'talos_options': ['--disable-e10s', 10:53:40 INFO - '--xperf_path', 10:53:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:40 INFO - 'tests': ['tp5n']}, 10:53:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:40 INFO - 'talos_options': ['--xperf_path', 10:53:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:40 INFO - 'tests': ['tp5n']}}, 10:53:40 INFO - 'talos.zip': {'path': '', 10:53:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:53:40 INFO - Running post-action listener: _resource_record_post_action 10:53:40 INFO - ##### 10:53:40 INFO - ##### Finished populate-webroot step (success) 10:53:40 INFO - ##### 10:53:40 INFO - ##### 10:53:40 INFO - ##### Running create-virtualenv step. 10:53:40 INFO - ##### 10:53:40 INFO - Running pre-action listener: _resource_record_pre_action 10:53:40 INFO - Running main action method: create_virtualenv 10:53:40 INFO - Creating virtualenv /builds/slave/test/build/venv 10:53:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:53:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:53:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:53:40 INFO - Using real prefix '/usr' 10:53:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:53:40 INFO - Installing distribute.............................................................................................................................................................................................done. 10:53:42 INFO - Installing pip.................done. 10:53:42 INFO - Return code: 0 10:53:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:42 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 0x7f39abcfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a139c0>, '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 0x1a148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a14d50>, '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': '7de08804244eb36560b44971000001c3-1463679007.640604-271538148', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:53:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:53:42 INFO - Using env: {'DISPLAY': ':0', 10:53:42 INFO - 'HOME': '/home/cltbld', 10:53:42 INFO - 'LANG': 'en_US.UTF-8', 10:53:42 INFO - 'LANGUAGE': 'en_US:en', 10:53:42 INFO - 'LOGNAME': 'cltbld', 10:53:42 INFO - 'MAIL': '/var/mail/cltbld', 10:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:42 INFO - 'MOZ_NO_REMOTE': '1', 10:53:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:42 INFO - 'NO_EM_RESTART': '1', 10:53:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:42 INFO - 'PWD': '/builds/slave/test', 10:53:42 INFO - 'SHELL': '/bin/bash', 10:53:42 INFO - 'SHLVL': '1', 10:53:42 INFO - 'TERM': 'linux', 10:53:42 INFO - 'TMOUT': '86400', 10:53:42 INFO - 'USER': 'cltbld', 10:53:42 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463679007.640604-271538148', 10:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:42 INFO - '_': '/tools/buildbot/bin/python'} 10:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:53:42 INFO - Cleaning up... 10:53:42 INFO - Return code: 0 10:53:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:42 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 0x7f39abcfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a139c0>, '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 0x1a148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a14d50>, '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': '7de08804244eb36560b44971000001c3-1463679007.640604-271538148', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:53:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:53:42 INFO - Using env: {'DISPLAY': ':0', 10:53:42 INFO - 'HOME': '/home/cltbld', 10:53:42 INFO - 'LANG': 'en_US.UTF-8', 10:53:42 INFO - 'LANGUAGE': 'en_US:en', 10:53:42 INFO - 'LOGNAME': 'cltbld', 10:53:42 INFO - 'MAIL': '/var/mail/cltbld', 10:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:42 INFO - 'MOZ_NO_REMOTE': '1', 10:53:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:42 INFO - 'NO_EM_RESTART': '1', 10:53:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:42 INFO - 'PWD': '/builds/slave/test', 10:53:42 INFO - 'SHELL': '/bin/bash', 10:53:42 INFO - 'SHLVL': '1', 10:53:42 INFO - 'TERM': 'linux', 10:53:42 INFO - 'TMOUT': '86400', 10:53:42 INFO - 'USER': 'cltbld', 10:53:42 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463679007.640604-271538148', 10:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:42 INFO - '_': '/tools/buildbot/bin/python'} 10:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:43 INFO - Downloading/unpacking psutil>=3.1.1 10:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:53:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:53:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:53:45 INFO - Installing collected packages: psutil 10:53:45 INFO - Running setup.py install for psutil 10:53:45 INFO - building 'psutil._psutil_linux' extension 10:53:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:53:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:53:45 INFO - building 'psutil._psutil_posix' extension 10:53:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:53:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:53:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:53:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:53:45 INFO - Successfully installed psutil 10:53:45 INFO - Cleaning up... 10:53:45 INFO - Return code: 0 10:53:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:45 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 0x7f39abcfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a139c0>, '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 0x1a148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a14d50>, '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': '7de08804244eb36560b44971000001c3-1463679007.640604-271538148', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:53:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:53:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:53:45 INFO - Using env: {'DISPLAY': ':0', 10:53:45 INFO - 'HOME': '/home/cltbld', 10:53:45 INFO - 'LANG': 'en_US.UTF-8', 10:53:45 INFO - 'LANGUAGE': 'en_US:en', 10:53:45 INFO - 'LOGNAME': 'cltbld', 10:53:45 INFO - 'MAIL': '/var/mail/cltbld', 10:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:45 INFO - 'MOZ_NO_REMOTE': '1', 10:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:45 INFO - 'NO_EM_RESTART': '1', 10:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:45 INFO - 'PWD': '/builds/slave/test', 10:53:45 INFO - 'SHELL': '/bin/bash', 10:53:45 INFO - 'SHLVL': '1', 10:53:45 INFO - 'TERM': 'linux', 10:53:45 INFO - 'TMOUT': '86400', 10:53:45 INFO - 'USER': 'cltbld', 10:53:45 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463679007.640604-271538148', 10:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:45 INFO - '_': '/tools/buildbot/bin/python'} 10:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:53:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:53:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:53:47 INFO - Installing collected packages: mozsystemmonitor 10:53:47 INFO - Running setup.py install for mozsystemmonitor 10:53:47 INFO - Successfully installed mozsystemmonitor 10:53:47 INFO - Cleaning up... 10:53:48 INFO - Return code: 0 10:53:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:53: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')]} 10:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53: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')]} 10:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:48 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 0x7f39abcfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a139c0>, '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 0x1a148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a14d50>, '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': '7de08804244eb36560b44971000001c3-1463679007.640604-271538148', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:53:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:53:48 INFO - Using env: {'DISPLAY': ':0', 10:53:48 INFO - 'HOME': '/home/cltbld', 10:53:48 INFO - 'LANG': 'en_US.UTF-8', 10:53:48 INFO - 'LANGUAGE': 'en_US:en', 10:53:48 INFO - 'LOGNAME': 'cltbld', 10:53:48 INFO - 'MAIL': '/var/mail/cltbld', 10:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:48 INFO - 'MOZ_NO_REMOTE': '1', 10:53:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:48 INFO - 'NO_EM_RESTART': '1', 10:53:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:48 INFO - 'PWD': '/builds/slave/test', 10:53:48 INFO - 'SHELL': '/bin/bash', 10:53:48 INFO - 'SHLVL': '1', 10:53:48 INFO - 'TERM': 'linux', 10:53:48 INFO - 'TMOUT': '86400', 10:53:48 INFO - 'USER': 'cltbld', 10:53:48 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463679007.640604-271538148', 10:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:48 INFO - '_': '/tools/buildbot/bin/python'} 10:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:48 INFO - Downloading/unpacking blobuploader==1.2.4 10:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:50 INFO - Downloading blobuploader-1.2.4.tar.gz 10:53:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:53:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:53:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:50 INFO - Downloading docopt-0.6.1.tar.gz 10:53:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:53:50 INFO - Installing collected packages: blobuploader, requests, docopt 10:53:50 INFO - Running setup.py install for blobuploader 10:53:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:53:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:53:50 INFO - Running setup.py install for requests 10:53:51 INFO - Running setup.py install for docopt 10:53:51 INFO - Successfully installed blobuploader requests docopt 10:53:51 INFO - Cleaning up... 10:53:51 INFO - Return code: 0 10:53:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:53:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:51 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 0x7f39abcfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a139c0>, '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 0x1a148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a14d50>, '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': '7de08804244eb36560b44971000001c3-1463679007.640604-271538148', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:53:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:53:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:53:51 INFO - Using env: {'DISPLAY': ':0', 10:53:51 INFO - 'HOME': '/home/cltbld', 10:53:51 INFO - 'LANG': 'en_US.UTF-8', 10:53:51 INFO - 'LANGUAGE': 'en_US:en', 10:53:51 INFO - 'LOGNAME': 'cltbld', 10:53:51 INFO - 'MAIL': '/var/mail/cltbld', 10:53:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:51 INFO - 'MOZ_NO_REMOTE': '1', 10:53:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:51 INFO - 'NO_EM_RESTART': '1', 10:53:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:51 INFO - 'PWD': '/builds/slave/test', 10:53:51 INFO - 'SHELL': '/bin/bash', 10:53:51 INFO - 'SHLVL': '1', 10:53:51 INFO - 'TERM': 'linux', 10:53:51 INFO - 'TMOUT': '86400', 10:53:51 INFO - 'USER': 'cltbld', 10:53:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463679007.640604-271538148', 10:53:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:51 INFO - '_': '/tools/buildbot/bin/python'} 10:53:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:53:51 INFO - Running setup.py (path:/tmp/pip-T24W9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:53:51 INFO - Running setup.py (path:/tmp/pip-DR4UbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:53:51 INFO - Running setup.py (path:/tmp/pip-CM2v7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:53:51 INFO - Running setup.py (path:/tmp/pip-PaTmlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:53:51 INFO - Running setup.py (path:/tmp/pip-iI0UWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:53:52 INFO - Running setup.py (path:/tmp/pip-qSQEr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:53:52 INFO - Running setup.py (path:/tmp/pip-PYPlsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:53:52 INFO - Running setup.py (path:/tmp/pip-ORxHEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:53:52 INFO - Running setup.py (path:/tmp/pip-8cYNtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:53:52 INFO - Running setup.py (path:/tmp/pip-Nw9XlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:53:52 INFO - Running setup.py (path:/tmp/pip-NpoWzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:53:52 INFO - Running setup.py (path:/tmp/pip-99E_YT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:53:52 INFO - Running setup.py (path:/tmp/pip-uPdUt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:53:52 INFO - Running setup.py (path:/tmp/pip-g1Tl63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:52 INFO - Running setup.py (path:/tmp/pip-038be8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:53:52 INFO - Running setup.py (path:/tmp/pip-1ydA4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:53:52 INFO - Running setup.py (path:/tmp/pip-_H8d3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:53:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:53:52 INFO - Running setup.py install for manifestparser 10:53:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:53:53 INFO - Running setup.py install for mozcrash 10:53:53 INFO - Running setup.py install for mozdebug 10:53:53 INFO - Running setup.py install for mozdevice 10:53:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:53:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:53:53 INFO - Running setup.py install for mozfile 10:53:53 INFO - Running setup.py install for mozhttpd 10:53:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:53:53 INFO - Running setup.py install for mozinfo 10:53:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:53:53 INFO - Running setup.py install for mozInstall 10:53:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:53:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:53:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:53:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:53:53 INFO - Running setup.py install for mozleak 10:53:53 INFO - Running setup.py install for mozlog 10:53:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:53:53 INFO - Running setup.py install for moznetwork 10:53:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:53:54 INFO - Running setup.py install for mozprocess 10:53:54 INFO - Running setup.py install for mozprofile 10:53:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:53:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:53:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:53:54 INFO - Running setup.py install for mozrunner 10:53:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:53:54 INFO - Running setup.py install for mozscreenshot 10:53:54 INFO - Running setup.py install for moztest 10:53:54 INFO - Running setup.py install for mozversion 10:53:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:53:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:53:54 INFO - Cleaning up... 10:53:54 INFO - Return code: 0 10:53:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:54 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 0x7f39abcfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a139c0>, '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 0x1a148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a14d50>, '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': '7de08804244eb36560b44971000001c3-1463679007.640604-271538148', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:53:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:53:54 INFO - Using env: {'DISPLAY': ':0', 10:53:54 INFO - 'HOME': '/home/cltbld', 10:53:54 INFO - 'LANG': 'en_US.UTF-8', 10:53:54 INFO - 'LANGUAGE': 'en_US:en', 10:53:54 INFO - 'LOGNAME': 'cltbld', 10:53:54 INFO - 'MAIL': '/var/mail/cltbld', 10:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:54 INFO - 'MOZ_NO_REMOTE': '1', 10:53:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:54 INFO - 'NO_EM_RESTART': '1', 10:53:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:54 INFO - 'PWD': '/builds/slave/test', 10:53:54 INFO - 'SHELL': '/bin/bash', 10:53:54 INFO - 'SHLVL': '1', 10:53:54 INFO - 'TERM': 'linux', 10:53:54 INFO - 'TMOUT': '86400', 10:53:54 INFO - 'USER': 'cltbld', 10:53:54 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463679007.640604-271538148', 10:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:54 INFO - '_': '/tools/buildbot/bin/python'} 10:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:53:54 INFO - Running setup.py (path:/tmp/pip-gf1u5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:53:55 INFO - Running setup.py (path:/tmp/pip-Z7CH3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:53:55 INFO - Running setup.py (path:/tmp/pip-1HqjTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:53:55 INFO - Running setup.py (path:/tmp/pip-i9GMdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:53:55 INFO - Running setup.py (path:/tmp/pip-A5RlgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:53:55 INFO - Running setup.py (path:/tmp/pip-iA3pl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:53:55 INFO - Running setup.py (path:/tmp/pip-cE0NTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:53:55 INFO - Running setup.py (path:/tmp/pip-J4cZxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:53:55 INFO - Running setup.py (path:/tmp/pip-4hpTeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:53:55 INFO - Running setup.py (path:/tmp/pip-qBaDqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:53:55 INFO - Running setup.py (path:/tmp/pip-Bj0WOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:53:55 INFO - Running setup.py (path:/tmp/pip-NfMFBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:53:55 INFO - Running setup.py (path:/tmp/pip-v410DJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:53:55 INFO - Running setup.py (path:/tmp/pip-xYHkgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:55 INFO - Running setup.py (path:/tmp/pip-ashN5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:53:56 INFO - Running setup.py (path:/tmp/pip-UW3a55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:53:56 INFO - Running setup.py (path:/tmp/pip-6rhnK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:53:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:58 INFO - Downloading blessings-1.6.tar.gz 10:53:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:53:58 INFO - Installing collected packages: blessings 10:53:58 INFO - Running setup.py install for blessings 10:53:58 INFO - Successfully installed blessings 10:53:58 INFO - Cleaning up... 10:53:58 INFO - Return code: 0 10:53:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:53:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:53:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:53:58 INFO - Reading from file tmpfile_stdout 10:53:58 INFO - Current package versions: 10:53:58 INFO - argparse == 1.2.1 10:53:58 INFO - blessings == 1.6 10:53:58 INFO - blobuploader == 1.2.4 10:53:58 INFO - docopt == 0.6.1 10:53:58 INFO - manifestparser == 1.1 10:53:58 INFO - mozInstall == 1.12 10:53:58 INFO - mozcrash == 0.17 10:53:58 INFO - mozdebug == 0.1 10:53:58 INFO - mozdevice == 0.48 10:53:58 INFO - mozfile == 1.2 10:53:58 INFO - mozhttpd == 0.7 10:53:58 INFO - mozinfo == 0.9 10:53:58 INFO - mozleak == 0.1 10:53:58 INFO - mozlog == 3.2 10:53:58 INFO - moznetwork == 0.27 10:53:58 INFO - mozprocess == 0.22 10:53:58 INFO - mozprofile == 0.28 10:53:58 INFO - mozrunner == 6.11 10:53:58 INFO - mozscreenshot == 0.1 10:53:58 INFO - mozsystemmonitor == 0.3 10:53:58 INFO - moztest == 0.7 10:53:58 INFO - mozversion == 1.4 10:53:58 INFO - psutil == 3.1.1 10:53:58 INFO - requests == 1.2.3 10:53:58 INFO - wsgiref == 0.1.2 10:53:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:58 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 0x7f39abcfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a139c0>, '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 0x1a148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a14d50>, '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': '7de08804244eb36560b44971000001c3-1463679007.640604-271538148', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:53:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:53:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:53:58 INFO - Using env: {'DISPLAY': ':0', 10:53:58 INFO - 'HOME': '/home/cltbld', 10:53:58 INFO - 'LANG': 'en_US.UTF-8', 10:53:58 INFO - 'LANGUAGE': 'en_US:en', 10:53:58 INFO - 'LOGNAME': 'cltbld', 10:53:58 INFO - 'MAIL': '/var/mail/cltbld', 10:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:58 INFO - 'MOZ_NO_REMOTE': '1', 10:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:58 INFO - 'NO_EM_RESTART': '1', 10:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:58 INFO - 'PWD': '/builds/slave/test', 10:53:58 INFO - 'SHELL': '/bin/bash', 10:53:58 INFO - 'SHLVL': '1', 10:53:58 INFO - 'TERM': 'linux', 10:53:58 INFO - 'TMOUT': '86400', 10:53:58 INFO - 'USER': 'cltbld', 10:53:58 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463679007.640604-271538148', 10:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:58 INFO - '_': '/tools/buildbot/bin/python'} 10:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:53:58 INFO - Cleaning up... 10:53:58 INFO - Return code: 0 10:53:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39abcfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a139c0>, '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 0x1a148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a14d50>, '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': '7de08804244eb36560b44971000001c3-1463679007.640604-271538148', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:53:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:53:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:53:58 INFO - Using env: {'DISPLAY': ':0', 10:53:58 INFO - 'HOME': '/home/cltbld', 10:53:58 INFO - 'LANG': 'en_US.UTF-8', 10:53:58 INFO - 'LANGUAGE': 'en_US:en', 10:53:58 INFO - 'LOGNAME': 'cltbld', 10:53:58 INFO - 'MAIL': '/var/mail/cltbld', 10:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:58 INFO - 'MOZ_NO_REMOTE': '1', 10:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:58 INFO - 'NO_EM_RESTART': '1', 10:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:58 INFO - 'PWD': '/builds/slave/test', 10:53:58 INFO - 'SHELL': '/bin/bash', 10:53:58 INFO - 'SHLVL': '1', 10:53:58 INFO - 'TERM': 'linux', 10:53:58 INFO - 'TMOUT': '86400', 10:53:58 INFO - 'USER': 'cltbld', 10:53:58 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463679007.640604-271538148', 10:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:58 INFO - '_': '/tools/buildbot/bin/python'} 10:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:58 INFO - Downloading/unpacking jsonschema 10:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:54:00 INFO - Downloading/unpacking functools32 (from jsonschema) 10:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:01 INFO - Downloading functools32-3.2.3-2.tar.gz 10:54:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:54:01 INFO - warning: no files found matching '*.txt' 10:54:01 INFO - no previously-included directories found matching 'build' 10:54:01 INFO - no previously-included directories found matching 'dist' 10:54:01 INFO - no previously-included directories found matching '.git*' 10:54:01 INFO - Installing collected packages: jsonschema, functools32 10:54:01 INFO - Running setup.py install for functools32 10:54:01 INFO - warning: no files found matching '*.txt' 10:54:01 INFO - no previously-included directories found matching 'build' 10:54:01 INFO - no previously-included directories found matching 'dist' 10:54:01 INFO - no previously-included directories found matching '.git*' 10:54:01 INFO - Successfully installed jsonschema functools32 10:54:01 INFO - Cleaning up... 10:54:01 INFO - Return code: 0 10:54:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:54: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')]} 10:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54: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')]} 10:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:01 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 0x7f39abcfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1984770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a139c0>, '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 0x1a148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a14d50>, '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': '7de08804244eb36560b44971000001c3-1463679007.640604-271538148', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:54:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:54:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:54:01 INFO - Using env: {'DISPLAY': ':0', 10:54:01 INFO - 'HOME': '/home/cltbld', 10:54:01 INFO - 'LANG': 'en_US.UTF-8', 10:54:01 INFO - 'LANGUAGE': 'en_US:en', 10:54:01 INFO - 'LOGNAME': 'cltbld', 10:54:01 INFO - 'MAIL': '/var/mail/cltbld', 10:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:01 INFO - 'MOZ_NO_REMOTE': '1', 10:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:01 INFO - 'NO_EM_RESTART': '1', 10:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:01 INFO - 'PWD': '/builds/slave/test', 10:54:01 INFO - 'SHELL': '/bin/bash', 10:54:01 INFO - 'SHLVL': '1', 10:54:01 INFO - 'TERM': 'linux', 10:54:01 INFO - 'TMOUT': '86400', 10:54:01 INFO - 'USER': 'cltbld', 10:54:01 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463679007.640604-271538148', 10:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:01 INFO - '_': '/tools/buildbot/bin/python'} 10:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:01 INFO - Downloading/unpacking flake8 10:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:54:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:54:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:54:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:54:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:54:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:54:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:54:04 INFO - no previously-included directories found matching 'docs/_build' 10:54:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:54:04 INFO - Running setup.py install for pep8 10:54:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:54:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:54:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:54:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:54:04 INFO - no previously-included directories found matching 'docs/_build' 10:54:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:54:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:54:04 INFO - Cleaning up... 10:54:04 INFO - Return code: 0 10:54:04 INFO - Running post-action listener: _resource_record_post_action 10:54:04 INFO - Running post-action listener: _start_resource_monitoring 10:54:04 INFO - Starting resource monitoring. 10:54:04 INFO - ##### 10:54:04 INFO - ##### Finished create-virtualenv step (success) 10:54:04 INFO - ##### 10:54:04 INFO - ##### 10:54:04 INFO - ##### Running install step. 10:54:04 INFO - ##### 10:54:04 INFO - Running pre-action listener: _resource_record_pre_action 10:54:04 INFO - Running main action method: install 10:54:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:54:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:54:04 INFO - Reading from file tmpfile_stdout 10:54:04 INFO - Detecting whether we're running mozinstall >=1.0... 10:54:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:54:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:54:04 INFO - Reading from file tmpfile_stdout 10:54:04 INFO - Output received: 10:54:04 INFO - Usage: mozinstall [options] installer 10:54:04 INFO - Options: 10:54:04 INFO - -h, --help show this help message and exit 10:54:04 INFO - -d DEST, --destination=DEST 10:54:04 INFO - Directory to install application into. [default: 10:54:04 INFO - "/builds/slave/test"] 10:54:04 INFO - --app=APP Application being installed. [default: firefox] 10:54:04 INFO - mkdir: /builds/slave/test/build/application 10:54:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:54:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:54:20 INFO - Reading from file tmpfile_stdout 10:54:20 INFO - Output received: 10:54:20 INFO - /builds/slave/test/build/application/firefox/firefox 10:54:20 INFO - Running post-action listener: _resource_record_post_action 10:54:20 INFO - ##### 10:54:20 INFO - ##### Finished install step (success) 10:54:20 INFO - ##### 10:54:20 INFO - ##### 10:54:20 INFO - ##### Running run-tests step. 10:54:20 INFO - ##### 10:54:20 INFO - Running pre-action listener: _resource_record_pre_action 10:54:20 INFO - Running main action method: run_tests 10:54:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:54:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:54:20 INFO - Python 2.7.3 10:54:20 INFO - Return code: 0 10:54:20 INFO - grabbing minidump binary from tooltool 10:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:20 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 0x1a139c0>, '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 0x1a148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a14d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:54:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:54:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:54:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:54:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:54:20 INFO - Return code: 0 10:54:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:54:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:54:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:54:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:54:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:54:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:54:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:54:21 INFO - Return code: 0 10:54:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:54:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:54:21 INFO - Using env: {'DISPLAY': ':0', 10:54:21 INFO - 'HOME': '/home/cltbld', 10:54:21 INFO - 'LANG': 'en_US.UTF-8', 10:54:21 INFO - 'LANGUAGE': 'en_US:en', 10:54:21 INFO - 'LOGNAME': 'cltbld', 10:54:21 INFO - 'MAIL': '/var/mail/cltbld', 10:54:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:54:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:54:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:21 INFO - 'MOZ_NO_REMOTE': '1', 10:54:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:54:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:21 INFO - 'NO_EM_RESTART': '1', 10:54:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:21 INFO - 'PWD': '/builds/slave/test', 10:54:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:54:21 INFO - 'SHELL': '/bin/bash', 10:54:21 INFO - 'SHLVL': '1', 10:54:21 INFO - 'TERM': 'linux', 10:54:21 INFO - 'TMOUT': '86400', 10:54:21 INFO - 'USER': 'cltbld', 10:54:21 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1463679007.640604-271538148', 10:54:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:21 INFO - '_': '/tools/buildbot/bin/python'} 10:54:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:54:21 INFO - mozversion application_buildid: 20160519094747 10:54:21 INFO - mozversion application_changeset: 1806d405c8715949b39fa3a4fc142d14a60df590 10:54:21 INFO - mozversion application_display_name: Nightly 10:54:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:54:21 INFO - mozversion application_name: Firefox 10:54:21 INFO - mozversion application_remotingname: firefox 10:54:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:54:21 INFO - mozversion application_vendor: Mozilla 10:54:21 INFO - mozversion application_version: 49.0a1 10:54:21 INFO - mozversion platform_buildid: 20160519094747 10:54:21 INFO - mozversion platform_changeset: 1806d405c8715949b39fa3a4fc142d14a60df590 10:54:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:54:21 INFO - mozversion platform_version: 49.0a1 10:54:21 INFO - using testdate: 1463680461 10:54:21 INFO - actual date: 1463680461 10:54:21 INFO - starting webserver on 'localhost:50133' 10:54:21 INFO - SUITE-START | Running 2 tests 10:54:21 INFO - TEST-START | dromaeo_css 10:54:21 INFO - operating with platform_type : linux_ 10:54:21 INFO - Initialising browser for dromaeo_css test... 10:54:21 INFO - TEST-INFO | started process 25763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5H3YCC/profile http://localhost:50133/getInfo.html) 10:54:26 INFO - PROCESS | 25763 | __metrics Screen width/height:1600/1200 10:54:26 INFO - PROCESS | 25763 | colorDepth:24 10:54:26 INFO - PROCESS | 25763 | Browser inner width/height: 1024/697 10:54:26 INFO - PROCESS | 25763 | __metrics 10:54:27 ERROR - PROCESS | 25763 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:54:28 INFO - TEST-INFO | 25763: exit 0 10:54:28 INFO - Browser initialized. 10:54:28 INFO - Running cycle 1/1 for dromaeo_css test... 10:54:28 INFO - TEST-INFO | started process 25843 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5H3YCC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:54:40 INFO - PROCESS | 25843 | RSS: Main: 155095040 10:54:40 INFO - PROCESS | 25843 | 10:55:32 INFO - PROCESS | 25843 | 1463680532299 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:57:43 INFO - PROCESS | 25843 | Cycle 1(1): loaded http://localhost:50133/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50133/tests/dromaeo/cssquery-ext.html) 10:57:45 INFO - PROCESS | 25843 | RSS: Main: 270548992 10:57:45 INFO - PROCESS | 25843 | 11:00:47 INFO - PROCESS | 25843 | Cycle 1(1): loaded http://localhost:50133/tests/dromaeo/cssquery-ext.html (next: http://localhost:50133/tests/dromaeo/cssquery-jquery.html) 11:00:48 INFO - PROCESS | 25843 | RSS: Main: 233582592 11:00:48 INFO - PROCESS | 25843 | 11:03:50 INFO - PROCESS | 25843 | Cycle 1(1): loaded http://localhost:50133/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50133/tests/dromaeo/cssquery-mootools.html) 11:03:50 INFO - PROCESS | 25843 | RSS: Main: 234909696 11:03:50 INFO - PROCESS | 25843 | 11:06:53 INFO - PROCESS | 25843 | Cycle 1(1): loaded http://localhost:50133/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50133/tests/dromaeo/cssquery-prototype.html) 11:06:53 INFO - PROCESS | 25843 | RSS: Main: 232083456 11:06:53 INFO - PROCESS | 25843 | 11:09:56 INFO - PROCESS | 25843 | Cycle 1(1): loaded http://localhost:50133/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50133/tests/dromaeo/cssquery-yui.html) 11:09:57 INFO - PROCESS | 25843 | RSS: Main: 219865088 11:09:57 INFO - PROCESS | 25843 | 11:13:00 INFO - PROCESS | 25843 | Cycle 1(1): loaded http://localhost:50133/tests/dromaeo/cssquery-yui.html (next: http://localhost:50133/tests/dromaeo/cssquery-dojo.html) 11:13:00 INFO - PROCESS | 25843 | RSS: Main: 270114816 11:13:00 INFO - PROCESS | 25843 | 11:13:00 INFO - PROCESS | 25843 | __start_tp_report 11:13:00 INFO - PROCESS | 25843 | _x_x_mozilla_page_load 11:13:00 INFO - PROCESS | 25843 | _x_x_mozilla_page_load_details 11:13:00 INFO - PROCESS | 25843 | |i|pagename|runs| 11:13:00 INFO - PROCESS | 25843 | |0;dojo.html;2631.8947242110316;2648.8145829791924;2686.9462610747787;2687.8387296762194;2696.4741875334307;4589.806650270933;4607.861764147073;4659.254519276917;4665.2768820832825;4713.340132381465;4686.062787442508;4715.575598196162;4744.57298843104;4779.091972525218;4781.928271075936;4294.334378171373;4306.870793876189;4324.524302326741;4380.978095109528;4425.203463376591;4382.4741031076155;4415.602595766396;4456.5766252205985;4496.685232033759;4500.414946057024;4251.383549385322;4418.955810441887;4434.490033646123;4455.710378825366;4463.174312752135;4289.335153051282;4310.82756689732;4333;4344.152890186415;4352.151330490556;4315.029118448324;4374.212641724488;4374.4531933508315;4375.846845360397;4435.223835828717;4505.346724724929;4678.95321046792;4691.835785747482;4710.905781884378;4718.528147185289;4946.282788995575;4951.331570238008;4963.354763880672;4977.925331120036;5030.89938201234;5016.523430274118;5036.169032109698;5040.899182016376;5041.369828771403;5047.293378926953;4615.330777037311;4630.097131059411;4748.38271024768;4772.284157376422;4775.5463230993;5065.797368105234;5080.517350851663;5152.27868098459;5156.561692256125;5157.896842063138;4932.062908047459;4940.382452193476;4971.825986090542;4980.800767969313;4985.326980857611;4928.28539861718;5004.649674522749;5016.046951079284;5017.498250175026;5064.088464076502;5008.449070602231;5023.723695196799;5042.067217564762;5047.141985862412;5077.644564880423;5027.798888044437;5027.949720502748;5033.597312215014;5035.597152227813;5067.391912970467;4146.751194928314;4181.790910454465;4203.453551038346;4228.492580890252;4306.224879521654;3693.8153092345274;3701.555813302421;3709.8145092745253;3751.005983414397;3767.3972164453558;4352.869413917588;4388.078503514298;4388.648908087345;4424.358468022118;4432.357308190294;4951.455339912607;5050.873728156826;5053.696778193246;5075.873103172376;5090.821821236313;4394.077243778778;4412.646988240933;4417.8232870684815;4428.092241090569;4462.085272519126;4562.954370456319;4565.292379681155;4568.840090596879;4571.497135315112;4620.214563524209;4703.459102203222;4742.881427964328;4753.691010084333;4788.640851936049;4792.424909010941;5065.316182315488;5077.1876499759865;5086.949130508648;5088.898222035613;5139.152039913522;4756.928646070242;4784.545468180518;4794.832180873653;4796.208625576741;4810.59109975656;4773.474917758975;4923.483034281492;4980.850574482772;5018.949810501848;5020.397552293748;5066.138756411346;5085.7457127144235;5087.949120508748;5092.159793634157;5142.357205349332;4759.6430267729365;4944.48082951285;4953.405591329064;4954.529319714621;4955;4862.489438608895;4866.464688884291;4885.4870238624435;4895.975520122377;4922.606191504743;4800.087983283165;4812.422509298906;4861.683990540603;4883.121038213156;4885.2427873679635;4766.046790641816;4909.631777616764;4942.456329803646;4982.427020892499;4995.050940321327;4814.638902082288;4826.493218212037;4826.686265392738;4880.438749543706;4882.487338829372 11:13:00 INFO - PROCESS | 25843 | |1;ext.html;564.6612032780332;582.8309790160853;585.4730742331898;589.8466398736327;594.1592646405337;28306.433871322588;31205.063848084537;31223.531647025313;31235.375292494136;31251.687483125217;30895.227619309528;41107;42717.35923961143;42779.786101069454;47292;7625.4280928930275;7753.689852405925;7780.8832867507035;7792;7792.337651299618;7606.619669016554;7757.922420775776;7765.572893490856;7769;7777.10563285221;7765.961170194141;7809.804754881145;7829.33450656692;7830.530168189927;7840.647170877324;7764.844703105934;7768.5338879667115;7772.611369431505;7809.180036096185;7830.56931868747;7625.161232264447;7662.118856331537;7682.692692292301;7684.654190561439;7687.2697093776005;39442.60557394418;39657.60342396568;39729.20541589152;39823;39823.60176398228;2939.3974235281717;2990.5514172874027;3125.828079455629;3312.7018568328967;3355.39602871483;30254.697453025627;30338.241543961358;30559.388812223853;30579.847100764575;30986.690133098607;3497.510348551205;3501.212227248874;3545.5213546171453;3588.2464682416726;3589.6589823966683;270182;273011;273067;274438.999999998;275046;31869;48602.51397486051;49272;49283.75358123187;49304.50695493071;32140.19649508781;34425.483617745755;34499.13752156216;34503.137421564665;34541;13249.205047696976;13316.46734130624;13339.333033348294;13419.865801342057;13444;9623.711288661352;9628.566714497725;9649.276304277208;9658.420494770337;9693.757656058513;7958.880616790752;7995.200479951958;7998.12020677725;8029.7189598363775;8063.27430531255;3079.892203772857;3081.5839861618842;3102.1314032071054;3120.9843950780555;3186.1715953852167;838.6268110690684;872.7207293665966;931.8322701913585;1029.912457441111;1068.5779117248644;27686;28412;28829.500972390375;28896.711032889823;29000.274993125342;822.3421262989584;972.5866506734609;979.3340528440586;993.0913214408879;995.328153496387;15248.695026099416;15396.61508462275;15434.073955562702;15681.921590391976;15716.764248536281;395526;450705;460331;460929;689854;50989.49010509848;51299;51558.48441515537;51730;51750.741246293524;1119.1158984402393;1193.6419074277683;1235.734317121823;1242.3043095866344;1253.8370011898394;24221.636675450234;27926.441471170056;28073.57889631616;28168.71831281661;28473.857630711715;39643.80178099091;39897.80051099726;40365;40380.586679466076;40397.798011009756;258815;260127;260387;261547;263014;22675.319740407813;24859.502809943337;25017.374565636004;25844.35389115287;25845.22464326073;41821.79089104535;42111.15777684368;42340.576594233666;42718.78640606901;42901.14197716091;35957.46063808993;36128.4580731284;36187.09532261715;36464.453033203994;36793.448098279085;35784.284314314085;36389.81805091064;37242;37369.25261494701;41123.58876411317;32072.6792732079;33381.49927751134;36265.818670906476;36966;37323.62676373201;31205.68794312028;32145.517817232292;32583.674163259013;32624.184395390304;32707;24142.39644008914;24386.756132439157;24466;24611.63082553727;24938 11:13:00 INFO - PROCESS | 25843 | |2;jquery.html;361.9330423871584;367.4139747103371;368.1055036261884;373.7551903503203;383.4669808965538;15863.682726345467;16711.749323760152;16928.4075057373;16982.745258821127;17216.741748873763;16104.275307611157;16328.18359082047;16968.49094527166;17013.48959531213;17071.743923841153;4965.205567109263;5062.493750624945;5128.205128205134;5145.536901678848;5151.201563757605;3616.7287453440968;3863.9806800965957;5056.469070747574;5582.609217354767;5873.412658734113;5914.970425147868;5917.5561832862495;5948.464638182562;5950.285965684124;5951.88096238075;5780.219670344533;5839.970800145993;5914.467697907187;5914.911276330837;5924.822255332347;3356.278400143981;4915.975420122876;5114.565261952738;5194;5203.973980130075;19545.315913942944;20153;20263.4934126648;20370.388888333375;20382.69425958612;1848.8613353998503;1910.293191519133;1924.8556358273186;2196.121551379445;2266.7393249776324;8889.155530224618;9092.318076144316;9434.669786557506;9507.857382139273;13008.284544350057;1723.1814887928258;1778.2353587957173;1778.5286898971783;1797.2631221199244;1854.5178253654012;61944;70079.64960175217;70985.64507177482;71612.64193678998;71747.92378114385;9091.954540227389;9688.982656821074;9690.321677482649;9796.608135674493;10220.795584088277;13608.65978350549;13614.659633509043;13723.1079979801;13723.931380343034;13750;6924.23833378328;6943.965280173667;6990.580565166107;7062.576245425291;7297.379722723522;6493.220813502316;6763.830904227434;6768.492363072789;6775.254721980578;6861.965690171517;4264.424302719155;4335.7615331157085;4352.260115780325;4413.933790993137;4424.3142312941545;1676.1535424610738;1738.5305967388733;1799.2623024559869;1837.7058574382686;1860.3488778927538;852.9957350213333;853.923146916768;902.2105657549644;926.4024704065974;996.1681995533665;16066.196690165445;16110.355585776671;16185.676286474205;16251.674966500605;16292.266847991868;794.1740589786673;821.1008945204991;864.6757465950269;893.7095443980733;904.7014485219862;8270.793230169294;9245.676401325922;9286.396384235004;9434.716958491255;9463.337566370288;409134;412933;412981;413916;423846;76847.61576192084;77637;77949.22050779419;79313.20686793173;80137;902.3683421604903;906.0848542971514;911.4816807124627;916.8945571259391;934.6495064350869;14012.299385030912;14661.41354345857;14884.18137002432;15373.38506459729;15755.13346765893;26433.60349594719;34040.65959340474;35763;36078.45882311715;37467.43798842965;45067;45602.31596526121;47438.855099819346;48187;48564.51435485741;6609.3060228675295;7269.091363579552;7278.890816637861;7297.63511824396;7430.665620047219;10252.538635761259;11734.765304693688;11753.588624398106;11953.581624643444;11975.580854670045;10181.490925453845;10207.285490015925;10256.743581410525;10339.276250662382;10443;9725.85411218818;9753.609855605697;9943.502824858873;10019.448930308903;10259.7435064124;9900.108990190918;10283.537240824331;10290.331128476626;10306.896931030593;10643;7208.675609597685;7223.891641625275;7349.522281051714;7369.889451658337;7510.286522780327;9445.527723613654;9493.905060949579;10236;10262.948685256526;10553.788924221319 11:13:00 INFO - PROCESS | 25843 | |3;mootools.html;1287.555793251328;1411.7811739180424;1457.016513853149;1549.4034796603305;1776.0498133498572;6732.2931092235285;7569.12955010174;7732.265434783687;7741.845163096735;8078.272955434009;7735.651895664694;7888.56612886291;7903.051633803937;7913.089994650617;7929.088154862178;1901.9429417117508;2177.7822217778253;2218.0794970087395;2248.291788086756;2255.5827171973237;2221.6445368741006;2243.1139699818564;2246.1127854497545;2246.2362796649136;2249.865008099511;2175.630142875707;2233.251860626692;2254.402583315423;2255.436140964759;2257.1535674122206;1867.55178757098;2140.2402147237663;2170.5116348821466;2202;2206.8455208135438;2223.3552269841725;2242.865428074321;2246.663000549914;2246.7191601049867;2247.359502541784;7850;7889.723859664941;7895.368370530344;7897.05235371759;7910.129885712567;4475.977620111878;4609.7695115244105;4622.306654001893;4622.722636641813;4625.953740462586;2777.8611069446447;2806.9157925262275;2921.3865088331477;2941.2793865502877;2949.970500294991;838.4256784102909;866.3805379153872;882.2412725056446;892.607252808762;903.5256490342557;10568.154547636248;10570.630027948984;10598.152147828156;10610.840837387444;10641.57433702651;4271.060366719316;4308.771999980053;4365.301551751768;4396.032872767986;4406.757628330409;9173.908260917438;9186.724398267928;9210.493422861808;9244.537773111317;9264.67573634933;4545.818167273338;4577.084583083397;4579.244424669959;4581.129585378767;4587.7017993830295;3683.1528748387486;4082.8366865325056;4198.286291330481;4207.431996680409;4262.616364527207;3689.741718079709;3715.7213209009433;3743.6817870481314;3820.5797362290127;3838.2707285615643;1188.7979043562616;1200.6218041317131;1217.178404576907;1220.3837062283667;1232.2175418609247;719.4280546965175;731.6890321613399;799.9040115186215;811.4441607498882;866.7529754020075;5119.795208191631;5122;5279.049771041173;5317.601179911522;5371.946280537223;391.74145064257453;394.8756141815319;400.70347942522324;402.3984143705121;407.1714061884052;3566.5720113586017;3599.226166374242;3633.8728144514816;3651.1602331463914;3675.8162091895297;9453.291003174789;9844.80310393788;9847.162991145833;9856.605735770489;9862.260330475243;9676.70969870905;9751.804963900682;9786.217102631772;9805;9816.950915245377;7372.373348265351;7502.62486875654;7508.662110205054;7522.435817313614;7530.811729706801;5122.103631864484;5154.561862241751;5193.091209038479;5288.101022826206;5319.2287118368395;8623.784405389915;8824.3381746368;9005.954970225106;9050.954745226232;9158.633654653739;9129.315301352557;9165.358424910459;9193.448393096436;9235.12266334697;9275.582598783207;6102.847428814315;6450.258220304538;6606.636634985122;6644.60132392058;6706.161729783777;7528.585927773806;7554.471187016856;7564.9243507566425;7598.164201937893;7598.848023039619;6490.188726409199;6576.112224849584;6613.074169616354;6698.866022679422;6732.225794033749;6635.402813746786;6642.468602511691;6648.5678430901835;6653.9667301663185;6688.765893193715;6131.172291740736;6160.753569857335;6171.6297022178815;6187.195664563578;6187.752489900354;4478.261086920622;4625.884352891205;4693.906121877475;4725.716457012591;4773.570378665798;4514.954850451453;4642.86071417858;4669.603083737785;4676.672632915664;4718.834840780693 11:13:00 INFO - PROCESS | 25843 | |4;prototype.html;285.42771742655987;292.654667492359;297.1694114948719;300.1445879244154;300.85859645966417;4787.784549695263;4814.3741313629225;4845.466998630152;4846.830360937368;4859.757012149396;4521.954780452194;4627.282771170466;4689.437267527901;4775.880602984918;4783.564930520839;3822.178231680188;3845.442410850425;3852.8266228019666;3853.730238883279;3856.113093988384;3826.7321287509885;3864.2657895;3864.9227015459674;3876.903077423073;3889.2027134437512;3616.801075940822;3648.726345524083;3785.318642644323;3840.6735427488557;3870.2646497165447;3776.017590764843;3814.275287695357;3824.598417166213;3835.1946091320715;3837.846486140579;3374.3588718143474;3383.2895092030703;3390.610079840825;3391.5082313064468;3397.5583174187445;4385.320275357293;4543.522930092358;4554.294084416921;4561.840335588238;4579.80924959513;4299.720518166309;4346.956530434687;4353.934690979606;4369.410129632491;4370.978145109254;5036.899262014776;5072.847814565569;5072.974635126838;5074.086664400406;5096.79612815487;3629.67332940034;3705.7776533407814;3710.5547334319785;3726.5341832270965;3727.254549090193;5182.870428239286;5215.426303106655;5215.869603259911;5240;5261;3771.4908487354405;3787.791671458096;3791.279656865242;3797.715171362159;3818.6181381862148;3852.556955950102;3861.5559210690567;3863.3818589025623;3865.265599536079;3883.669888059547;4093.5087789465456;4320;4349.695521313541;4350.042990542076;4354.259775838115;4998.975005125024;5010.599152067826;5026.4973502649445;5059.494050594984;5074.517920797518;1249.1443361297358;1295.2099219476113;1323.007744191856;1343.4424713743688;1348.298884580013;876.5047748022347;878.332467324825;896.4666023715879;902.1429641840278;905.2395987370641;3992.540857801332;4010.7794071325775;4016;4047.5547689754103;4060.827457310325;4605.378273933044;4605.654575906753;4616.238320677051;4642.396488456547;4663.300504924288;4123.463949686581;4124.958750412457;4129.752214867118;4130.194612050621;4132.504099508078;2342.906283748665;2417.262734865883;2472.4066224106086;2486.2914069490107;2521.407469244726;4307.504636966789;4348.543402942709;4349.891252718644;4400.031992961607;4424.867253982386;4641.655963738291;4690.061987602493;4696.272077827942;4699.697148397261;4728.692634978715;4210.32634778434;4346.847860324873;4358.932061644854;4378.649708023414;4383.342498625232;4567.223571992836;4600.631949444103;4652.93020604698;4670.626349892068;4673.859784206479;4480.596746292719;4498.662600304925;4505.594496495331;4542;4567.314902764479;4083.244599749056;4332.458442694663;4332.4801023877335;4356.455443069616;4381.568229632585;3378.4256676364585;3449.2066824629974;3453.706434953057;3457.481377793351;3460.7231421486727;4520.779389564734;4527.275635898241;4534.478534968389;4560.703554268962;4979.526944940225;4816.4220293564995;5021.84934451967;5022.497750225094;5028.9245661315845;5032.874178145576;4990.3762029746285;5012.348394708664;5037.471065538066;5058.822941197188;5072.416672082758;4831.154547954165;4964.602831773377;4965.280034395065;4977.203647416396;4979.9004019918675;5047.722375269395;5054.4187418447345;5070.340855688884;5071.721055341844;5076.670016448919;4943.950560494349;4944.406671199479;4958.776855041459;4966.62269656637;4975.800967961386 11:13:00 INFO - PROCESS | 25843 | |5;yui.html;595.5116804220539;610.9694515274235;637.4326849104298;683.5727670206121;693.0920494152659;12004.75990480191;12092.153549251534;12106.878931210696;12128.81806772897;12781.105322627409;11738.765224695522;11833.881661183386;11899.821502677467;11967.820482692767;11996.700082497942;627.9183706118198;776.8407476467339;790.6876783670461;803.586153131135;806.1454857850667;794.7774623105539;795.327947884037;797.8763291689797;802.009518244967;802.0375549340786;851.1148405658108;851.5018714052287;851.748734123432;852.1095455249249;854.0989256334565;652.6377860287539;814.6334149632689;834.028356964136;834.3617132893341;839.4375768235298;617.9134921111048;619.2537991719967;619.4177473175246;619.5848781316529;619.6963487890946;11946.223495472766;11985;12005.219660722112;12022.27866328023;12022.338771367571;11574.247673901255;11900.940495297467;11983.94008029963;11988.70028249292;12179.208351457128;10414.114800241989;10433.634822781167;10565.73585660357;10624.256302058859;10861.945690271577;4049.2104039712267;4052.331365324718;4086.7752273624938;4107.178564287125;4155.937660935088;43777;44100.897477563;45387.773061134816;45651.54348456506;45795;9211.631534738535;9295.628174873065;9432.056794320513;9466.715998520056;9659.565319560637;16878.74681879773;16887.493375198763;16911.408100716417;16915.661686766194;16947.57631059209;6340.302566717657;6399.872002559922;6436.485081193493;6453.386928241809;6575.4410875076155;3534.4698295255403;3582.2477279771538;3605.4591811228524;3632.9818350908604;3670.3576874047467;2756.1593713917446;2834.5748137779087;2843.9857800710865;2845.7865660075577;2847.8148920320114;448.49544262704455;489.5471688687949;490.6712502623251;497.1647631978311;508.5600955173748;477.2652700028854;493.2108626198126;493.8074151081081;497.6267799150637;503.1923762361357;7774.727884524128;7894.9847067512965;7979.3217576505485;8050.798730031679;8075;463.4716423277466;529.7377797990019;532.4382776171177;555.7360253879375;563.599844110686;3707.3141468828353;3710.165212827092;3711.480392745018;3738.065483629093;3829.617038296148;58261.41738582645;59155.40844591585;59279.40720592739;59361.40638593559;59402.40597594055;43687.344689829675;45338.31992520115;53687.73156134273;54654.45345546573;54663.72668136634;45137.77431112823;45462.54537454649;45772.77113614477;45850.54149458463;46150;7921;8035.517868927883;8122.309603683753;8182.386321026066;8240.793980150544;30853.22866928255;31359.372812543166;31372;31452.370952580364;32013;37537.624623753414;39033.609663903;40744;40806.591934081465;40980.3852942212;8954.194122529003;9132.452052876848;9157.86263206039;9179.403338782959;9264.814703706023;11378.43107844588;11539.423028848356;11549.36478493691;11603.709907252387;11874.346910919983;8089.271965523131;8243.876341854997;9847.803043939224;10659.840102398626;10723.785524289626;9270.629174832931;9486.762830929281;10775.6228532001;11054;11153.275037122561;10218;10802.405867677353;10907.345559266469;11107.72230694239;11256.549738010388;8847.560462618905;8969.327300452362;9128.680496182602;9131.269498439977;9361.578728957076;8895.510746908982;9046.773830654287;9437.716868493957;9558.761030974003;9796.020397960147 11:13:00 INFO - PROCESS | 25843 | __end_tp_report 11:13:00 INFO - PROCESS | 25843 | __start_cc_report 11:13:00 INFO - PROCESS | 25843 | _x_x_mozilla_cycle_collect,1044 11:13:00 INFO - PROCESS | 25843 | __end_cc_report 11:13:00 INFO - PROCESS | 25843 | __startTimestamp1463681580309__endTimestamp 11:13:00 INFO - PROCESS | 25843 | 11:13:00 INFO - PROCESS | 25843 | ------- Summary: start ------- 11:13:00 INFO - PROCESS | 25843 | Number of tests: 6 11:13:00 INFO - PROCESS | 25843 | 11:13:00 INFO - PROCESS | 25843 | [#0] dojo.html Cycles:165 Average:4666.04 Median:4784.55 stddev:477.42 (10.0%) stddev-sans-first:451.43 11:13:00 INFO - PROCESS | 25843 | Values: 2631.9 2648.8 2686.9 2687.8 2696.5 4589.8 4607.9 4659.3 4665.3 4713.3 4686.1 4715.6 4744.6 4779.1 4781.9 4294.3 4306.9 4324.5 4381.0 4425.2 4382.5 4415.6 4456.6 4496.7 4500.4 4251.4 4419.0 4434.5 4455.7 4463.2 4289.3 4310.8 4333.0 4344.2 4352.2 4315.0 4374.2 4374.5 4375.8 4435.2 4505.3 4679.0 4691.8 4710.9 4718.5 4946.3 4951.3 4963.4 4977.9 5030.9 5016.5 5036.2 5040.9 5041.4 5047.3 4615.3 4630.1 4748.4 4772.3 4775.5 5065.8 5080.5 5152.3 5156.6 5157.9 4932.1 4940.4 4971.8 4980.8 4985.3 4928.3 5004.6 5016.0 5017.5 5064.1 5008.4 5023.7 5042.1 5047.1 5077.6 5027.8 5027.9 5033.6 5035.6 5067.4 4146.8 4181.8 4203.5 4228.5 4306.2 3693.8 3701.6 3709.8 3751.0 3767.4 4352.9 4388.1 4388.6 4424.4 4432.4 4951.5 5050.9 5053.7 5075.9 5090.8 4394.1 4412.6 4417.8 4428.1 4462.1 4563.0 4565.3 4568.8 4571.5 4620.2 4703.5 4742.9 4753.7 4788.6 4792.4 5065.3 5077.2 5086.9 5088.9 5139.2 4756.9 4784.5 4794.8 4796.2 4810.6 4773.5 4923.5 4980.9 5018.9 5020.4 5066.1 5085.7 5087.9 5092.2 5142.4 4759.6 4944.5 4953.4 4954.5 4955.0 4862.5 4866.5 4885.5 4896.0 4922.6 4800.1 4812.4 4861.7 4883.1 4885.2 4766.0 4909.6 4942.5 4982.4 4995.1 4814.6 4826.5 4826.7 4880.4 4882.5 11:13:00 INFO - PROCESS | 25843 | 11:13:00 INFO - PROCESS | 25843 | [#1] ext.html Cycles:180 Average:47953.00 Median:36327.82 stddev:96738.30 (266.3%) stddev-sans-first:96944.25 11:13:00 INFO - PROCESS | 25843 | Values: 564.7 582.8 585.5 589.8 594.2 28306.4 31205.1 31223.5 31235.4 31251.7 30895.2 41107.0 42717.4 42779.8 47292.0 7625.4 7753.7 7780.9 7792.0 7792.3 7606.6 7757.9 7765.6 7769.0 7777.1 7766.0 7809.8 7829.3 7830.5 7840.6 7764.8 7768.5 7772.6 7809.2 7830.6 7625.2 7662.1 7682.7 7684.7 7687.3 39442.6 39657.6 39729.2 39823.0 39823.6 2939.4 2990.6 3125.8 3312.7 3355.4 30254.7 30338.2 30559.4 30579.8 30986.7 3497.5 3501.2 3545.5 3588.2 3589.7 270182.0 273011.0 273067.0 274439.0 275046.0 31869.0 48602.5 49272.0 49283.8 49304.5 32140.2 34425.5 34499.1 34503.1 34541.0 13249.2 13316.5 13339.3 13419.9 13444.0 9623.7 9628.6 9649.3 9658.4 9693.8 7958.9 7995.2 7998.1 8029.7 8063.3 3079.9 3081.6 3102.1 3121.0 3186.2 838.6 872.7 931.8 1029.9 1068.6 27686.0 28412.0 28829.5 28896.7 29000.3 822.3 972.6 979.3 993.1 995.3 15248.7 15396.6 15434.1 15681.9 15716.8 395526.0 450705.0 460331.0 460929.0 689854.0 50989.5 51299.0 51558.5 51730.0 51750.7 1119.1 1193.6 1235.7 1242.3 1253.8 24221.6 27926.4 28073.6 28168.7 28473.9 39643.8 39897.8 40365.0 40380.6 40397.8 258815.0 260127.0 260387.0 261547.0 263014.0 22675.3 24859.5 25017.4 25844.4 25845.2 41821.8 42111.2 42340.6 42718.8 42901.1 35957.5 36128.5 36187.1 36464.5 36793.4 35784.3 36389.8 37242.0 37369.3 41123.6 32072.7 33381.5 36265.8 36966.0 37323.6 31205.7 32145.5 32583.7 32624.2 32707.0 24142.4 24386.8 24466.0 24611.6 24938.0 11:13:00 INFO - PROCESS | 25843 | 11:13:00 INFO - PROCESS | 25843 | [#2] jquery.html Cycles:180 Average:24726.09 Median:46520.59 stddev:68308.96 (146.8%) stddev-sans-first:68476.09 11:13:00 INFO - PROCESS | 25843 | Values: 361.9 367.4 368.1 373.8 383.5 15863.7 16711.7 16928.4 16982.7 17216.7 16104.3 16328.2 16968.5 17013.5 17071.7 4965.2 5062.5 5128.2 5145.5 5151.2 3616.7 3864.0 5056.5 5582.6 5873.4 5915.0 5917.6 5948.5 5950.3 5951.9 5780.2 5840.0 5914.5 5914.9 5924.8 3356.3 4916.0 5114.6 5194.0 5204.0 19545.3 20153.0 20263.5 20370.4 20382.7 1848.9 1910.3 1924.9 2196.1 2266.7 8889.2 9092.3 9434.7 9507.9 13008.3 1723.2 1778.2 1778.5 1797.3 1854.5 61944.0 70079.6 70985.6 71612.6 71747.9 9092.0 9689.0 9690.3 9796.6 10220.8 13608.7 13614.7 13723.1 13723.9 13750.0 6924.2 6944.0 6990.6 7062.6 7297.4 6493.2 6763.8 6768.5 6775.3 6862.0 4264.4 4335.8 4352.3 4413.9 4424.3 1676.2 1738.5 1799.3 1837.7 1860.3 853.0 853.9 902.2 926.4 996.2 16066.2 16110.4 16185.7 16251.7 16292.3 794.2 821.1 864.7 893.7 904.7 8270.8 9245.7 9286.4 9434.7 9463.3 409134.0 412933.0 412981.0 413916.0 423846.0 76847.6 77637.0 77949.2 79313.2 80137.0 902.4 906.1 911.5 916.9 934.6 14012.3 14661.4 14884.2 15373.4 15755.1 26433.6 34040.7 35763.0 36078.5 37467.4 45067.0 45602.3 47438.9 48187.0 48564.5 6609.3 7269.1 7278.9 7297.6 7430.7 10252.5 11734.8 11753.6 11953.6 11975.6 10181.5 10207.3 10256.7 10339.3 10443.0 9725.9 9753.6 9943.5 10019.4 10259.7 9900.1 10283.5 10290.3 10306.9 10643.0 7208.7 7223.9 7349.5 7369.9 7510.3 9445.5 9493.9 10236.0 10262.9 10553.8 11:13:00 INFO - PROCESS | 25843 | 11:13:00 INFO - PROCESS | 25843 | [#3] mootools.html Cycles:180 Average:5144.93 Median:5120.90 stddev:2914.55 (56.9%) stddev-sans-first:2908.31 11:13:00 INFO - PROCESS | 25843 | Values: 1287.6 1411.8 1457.0 1549.4 1776.0 6732.3 7569.1 7732.3 7741.8 8078.3 7735.7 7888.6 7903.1 7913.1 7929.1 1901.9 2177.8 2218.1 2248.3 2255.6 2221.6 2243.1 2246.1 2246.2 2249.9 2175.6 2233.3 2254.4 2255.4 2257.2 1867.6 2140.2 2170.5 2202.0 2206.8 2223.4 2242.9 2246.7 2246.7 2247.4 7850.0 7889.7 7895.4 7897.1 7910.1 4476.0 4609.8 4622.3 4622.7 4626.0 2777.9 2806.9 2921.4 2941.3 2950.0 838.4 866.4 882.2 892.6 903.5 10568.2 10570.6 10598.2 10610.8 10641.6 4271.1 4308.8 4365.3 4396.0 4406.8 9173.9 9186.7 9210.5 9244.5 9264.7 4545.8 4577.1 4579.2 4581.1 4587.7 3683.2 4082.8 4198.3 4207.4 4262.6 3689.7 3715.7 3743.7 3820.6 3838.3 1188.8 1200.6 1217.2 1220.4 1232.2 719.4 731.7 799.9 811.4 866.8 5119.8 5122.0 5279.0 5317.6 5371.9 391.7 394.9 400.7 402.4 407.2 3566.6 3599.2 3633.9 3651.2 3675.8 9453.3 9844.8 9847.2 9856.6 9862.3 9676.7 9751.8 9786.2 9805.0 9817.0 7372.4 7502.6 7508.7 7522.4 7530.8 5122.1 5154.6 5193.1 5288.1 5319.2 8623.8 8824.3 9006.0 9051.0 9158.6 9129.3 9165.4 9193.4 9235.1 9275.6 6102.8 6450.3 6606.6 6644.6 6706.2 7528.6 7554.5 7564.9 7598.2 7598.8 6490.2 6576.1 6613.1 6698.9 6732.2 6635.4 6642.5 6648.6 6654.0 6688.8 6131.2 6160.8 6171.6 6187.2 6187.8 4478.3 4625.9 4693.9 4725.7 4773.6 4515.0 4642.9 4669.6 4676.7 4718.8 11:13:00 INFO - PROCESS | 25843 | 11:13:00 INFO - PROCESS | 25843 | [#4] prototype.html Cycles:180 Average:4045.83 Median:4380.11 stddev:1141.45 (26.1%) stddev-sans-first:1109.20 11:13:00 INFO - PROCESS | 25843 | Values: 285.4 292.7 297.2 300.1 300.9 4787.8 4814.4 4845.5 4846.8 4859.8 4522.0 4627.3 4689.4 4775.9 4783.6 3822.2 3845.4 3852.8 3853.7 3856.1 3826.7 3864.3 3864.9 3876.9 3889.2 3616.8 3648.7 3785.3 3840.7 3870.3 3776.0 3814.3 3824.6 3835.2 3837.8 3374.4 3383.3 3390.6 3391.5 3397.6 4385.3 4543.5 4554.3 4561.8 4579.8 4299.7 4347.0 4353.9 4369.4 4371.0 5036.9 5072.8 5073.0 5074.1 5096.8 3629.7 3705.8 3710.6 3726.5 3727.3 5182.9 5215.4 5215.9 5240.0 5261.0 3771.5 3787.8 3791.3 3797.7 3818.6 3852.6 3861.6 3863.4 3865.3 3883.7 4093.5 4320.0 4349.7 4350.0 4354.3 4999.0 5010.6 5026.5 5059.5 5074.5 1249.1 1295.2 1323.0 1343.4 1348.3 876.5 878.3 896.5 902.1 905.2 3992.5 4010.8 4016.0 4047.6 4060.8 4605.4 4605.7 4616.2 4642.4 4663.3 4123.5 4125.0 4129.8 4130.2 4132.5 2342.9 2417.3 2472.4 2486.3 2521.4 4307.5 4348.5 4349.9 4400.0 4424.9 4641.7 4690.1 4696.3 4699.7 4728.7 4210.3 4346.8 4358.9 4378.6 4383.3 4567.2 4600.6 4652.9 4670.6 4673.9 4480.6 4498.7 4505.6 4542.0 4567.3 4083.2 4332.5 4332.5 4356.5 4381.6 3378.4 3449.2 3453.7 3457.5 3460.7 4520.8 4527.3 4534.5 4560.7 4979.5 4816.4 5021.8 5022.5 5028.9 5032.9 4990.4 5012.3 5037.5 5058.8 5072.4 4831.2 4964.6 4965.3 4977.2 4979.9 5047.7 5054.4 5070.3 5071.7 5076.7 4944.0 4944.4 4958.8 4966.6 4975.8 11:13:00 INFO - PROCESS | 25843 | 11:13:00 INFO - PROCESS | 25843 | [#5] yui.html Cycles:180 Average:13024.87 Median:490.11 stddev:15521.93 (3167.0%) stddev-sans-first:15537.41 11:13:00 INFO - PROCESS | 25843 | Values: 595.5 611.0 637.4 683.6 693.1 12004.8 12092.2 12106.9 12128.8 12781.1 11738.8 11833.9 11899.8 11967.8 11996.7 627.9 776.8 790.7 803.6 806.1 794.8 795.3 797.9 802.0 802.0 851.1 851.5 851.7 852.1 854.1 652.6 814.6 834.0 834.4 839.4 617.9 619.3 619.4 619.6 619.7 11946.2 11985.0 12005.2 12022.3 12022.3 11574.2 11900.9 11983.9 11988.7 12179.2 10414.1 10433.6 10565.7 10624.3 10861.9 4049.2 4052.3 4086.8 4107.2 4155.9 43777.0 44100.9 45387.8 45651.5 45795.0 9211.6 9295.6 9432.1 9466.7 9659.6 16878.7 16887.5 16911.4 16915.7 16947.6 6340.3 6399.9 6436.5 6453.4 6575.4 3534.5 3582.2 3605.5 3633.0 3670.4 2756.2 2834.6 2844.0 2845.8 2847.8 448.5 489.5 490.7 497.2 508.6 477.3 493.2 493.8 497.6 503.2 7774.7 7895.0 7979.3 8050.8 8075.0 463.5 529.7 532.4 555.7 563.6 3707.3 3710.2 3711.5 3738.1 3829.6 58261.4 59155.4 59279.4 59361.4 59402.4 43687.3 45338.3 53687.7 54654.5 54663.7 45137.8 45462.5 45772.8 45850.5 46150.0 7921.0 8035.5 8122.3 8182.4 8240.8 30853.2 31359.4 31372.0 31452.4 32013.0 37537.6 39033.6 40744.0 40806.6 40980.4 8954.2 9132.5 9157.9 9179.4 9264.8 11378.4 11539.4 11549.4 11603.7 11874.3 8089.3 8243.9 9847.8 10659.8 10723.8 9270.6 9486.8 10775.6 11054.0 11153.3 10218.0 10802.4 10907.3 11107.7 11256.5 8847.6 8969.3 9128.7 9131.3 9361.6 8895.5 9046.8 9437.7 9558.8 9796.0 11:13:00 INFO - PROCESS | 25843 | -------- Summary: end -------- 11:13:00 INFO - PROCESS | 25843 | 11:13:01 INFO - TEST-INFO | 25843: exit 0 11:13:01 INFO - TEST-OK | dromaeo_css | took 1119428ms 11:13:01 INFO - TEST-START | kraken 11:13:01 INFO - operating with platform_type : linux_ 11:13:01 INFO - Initialising browser for kraken test... 11:13:01 INFO - TEST-INFO | started process 26021 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3Mpaq7/profile http://localhost:50133/getInfo.html) 11:13:05 INFO - PROCESS | 26021 | __metrics Screen width/height:1600/1200 11:13:05 INFO - PROCESS | 26021 | colorDepth:24 11:13:05 INFO - PROCESS | 26021 | Browser inner width/height: 1024/697 11:13:05 INFO - PROCESS | 26021 | __metrics 11:13:06 ERROR - PROCESS | 26021 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:13:07 INFO - TEST-INFO | 26021: exit 0 11:13:07 INFO - Browser initialized. 11:13:07 INFO - Running cycle 1/1 for kraken test... 11:13:07 INFO - TEST-INFO | started process 26100 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3Mpaq7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:19 INFO - PROCESS | 26100 | RSS: Main: 154546176 11:13:19 INFO - PROCESS | 26100 | 11:13:22 INFO - PROCESS | 26100 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50133/tests/kraken/driver.html?testName=audio-beat-detection) 11:13:23 INFO - PROCESS | 26100 | RSS: Main: 210190336 11:13:23 INFO - PROCESS | 26100 | 11:13:26 INFO - PROCESS | 26100 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50133/tests/kraken/driver.html?testName=audio-dft) 11:13:26 INFO - PROCESS | 26100 | RSS: Main: 198938624 11:13:26 INFO - PROCESS | 26100 | 11:13:30 INFO - PROCESS | 26100 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50133/tests/kraken/driver.html?testName=audio-fft) 11:13:30 INFO - PROCESS | 26100 | RSS: Main: 267546624 11:13:30 INFO - PROCESS | 26100 | 11:13:32 INFO - PROCESS | 26100 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50133/tests/kraken/driver.html?testName=audio-oscillator) 11:13:33 INFO - PROCESS | 26100 | RSS: Main: 176959488 11:13:33 INFO - PROCESS | 26100 | 11:13:35 INFO - PROCESS | 26100 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50133/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:13:36 INFO - PROCESS | 26100 | RSS: Main: 180404224 11:13:36 INFO - PROCESS | 26100 | 11:13:39 INFO - PROCESS | 26100 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50133/tests/kraken/driver.html?testName=imaging-darkroom) 11:13:40 INFO - PROCESS | 26100 | RSS: Main: 215789568 11:13:40 INFO - PROCESS | 26100 | 11:13:44 INFO - PROCESS | 26100 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50133/tests/kraken/driver.html?testName=imaging-desaturate) 11:13:44 INFO - PROCESS | 26100 | RSS: Main: 214777856 11:13:44 INFO - PROCESS | 26100 | 11:13:47 INFO - PROCESS | 26100 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50133/tests/kraken/driver.html?testName=json-parse-financial) 11:13:48 INFO - PROCESS | 26100 | RSS: Main: 215183360 11:13:48 INFO - PROCESS | 26100 | 11:13:50 INFO - PROCESS | 26100 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50133/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:13:50 INFO - PROCESS | 26100 | RSS: Main: 210255872 11:13:50 INFO - PROCESS | 26100 | 11:13:52 INFO - PROCESS | 26100 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50133/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:13:53 INFO - PROCESS | 26100 | RSS: Main: 212688896 11:13:53 INFO - PROCESS | 26100 | 11:13:55 INFO - PROCESS | 26100 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50133/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:13:56 INFO - PROCESS | 26100 | RSS: Main: 218742784 11:13:56 INFO - PROCESS | 26100 | 11:13:59 INFO - PROCESS | 26100 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50133/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:14:00 INFO - PROCESS | 26100 | RSS: Main: 220303360 11:14:00 INFO - PROCESS | 26100 | 11:14:02 INFO - PROCESS | 26100 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50133/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:14:03 INFO - PROCESS | 26100 | RSS: Main: 218161152 11:14:03 INFO - PROCESS | 26100 | 11:14:05 INFO - PROCESS | 26100 | Cycle 1(1): loaded http://localhost:50133/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50133/tests/kraken/driver.html?testName=ai-astar) 11:14:05 INFO - PROCESS | 26100 | RSS: Main: 264359936 11:14:05 INFO - PROCESS | 26100 | 11:14:05 INFO - PROCESS | 26100 | __start_tp_report 11:14:05 INFO - PROCESS | 26100 | _x_x_mozilla_page_load 11:14:05 INFO - PROCESS | 26100 | _x_x_mozilla_page_load_details 11:14:05 INFO - PROCESS | 26100 | |i|pagename|runs| 11:14:05 INFO - PROCESS | 26100 | |0;ai-astar;113;110;117;116;116;114;114;115;113;115 11:14:05 INFO - PROCESS | 26100 | |1;audio-beat-detection;159;129;154;210;130;155;162;132;195;130 11:14:05 INFO - PROCESS | 26100 | |2;audio-dft;161;161;161;160;161;160;160;162;160;160 11:14:05 INFO - PROCESS | 26100 | |3;audio-fft;76;76;76;159;75;75;78;74;138;74 11:14:05 INFO - PROCESS | 26100 | |4;audio-oscillator;95;94;152;94;97;94;121;93;93;126 11:14:05 INFO - PROCESS | 26100 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;116 11:14:05 INFO - PROCESS | 26100 | |6;imaging-darkroom;145;146;146;146;146;145;145;147;146;145 11:14:05 INFO - PROCESS | 26100 | |7;imaging-desaturate;94;94;94;95;95;94;94;94;94;95 11:14:05 INFO - PROCESS | 26100 | |8;json-parse-financial;64;64;65;64;64;64;64;65;64;64 11:14:05 INFO - PROCESS | 26100 | |9;json-stringify-tinderbox;66;65;67;66;65;66;65;65;68;65 11:14:05 INFO - PROCESS | 26100 | |10;stanford-crypto-aes;88;83;82;81;84;83;91;88;164;83 11:14:05 INFO - PROCESS | 26100 | |11;stanford-crypto-ccm;132;131;132;145;128;137;129;129;151;133 11:14:05 INFO - PROCESS | 26100 | |12;stanford-crypto-pbkdf2;178;172;170;169;170;170;179;175;172;167 11:14:05 INFO - PROCESS | 26100 | |13;stanford-crypto-sha256-iterative;66;66;69;66;67;65;66;66;64;65 11:14:05 INFO - PROCESS | 26100 | __end_tp_report 11:14:05 INFO - PROCESS | 26100 | __start_cc_report 11:14:05 INFO - PROCESS | 26100 | _x_x_mozilla_cycle_collect,2106 11:14:05 INFO - PROCESS | 26100 | __end_cc_report 11:14:05 INFO - PROCESS | 26100 | __startTimestamp1463681645674__endTimestamp 11:14:05 INFO - PROCESS | 26100 | 11:14:05 INFO - PROCESS | 26100 | ------- Summary: start ------- 11:14:05 INFO - PROCESS | 26100 | Number of tests: 14 11:14:05 INFO - PROCESS | 26100 | 11:14:05 INFO - PROCESS | 26100 | [#0] ai-astar Cycles:10 Average:114.30 Median:115.00 stddev:2.00 (1.7%) stddev-sans-first:2.07 11:14:05 INFO - PROCESS | 26100 | Values: 113.0 110.0 117.0 116.0 116.0 114.0 114.0 115.0 113.0 115.0 11:14:05 INFO - PROCESS | 26100 | 11:14:05 INFO - PROCESS | 26100 | [#1] audio-beat-detection Cycles:10 Average:155.60 Median:157.00 stddev:28.17 (17.9%) stddev-sans-first:29.85 11:14:05 INFO - PROCESS | 26100 | Values: 159.0 129.0 154.0 210.0 130.0 155.0 162.0 132.0 195.0 130.0 11:14:05 INFO - PROCESS | 26100 | 11:14:05 INFO - PROCESS | 26100 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 11:14:05 INFO - PROCESS | 26100 | Values: 161.0 161.0 161.0 160.0 161.0 160.0 160.0 162.0 160.0 160.0 11:14:05 INFO - PROCESS | 26100 | 11:14:05 INFO - PROCESS | 26100 | [#3] audio-fft Cycles:10 Average:90.10 Median:75.50 stddev:31.20 (41.3%) stddev-sans-first:32.67 11:14:05 INFO - PROCESS | 26100 | Values: 76.0 76.0 76.0 159.0 75.0 75.0 78.0 74.0 138.0 74.0 11:14:05 INFO - PROCESS | 26100 | 11:14:05 INFO - PROCESS | 26100 | [#4] audio-oscillator Cycles:10 Average:105.90 Median:94.00 stddev:20.31 (21.6%) stddev-sans-first:21.16 11:14:05 INFO - PROCESS | 26100 | Values: 95.0 94.0 152.0 94.0 97.0 94.0 121.0 93.0 93.0 126.0 11:14:05 INFO - PROCESS | 26100 | 11:14:05 INFO - PROCESS | 26100 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:14:05 INFO - PROCESS | 26100 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 11:14:05 INFO - PROCESS | 26100 | 11:14:05 INFO - PROCESS | 26100 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 11:14:05 INFO - PROCESS | 26100 | Values: 145.0 146.0 146.0 146.0 146.0 145.0 145.0 147.0 146.0 145.0 11:14:05 INFO - PROCESS | 26100 | 11:14:05 INFO - PROCESS | 26100 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:14:05 INFO - PROCESS | 26100 | Values: 94.0 94.0 94.0 95.0 95.0 94.0 94.0 94.0 94.0 95.0 11:14:05 INFO - PROCESS | 26100 | 11:14:05 INFO - PROCESS | 26100 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 11:14:05 INFO - PROCESS | 26100 | Values: 64.0 64.0 65.0 64.0 64.0 64.0 64.0 65.0 64.0 64.0 11:14:05 INFO - PROCESS | 26100 | 11:14:05 INFO - PROCESS | 26100 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:1.03 (1.6%) stddev-sans-first:1.09 11:14:05 INFO - PROCESS | 26100 | Values: 66.0 65.0 67.0 66.0 65.0 66.0 65.0 65.0 68.0 65.0 11:14:05 INFO - PROCESS | 26100 | 11:14:05 INFO - PROCESS | 26100 | [#10] stanford-crypto-aes Cycles:10 Average:92.70 Median:83.50 stddev:25.25 (30.2%) stddev-sans-first:26.73 11:14:05 INFO - PROCESS | 26100 | Values: 88.0 83.0 82.0 81.0 84.0 83.0 91.0 88.0 164.0 83.0 11:14:05 INFO - PROCESS | 26100 | 11:14:05 INFO - PROCESS | 26100 | [#11] stanford-crypto-ccm Cycles:10 Average:134.70 Median:132.50 stddev:7.59 (5.7%) stddev-sans-first:7.98 11:14:05 INFO - PROCESS | 26100 | Values: 132.0 131.0 132.0 145.0 128.0 137.0 129.0 129.0 151.0 133.0 11:14:05 INFO - PROCESS | 26100 | 11:14:05 INFO - PROCESS | 26100 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:172.00 stddev:3.94 (2.3%) stddev-sans-first:3.57 11:14:05 INFO - PROCESS | 26100 | Values: 178.0 172.0 170.0 169.0 170.0 170.0 179.0 175.0 172.0 167.0 11:14:05 INFO - PROCESS | 26100 | 11:14:05 INFO - PROCESS | 26100 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.33 (2.0%) stddev-sans-first:1.41 11:14:05 INFO - PROCESS | 26100 | Values: 66.0 66.0 69.0 66.0 67.0 65.0 66.0 66.0 64.0 65.0 11:14:05 INFO - PROCESS | 26100 | -------- Summary: end -------- 11:14:05 INFO - PROCESS | 26100 | 11:14:06 INFO - TEST-INFO | 26100: exit 0 11:14:06 INFO - TEST-OK | kraken | took 65683ms 11:14:06 INFO - SUITE-END | took 1185s 11:14:06 INFO - Completed test suite (00:19:45) 11:14:06 INFO - javascript benchmark 11:14:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2631.8947242110316, 2648.8145829791924, 2686.9462610747787, 2687.8387296762194, 2696.4741875334307, 4589.806650270933, 4607.861764147073, 4659.254519276917, 4665.2768820832825, 4713.340132381465, 4686.062787442508, 4715.575598196162, 4744.57298843104, 4779.091972525218, 4781.928271075936, 4294.334378171373, 4306.870793876189, 4324.524302326741, 4380.978095109528, 4425.203463376591, 4382.4741031076155, 4415.602595766396, 4456.5766252205985, 4496.685232033759, 4500.414946057024, 4251.383549385322, 4418.955810441887, 4434.490033646123, 4455.710378825366, 4463.174312752135, 4289.335153051282, 4310.82756689732, 4333.0, 4344.152890186415, 4352.151330490556, 4315.029118448324, 4374.212641724488, 4374.4531933508315, 4375.846845360397, 4435.223835828717, 4505.346724724929, 4678.95321046792, 4691.835785747482, 4710.905781884378, 4718.528147185289, 4946.282788995575, 4951.331570238008, 4963.354763880672, 4977.925331120036, 5030.89938201234, 5016.523430274118, 5036.169032109698, 5040.899182016376, 5041.369828771403, 5047.293378926953, 4615.330777037311, 4630.097131059411, 4748.38271024768, 4772.284157376422, 4775.5463230993, 5065.797368105234, 5080.517350851663, 5152.27868098459, 5156.561692256125, 5157.896842063138, 4932.062908047459, 4940.382452193476, 4971.825986090542, 4980.800767969313, 4985.326980857611, 4928.28539861718, 5004.649674522749, 5016.046951079284, 5017.498250175026, 5064.088464076502, 5008.449070602231, 5023.723695196799, 5042.067217564762, 5047.141985862412, 5077.644564880423, 5027.798888044437, 5027.949720502748, 5033.597312215014, 5035.597152227813, 5067.391912970467, 4146.751194928314, 4181.790910454465, 4203.453551038346, 4228.492580890252, 4306.224879521654, 3693.8153092345274, 3701.555813302421, 3709.8145092745253, 3751.005983414397, 3767.3972164453558, 4352.869413917588, 4388.078503514298, 4388.648908087345, 4424.358468022118, 4432.357308190294, 4951.455339912607, 5050.873728156826, 5053.696778193246, 5075.873103172376, 5090.821821236313, 4394.077243778778, 4412.646988240933, 4417.8232870684815, 4428.092241090569, 4462.085272519126, 4562.954370456319, 4565.292379681155, 4568.840090596879, 4571.497135315112, 4620.214563524209, 4703.459102203222, 4742.881427964328, 4753.691010084333, 4788.640851936049, 4792.424909010941, 5065.316182315488, 5077.1876499759865, 5086.949130508648, 5088.898222035613, 5139.152039913522, 4756.928646070242, 4784.545468180518, 4794.832180873653, 4796.208625576741, 4810.59109975656, 4773.474917758975, 4923.483034281492, 4980.850574482772, 5018.949810501848, 5020.397552293748, 5066.138756411346, 5085.7457127144235, 5087.949120508748, 5092.159793634157, 5142.357205349332, 4759.6430267729365, 4944.48082951285, 4953.405591329064, 4954.529319714621, 4955.0, 4862.489438608895, 4866.464688884291, 4885.4870238624435, 4895.975520122377, 4922.606191504743, 4800.087983283165, 4812.422509298906, 4861.683990540603, 4883.121038213156, 4885.2427873679635, 4766.046790641816, 4909.631777616764, 4942.456329803646, 4982.427020892499, 4995.050940321327, 4814.638902082288, 4826.493218212037, 4826.686265392738, 4880.438749543706, 4882.487338829372], "value": 4636.276983310348, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.6612032780332, 582.8309790160853, 585.4730742331898, 589.8466398736327, 594.1592646405337, 28306.433871322588, 31205.063848084537, 31223.531647025313, 31235.375292494136, 31251.687483125217, 30895.227619309528, 41107.0, 42717.35923961143, 42779.786101069454, 47292.0, 7625.4280928930275, 7753.689852405925, 7780.8832867507035, 7792.0, 7792.337651299618, 7606.619669016554, 7757.922420775776, 7765.572893490856, 7769.0, 7777.10563285221, 7765.961170194141, 7809.804754881145, 7829.33450656692, 7830.530168189927, 7840.647170877324, 7764.844703105934, 7768.5338879667115, 7772.611369431505, 7809.180036096185, 7830.56931868747, 7625.161232264447, 7662.118856331537, 7682.692692292301, 7684.654190561439, 7687.2697093776005, 39442.60557394418, 39657.60342396568, 39729.20541589152, 39823.0, 39823.60176398228, 2939.3974235281717, 2990.5514172874027, 3125.828079455629, 3312.7018568328967, 3355.39602871483, 30254.697453025627, 30338.241543961358, 30559.388812223853, 30579.847100764575, 30986.690133098607, 3497.510348551205, 3501.212227248874, 3545.5213546171453, 3588.2464682416726, 3589.6589823966683, 270182.0, 273011.0, 273067.0, 274438.999999998, 275046.0, 31869.0, 48602.51397486051, 49272.0, 49283.75358123187, 49304.50695493071, 32140.19649508781, 34425.483617745755, 34499.13752156216, 34503.137421564665, 34541.0, 13249.205047696976, 13316.46734130624, 13339.333033348294, 13419.865801342057, 13444.0, 9623.711288661352, 9628.566714497725, 9649.276304277208, 9658.420494770337, 9693.757656058513, 7958.880616790752, 7995.200479951958, 7998.12020677725, 8029.7189598363775, 8063.27430531255, 3079.892203772857, 3081.5839861618842, 3102.1314032071054, 3120.9843950780555, 3186.1715953852167, 838.6268110690684, 872.7207293665966, 931.8322701913585, 1029.912457441111, 1068.5779117248644, 27686.0, 28412.0, 28829.500972390375, 28896.711032889823, 29000.274993125342, 822.3421262989584, 972.5866506734609, 979.3340528440586, 993.0913214408879, 995.328153496387, 15248.695026099416, 15396.61508462275, 15434.073955562702, 15681.921590391976, 15716.764248536281, 395526.0, 450705.0, 460331.0, 460929.0, 689854.0, 50989.49010509848, 51299.0, 51558.48441515537, 51730.0, 51750.741246293524, 1119.1158984402393, 1193.6419074277683, 1235.734317121823, 1242.3043095866344, 1253.8370011898394, 24221.636675450234, 27926.441471170056, 28073.57889631616, 28168.71831281661, 28473.857630711715, 39643.80178099091, 39897.80051099726, 40365.0, 40380.586679466076, 40397.798011009756, 258815.0, 260127.0, 260387.0, 261547.0, 263014.0, 22675.319740407813, 24859.502809943337, 25017.374565636004, 25844.35389115287, 25845.22464326073, 41821.79089104535, 42111.15777684368, 42340.576594233666, 42718.78640606901, 42901.14197716091, 35957.46063808993, 36128.4580731284, 36187.09532261715, 36464.453033203994, 36793.448098279085, 35784.284314314085, 36389.81805091064, 37242.0, 37369.25261494701, 41123.58876411317, 32072.6792732079, 33381.49927751134, 36265.818670906476, 36966.0, 37323.62676373201, 31205.68794312028, 32145.517817232292, 32583.674163259013, 32624.184395390304, 32707.0, 24142.39644008914, 24386.756132439157, 24466.0, 24611.63082553727, 24938.0], "value": 16390.75585647739, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.9330423871584, 367.4139747103371, 368.1055036261884, 373.7551903503203, 383.4669808965538, 15863.682726345467, 16711.749323760152, 16928.4075057373, 16982.745258821127, 17216.741748873763, 16104.275307611157, 16328.18359082047, 16968.49094527166, 17013.48959531213, 17071.743923841153, 4965.205567109263, 5062.493750624945, 5128.205128205134, 5145.536901678848, 5151.201563757605, 3616.7287453440968, 3863.9806800965957, 5056.469070747574, 5582.609217354767, 5873.412658734113, 5914.970425147868, 5917.5561832862495, 5948.464638182562, 5950.285965684124, 5951.88096238075, 5780.219670344533, 5839.970800145993, 5914.467697907187, 5914.911276330837, 5924.822255332347, 3356.278400143981, 4915.975420122876, 5114.565261952738, 5194.0, 5203.973980130075, 19545.315913942944, 20153.0, 20263.4934126648, 20370.388888333375, 20382.69425958612, 1848.8613353998503, 1910.293191519133, 1924.8556358273186, 2196.121551379445, 2266.7393249776324, 8889.155530224618, 9092.318076144316, 9434.669786557506, 9507.857382139273, 13008.284544350057, 1723.1814887928258, 1778.2353587957173, 1778.5286898971783, 1797.2631221199244, 1854.5178253654012, 61944.0, 70079.64960175217, 70985.64507177482, 71612.64193678998, 71747.92378114385, 9091.954540227389, 9688.982656821074, 9690.321677482649, 9796.608135674493, 10220.795584088277, 13608.65978350549, 13614.659633509043, 13723.1079979801, 13723.931380343034, 13750.0, 6924.23833378328, 6943.965280173667, 6990.580565166107, 7062.576245425291, 7297.379722723522, 6493.220813502316, 6763.830904227434, 6768.492363072789, 6775.254721980578, 6861.965690171517, 4264.424302719155, 4335.7615331157085, 4352.260115780325, 4413.933790993137, 4424.3142312941545, 1676.1535424610738, 1738.5305967388733, 1799.2623024559869, 1837.7058574382686, 1860.3488778927538, 852.9957350213333, 853.923146916768, 902.2105657549644, 926.4024704065974, 996.1681995533665, 16066.196690165445, 16110.355585776671, 16185.676286474205, 16251.674966500605, 16292.266847991868, 794.1740589786673, 821.1008945204991, 864.6757465950269, 893.7095443980733, 904.7014485219862, 8270.793230169294, 9245.676401325922, 9286.396384235004, 9434.716958491255, 9463.337566370288, 409134.0, 412933.0, 412981.0, 413916.0, 423846.0, 76847.61576192084, 77637.0, 77949.22050779419, 79313.20686793173, 80137.0, 902.3683421604903, 906.0848542971514, 911.4816807124627, 916.8945571259391, 934.6495064350869, 14012.299385030912, 14661.41354345857, 14884.18137002432, 15373.38506459729, 15755.13346765893, 26433.60349594719, 34040.65959340474, 35763.0, 36078.45882311715, 37467.43798842965, 45067.0, 45602.31596526121, 47438.855099819346, 48187.0, 48564.51435485741, 6609.3060228675295, 7269.091363579552, 7278.890816637861, 7297.63511824396, 7430.665620047219, 10252.538635761259, 11734.765304693688, 11753.588624398106, 11953.581624643444, 11975.580854670045, 10181.490925453845, 10207.285490015925, 10256.743581410525, 10339.276250662382, 10443.0, 9725.85411218818, 9753.609855605697, 9943.502824858873, 10019.448930308903, 10259.7435064124, 9900.108990190918, 10283.537240824331, 10290.331128476626, 10306.896931030593, 10643.0, 7208.675609597685, 7223.891641625275, 7349.522281051714, 7369.889451658337, 7510.286522780327, 9445.527723613654, 9493.905060949579, 10236.0, 10262.948685256526, 10553.788924221319], "value": 8114.374034514258, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1287.555793251328, 1411.7811739180424, 1457.016513853149, 1549.4034796603305, 1776.0498133498572, 6732.2931092235285, 7569.12955010174, 7732.265434783687, 7741.845163096735, 8078.272955434009, 7735.651895664694, 7888.56612886291, 7903.051633803937, 7913.089994650617, 7929.088154862178, 1901.9429417117508, 2177.7822217778253, 2218.0794970087395, 2248.291788086756, 2255.5827171973237, 2221.6445368741006, 2243.1139699818564, 2246.1127854497545, 2246.2362796649136, 2249.865008099511, 2175.630142875707, 2233.251860626692, 2254.402583315423, 2255.436140964759, 2257.1535674122206, 1867.55178757098, 2140.2402147237663, 2170.5116348821466, 2202.0, 2206.8455208135438, 2223.3552269841725, 2242.865428074321, 2246.663000549914, 2246.7191601049867, 2247.359502541784, 7850.0, 7889.723859664941, 7895.368370530344, 7897.05235371759, 7910.129885712567, 4475.977620111878, 4609.7695115244105, 4622.306654001893, 4622.722636641813, 4625.953740462586, 2777.8611069446447, 2806.9157925262275, 2921.3865088331477, 2941.2793865502877, 2949.970500294991, 838.4256784102909, 866.3805379153872, 882.2412725056446, 892.607252808762, 903.5256490342557, 10568.154547636248, 10570.630027948984, 10598.152147828156, 10610.840837387444, 10641.57433702651, 4271.060366719316, 4308.771999980053, 4365.301551751768, 4396.032872767986, 4406.757628330409, 9173.908260917438, 9186.724398267928, 9210.493422861808, 9244.537773111317, 9264.67573634933, 4545.818167273338, 4577.084583083397, 4579.244424669959, 4581.129585378767, 4587.7017993830295, 3683.1528748387486, 4082.8366865325056, 4198.286291330481, 4207.431996680409, 4262.616364527207, 3689.741718079709, 3715.7213209009433, 3743.6817870481314, 3820.5797362290127, 3838.2707285615643, 1188.7979043562616, 1200.6218041317131, 1217.178404576907, 1220.3837062283667, 1232.2175418609247, 719.4280546965175, 731.6890321613399, 799.9040115186215, 811.4441607498882, 866.7529754020075, 5119.795208191631, 5122.0, 5279.049771041173, 5317.601179911522, 5371.946280537223, 391.74145064257453, 394.8756141815319, 400.70347942522324, 402.3984143705121, 407.1714061884052, 3566.5720113586017, 3599.226166374242, 3633.8728144514816, 3651.1602331463914, 3675.8162091895297, 9453.291003174789, 9844.80310393788, 9847.162991145833, 9856.605735770489, 9862.260330475243, 9676.70969870905, 9751.804963900682, 9786.217102631772, 9805.0, 9816.950915245377, 7372.373348265351, 7502.62486875654, 7508.662110205054, 7522.435817313614, 7530.811729706801, 5122.103631864484, 5154.561862241751, 5193.091209038479, 5288.101022826206, 5319.2287118368395, 8623.784405389915, 8824.3381746368, 9005.954970225106, 9050.954745226232, 9158.633654653739, 9129.315301352557, 9165.358424910459, 9193.448393096436, 9235.12266334697, 9275.582598783207, 6102.847428814315, 6450.258220304538, 6606.636634985122, 6644.60132392058, 6706.161729783777, 7528.585927773806, 7554.471187016856, 7564.9243507566425, 7598.164201937893, 7598.848023039619, 6490.188726409199, 6576.112224849584, 6613.074169616354, 6698.866022679422, 6732.225794033749, 6635.402813746786, 6642.468602511691, 6648.5678430901835, 6653.9667301663185, 6688.765893193715, 6131.172291740736, 6160.753569857335, 6171.6297022178815, 6187.195664563578, 6187.752489900354, 4478.261086920622, 4625.884352891205, 4693.906121877475, 4725.716457012591, 4773.570378665798, 4514.954850451453, 4642.86071417858, 4669.603083737785, 4676.672632915664, 4718.834840780693], "value": 4059.765691421324, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.42771742655987, 292.654667492359, 297.1694114948719, 300.1445879244154, 300.85859645966417, 4787.784549695263, 4814.3741313629225, 4845.466998630152, 4846.830360937368, 4859.757012149396, 4521.954780452194, 4627.282771170466, 4689.437267527901, 4775.880602984918, 4783.564930520839, 3822.178231680188, 3845.442410850425, 3852.8266228019666, 3853.730238883279, 3856.113093988384, 3826.7321287509885, 3864.2657895, 3864.9227015459674, 3876.903077423073, 3889.2027134437512, 3616.801075940822, 3648.726345524083, 3785.318642644323, 3840.6735427488557, 3870.2646497165447, 3776.017590764843, 3814.275287695357, 3824.598417166213, 3835.1946091320715, 3837.846486140579, 3374.3588718143474, 3383.2895092030703, 3390.610079840825, 3391.5082313064468, 3397.5583174187445, 4385.320275357293, 4543.522930092358, 4554.294084416921, 4561.840335588238, 4579.80924959513, 4299.720518166309, 4346.956530434687, 4353.934690979606, 4369.410129632491, 4370.978145109254, 5036.899262014776, 5072.847814565569, 5072.974635126838, 5074.086664400406, 5096.79612815487, 3629.67332940034, 3705.7776533407814, 3710.5547334319785, 3726.5341832270965, 3727.254549090193, 5182.870428239286, 5215.426303106655, 5215.869603259911, 5240.0, 5261.0, 3771.4908487354405, 3787.791671458096, 3791.279656865242, 3797.715171362159, 3818.6181381862148, 3852.556955950102, 3861.5559210690567, 3863.3818589025623, 3865.265599536079, 3883.669888059547, 4093.5087789465456, 4320.0, 4349.695521313541, 4350.042990542076, 4354.259775838115, 4998.975005125024, 5010.599152067826, 5026.4973502649445, 5059.494050594984, 5074.517920797518, 1249.1443361297358, 1295.2099219476113, 1323.007744191856, 1343.4424713743688, 1348.298884580013, 876.5047748022347, 878.332467324825, 896.4666023715879, 902.1429641840278, 905.2395987370641, 3992.540857801332, 4010.7794071325775, 4016.0, 4047.5547689754103, 4060.827457310325, 4605.378273933044, 4605.654575906753, 4616.238320677051, 4642.396488456547, 4663.300504924288, 4123.463949686581, 4124.958750412457, 4129.752214867118, 4130.194612050621, 4132.504099508078, 2342.906283748665, 2417.262734865883, 2472.4066224106086, 2486.2914069490107, 2521.407469244726, 4307.504636966789, 4348.543402942709, 4349.891252718644, 4400.031992961607, 4424.867253982386, 4641.655963738291, 4690.061987602493, 4696.272077827942, 4699.697148397261, 4728.692634978715, 4210.32634778434, 4346.847860324873, 4358.932061644854, 4378.649708023414, 4383.342498625232, 4567.223571992836, 4600.631949444103, 4652.93020604698, 4670.626349892068, 4673.859784206479, 4480.596746292719, 4498.662600304925, 4505.594496495331, 4542.0, 4567.314902764479, 4083.244599749056, 4332.458442694663, 4332.4801023877335, 4356.455443069616, 4381.568229632585, 3378.4256676364585, 3449.2066824629974, 3453.706434953057, 3457.481377793351, 3460.7231421486727, 4520.779389564734, 4527.275635898241, 4534.478534968389, 4560.703554268962, 4979.526944940225, 4816.4220293564995, 5021.84934451967, 5022.497750225094, 5028.9245661315845, 5032.874178145576, 4990.3762029746285, 5012.348394708664, 5037.471065538066, 5058.822941197188, 5072.416672082758, 4831.154547954165, 4964.602831773377, 4965.280034395065, 4977.203647416396, 4979.9004019918675, 5047.722375269395, 5054.4187418447345, 5070.340855688884, 5071.721055341844, 5076.670016448919, 4943.950560494349, 4944.406671199479, 4958.776855041459, 4966.62269656637, 4975.800967961386], "value": 3689.37595398555, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.5116804220539, 610.9694515274235, 637.4326849104298, 683.5727670206121, 693.0920494152659, 12004.75990480191, 12092.153549251534, 12106.878931210696, 12128.81806772897, 12781.105322627409, 11738.765224695522, 11833.881661183386, 11899.821502677467, 11967.820482692767, 11996.700082497942, 627.9183706118198, 776.8407476467339, 790.6876783670461, 803.586153131135, 806.1454857850667, 794.7774623105539, 795.327947884037, 797.8763291689797, 802.009518244967, 802.0375549340786, 851.1148405658108, 851.5018714052287, 851.748734123432, 852.1095455249249, 854.0989256334565, 652.6377860287539, 814.6334149632689, 834.028356964136, 834.3617132893341, 839.4375768235298, 617.9134921111048, 619.2537991719967, 619.4177473175246, 619.5848781316529, 619.6963487890946, 11946.223495472766, 11985.0, 12005.219660722112, 12022.27866328023, 12022.338771367571, 11574.247673901255, 11900.940495297467, 11983.94008029963, 11988.70028249292, 12179.208351457128, 10414.114800241989, 10433.634822781167, 10565.73585660357, 10624.256302058859, 10861.945690271577, 4049.2104039712267, 4052.331365324718, 4086.7752273624938, 4107.178564287125, 4155.937660935088, 43777.0, 44100.897477563, 45387.773061134816, 45651.54348456506, 45795.0, 9211.631534738535, 9295.628174873065, 9432.056794320513, 9466.715998520056, 9659.565319560637, 16878.74681879773, 16887.493375198763, 16911.408100716417, 16915.661686766194, 16947.57631059209, 6340.302566717657, 6399.872002559922, 6436.485081193493, 6453.386928241809, 6575.4410875076155, 3534.4698295255403, 3582.2477279771538, 3605.4591811228524, 3632.9818350908604, 3670.3576874047467, 2756.1593713917446, 2834.5748137779087, 2843.9857800710865, 2845.7865660075577, 2847.8148920320114, 448.49544262704455, 489.5471688687949, 490.6712502623251, 497.1647631978311, 508.5600955173748, 477.2652700028854, 493.2108626198126, 493.8074151081081, 497.6267799150637, 503.1923762361357, 7774.727884524128, 7894.9847067512965, 7979.3217576505485, 8050.798730031679, 8075.0, 463.4716423277466, 529.7377797990019, 532.4382776171177, 555.7360253879375, 563.599844110686, 3707.3141468828353, 3710.165212827092, 3711.480392745018, 3738.065483629093, 3829.617038296148, 58261.41738582645, 59155.40844591585, 59279.40720592739, 59361.40638593559, 59402.40597594055, 43687.344689829675, 45338.31992520115, 53687.73156134273, 54654.45345546573, 54663.72668136634, 45137.77431112823, 45462.54537454649, 45772.77113614477, 45850.54149458463, 46150.0, 7921.0, 8035.517868927883, 8122.309603683753, 8182.386321026066, 8240.793980150544, 30853.22866928255, 31359.372812543166, 31372.0, 31452.370952580364, 32013.0, 37537.624623753414, 39033.609663903, 40744.0, 40806.591934081465, 40980.3852942212, 8954.194122529003, 9132.452052876848, 9157.86263206039, 9179.403338782959, 9264.814703706023, 11378.43107844588, 11539.423028848356, 11549.36478493691, 11603.709907252387, 11874.346910919983, 8089.271965523131, 8243.876341854997, 9847.803043939224, 10659.840102398626, 10723.785524289626, 9270.629174832931, 9486.762830929281, 10775.6228532001, 11054.0, 11153.275037122561, 10218.0, 10802.405867677353, 10907.345559266469, 11107.72230694239, 11256.549738010388, 8847.560462618905, 8969.327300452362, 9128.680496182602, 9131.269498439977, 9361.578728957076, 8895.510746908982, 9046.773830654287, 9437.716868493957, 9558.761030974003, 9796.020397960147], "value": 5822.901577090623, "unit": "score"}], "name": "dromaeo_css", "value": 6143.9016660696825, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 117.0, 116.0, 116.0, 114.0, 114.0, 115.0, 113.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 129.0, 154.0, 210.0, 130.0, 155.0, 162.0, 132.0, 195.0, 130.0], "value": 155.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 161.0, 160.0, 160.0, 162.0, 160.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 159.0, 75.0, 75.0, 78.0, 74.0, 138.0, 74.0], "value": 90.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 152.0, 94.0, 97.0, 94.0, 121.0, 93.0, 93.0, 126.0], "value": 105.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 147.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 66.0, 65.0, 66.0, 65.0, 65.0, 68.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 83.0, 82.0, 81.0, 84.0, 83.0, 91.0, 88.0, 164.0, 83.0], "value": 92.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 131.0, 132.0, 145.0, 128.0, 137.0, 129.0, 129.0, 151.0, 133.0], "value": 134.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 172.0, 170.0, 169.0, 170.0, 170.0, 179.0, 175.0, 172.0, 167.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 69.0, 66.0, 67.0, 65.0, 66.0, 66.0, 64.0, 65.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1578.9, "alertThreshold": 2.0}]} 11:14:06 INFO - Return code: 0 11:14:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:14:06 ERROR - # TBPL SUCCESS # 11:14:06 INFO - Running post-action listener: _resource_record_post_action 11:14:06 INFO - ##### 11:14:06 INFO - ##### Finished run-tests step (success) 11:14:06 INFO - ##### 11:14:06 INFO - Running post-run listener: _resource_record_post_run 11:14:07 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 383893504; Read time: 0; Write time: 341492 11:14:07 INFO - TinderboxPrint: CPU usage
13.2% 11:14:07 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:14:07 INFO - TinderboxPrint: I/O write bytes / time
383,893,504 / 341,492 11:14:07 INFO - TinderboxPrint: CPU idle
8,328.0 (86.8%) 11:14:07 INFO - TinderboxPrint: CPU user
1,222.2 (12.7%) 11:14:07 INFO - TinderboxPrint: Swap in / out
0 / 0 11:14:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 94887936; Read time: 0; Write time: 71216 11:14:07 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 289005568; Read time: 0; Write time: 270276 11:14:07 INFO - Running post-run listener: _upload_blobber_files 11:14:07 INFO - Blob upload gear active. 11:14:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:14:07 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 11:14:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:14:08 INFO - (blobuploader) - INFO - Open directory for files ... 11:14:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:14:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:14:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:08 INFO - (blobuploader) - INFO - Done attempting. 11:14:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:14:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:14:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:09 INFO - (blobuploader) - INFO - Done attempting. 11:14:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:14:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:14:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:13 INFO - (blobuploader) - INFO - Done attempting. 11:14:13 INFO - (blobuploader) - INFO - Iteration through files over. 11:14:13 INFO - Return code: 0 11:14:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:14:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:14:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bb54c8b0048789c1d929df835370b4af5973d901040ce36ef88a485a24e42952f6f212339b6d3f61d54929ed8ccf36b65541ee51a8eb2fda652f0dd698cb84ee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/361fc54d4ffd6c855bda501d25e33be7b1de9433eed740e012e696420f550cf8af646918286eac9674ca4c85b289fbd7b18d337705441fc1774ccd0a9e6f2744", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f54198d69841c34053db913277f06df2f4faca64945297aa49bac1826c26658b3df44716ea6ca7baa967f97c507b53f2c02c52d8317da6bde99e263518066cfa"} 11:14:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:14:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:14:13 INFO - Contents: 11:14:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bb54c8b0048789c1d929df835370b4af5973d901040ce36ef88a485a24e42952f6f212339b6d3f61d54929ed8ccf36b65541ee51a8eb2fda652f0dd698cb84ee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/361fc54d4ffd6c855bda501d25e33be7b1de9433eed740e012e696420f550cf8af646918286eac9674ca4c85b289fbd7b18d337705441fc1774ccd0a9e6f2744", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f54198d69841c34053db913277f06df2f4faca64945297aa49bac1826c26658b3df44716ea6ca7baa967f97c507b53f2c02c52d8317da6bde99e263518066cfa"} 11:14:13 INFO - Running post-run listener: copy_logs_to_upload_dir 11:14:13 INFO - Copying logs to upload dir... 11:14:13 INFO - mkdir: /builds/slave/test/build/upload/logs 11:14:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1432.030079 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 52 secs) (at 2016-05-19 11:14:12.906124) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 11:14:12.909986) ========= 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=7de08804244eb36560b44971000001c3-1463679007.640604-271538148 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-Non-PGO/sha512/bb54c8b0048789c1d929df835370b4af5973d901040ce36ef88a485a24e42952f6f212339b6d3f61d54929ed8ccf36b65541ee51a8eb2fda652f0dd698cb84ee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/361fc54d4ffd6c855bda501d25e33be7b1de9433eed740e012e696420f550cf8af646918286eac9674ca4c85b289fbd7b18d337705441fc1774ccd0a9e6f2744", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f54198d69841c34053db913277f06df2f4faca64945297aa49bac1826c26658b3df44716ea6ca7baa967f97c507b53f2c02c52d8317da6bde99e263518066cfa"} build_url:https://queue.taskcluster.net/v1/task/XmrybJw_RWK0ozRe1WaXXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011463 build_url: 'https://queue.taskcluster.net/v1/task/XmrybJw_RWK0ozRe1WaXXQ/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-Non-PGO/sha512/bb54c8b0048789c1d929df835370b4af5973d901040ce36ef88a485a24e42952f6f212339b6d3f61d54929ed8ccf36b65541ee51a8eb2fda652f0dd698cb84ee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/361fc54d4ffd6c855bda501d25e33be7b1de9433eed740e012e696420f550cf8af646918286eac9674ca4c85b289fbd7b18d337705441fc1774ccd0a9e6f2744", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f54198d69841c34053db913277f06df2f4faca64945297aa49bac1826c26658b3df44716ea6ca7baa967f97c507b53f2c02c52d8317da6bde99e263518066cfa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 11:14:12.934352) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 11:14:12.934700) ========= 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=7de08804244eb36560b44971000001c3-1463679007.640604-271538148 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 11:14:13.019462) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 11:14:13.019871) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 11:14:13.020181) ========= ========= Total master_lag: 0.17 =========