builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-070 starttime: 1496193407.88 results: success (0) revision: 9a5c710587f9e64bf044602d5e988b152ef4f40c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 18:16:47.883682) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 18:16:47.884213) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 18:16:47.886688) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 18:16:48.122725) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 18:16:48.123015) ========= 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=2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-30 18:16:49-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 27.0M=0s 2017-05-30 18:16:49 (27.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.096526 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 18:16:48.281500) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 18:16:48.281979) ========= 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=2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018802 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 18:16:48.360097) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 18:16:48.364649) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9a5c710587f9e64bf044602d5e988b152ef4f40c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 9a5c710587f9e64bf044602d5e988b152ef4f40c --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=2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-30 18:16:49,945 truncating revision to first 12 chars 2017-05-30 18:16:49,945 Setting DEBUG logging. 2017-05-30 18:16:49,945 attempt 1/10 2017-05-30 18:16:49,945 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9a5c710587f9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-30 18:16:50,354 unpacking tar archive at: mozilla-central-9a5c710587f9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.833974 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 18:16:49.242833) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 18:16:49.243433) ========= script_repo_revision: 9a5c710587f9e64bf044602d5e988b152ef4f40c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 18:16:49.244037) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 18:16:49.248647) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 18:16:49.262947) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 3 secs) (at 2017-05-30 18:16:49.263534) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:16:50 INFO - MultiFileLogger online at 20170530 18:16:50 in /builds/slave/test 18:16:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:16:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:16:50 INFO - {'append_to_log': False, 18:16:50 INFO - 'base_work_dir': '/builds/slave/test', 18:16:50 INFO - 'blob_upload_branch': 'Firefox', 18:16:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:16:50 INFO - 'branch': 'Firefox', 18:16:50 INFO - 'buildbot_json_path': 'buildprops.json', 18:16:50 INFO - 'config_files': ('talos/linux_config.py',), 18:16:50 INFO - 'default_actions': ('clobber', 18:16:50 INFO - 'read-buildbot-config', 18:16:50 INFO - 'download-and-extract', 18:16:50 INFO - 'populate-webroot', 18:16:50 INFO - 'create-virtualenv', 18:16:50 INFO - 'install', 18:16:50 INFO - 'setup-mitmproxy', 18:16:50 INFO - 'run-tests'), 18:16:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:16:50 INFO - 'download_minidump_stackwalk': True, 18:16:50 INFO - 'download_symbols': 'ondemand', 18:16:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:16:50 INFO - 'tooltool.py': '/tools/tooltool.py', 18:16:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:16:50 INFO - '/tools/misc-python/virtualenv.py')}, 18:16:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:16:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:16:50 INFO - 'gecko_profile': False, 18:16:50 INFO - 'gecko_profile_interval': 0, 18:16:50 INFO - 'installer_path': 'installer.exe', 18:16:50 INFO - 'log_level': 'info', 18:16:50 INFO - 'log_name': 'talos', 18:16:50 INFO - 'log_to_console': True, 18:16:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:16:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:16:50 INFO - 'opt_config_files': (), 18:16:50 INFO - 'pip_index': False, 18:16:50 INFO - 'suite': 'dromaeojs-e10s', 18:16:50 INFO - 'system_bits': '32', 18:16:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:16:50 INFO - 'title': 'talos-linux64-ix-070', 18:16:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:16:50 INFO - 'use_talos_json': True, 18:16:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:16:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:16:50 INFO - 'work_dir': 'build'} 18:16:50 INFO - [mozharness: 2017-05-31 01:16:50.929790Z] Running clobber step. 18:16:50 INFO - Running pre-action listener: _resource_record_pre_action 18:16:50 INFO - Running main action method: clobber 18:16:50 INFO - rmtree: /builds/slave/test/build 18:16:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:16:52 INFO - Running post-action listener: _resource_record_post_action 18:16:52 INFO - [mozharness: 2017-05-31 01:16:52.483265Z] Finished clobber step (success) 18:16:52 INFO - [mozharness: 2017-05-31 01:16:52.483365Z] Running read-buildbot-config step. 18:16:52 INFO - Running pre-action listener: _resource_record_pre_action 18:16:52 INFO - Running main action method: read_buildbot_config 18:16:52 INFO - Using buildbot properties: 18:16:52 INFO - { 18:16:52 INFO - "project": "", 18:16:52 INFO - "product": "firefox", 18:16:52 INFO - "who": "ryanvm@gmail.com", 18:16:52 INFO - "installer_path": "public/build/target.tar.bz2", 18:16:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 18:16:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:16:52 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 18:16:52 INFO - "stage_platform": "linux64-stylosequential", 18:16:52 INFO - "basedir": "/builds/slave/test", 18:16:52 INFO - "buildnumber": 35, 18:16:52 INFO - "platform": "ubuntu64_hw_styloseq", 18:16:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:16:52 INFO - "slavebuilddir": "test", 18:16:52 INFO - "taskId": "fXYbbuzbQJqu08fnFXvYWA", 18:16:52 INFO - "branch": "mozilla-central", 18:16:52 INFO - "script_repo_revision": "production", 18:16:52 INFO - "revision": "9a5c710587f9e64bf044602d5e988b152ef4f40c", 18:16:52 INFO - "slavename": "talos-linux64-ix-070", 18:16:52 INFO - "repo_path": "mozilla-central" 18:16:52 INFO - } 18:16:52 INFO - Finding installer, test and symbols from parent task. 18:16:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fXYbbuzbQJqu08fnFXvYWA'}, attempt #1 18:16:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fXYbbuzbQJqu08fnFXvYWA'}, attempt #1 18:16:53 INFO - Task dependencies: B3CJPPp4Srq-sORFAT76XQ 18:16:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ'}, attempt #1 18:16:53 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/target.tar.bz2 18:16:53 INFO - Set test_url: https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/test_packages.json 18:16:53 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/target.crashreporter-symbols.zip 18:16:53 INFO - Running post-action listener: _resource_record_post_action 18:16:53 INFO - [mozharness: 2017-05-31 01:16:53.816844Z] Finished read-buildbot-config step (success) 18:16:53 INFO - [mozharness: 2017-05-31 01:16:53.817064Z] Running download-and-extract step. 18:16:53 INFO - Running pre-action listener: _resource_record_pre_action 18:16:53 INFO - Running main action method: download_and_extract 18:16:53 INFO - mkdir: /builds/slave/test/build/tests 18:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:16:53 INFO - trying https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/target.test_packages.json 18:16:53 INFO - Downloading https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:16:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:16:54 INFO - Downloaded 986 bytes. 18:16:54 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:16:54 INFO - Using the following test package requirements: 18:16:54 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:16:54 INFO - u'common': [u'target.common.tests.zip'], 18:16:54 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:16:54 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:16:54 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:16:54 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:16:54 INFO - u'mozbase': [u'target.common.tests.zip'], 18:16:54 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:16:54 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:16:54 INFO - u'web-platform': [u'target.common.tests.zip', 18:16:54 INFO - u'target.web-platform.tests.zip'], 18:16:54 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:16:54 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:16:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/target.common.tests.zip 18:16:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:16:54 INFO - Fetch https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/target.common.tests.zip into memory 18:16:56 INFO - Content-Length response header: 63526279 18:16:56 INFO - Bytes received: 63526279 18:17:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:17:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/target.common.tests.zip 18:17:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:17:07 INFO - Fetch https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/target.common.tests.zip into memory 18:17:10 INFO - Content-Length response header: 63526279 18:17:10 INFO - Bytes received: 63526279 18:17:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/target.talos.tests.zip 18:17:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:17:22 INFO - Fetch https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/target.talos.tests.zip into memory 18:17:23 INFO - Content-Length response header: 14447425 18:17:23 INFO - Bytes received: 14447425 18:17:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:23 INFO - trying https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/target.tar.bz2 18:17:23 INFO - Downloading https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:17:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:17:26 INFO - Downloaded 56021866 bytes. 18:17:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/target.tar.bz2 18:17:26 INFO - mkdir: /builds/slave/test/properties 18:17:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:17:26 INFO - Writing to file /builds/slave/test/properties/build_url 18:17:26 INFO - Contents: 18:17:26 INFO - build_url:https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/target.tar.bz2 18:17:26 INFO - Running post-action listener: _resource_record_post_action 18:17:26 INFO - Running post-action listener: set_extra_try_arguments 18:17:26 INFO - [mozharness: 2017-05-31 01:17:26.773188Z] Finished download-and-extract step (success) 18:17:26 INFO - [mozharness: 2017-05-31 01:17:26.773306Z] Running populate-webroot step. 18:17:26 INFO - Running pre-action listener: _resource_record_pre_action 18:17:26 INFO - Running main action method: populate_webroot 18:17:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:17:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:17:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:17:26 INFO - '--tppagecycles', 18:17:26 INFO - '7'], 18:17:26 INFO - 'tests': ['tsvgm']}}, 18:17:26 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:17:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:17:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:17:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:17:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:17:26 INFO - 'talos_options': ['--disable-e10s'], 18:17:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:17:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:17:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:17:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:17:26 INFO - 'talos_options': ['--disable-e10s'], 18:17:26 INFO - 'tests': ['damp', 'tps']}, 18:17:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:17:26 INFO - 'tests': ['damp', 'tps']}, 18:17:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:17:26 INFO - 'tests': ['dromaeo_dom']}, 18:17:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:17:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:17:26 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:17:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:17:26 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:17:26 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:17:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:17:26 INFO - 'tests': ['a11yr', 18:17:26 INFO - 'ts_paint', 18:17:26 INFO - 'tpaint', 18:17:26 INFO - 'sessionrestore', 18:17:26 INFO - 'sessionrestore_no_auto_restore', 18:17:26 INFO - 'tabpaint']}, 18:17:26 INFO - 'other-e10s': {'tests': ['a11yr', 18:17:26 INFO - 'ts_paint', 18:17:26 INFO - 'tpaint', 18:17:26 INFO - 'sessionrestore', 18:17:26 INFO - 'sessionrestore_no_auto_restore', 18:17:26 INFO - 'tabpaint']}, 18:17:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:17:26 INFO - 'ts_paint', 18:17:26 INFO - 'tpaint', 18:17:26 INFO - 'sessionrestore', 18:17:26 INFO - 'sessionrestore_no_auto_restore', 18:17:26 INFO - 'tabpaint']}, 18:17:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:17:26 INFO - 'ts_paint', 18:17:26 INFO - 'tpaint', 18:17:26 INFO - 'sessionrestore', 18:17:26 INFO - 'sessionrestore_no_auto_restore', 18:17:26 INFO - 'tabpaint']}, 18:17:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:17:26 INFO - 'tests': ['a11yr', 18:17:26 INFO - 'ts_paint', 18:17:26 INFO - 'tpaint', 18:17:26 INFO - 'sessionrestore', 18:17:26 INFO - 'sessionrestore_no_auto_restore', 18:17:26 INFO - 'tabpaint']}, 18:17:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:17:26 INFO - 'tests': ['a11yr', 18:17:26 INFO - 'ts_paint', 18:17:26 INFO - 'tpaint', 18:17:26 INFO - 'sessionrestore', 18:17:26 INFO - 'sessionrestore_no_auto_restore', 18:17:26 INFO - 'tabpaint']}, 18:17:26 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 18:17:26 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 18:17:26 INFO - 'bloom_basic_ref']}, 18:17:26 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 18:17:26 INFO - 'talos_options': ['--mitmproxy', 18:17:26 INFO - 'mitmproxy-recording-1.mp', 18:17:26 INFO - '--firstNonBlankPaint'], 18:17:26 INFO - 'tests': ['Quantum_1']}, 18:17:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:17:26 INFO - 'tests': ['tsvgx', 18:17:26 INFO - 'tsvgr_opacity', 18:17:26 INFO - 'tart', 18:17:26 INFO - 'tscrollx', 18:17:26 INFO - 'cart', 18:17:26 INFO - 'tsvg_static']}, 18:17:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:17:26 INFO - 'tsvgr_opacity', 18:17:26 INFO - 'tart', 18:17:26 INFO - 'tscrollx', 18:17:26 INFO - 'cart', 18:17:26 INFO - 'tsvg_static']}, 18:17:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:17:26 INFO - 'talos_options': ['--disable-e10s'], 18:17:26 INFO - 'tests': ['tp5o']}, 18:17:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:17:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:17:26 INFO - 'talos_options': ['--disable-e10s', 18:17:26 INFO - '--xperf_path', 18:17:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:17:26 INFO - 'tests': ['tp5n']}, 18:17:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:17:26 INFO - 'talos_options': ['--xperf_path', 18:17:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:17:26 INFO - 'tests': ['tp5n']}}, 18:17:26 INFO - 'talos.zip': {'path': '', 18:17:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:17:26 INFO - Running post-action listener: _resource_record_post_action 18:17:26 INFO - [mozharness: 2017-05-31 01:17:26.787639Z] Finished populate-webroot step (success) 18:17:26 INFO - [mozharness: 2017-05-31 01:17:26.787733Z] Running create-virtualenv step. 18:17:26 INFO - Running pre-action listener: _resource_record_pre_action 18:17:26 INFO - Running main action method: create_virtualenv 18:17:26 INFO - Creating virtualenv /builds/slave/test/build/venv 18:17:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:17:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:17:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:17:26 INFO - Using real prefix '/usr' 18:17:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:17:27 INFO - Installing distribute.............................................................................................................................................................................................done. 18:17:29 INFO - Installing pip.................done. 18:17:29 INFO - Return code: 0 18:17:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:17:29 INFO - Reading from file tmpfile_stdout 18:17:29 INFO - Output received: 18:17:29 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:17:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:29 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/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 0x134b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1525a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c6840>, '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 0x16c7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c7bd0>, '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': '2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:17:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:17:29 INFO - Using env: {'DISPLAY': ':0', 18:17:29 INFO - 'HOME': '/home/cltbld', 18:17:29 INFO - 'LANG': 'en_US.UTF-8', 18:17:29 INFO - 'LANGUAGE': 'en_US:en', 18:17:29 INFO - 'LOGNAME': 'cltbld', 18:17:29 INFO - 'MAIL': '/var/mail/cltbld', 18:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:29 INFO - 'MOZ_NO_REMOTE': '1', 18:17:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:29 INFO - 'NO_EM_RESTART': '1', 18:17:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:29 INFO - 'PWD': '/builds/slave/test', 18:17:29 INFO - 'SHELL': '/bin/bash', 18:17:29 INFO - 'SHLVL': '1', 18:17:29 INFO - 'TERM': 'linux', 18:17:29 INFO - 'TMOUT': '86400', 18:17:29 INFO - 'USER': 'cltbld', 18:17:29 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978', 18:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:29 INFO - '_': '/tools/buildbot/bin/python'} 18:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:17:29 INFO - Cleaning up... 18:17:29 INFO - Return code: 0 18:17:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:29 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/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 0x134b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1525a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c6840>, '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 0x16c7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c7bd0>, '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': '2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:17:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:17:29 INFO - Using env: {'DISPLAY': ':0', 18:17:29 INFO - 'HOME': '/home/cltbld', 18:17:29 INFO - 'LANG': 'en_US.UTF-8', 18:17:29 INFO - 'LANGUAGE': 'en_US:en', 18:17:29 INFO - 'LOGNAME': 'cltbld', 18:17:29 INFO - 'MAIL': '/var/mail/cltbld', 18:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:29 INFO - 'MOZ_NO_REMOTE': '1', 18:17:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:29 INFO - 'NO_EM_RESTART': '1', 18:17:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:29 INFO - 'PWD': '/builds/slave/test', 18:17:29 INFO - 'SHELL': '/bin/bash', 18:17:29 INFO - 'SHLVL': '1', 18:17:29 INFO - 'TERM': 'linux', 18:17:29 INFO - 'TMOUT': '86400', 18:17:29 INFO - 'USER': 'cltbld', 18:17:29 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978', 18:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:29 INFO - '_': '/tools/buildbot/bin/python'} 18:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:29 INFO - Downloading/unpacking psutil>=3.1.1 18:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:17:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:17:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:17:31 INFO - Installing collected packages: psutil 18:17:31 INFO - Running setup.py install for psutil 18:17:31 INFO - building 'psutil._psutil_linux' extension 18:17:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:17:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:17:31 INFO - building 'psutil._psutil_posix' extension 18:17:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:17:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:17:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:17:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:17:31 INFO - Successfully installed psutil 18:17:31 INFO - Cleaning up... 18:17:31 INFO - Return code: 0 18:17:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:31 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/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 0x134b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1525a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c6840>, '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 0x16c7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c7bd0>, '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': '2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:17:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:17:31 INFO - Using env: {'DISPLAY': ':0', 18:17:31 INFO - 'HOME': '/home/cltbld', 18:17:31 INFO - 'LANG': 'en_US.UTF-8', 18:17:31 INFO - 'LANGUAGE': 'en_US:en', 18:17:31 INFO - 'LOGNAME': 'cltbld', 18:17:31 INFO - 'MAIL': '/var/mail/cltbld', 18:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:31 INFO - 'MOZ_NO_REMOTE': '1', 18:17:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:31 INFO - 'NO_EM_RESTART': '1', 18:17:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:31 INFO - 'PWD': '/builds/slave/test', 18:17:31 INFO - 'SHELL': '/bin/bash', 18:17:31 INFO - 'SHLVL': '1', 18:17:31 INFO - 'TERM': 'linux', 18:17:31 INFO - 'TMOUT': '86400', 18:17:31 INFO - 'USER': 'cltbld', 18:17:31 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978', 18:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:31 INFO - '_': '/tools/buildbot/bin/python'} 18:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:17:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:17:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:17:33 INFO - Installing collected packages: mozsystemmonitor 18:17:33 INFO - Running setup.py install for mozsystemmonitor 18:17:33 INFO - Successfully installed mozsystemmonitor 18:17:33 INFO - Cleaning up... 18:17:33 INFO - Return code: 0 18:17:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:33 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1525a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c6840>, '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 0x16c7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c7bd0>, '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': '2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:17:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:17:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:17:33 INFO - Using env: {'DISPLAY': ':0', 18:17:33 INFO - 'HOME': '/home/cltbld', 18:17:33 INFO - 'LANG': 'en_US.UTF-8', 18:17:33 INFO - 'LANGUAGE': 'en_US:en', 18:17:33 INFO - 'LOGNAME': 'cltbld', 18:17:33 INFO - 'MAIL': '/var/mail/cltbld', 18:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:33 INFO - 'MOZ_NO_REMOTE': '1', 18:17:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:33 INFO - 'NO_EM_RESTART': '1', 18:17:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:33 INFO - 'PWD': '/builds/slave/test', 18:17:33 INFO - 'SHELL': '/bin/bash', 18:17:33 INFO - 'SHLVL': '1', 18:17:33 INFO - 'TERM': 'linux', 18:17:33 INFO - 'TMOUT': '86400', 18:17:33 INFO - 'USER': 'cltbld', 18:17:33 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978', 18:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:33 INFO - '_': '/tools/buildbot/bin/python'} 18:17:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:33 INFO - Downloading/unpacking jsonschema==2.5.1 18:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:17:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:34 INFO - Downloading functools32-3.2.3-2.tar.gz 18:17:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:17:34 INFO - warning: no files found matching '*.txt' 18:17:34 INFO - no previously-included directories found matching 'build' 18:17:34 INFO - no previously-included directories found matching 'dist' 18:17:34 INFO - no previously-included directories found matching '.git*' 18:17:34 INFO - Installing collected packages: jsonschema, functools32 18:17:34 INFO - Running setup.py install for functools32 18:17:34 INFO - warning: no files found matching '*.txt' 18:17:34 INFO - no previously-included directories found matching 'build' 18:17:34 INFO - no previously-included directories found matching 'dist' 18:17:34 INFO - no previously-included directories found matching '.git*' 18:17:34 INFO - Successfully installed jsonschema functools32 18:17:34 INFO - Cleaning up... 18:17:34 INFO - Return code: 0 18:17:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:34 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1525a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c6840>, '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 0x16c7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c7bd0>, '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': '2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:17:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:17:34 INFO - Using env: {'DISPLAY': ':0', 18:17:34 INFO - 'HOME': '/home/cltbld', 18:17:34 INFO - 'LANG': 'en_US.UTF-8', 18:17:34 INFO - 'LANGUAGE': 'en_US:en', 18:17:34 INFO - 'LOGNAME': 'cltbld', 18:17:34 INFO - 'MAIL': '/var/mail/cltbld', 18:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:34 INFO - 'MOZ_NO_REMOTE': '1', 18:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:34 INFO - 'NO_EM_RESTART': '1', 18:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:34 INFO - 'PWD': '/builds/slave/test', 18:17:34 INFO - 'SHELL': '/bin/bash', 18:17:34 INFO - 'SHLVL': '1', 18:17:34 INFO - 'TERM': 'linux', 18:17:34 INFO - 'TMOUT': '86400', 18:17:34 INFO - 'USER': 'cltbld', 18:17:34 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978', 18:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:34 INFO - '_': '/tools/buildbot/bin/python'} 18:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:17:35 INFO - Cleaning up... 18:17:35 INFO - Return code: 0 18:17:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:35 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/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 0x134b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1525a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c6840>, '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 0x16c7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c7bd0>, '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': '2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:17:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:17:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:17:35 INFO - Using env: {'DISPLAY': ':0', 18:17:35 INFO - 'HOME': '/home/cltbld', 18:17:35 INFO - 'LANG': 'en_US.UTF-8', 18:17:35 INFO - 'LANGUAGE': 'en_US:en', 18:17:35 INFO - 'LOGNAME': 'cltbld', 18:17:35 INFO - 'MAIL': '/var/mail/cltbld', 18:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:35 INFO - 'MOZ_NO_REMOTE': '1', 18:17:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:35 INFO - 'NO_EM_RESTART': '1', 18:17:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:35 INFO - 'PWD': '/builds/slave/test', 18:17:35 INFO - 'SHELL': '/bin/bash', 18:17:35 INFO - 'SHLVL': '1', 18:17:35 INFO - 'TERM': 'linux', 18:17:35 INFO - 'TMOUT': '86400', 18:17:35 INFO - 'USER': 'cltbld', 18:17:35 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978', 18:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:35 INFO - '_': '/tools/buildbot/bin/python'} 18:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:35 INFO - Downloading/unpacking blobuploader==1.2.4 18:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:36 INFO - Downloading blobuploader-1.2.4.tar.gz 18:17:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:17:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:17:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:36 INFO - Downloading docopt-0.6.1.tar.gz 18:17:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:17:36 INFO - Installing collected packages: blobuploader, requests, docopt 18:17:36 INFO - Running setup.py install for blobuploader 18:17:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:17:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:17:37 INFO - Running setup.py install for requests 18:17:37 INFO - Running setup.py install for docopt 18:17:37 INFO - Successfully installed blobuploader requests docopt 18:17:37 INFO - Cleaning up... 18:17:37 INFO - Return code: 0 18:17:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:37 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/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 0x134b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1525a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c6840>, '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 0x16c7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c7bd0>, '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': '2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:17:37 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:17:37 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:17:37 INFO - Using env: {'DISPLAY': ':0', 18:17:37 INFO - 'HOME': '/home/cltbld', 18:17:37 INFO - 'LANG': 'en_US.UTF-8', 18:17:37 INFO - 'LANGUAGE': 'en_US:en', 18:17:37 INFO - 'LOGNAME': 'cltbld', 18:17:37 INFO - 'MAIL': '/var/mail/cltbld', 18:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:37 INFO - 'MOZ_NO_REMOTE': '1', 18:17:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:37 INFO - 'NO_EM_RESTART': '1', 18:17:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:37 INFO - 'PWD': '/builds/slave/test', 18:17:37 INFO - 'SHELL': '/bin/bash', 18:17:37 INFO - 'SHLVL': '1', 18:17:37 INFO - 'TERM': 'linux', 18:17:37 INFO - 'TMOUT': '86400', 18:17:37 INFO - 'USER': 'cltbld', 18:17:37 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978', 18:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:37 INFO - '_': '/tools/buildbot/bin/python'} 18:17:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:17:37 INFO - Running setup.py (path:/tmp/pip-5j5C8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:17:37 INFO - Running setup.py (path:/tmp/pip-gSo7mA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:17:37 INFO - Running setup.py (path:/tmp/pip-rt99B3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:17:37 INFO - Running setup.py (path:/tmp/pip-RR0UiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:17:38 INFO - Running setup.py (path:/tmp/pip-lDA5mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:17:38 INFO - Running setup.py (path:/tmp/pip-IWpGhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:17:38 INFO - Running setup.py (path:/tmp/pip-d3XyII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:17:38 INFO - Running setup.py (path:/tmp/pip-KA2e1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:17:38 INFO - Running setup.py (path:/tmp/pip-47_oYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:17:38 INFO - Running setup.py (path:/tmp/pip-jTmWkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:17:38 INFO - Running setup.py (path:/tmp/pip-1p2CUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:17:38 INFO - Running setup.py (path:/tmp/pip-AhvhN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:17:38 INFO - Running setup.py (path:/tmp/pip-7jFX1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:17:38 INFO - Running setup.py (path:/tmp/pip-XFOMG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:17:38 INFO - Running setup.py (path:/tmp/pip-SiAPqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:17:38 INFO - Running setup.py (path:/tmp/pip-trO6AZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:17:38 INFO - Running setup.py (path:/tmp/pip-xuHvr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:17:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:17:39 INFO - Running setup.py install for manifestparser 18:17:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:17:39 INFO - Running setup.py install for mozcrash 18:17:39 INFO - Running setup.py install for mozdebug 18:17:39 INFO - Running setup.py install for mozdevice 18:17:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:17:39 INFO - Running setup.py install for mozfile 18:17:39 INFO - Running setup.py install for mozhttpd 18:17:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:17:39 INFO - Running setup.py install for mozinfo 18:17:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:17:39 INFO - Running setup.py install for mozInstall 18:17:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:17:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:17:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:17:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:17:39 INFO - Running setup.py install for mozleak 18:17:39 INFO - Running setup.py install for mozlog 18:17:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:17:40 INFO - Running setup.py install for moznetwork 18:17:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:17:40 INFO - Running setup.py install for mozprocess 18:17:40 INFO - Running setup.py install for mozprofile 18:17:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:17:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:17:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:17:40 INFO - Running setup.py install for mozrunner 18:17:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:17:40 INFO - Running setup.py install for mozscreenshot 18:17:40 INFO - Running setup.py install for moztest 18:17:40 INFO - Running setup.py install for mozversion 18:17:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:17:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:17:40 INFO - Cleaning up... 18:17:40 INFO - Return code: 0 18:17:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:40 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/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 0x134b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1525a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c6840>, '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 0x16c7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c7bd0>, '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': '2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:17:40 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:17:40 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:17:40 INFO - Using env: {'DISPLAY': ':0', 18:17:40 INFO - 'HOME': '/home/cltbld', 18:17:40 INFO - 'LANG': 'en_US.UTF-8', 18:17:40 INFO - 'LANGUAGE': 'en_US:en', 18:17:40 INFO - 'LOGNAME': 'cltbld', 18:17:40 INFO - 'MAIL': '/var/mail/cltbld', 18:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:40 INFO - 'MOZ_NO_REMOTE': '1', 18:17:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:40 INFO - 'NO_EM_RESTART': '1', 18:17:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:40 INFO - 'PWD': '/builds/slave/test', 18:17:40 INFO - 'SHELL': '/bin/bash', 18:17:40 INFO - 'SHLVL': '1', 18:17:40 INFO - 'TERM': 'linux', 18:17:40 INFO - 'TMOUT': '86400', 18:17:40 INFO - 'USER': 'cltbld', 18:17:40 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978', 18:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:40 INFO - '_': '/tools/buildbot/bin/python'} 18:17:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:17:40 INFO - Running setup.py (path:/tmp/pip-tIRvYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:17:41 INFO - Running setup.py (path:/tmp/pip-K5LcLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:17:41 INFO - Running setup.py (path:/tmp/pip-6RFZdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:17:41 INFO - Running setup.py (path:/tmp/pip-Uol6LD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:17:41 INFO - Running setup.py (path:/tmp/pip-9ibz07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:17:41 INFO - Running setup.py (path:/tmp/pip-3DdGPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:17:41 INFO - Running setup.py (path:/tmp/pip-bgHbg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:17:41 INFO - Running setup.py (path:/tmp/pip-mmwy6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:17:41 INFO - Running setup.py (path:/tmp/pip-59P5BR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:17:41 INFO - Running setup.py (path:/tmp/pip-JOh3Dr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:17:41 INFO - Running setup.py (path:/tmp/pip-0hxAf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:17:41 INFO - Running setup.py (path:/tmp/pip-u3fZi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:17:41 INFO - Running setup.py (path:/tmp/pip-Jj8CAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:17:41 INFO - Running setup.py (path:/tmp/pip-8lSE7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:17:42 INFO - Running setup.py (path:/tmp/pip-d8L740-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:17:42 INFO - Running setup.py (path:/tmp/pip-07D0Pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:17:42 INFO - Running setup.py (path:/tmp/pip-U_P5wU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:17:42 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:17:42 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:17:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:43 INFO - Downloading blessings-1.6.tar.gz 18:17:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:17:43 INFO - Installing collected packages: blessings 18:17:43 INFO - Running setup.py install for blessings 18:17:43 INFO - Successfully installed blessings 18:17:43 INFO - Cleaning up... 18:17:43 INFO - Return code: 0 18:17:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:17:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:17:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:17:43 INFO - Reading from file tmpfile_stdout 18:17:43 INFO - Current package versions: 18:17:43 INFO - argparse == 1.2.1 18:17:43 INFO - blessings == 1.6 18:17:43 INFO - blobuploader == 1.2.4 18:17:43 INFO - docopt == 0.6.1 18:17:43 INFO - functools32 == 3.2.3-2 18:17:43 INFO - jsonschema == 2.5.1 18:17:43 INFO - manifestparser == 1.1 18:17:43 INFO - mozInstall == 1.12 18:17:43 INFO - mozcrash == 1.0 18:17:43 INFO - mozdebug == 0.1 18:17:43 INFO - mozdevice == 0.51 18:17:43 INFO - mozfile == 1.2 18:17:43 INFO - mozhttpd == 0.7 18:17:43 INFO - mozinfo == 0.9 18:17:43 INFO - mozleak == 0.1 18:17:43 INFO - mozlog == 3.4 18:17:43 INFO - moznetwork == 0.27 18:17:43 INFO - mozprocess == 0.25 18:17:43 INFO - mozprofile == 0.28 18:17:43 INFO - mozrunner == 6.13 18:17:43 INFO - mozscreenshot == 0.1 18:17:43 INFO - mozsystemmonitor == 0.3 18:17:43 INFO - moztest == 0.8 18:17:43 INFO - mozversion == 1.4 18:17:43 INFO - psutil == 3.1.1 18:17:43 INFO - requests == 1.2.3 18:17:43 INFO - wsgiref == 0.1.2 18:17:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:43 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/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 0x134b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1525a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c6840>, '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 0x16c7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c7bd0>, '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': '2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:17:43 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:17:43 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:17:43 INFO - Using env: {'DISPLAY': ':0', 18:17:43 INFO - 'HOME': '/home/cltbld', 18:17:43 INFO - 'LANG': 'en_US.UTF-8', 18:17:43 INFO - 'LANGUAGE': 'en_US:en', 18:17:43 INFO - 'LOGNAME': 'cltbld', 18:17:43 INFO - 'MAIL': '/var/mail/cltbld', 18:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:43 INFO - 'MOZ_NO_REMOTE': '1', 18:17:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:43 INFO - 'NO_EM_RESTART': '1', 18:17:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:43 INFO - 'PWD': '/builds/slave/test', 18:17:43 INFO - 'SHELL': '/bin/bash', 18:17:43 INFO - 'SHLVL': '1', 18:17:43 INFO - 'TERM': 'linux', 18:17:43 INFO - 'TMOUT': '86400', 18:17:43 INFO - 'USER': 'cltbld', 18:17:43 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978', 18:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:43 INFO - '_': '/tools/buildbot/bin/python'} 18:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:17:43 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:17: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 18:17: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 18:17: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 18:17: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 18:17:45 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:17:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:17:45 INFO - Installing collected packages: marionette-driver 18:17:45 INFO - Running setup.py install for marionette-driver 18:17:45 INFO - Successfully installed marionette-driver 18:17:45 INFO - Cleaning up... 18:17:45 INFO - Return code: 0 18:17:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17: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/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 0x134b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1525a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c6840>, '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 0x16c7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c7bd0>, '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': '2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:17:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:17:45 INFO - Using env: {'DISPLAY': ':0', 18:17:45 INFO - 'HOME': '/home/cltbld', 18:17:45 INFO - 'LANG': 'en_US.UTF-8', 18:17:45 INFO - 'LANGUAGE': 'en_US:en', 18:17:45 INFO - 'LOGNAME': 'cltbld', 18:17:45 INFO - 'MAIL': '/var/mail/cltbld', 18:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:45 INFO - 'MOZ_NO_REMOTE': '1', 18:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:45 INFO - 'NO_EM_RESTART': '1', 18:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:45 INFO - 'PWD': '/builds/slave/test', 18:17:45 INFO - 'SHELL': '/bin/bash', 18:17:45 INFO - 'SHLVL': '1', 18:17:45 INFO - 'TERM': 'linux', 18:17:45 INFO - 'TMOUT': '86400', 18:17:45 INFO - 'USER': 'cltbld', 18:17:45 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978', 18:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:45 INFO - '_': '/tools/buildbot/bin/python'} 18:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:17:45 INFO - Cleaning up... 18:17:45 INFO - Return code: 0 18:17:45 INFO - Running post-action listener: _resource_record_post_action 18:17:45 INFO - Running post-action listener: _start_resource_monitoring 18:17:45 INFO - Starting resource monitoring. 18:17:45 INFO - [mozharness: 2017-05-31 01:17:45.547895Z] Finished create-virtualenv step (success) 18:17:45 INFO - [mozharness: 2017-05-31 01:17:45.548408Z] Running install step. 18:17:45 INFO - Running pre-action listener: _resource_record_pre_action 18:17:45 INFO - Running main action method: install 18:17:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:17:45 INFO - Reading from file tmpfile_stdout 18:17:45 INFO - Detecting whether we're running mozinstall >=1.0... 18:17:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:17:45 INFO - Reading from file tmpfile_stdout 18:17:45 INFO - Output received: 18:17:45 INFO - Usage: mozinstall [options] installer 18:17:45 INFO - Options: 18:17:45 INFO - -h, --help show this help message and exit 18:17:45 INFO - -d DEST, --destination=DEST 18:17:45 INFO - Directory to install application into. [default: 18:17:45 INFO - "/builds/slave/test"] 18:17:45 INFO - --app=APP Application being installed. [default: firefox] 18:17:45 INFO - mkdir: /builds/slave/test/build/application 18:17:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:18:01 INFO - Reading from file tmpfile_stdout 18:18:01 INFO - Output received: 18:18:01 INFO - /builds/slave/test/build/application/firefox/firefox 18:18:01 INFO - Running post-action listener: _resource_record_post_action 18:18:01 INFO - [mozharness: 2017-05-31 01:18:01.903260Z] Finished install step (success) 18:18:01 INFO - [mozharness: 2017-05-31 01:18:01.903540Z] Running setup-mitmproxy step. 18:18:01 INFO - Running pre-action listener: _resource_record_pre_action 18:18:01 INFO - Running main action method: setup_mitmproxy 18:18:01 INFO - Skipping: mitmproxy is not required 18:18:01 INFO - Running post-action listener: _resource_record_post_action 18:18:01 INFO - [mozharness: 2017-05-31 01:18:01.904656Z] Finished setup-mitmproxy step (success) 18:18:01 INFO - [mozharness: 2017-05-31 01:18:01.904876Z] Running run-tests step. 18:18:01 INFO - Running pre-action listener: _resource_record_pre_action 18:18:01 INFO - Running main action method: run_tests 18:18:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:18:01 INFO - Python 2.7.3 18:18:01 INFO - Return code: 0 18:18:01 INFO - grabbing minidump binary from tooltool 18:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:01 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 0x16c6840>, '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 0x16c7740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c7bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:18:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:18:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:18:01 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:18:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:18:01 INFO - Return code: 0 18:18:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:18:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:18:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:18:01 INFO - ENV: RUST_BACKTRACE is now 1 18:18:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:18:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:18:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-070 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:18:01 INFO - Using env: {'DISPLAY': ':0', 18:18:01 INFO - 'HOME': '/home/cltbld', 18:18:01 INFO - 'LANG': 'en_US.UTF-8', 18:18:01 INFO - 'LANGUAGE': 'en_US:en', 18:18:01 INFO - 'LOGNAME': 'cltbld', 18:18:01 INFO - 'MAIL': '/var/mail/cltbld', 18:18:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:18:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:01 INFO - 'MOZ_NO_REMOTE': '1', 18:18:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:01 INFO - 'NO_EM_RESTART': '1', 18:18:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:01 INFO - 'PWD': '/builds/slave/test', 18:18:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:18:01 INFO - 'RUST_BACKTRACE': '1', 18:18:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:18:01 INFO - 'SHELL': '/bin/bash', 18:18:01 INFO - 'SHLVL': '1', 18:18:01 INFO - 'TERM': 'linux', 18:18:01 INFO - 'TMOUT': '86400', 18:18:01 INFO - 'USER': 'cltbld', 18:18:01 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978', 18:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:01 INFO - '_': '/tools/buildbot/bin/python'} 18:18:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:18:02 INFO - mozversion application_buildid: 20170531003810 18:18:02 INFO - mozversion application_changeset: 9a5c710587f9e64bf044602d5e988b152ef4f40c 18:18:02 INFO - mozversion application_display_name: Nightly 18:18:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:18:02 INFO - mozversion application_name: Firefox 18:18:02 INFO - mozversion application_remotingname: firefox 18:18:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:18:02 INFO - mozversion application_vendor: Mozilla 18:18:02 INFO - mozversion application_version: 55.0a1 18:18:02 INFO - mozversion platform_buildid: 20170531003810 18:18:02 INFO - mozversion platform_changeset: 9a5c710587f9e64bf044602d5e988b152ef4f40c 18:18:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:18:02 INFO - mozversion platform_version: 55.0a1 18:18:02 INFO - using testdate: 1496193482 18:18:02 INFO - actual date: 1496193482 18:18:02 INFO - starting webserver on 'localhost:48967' 18:18:02 INFO - SUITE-START | Running 2 tests 18:18:02 INFO - TEST-START | dromaeo_css 18:18:02 INFO - operating with platform_type : linux_ 18:18:02 INFO - Initialising browser for dromaeo_css test... 18:18:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48967/getInfo.html -profile /tmp/tmp3YGvWG/profile 18:18:02 INFO - TEST-INFO | started process 2970 (/builds/slave/test/build/application/firefox/firefox http://localhost:48967/getInfo.html) 18:18:37 INFO - TEST-INFO | 2970: killed by SIGTERM 18:18:37 INFO - Browser initialized. 18:18:37 INFO - Running cycle 1/1 for dromaeo_css test... 18:18:37 INFO - TEST-INFO | started process 3193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3YGvWG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:18:49 INFO - PID 3193 | RSS: Main: 188080128 18:18:49 INFO - PID 3193 | 18:21:53 INFO - PID 3193 | Cycle 1(1): loaded http://localhost:48967/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48967/tests/dromaeo/cssquery-ext.html) 18:21:55 INFO - PID 3193 | RSS: Main: 182054912 18:21:55 INFO - PID 3193 | 18:24:57 INFO - PID 3193 | Cycle 1(1): loaded http://localhost:48967/tests/dromaeo/cssquery-ext.html (next: http://localhost:48967/tests/dromaeo/cssquery-jquery.html) 18:24:58 INFO - PID 3193 | RSS: Main: 187822080 18:24:58 INFO - PID 3193 | 18:28:00 INFO - PID 3193 | Cycle 1(1): loaded http://localhost:48967/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48967/tests/dromaeo/cssquery-mootools.html) 18:28:00 INFO - PID 3193 | RSS: Main: 184684544 18:28:00 INFO - PID 3193 | 18:31:02 INFO - PID 3193 | Cycle 1(1): loaded http://localhost:48967/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48967/tests/dromaeo/cssquery-prototype.html) 18:31:03 INFO - PID 3193 | RSS: Main: 189419520 18:31:03 INFO - PID 3193 | 18:34:06 INFO - PID 3193 | Cycle 1(1): loaded http://localhost:48967/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48967/tests/dromaeo/cssquery-yui.html) 18:34:06 INFO - PID 3193 | RSS: Main: 187744256 18:34:06 INFO - PID 3193 | 18:37:08 INFO - PID 3193 | Cycle 1(1): loaded http://localhost:48967/tests/dromaeo/cssquery-yui.html (next: http://localhost:48967/tests/dromaeo/cssquery-dojo.html) 18:37:09 INFO - PID 3193 | RSS: Main: 185352192 18:37:09 INFO - PID 3193 | 18:37:09 INFO - PID 3193 | __start_tp_report 18:37:09 INFO - PID 3193 | _x_x_mozilla_page_load 18:37:09 INFO - PID 3193 | _x_x_mozilla_page_load_details 18:37:09 INFO - PID 3193 | |i|pagename|runs| 18:37:09 INFO - PID 3193 | |0;dojo.html;2731.9043833465826;2743.6570428696414;2765.6404667393235;2784.095169070052;2785.9721402785967;5108.540231379176;5288.814891478799;5327.706976116317;5335.866603334909;5361.276227709258;5209.661372010816;5240.580753539717;5251.159814429692;5376.704281264529;5407.83776486706;4733.313669517918;4748.145333839908;4768.022555376157;4781.45013323467;4810.831620893269;4735.526447355272;4751.287306903958;4836.274558816171;4840.419149702041;4870.610351171916;4614.077184563067;4649.18639238132;4759.262314341283;4771.4512831024185;4837.758112094399;4665.486796452387;4722.905541889178;4752.144613969484;4757.500462451462;4772.451168115676;4706.505816889212;4716.292556116576;4727.196376615949;4730.881727956794;4769.117713223065;5264.631475796696;5283.86790330241;5328.040952628526;5335.946640533583;5365.570754339644;5581.832545023656;5668.319801623831;5695.943040569583;5740.799072032501;5766.0197766379815;5843.328017278025;5846.561507886883;5849.532037437038;5850.180974663551;5916.437938395846;5378.139497680352;5394.271773310592;5396.244525766396;5398.325209348832;5400.405955344909;5749.770009199585;5817.185594016841;5858.326292476335;5986.49114825236;5996.430339117776;5588.1059030555725;5639.577031722637;5640.661560306395;5643.435656434323;5679.261695979579;5746.712664366765;5792.333881603669;5798.88402231953;5800.88398232033;5807.506361959281;5522.171674248814;5609.80365687199;5752.741126649311;5754.856128596819;5755.510781583613;5616.382197958222;5639.379668236491;5674.858128546737;5683.715814209273;5722.885542289131;4800.927986080212;4801.4958429365115;4805.207140821725;4809.591184749335;4854.466008739036;4109.301418758818;4112.485939257593;4122.6083522065355;4157.355609880473;4184.66522678185;4756.1438940990265;4801.639877009238;4819.614430845524;4869.172240719086;4888.902221955612;5825.446582574648;5831.271091113611;5848.5321174305955;5861.120831875168;5871.178035075093;4884.462709101996;4895.902081958341;4899.755012249373;4913.361263035782;4933.9506604933495;4956.603471722254;5123.3339665843205;5126.769295381717;5131.61512886535;5140.974295128501;5262.315898933114;5304.151335786256;5382.703951282717;5385.461453854583;5409.78360865561;5649.54803615718;5694.715264236689;5795.7828855940725;5810.331811841524;5821.27234095738;5291.523762861361;5307.57539396855;5317.680939143664;5383.300170977748;5416.133418652997;5669.801556945652;5675.0068737971515;5678.20505129274;5679.233303503974;5715.828525144252;5618.2415373924;5683.8863222736145;5696.772129114789;5806.912896306474;5817.825465236049;5449.536789372789;5466.644668096561;5563.805266815642;5577.8047768327915;5593.272874526286;5609.887802244014;5609.943900560942;5615.494605485526;5635.6618602883955;5668.206451096932;5474.7810087597645;5519.3652729936575;5545.279113715191;5549.722513874371;5551.611387202857;5476.09644408684;5572.275604171432;5627.7467513961155;5654.830355089354;5683.943160568341;5528.530074943675;5531.695756733418;5534.1145416733125;5572.164175373727;5572.192032155396 18:37:09 INFO - PID 3193 | |1;ext.html;608.1789584061518;666.2138676361892;680.6426626021338;1046.7487802927299;1080.5461706083445;29904.25239369014;30986.845065774694;31082.844585777097;31084.84457577712;31121.533177002308;29762.172593603627;29959.251018724488;29974.55038174429;30050.699493005064;30095.548566771515;6406.647634380119;6555.213374395079;6609.107770451;6835.7607483738075;6838.14523184602;6727.360900714424;6823.283555226704;6829.931700683004;6838.042674025641;6842.726290948356;6803.65981700913;6818.386345228929;6826.965865170667;6853.828654283658;6857.348551887562;6818.9659051704675;6838.521303508756;6843.452523798084;6846.6576671166495;6856.6228857412825;6728.697208625624;6758.966205168943;6769.187697476285;6789.18529776425;6795.898061529081;28453.430931381463;28612.713872861423;28630.71369286322;28636.427271454664;28641.427171456664;2715.470483255766;2732.8770205340807;2739.7123302053196;2741.1228406909795;2746;22625.773742262696;22632;22883.656745148837;22885.885570572205;22931.77068229313;3011.3224524482034;3026.8940587079346;3031.10582378199;3055.2972816252386;3072.032309822399;149353;149509.25245373813;149690;155910;161148.99999999884;34504.30991380158;34584.82707586446;34629.134271642906;34698.47952280718;34737.478937815955;35762.46356304658;35839.4624080639;35884;38783.31558501938;39439.40840887389;11572.59495917639;11648.825267620992;11660.88339116615;11675.299482031105;11682.591109311134;9413.246940244764;9415.905840941503;9427.387219830689;9449.149576538144;9456.290778191664;11860.94069529647;11946.581869634521;11967.222130561486;11992.160548761503;12094.939525302318;4634.096351211481;4721.716696998191;4723.267893476516;4801.231802911518;4844.297576851407;811.5617566514017;824.7814329202766;826.0789220019635;831.0442990560904;840.7225615546855;19807.20771169137;20261.290854820305;20376.49058773513;20949.79050209509;21665.67501487479;877.4515927545284;881.9250363719027;889.9065598112235;897.4974014551741;900.8918929728475;10322.793544129076;10625.9468702656;10699.732506687395;10835.349879007284;10851.51168197433;169264;169877;170422;170611;170975;35102.824485877914;35303;35305.470417943754;35306.11734706653;35368.646313536534;1045.6706137566641;1089.9400532970762;1090.705509512443;1091.5906535049357;1100.9889901100887;18719.719204211677;22218.77781222167;23593.76406235984;23597.646035309142;23644.172453964027;35653.64346356607;35892.461613076346;35911.64088359083;35958.101047474025;36043.27913441664;164197;166357;166413.16793415954;166623.1668841648;166801;27526.724732753217;27771.722282777722;30121.849390752905;30933.226669333446;30946;32062.35875282528;32083.679163208068;32089.358212835145;32092.67907320897;32222.83888580542;23805.64291535663;25016.37459063538;25260.242192734248;25317.746822532277;25467.490650186523;24768.752312477365;25105.87447062753;25239;26159.476810463304;26422.07522736695;30357.696423035486;30439.695603044573;30583.694163058084;30865.382692346477;30943.381132377675;23484.06063757499;24090.879545602158;24726.302002620163;24746.381340466633;25909.870450647628;19116;22075.66886496736;22177.445563861034;22275.220367287067;22382.776172238722 18:37:09 INFO - PID 3193 | |2;jquery.html;367.25005349509576;382.6441409489176;384.31783584138134;388.06282826972864;395.3575439910146;12897;13284.402201900913;16595.58511037223;17244;17303.65392692147;13230.735385292288;16465.588360291;16474.505764827045;16486.83513164868;16512.58718532037;5178.430372659004;5315.840524784243;5316.12283973144;5330.733463326818;5331.920021199685;5204.973975130138;5272.23552584875;5279.445658205891;5280.260763493114;5281.841544753664;5251.527362537371;5259.342582177228;5265.499777521149;5269.920951185735;5291.417944026154;4953.455119936804;5260.263563101169;5260.631755777097;5268.341457317835;5272.551833094191;4624.329472226542;4639.048994956026;4645.256758918591;4645.512221216757;4648.558386953234;20567.5886482271;20827.5834483311;20947.68578471324;20966.790332096636;20972.16111355544;1608.123572652907;1623.845734655206;1628.9429869954495;1630.7716919631143;1634.3462614953994;14020.649483762885;14103.153810771386;14178.574642760734;14189.43242270308;14250.501232456814;1960.5098725318671;2026.5845501672122;2055.7122002919605;2061.8969051547365;2077.7610574783944;107088.4645576775;109399.45300273447;112006.43996779964;114123.85876141215;114442;10139.290249682452;10232.283740138118;10395.16838652921;10420.603261249955;10855.837162442569;14178.645533861736;14184.574462766133;14196.432142714175;14201.431942722176;14208.857911420753;6929.930700693029;6973.616451095137;7111.395531379787;7160.785176444715;7191.460640451883;6701.765438209639;6807.421369183675;6868.313168683092;6922.7923162305215;6942.201646810681;6348.761991411723;6501.309659488567;6538.215414150332;6570.507211959122;6625.3043430440075;1808.5117018404958;1816.8826171904184;1821.4444594398572;1821.4535639308156;2020.7474065741783;770.9537427754352;792.6353877216545;813.4793732011517;823.6746485138336;837.4849467577396;16538.751918721227;16660.833391666172;16774.41289554884;16967.490975270513;17239.655206895794;796.5181065455432;803.5901690138072;810.4326971120239;811.2050190812919;836.8953880764905;9129.81740365189;9178.770530736785;9418.623255069857;9524.809503809885;9684.612615495442;330207;332051;332567;337079;339075;87503.56248218846;88506.55746721225;89668;90436.5478172618;93195.53402233082;840.9789755256045;876.8640860666607;938.77000134966;940.703678341334;990.1880458024351;17348.04585747796;17470;17681.469555913343;18111;18667.439976800717;43612.56387436212;44423.777881110385;45087.098258034;45156.548434515236;45612.77193614011;56333.43666563446;56513;56518.7174064127;56642;56706.716466417405;8687.565621718762;8993.775155621162;9056.637734490547;9075.364724469224;9085.318601104811;15383.846161538242;15403.383864645288;15429;15437.2281385928;15487.690246195238;12818;12924.353782310658;12927.5475358362;12999.415026324028;13163.53927612529;11151.665450036511;11980.221285616755;12015;12055.75888482243;12474.5010199591;12184.147109702235;12416;12445.62663120108;12446.128770986306;12461.813072803734;8577.699780507652;8585.570721464026;8595.785105372166;8612.698555550525;8650.221480066824;12106.697332566757;12113.576024839089;12134.93932530367;12169.81745273804;13056.281904495345 18:37:09 INFO - PID 3193 | |3;mootools.html;1049.8635177426934;1084.7613525024492;1091.7161538000119;1094;1095.594629986905;8654.783630409243;8930.508822014786;9898;10384.532696028687;10387.792244155113;9873.210143188546;10149.391036537794;10208.540615672295;10223.948880255606;10229.846552301702;2167.1331467413;2183.9344819655435;2196.560687862434;2205.3163519308987;2205.878676672782;2015.5062009807543;2067.607154640621;2101.05452546354;2104.7895210478905;2138.7433507979063;2145.2813307541915;2151.268568686646;2165.7834216578294;2169.403414061138;2172.250573552122;2017.535966727661;2031.451508092814;2057.4856285928518;2097.3498215553077;2101.401100686297;1992.8106829851286;2018.2431588154443;2019.1519561784087;2019.8687085339407;2027.472857057161;9838.212942964547;10088.344257623232;10102.797944041078;10109.39343639384;10140.391576505433;5214.895702085975;5361.490658387447;5388.5958553108285;5396.757145928443;5402.405735369106;3126.3278395144926;3172.254520187754;3236.4821628539557;3241.2221066944;3270.5421241026274;1060.194252368198;1072.6728347853903;1081.1620993729844;1091.0671375973586;1099.7580532282884;15481.5355539334;15677.686446271126;15697.921510392489;15780.921095394679;15790.68418631621;4319.654427645781;4424.977875110604;4525.909481810345;4572.245579479349;4578.702384345073;10649.84025239622;10662.89337106619;10666.14670826332;10669.626563070255;10682.893171068345;5107.157319042316;5291.153415453509;5296.655717378358;5314.441983591744;5326.680399176062;4738.5261473853025;4898.657094003385;4900.852974410774;4905.896173360965;4914.975425122851;3586.9820650896577;3596.82015899204;3660.5424321959754;3666.8533258669886;3695.5380577427823;951.6050838901916;971.2230215827451;1003.117256813999;1025.6051420203275;1047.1936608811325;616.0635833533005;619.9442050215412;619.9523646825191;623.4731651754261;655.5116438253436;5632.464915832989;5693.629914055573;5702;5813.314138899672;5931.584789064724;764.6826566974754;782.6751897962282;784.8901153838467;791.3431851563189;809.9838003239902;3495.7378196635354;3557.2529768748336;3648.0633090361985;3659.9817000914827;3732;13693.657658558417;14047.85952140486;14073.929630351782;14100.435982560788;14101.435942562182;13445.798313025312;13625;13668.863311366958;13894.791578126336;13894.861051389558;7275.435781307045;7397.149327827261;7406.222346653632;7418.443616728767;7435.851282974419;5533.170024496358;5574.9442505574425;5587.329520457572;5691.658500489983;5812.273465816773;12468.438920248793;12474.18917770342;12495;12552.121351505308;12761.170523915916;12350.505979760708;12732;12775;12844.743105138032;12982.285974271506;8218.876716849372;8273.503589784632;8357.289630381485;8391.748247552583;8397.580120993804;9165.77085572866;9305.906940930505;9311.953440232755;9354.064593540592;9432.151106400457;8050.194980501903;8071.798205044921;8090.635921383434;8138.738495533202;8364.707235246737;8024.077231118263;8100.108988011196;8141.8778718320455;8198;8229.917700822914;6965.860682786417;7188.388986936169;7221;7446.478746487694;7525.397968162643;5069.746512674278;5094.617903657315;5129.153689641167;5180.119379705384;5237.198099017008;5191.351081114861;5200.427952925251;5280.128778751463;5297.894042119059;5333.040052790535 18:37:09 INFO - PID 3193 | |4;prototype.html;331.83905805684225;335.8455110649101;350.30639334118445;355.2752385134326;355.7509743179774;5526.364468086172;5564.777408903639;5597;5603.523700485453;5636.915446268309;5428.37573679027;5453.754581043852;5467.152591348347;5477.67133971962;5490.69801160936;3971.8609848655233;4048.251073551388;4058.817353219112;4079.6328330450256;4088.9386659199986;4065.796710164495;4070.267351876661;4074.4295798588223;4074.9592504075026;4096.426500289962;4019.5779443158485;4028.919421611566;4034.5158580970324;4060.4924384451942;4060.8375664973514;4045.5954404559457;4056.7565946043333;4058.939115913234;4063.3904914262803;4076.8776936691947;3499.737519686034;3501.649835016478;3510.4558793387064;3529.400001999666;3533.5583052118486;5328.17413300939;5332.973335133338;5344.759485823109;5349.652272602269;5354.759035843396;4762.1428142934255;4793.832215872428;4805.255185446262;4807.894184337622;4838.104950584118;5799.33307669615;5825.398015545717;5825.854353641193;5838.241028666246;5839.153322768175;3968.980155099206;3984.9041513583707;3989.940150897739;3994.1013272013856;3997.860609726214;5839.386864379264;6184;6234.251889773256;6264.718087686065;6268.49852011838;4048.2105989332385;4059.5331536873045;4072.165206132736;4080.489938757655;4085.55058943516;4130.710850240514;4132.91734165315;4134.607212314825;4150.232207041647;4152.896177595584;4639.257718764981;4801.4718380978065;4804.711717296974;4811.133995880705;4823.397075365579;5799.159121927297;5835.79574714883;5841.539615096226;5842.152887831241;5871.412858714094;1412.8022076909242;1416.525463969561;1418.907770994882;1427;1428.5000249912655;918.9724308270762;949.3259785552198;951.7668171297938;952.8708480450688;960.0639376607752;5031.22016087507;5067.873303167376;5070.2141168119;5072.264521644414;5080.7205603692155;6008.309044459856;6073.848153796191;6088.847778805477;6097.17688112108;6098.1157732128595;5057.207094678991;5062.810239593692;5065.214891691794;5065.924011139836;5076.670016448919;3199.6642451010894;3203.1831882870183;3209.261869769966;3222.5971753530807;3228.8869889553753;5592.692401917852;5605.7197140142825;5607.579431542651;5626.718664066862;5630.268065151504;6196.47329976957;6207.34822843604;6219.502439804804;6268.780592679234;6275.748970041239;5575.526080283222;5613.550915926798;5616.719164041863;5633.3240011198095;5646.181303710939;6048.824367207251;6056.878862422815;6060.727267273071;6067.302260240129;6087.391260873877;5978.910316345171;5979.1928089707335;5980.760769569169;5986.036911728722;6004.1294012368835;5301.602379821452;5591.524720398812;5596.580256480862;5613.859653508695;5630.324361076697;4048.781218930898;4077.938830917479;4079.2045551118435;4086.4279000940487;4099.631033207026;6047.183630209865;6088.5737998341465;6090;6107.9083813741945;6110.686202466491;5618.971905140448;5835.124731290341;5845.784818349805;5859.882802343844;5862;5789.79735709265;5826.300843898759;5836.503897168788;5836.854078648068;5850.356460789225;5772.740226689725;5777.162311464898;5811.082342826772;5816.127580862904;5837.299524056971;5925.348211696796;5928.466438020599;5947.6431414115295;5957.314908785372;5957.4042595740075;5734.827955161351;5742.598018138858;5758.712064396847;5758.971205143947;5766.798162064308 18:37:09 INFO - PID 3193 | |5;yui.html;611.3855575146977;619.374431823858;632.1939527102944;653.7352372289224;655.8852200864848;13019.414126364312;13552.39014244359;13558.796618050725;14832.406703731865;16586.25361858716;14477.131372117654;14633.560993170195;14634.780478292834;14666.340014699337;14722.337494812733;638.0461210490312;661.0249881424908;669.6885948034163;670.7752902777576;674.0664180110533;641.4483544152025;665.6072916978982;665.8901281288581;666.5800545656253;673.2964052565056;689.4966674327744;690.9136357955256;691.4848437913761;693.0124572484215;693.7710555516693;689.8930665746817;692.882210024297;693.719043787267;694.3195668245097;695.5131408014411;500.1172929778943;501.64633933077096;503.2451323015477;503.48141414343286;504.8081728943015;13496.595102146854;13523.526676566273;13603.659908502366;13667.384967676478;13672.521461748891;14705.485308014167;15353.846461535353;15508.612284692974;15569.92215038929;15626.45307414235;11605;11788.1158913081;11820.172587918849;11931.403429828473;11935.701607459796;3006.128222815381;3012.7589792816743;3017.321102751885;3022.607061082067;3032.9545056824163;82967.5851620744;84194.57902710569;84484;86692.56653716692;86702;11573.537058517733;11664.708382290512;11769.352685602204;11811.52753889852;11877.940610297066;18161.273549058154;19209.8079019208;19358.80641193598;19372.2251109954;20520;5892.1161825726485;6249.812505624747;6422.775202867877;6425.646589437626;6443.259025212067;2863.742263196281;2915.825050496977;2925.341798095454;2955.926101847471;2960.7335339819087;3279.950800737991;3343.6154842192973;3344.030231232964;3351.5307856899567;3351.8826841060445;692.4840993459904;693.3724978894109;696.0220889649949;696.4915611603558;698.8462538241579;510.83908568800706;514.9304843846107;527.8099884041742;533.6371267538111;534.7272890825707;9295.442273463614;10304.845427318596;10508;10536.841947370642;10883.727906802393;542.6201658838828;546.5627498001583;547.6686604604157;558.8658721906713;566.6741623566384;4527.796249168795;4667.926376933325;4695.624350051988;4793.1372352976105;4890.755462226945;85422.8746275213;85459.5727021361;85597.57201214078;86912.56543717241;87841;74149;76057;77439;78549;78892.60553697195;65493.34506654968;65890.67054664696;66161.00758488626;67346;67851;9330.860037099314;9411.858822117536;9490.667826626312;9497.43015419077;9740.074692904163;28247.57628635531;28539;28666.570001449578;28852.134435966953;29120.7087929118;36863.81568092143;52870.47129528655;53312;53342;54032.72983635057;13073.346332683517;13401.329933503092;13513.797293040416;13589.388477518338;13656.453741850215;15314.463993760164;15363.15502647365;16088.839111608733;16226.67546649084;16399;13892.444302228201;14340.569782906112;14659.921416502228;14745.778813317595;14770;14553.708925821637;14637.780433293721;14774.77837832412;14893.702125957638;15050.322735476711;13346.799798002843;13370.264635445144;13416.597502074954;13490.662733431744;13585.116967397087;10233.897661023593;10435.51671053279;10962.780744384909;10964.945175274073;11012.119030477383;11083.50124244427;11903.523859045541;11930.105242106703;11968;12097.879021209676 18:37:09 INFO - PID 3193 | __end_tp_report 18:37:09 INFO - PID 3193 | __start_cc_report 18:37:09 INFO - PID 3193 | _x_x_mozilla_cycle_collect,388 18:37:09 INFO - PID 3193 | __end_cc_report 18:37:09 INFO - PID 3193 | __startTimestamp1496194629121__endTimestamp 18:37:09 INFO - PID 3193 | 18:37:09 INFO - PID 3193 | ------- Summary: start ------- 18:37:09 INFO - PID 3193 | Number of tests: 6 18:37:09 INFO - PID 3193 | 18:37:09 INFO - PID 3193 | [#0] dojo.html Cycles:165 Average:5252.89 Median:5407.84 stddev:620.23 (11.5%) stddev-sans-first:589.76 18:37:09 INFO - PID 3193 | Values: 2731.9 2743.7 2765.6 2784.1 2786.0 5108.5 5288.8 5327.7 5335.9 5361.3 5209.7 5240.6 5251.2 5376.7 5407.8 4733.3 4748.1 4768.0 4781.5 4810.8 4735.5 4751.3 4836.3 4840.4 4870.6 4614.1 4649.2 4759.3 4771.5 4837.8 4665.5 4722.9 4752.1 4757.5 4772.5 4706.5 4716.3 4727.2 4730.9 4769.1 5264.6 5283.9 5328.0 5335.9 5365.6 5581.8 5668.3 5695.9 5740.8 5766.0 5843.3 5846.6 5849.5 5850.2 5916.4 5378.1 5394.3 5396.2 5398.3 5400.4 5749.8 5817.2 5858.3 5986.5 5996.4 5588.1 5639.6 5640.7 5643.4 5679.3 5746.7 5792.3 5798.9 5800.9 5807.5 5522.2 5609.8 5752.7 5754.9 5755.5 5616.4 5639.4 5674.9 5683.7 5722.9 4800.9 4801.5 4805.2 4809.6 4854.5 4109.3 4112.5 4122.6 4157.4 4184.7 4756.1 4801.6 4819.6 4869.2 4888.9 5825.4 5831.3 5848.5 5861.1 5871.2 4884.5 4895.9 4899.8 4913.4 4934.0 4956.6 5123.3 5126.8 5131.6 5141.0 5262.3 5304.2 5382.7 5385.5 5409.8 5649.5 5694.7 5795.8 5810.3 5821.3 5291.5 5307.6 5317.7 5383.3 5416.1 5669.8 5675.0 5678.2 5679.2 5715.8 5618.2 5683.9 5696.8 5806.9 5817.8 5449.5 5466.6 5563.8 5577.8 5593.3 5609.9 5609.9 5615.5 5635.7 5668.2 5474.8 5519.4 5545.3 5549.7 5551.6 5476.1 5572.3 5627.7 5654.8 5683.9 5528.5 5531.7 5534.1 5572.2 5572.2 18:37:09 INFO - PID 3193 | 18:37:09 INFO - PID 3193 | [#1] ext.html Cycles:180 Average:29672.39 Median:16566.59 stddev:42118.41 (254.2%) stddev-sans-first:42180.02 18:37:09 INFO - PID 3193 | Values: 608.2 666.2 680.6 1046.7 1080.5 29904.3 30986.8 31082.8 31084.8 31121.5 29762.2 29959.3 29974.6 30050.7 30095.5 6406.6 6555.2 6609.1 6835.8 6838.1 6727.4 6823.3 6829.9 6838.0 6842.7 6803.7 6818.4 6827.0 6853.8 6857.3 6819.0 6838.5 6843.5 6846.7 6856.6 6728.7 6759.0 6769.2 6789.2 6795.9 28453.4 28612.7 28630.7 28636.4 28641.4 2715.5 2732.9 2739.7 2741.1 2746.0 22625.8 22632.0 22883.7 22885.9 22931.8 3011.3 3026.9 3031.1 3055.3 3072.0 149353.0 149509.3 149690.0 155910.0 161149.0 34504.3 34584.8 34629.1 34698.5 34737.5 35762.5 35839.5 35884.0 38783.3 39439.4 11572.6 11648.8 11660.9 11675.3 11682.6 9413.2 9415.9 9427.4 9449.1 9456.3 11860.9 11946.6 11967.2 11992.2 12094.9 4634.1 4721.7 4723.3 4801.2 4844.3 811.6 824.8 826.1 831.0 840.7 19807.2 20261.3 20376.5 20949.8 21665.7 877.5 881.9 889.9 897.5 900.9 10322.8 10625.9 10699.7 10835.3 10851.5 169264.0 169877.0 170422.0 170611.0 170975.0 35102.8 35303.0 35305.5 35306.1 35368.6 1045.7 1089.9 1090.7 1091.6 1101.0 18719.7 22218.8 23593.8 23597.6 23644.2 35653.6 35892.5 35911.6 35958.1 36043.3 164197.0 166357.0 166413.2 166623.2 166801.0 27526.7 27771.7 30121.8 30933.2 30946.0 32062.4 32083.7 32089.4 32092.7 32222.8 23805.6 25016.4 25260.2 25317.7 25467.5 24768.8 25105.9 25239.0 26159.5 26422.1 30357.7 30439.7 30583.7 30865.4 30943.4 23484.1 24090.9 24726.3 24746.4 25909.9 19116.0 22075.7 22177.4 22275.2 22382.8 18:37:09 INFO - PID 3193 | 18:37:09 INFO - PID 3193 | [#2] jquery.html Cycles:180 Average:25248.51 Median:374.95 stddev:57381.11 (15303.8%) stddev-sans-first:57511.67 18:37:09 INFO - PID 3193 | Values: 367.3 382.6 384.3 388.1 395.4 12897.0 13284.4 16595.6 17244.0 17303.7 13230.7 16465.6 16474.5 16486.8 16512.6 5178.4 5315.8 5316.1 5330.7 5331.9 5205.0 5272.2 5279.4 5280.3 5281.8 5251.5 5259.3 5265.5 5269.9 5291.4 4953.5 5260.3 5260.6 5268.3 5272.6 4624.3 4639.0 4645.3 4645.5 4648.6 20567.6 20827.6 20947.7 20966.8 20972.2 1608.1 1623.8 1628.9 1630.8 1634.3 14020.6 14103.2 14178.6 14189.4 14250.5 1960.5 2026.6 2055.7 2061.9 2077.8 107088.5 109399.5 112006.4 114123.9 114442.0 10139.3 10232.3 10395.2 10420.6 10855.8 14178.6 14184.6 14196.4 14201.4 14208.9 6929.9 6973.6 7111.4 7160.8 7191.5 6701.8 6807.4 6868.3 6922.8 6942.2 6348.8 6501.3 6538.2 6570.5 6625.3 1808.5 1816.9 1821.4 1821.5 2020.7 771.0 792.6 813.5 823.7 837.5 16538.8 16660.8 16774.4 16967.5 17239.7 796.5 803.6 810.4 811.2 836.9 9129.8 9178.8 9418.6 9524.8 9684.6 330207.0 332051.0 332567.0 337079.0 339075.0 87503.6 88506.6 89668.0 90436.5 93195.5 841.0 876.9 938.8 940.7 990.2 17348.0 17470.0 17681.5 18111.0 18667.4 43612.6 44423.8 45087.1 45156.5 45612.8 56333.4 56513.0 56518.7 56642.0 56706.7 8687.6 8993.8 9056.6 9075.4 9085.3 15383.8 15403.4 15429.0 15437.2 15487.7 12818.0 12924.4 12927.5 12999.4 13163.5 11151.7 11980.2 12015.0 12055.8 12474.5 12184.1 12416.0 12445.6 12446.1 12461.8 8577.7 8585.6 8595.8 8612.7 8650.2 12106.7 12113.6 12134.9 12169.8 13056.3 18:37:09 INFO - PID 3193 | 18:37:09 INFO - PID 3193 | [#3] mootools.html Cycles:180 Average:6252.98 Median:3681.20 stddev:4202.41 (114.2%) stddev-sans-first:4196.01 18:37:09 INFO - PID 3193 | Values: 1049.9 1084.8 1091.7 1094.0 1095.6 8654.8 8930.5 9898.0 10384.5 10387.8 9873.2 10149.4 10208.5 10223.9 10229.8 2167.1 2183.9 2196.6 2205.3 2205.9 2015.5 2067.6 2101.1 2104.8 2138.7 2145.3 2151.3 2165.8 2169.4 2172.3 2017.5 2031.5 2057.5 2097.3 2101.4 1992.8 2018.2 2019.2 2019.9 2027.5 9838.2 10088.3 10102.8 10109.4 10140.4 5214.9 5361.5 5388.6 5396.8 5402.4 3126.3 3172.3 3236.5 3241.2 3270.5 1060.2 1072.7 1081.2 1091.1 1099.8 15481.5 15677.7 15697.9 15780.9 15790.7 4319.7 4425.0 4525.9 4572.2 4578.7 10649.8 10662.9 10666.1 10669.6 10682.9 5107.2 5291.2 5296.7 5314.4 5326.7 4738.5 4898.7 4900.9 4905.9 4915.0 3587.0 3596.8 3660.5 3666.9 3695.5 951.6 971.2 1003.1 1025.6 1047.2 616.1 619.9 620.0 623.5 655.5 5632.5 5693.6 5702.0 5813.3 5931.6 764.7 782.7 784.9 791.3 810.0 3495.7 3557.3 3648.1 3660.0 3732.0 13693.7 14047.9 14073.9 14100.4 14101.4 13445.8 13625.0 13668.9 13894.8 13894.9 7275.4 7397.1 7406.2 7418.4 7435.9 5533.2 5574.9 5587.3 5691.7 5812.3 12468.4 12474.2 12495.0 12552.1 12761.2 12350.5 12732.0 12775.0 12844.7 12982.3 8218.9 8273.5 8357.3 8391.7 8397.6 9165.8 9305.9 9312.0 9354.1 9432.2 8050.2 8071.8 8090.6 8138.7 8364.7 8024.1 8100.1 8141.9 8198.0 8229.9 6965.9 7188.4 7221.0 7446.5 7525.4 5069.7 5094.6 5129.2 5180.1 5237.2 5191.4 5200.4 5280.1 5297.9 5333.0 18:37:09 INFO - PID 3193 | 18:37:09 INFO - PID 3193 | [#4] prototype.html Cycles:180 Average:4783.79 Median:5508.53 stddev:1453.92 (26.4%) stddev-sans-first:1419.08 18:37:09 INFO - PID 3193 | Values: 331.8 335.8 350.3 355.3 355.8 5526.4 5564.8 5597.0 5603.5 5636.9 5428.4 5453.8 5467.2 5477.7 5490.7 3971.9 4048.3 4058.8 4079.6 4088.9 4065.8 4070.3 4074.4 4075.0 4096.4 4019.6 4028.9 4034.5 4060.5 4060.8 4045.6 4056.8 4058.9 4063.4 4076.9 3499.7 3501.6 3510.5 3529.4 3533.6 5328.2 5333.0 5344.8 5349.7 5354.8 4762.1 4793.8 4805.3 4807.9 4838.1 5799.3 5825.4 5825.9 5838.2 5839.2 3969.0 3984.9 3989.9 3994.1 3997.9 5839.4 6184.0 6234.3 6264.7 6268.5 4048.2 4059.5 4072.2 4080.5 4085.6 4130.7 4132.9 4134.6 4150.2 4152.9 4639.3 4801.5 4804.7 4811.1 4823.4 5799.2 5835.8 5841.5 5842.2 5871.4 1412.8 1416.5 1418.9 1427.0 1428.5 919.0 949.3 951.8 952.9 960.1 5031.2 5067.9 5070.2 5072.3 5080.7 6008.3 6073.8 6088.8 6097.2 6098.1 5057.2 5062.8 5065.2 5065.9 5076.7 3199.7 3203.2 3209.3 3222.6 3228.9 5592.7 5605.7 5607.6 5626.7 5630.3 6196.5 6207.3 6219.5 6268.8 6275.7 5575.5 5613.6 5616.7 5633.3 5646.2 6048.8 6056.9 6060.7 6067.3 6087.4 5978.9 5979.2 5980.8 5986.0 6004.1 5301.6 5591.5 5596.6 5613.9 5630.3 4048.8 4077.9 4079.2 4086.4 4099.6 6047.2 6088.6 6090.0 6107.9 6110.7 5619.0 5835.1 5845.8 5859.9 5862.0 5789.8 5826.3 5836.5 5836.9 5850.4 5772.7 5777.2 5811.1 5816.1 5837.3 5925.3 5928.5 5947.6 5957.3 5957.4 5734.8 5742.6 5758.7 5759.0 5766.8 18:37:09 INFO - PID 3193 | 18:37:09 INFO - PID 3193 | [#5] yui.html Cycles:180 Average:17627.78 Median:3343.82 stddev:23812.95 (712.1%) stddev-sans-first:23845.47 18:37:09 INFO - PID 3193 | Values: 611.4 619.4 632.2 653.7 655.9 13019.4 13552.4 13558.8 14832.4 16586.3 14477.1 14633.6 14634.8 14666.3 14722.3 638.0 661.0 669.7 670.8 674.1 641.4 665.6 665.9 666.6 673.3 689.5 690.9 691.5 693.0 693.8 689.9 692.9 693.7 694.3 695.5 500.1 501.6 503.2 503.5 504.8 13496.6 13523.5 13603.7 13667.4 13672.5 14705.5 15353.8 15508.6 15569.9 15626.5 11605.0 11788.1 11820.2 11931.4 11935.7 3006.1 3012.8 3017.3 3022.6 3033.0 82967.6 84194.6 84484.0 86692.6 86702.0 11573.5 11664.7 11769.4 11811.5 11877.9 18161.3 19209.8 19358.8 19372.2 20520.0 5892.1 6249.8 6422.8 6425.6 6443.3 2863.7 2915.8 2925.3 2955.9 2960.7 3280.0 3343.6 3344.0 3351.5 3351.9 692.5 693.4 696.0 696.5 698.8 510.8 514.9 527.8 533.6 534.7 9295.4 10304.8 10508.0 10536.8 10883.7 542.6 546.6 547.7 558.9 566.7 4527.8 4667.9 4695.6 4793.1 4890.8 85422.9 85459.6 85597.6 86912.6 87841.0 74149.0 76057.0 77439.0 78549.0 78892.6 65493.3 65890.7 66161.0 67346.0 67851.0 9330.9 9411.9 9490.7 9497.4 9740.1 28247.6 28539.0 28666.6 28852.1 29120.7 36863.8 52870.5 53312.0 53342.0 54032.7 13073.3 13401.3 13513.8 13589.4 13656.5 15314.5 15363.2 16088.8 16226.7 16399.0 13892.4 14340.6 14659.9 14745.8 14770.0 14553.7 14637.8 14774.8 14893.7 15050.3 13346.8 13370.3 13416.6 13490.7 13585.1 10233.9 10435.5 10962.8 10964.9 11012.1 11083.5 11903.5 11930.1 11968.0 12097.9 18:37:09 INFO - PID 3193 | -------- Summary: end -------- 18:37:09 INFO - PID 3193 | 18:37:10 INFO - TEST-INFO | 3193: exit 0 18:37:10 INFO - TEST-OK | dromaeo_css | took 1147858ms 18:37:10 INFO - TEST-START | kraken 18:37:10 INFO - operating with platform_type : linux_ 18:37:10 INFO - Initialising browser for kraken test... 18:37:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48967/getInfo.html -profile /tmp/tmpF6p3qW/profile 18:37:10 INFO - TEST-INFO | started process 3621 (/builds/slave/test/build/application/firefox/firefox http://localhost:48967/getInfo.html) 18:37:45 INFO - TEST-INFO | 3621: killed by SIGTERM 18:37:45 INFO - Browser initialized. 18:37:45 INFO - Running cycle 1/1 for kraken test... 18:37:45 INFO - TEST-INFO | started process 3843 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF6p3qW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:37:57 INFO - PID 3843 | RSS: Main: 187850752 18:37:57 INFO - PID 3843 | 18:37:59 INFO - PID 3843 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48967/tests/kraken/driver.html?testName=audio-beat-detection) 18:38:00 INFO - PID 3843 | RSS: Main: 191918080 18:38:00 INFO - PID 3843 | 18:38:03 INFO - PID 3843 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48967/tests/kraken/driver.html?testName=audio-dft) 18:38:04 INFO - PID 3843 | RSS: Main: 190783488 18:38:04 INFO - PID 3843 | 18:38:07 INFO - PID 3843 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48967/tests/kraken/driver.html?testName=audio-fft) 18:38:07 INFO - PID 3843 | RSS: Main: 185778176 18:38:07 INFO - PID 3843 | 18:38:09 INFO - PID 3843 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48967/tests/kraken/driver.html?testName=audio-oscillator) 18:38:10 INFO - PID 3843 | RSS: Main: 185974784 18:38:10 INFO - PID 3843 | 18:38:12 INFO - PID 3843 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48967/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:38:13 INFO - PID 3843 | RSS: Main: 186269696 18:38:13 INFO - PID 3843 | 18:38:16 INFO - PID 3843 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48967/tests/kraken/driver.html?testName=imaging-darkroom) 18:38:17 INFO - PID 3843 | RSS: Main: 187564032 18:38:17 INFO - PID 3843 | 18:38:20 INFO - PID 3843 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48967/tests/kraken/driver.html?testName=imaging-desaturate) 18:38:21 INFO - PID 3843 | RSS: Main: 186511360 18:38:21 INFO - PID 3843 | 18:38:24 INFO - PID 3843 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48967/tests/kraken/driver.html?testName=json-parse-financial) 18:38:24 INFO - PID 3843 | RSS: Main: 187109376 18:38:24 INFO - PID 3843 | 18:38:26 INFO - PID 3843 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48967/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:38:27 INFO - PID 3843 | RSS: Main: 187088896 18:38:27 INFO - PID 3843 | 18:38:28 INFO - PID 3843 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48967/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:38:29 INFO - PID 3843 | RSS: Main: 187142144 18:38:29 INFO - PID 3843 | 18:38:31 INFO - PID 3843 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48967/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:38:32 INFO - PID 3843 | RSS: Main: 186757120 18:38:32 INFO - PID 3843 | 18:38:35 INFO - PID 3843 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48967/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:38:36 INFO - PID 3843 | RSS: Main: 187437056 18:38:36 INFO - PID 3843 | 18:38:39 INFO - PID 3843 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48967/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:38:39 INFO - PID 3843 | RSS: Main: 186847232 18:38:39 INFO - PID 3843 | 18:38:41 INFO - PID 3843 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48967/tests/kraken/driver.html?testName=ai-astar) 18:38:41 INFO - PID 3843 | RSS: Main: 188502016 18:38:41 INFO - PID 3843 | 18:38:41 INFO - PID 3843 | __start_tp_report 18:38:41 INFO - PID 3843 | _x_x_mozilla_page_load 18:38:41 INFO - PID 3843 | _x_x_mozilla_page_load_details 18:38:41 INFO - PID 3843 | |i|pagename|runs| 18:38:41 INFO - PID 3843 | |0;ai-astar;102;109;109;113;112;111;111;112;110;111 18:38:41 INFO - PID 3843 | |1;audio-beat-detection;150;122;135;176;125;124;123;126;148;125 18:38:41 INFO - PID 3843 | |2;audio-dft;163;165;164;167;171;168;173;167;162;164 18:38:41 INFO - PID 3843 | |3;audio-fft;74;74;74;106;75;73;74;75;98;79 18:38:41 INFO - PID 3843 | |4;audio-oscillator;83;86;115;83;84;82;100;83;84;107 18:38:41 INFO - PID 3843 | |5;imaging-gaussian-blur;114;114;113;114;115;114;115;115;114;114 18:38:41 INFO - PID 3843 | |6;imaging-darkroom;150;149;152;156;151;151;150;150;149;151 18:38:41 INFO - PID 3843 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;97;99 18:38:41 INFO - PID 3843 | |8;json-parse-financial;56;55;55;56;55;60;55;60;60;56 18:38:41 INFO - PID 3843 | |9;json-stringify-tinderbox;56;57;58;58;64;57;56;55;56;56 18:38:41 INFO - PID 3843 | |10;stanford-crypto-aes;87;87;90;106;91;86;94;93;125;87 18:38:41 INFO - PID 3843 | |11;stanford-crypto-ccm;139;140;138;134;130;132;132;130;138;138 18:38:41 INFO - PID 3843 | |12;stanford-crypto-pbkdf2;187;205;198;196;190;195;197;191;193;195 18:38:41 INFO - PID 3843 | |13;stanford-crypto-sha256-iterative;75;75;75;76;75;75;72;72;80;71 18:38:41 INFO - PID 3843 | __end_tp_report 18:38:41 INFO - PID 3843 | __start_cc_report 18:38:41 INFO - PID 3843 | _x_x_mozilla_cycle_collect,1036 18:38:41 INFO - PID 3843 | __end_cc_report 18:38:41 INFO - PID 3843 | __startTimestamp1496194721868__endTimestamp 18:38:41 INFO - PID 3843 | 18:38:41 INFO - PID 3843 | ------- Summary: start ------- 18:38:41 INFO - PID 3843 | Number of tests: 14 18:38:41 INFO - PID 3843 | 18:38:41 INFO - PID 3843 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:3.09 (2.8%) stddev-sans-first:1.36 18:38:41 INFO - PID 3843 | Values: 102.0 109.0 109.0 113.0 112.0 111.0 111.0 112.0 110.0 111.0 18:38:41 INFO - PID 3843 | 18:38:41 INFO - PID 3843 | [#1] audio-beat-detection Cycles:10 Average:135.40 Median:130.50 stddev:17.60 (13.5%) stddev-sans-first:17.86 18:38:41 INFO - PID 3843 | Values: 150.0 122.0 135.0 176.0 125.0 124.0 123.0 126.0 148.0 125.0 18:38:41 INFO - PID 3843 | 18:38:41 INFO - PID 3843 | [#2] audio-dft Cycles:10 Average:166.40 Median:167.00 stddev:3.53 (2.1%) stddev-sans-first:3.53 18:38:41 INFO - PID 3843 | Values: 163.0 165.0 164.0 167.0 171.0 168.0 173.0 167.0 162.0 164.0 18:38:41 INFO - PID 3843 | 18:38:41 INFO - PID 3843 | [#3] audio-fft Cycles:10 Average:80.20 Median:74.50 stddev:11.75 (15.8%) stddev-sans-first:12.25 18:38:41 INFO - PID 3843 | Values: 74.0 74.0 74.0 106.0 75.0 73.0 74.0 75.0 98.0 79.0 18:38:41 INFO - PID 3843 | 18:38:41 INFO - PID 3843 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:83.00 stddev:12.06 (14.5%) stddev-sans-first:12.46 18:38:41 INFO - PID 3843 | Values: 83.0 86.0 115.0 83.0 84.0 82.0 100.0 83.0 84.0 107.0 18:38:41 INFO - PID 3843 | 18:38:41 INFO - PID 3843 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 18:38:41 INFO - PID 3843 | Values: 114.0 114.0 113.0 114.0 115.0 114.0 115.0 115.0 114.0 114.0 18:38:41 INFO - PID 3843 | 18:38:41 INFO - PID 3843 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:2.02 (1.3%) stddev-sans-first:2.12 18:38:41 INFO - PID 3843 | Values: 150.0 149.0 152.0 156.0 151.0 151.0 150.0 150.0 149.0 151.0 18:38:41 INFO - PID 3843 | 18:38:41 INFO - PID 3843 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:1.43 (1.5%) stddev-sans-first:1.51 18:38:41 INFO - PID 3843 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 97.0 99.0 18:38:41 INFO - PID 3843 | 18:38:41 INFO - PID 3843 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.00 stddev:2.25 (4.0%) stddev-sans-first:2.37 18:38:41 INFO - PID 3843 | Values: 56.0 55.0 55.0 56.0 55.0 60.0 55.0 60.0 60.0 56.0 18:38:41 INFO - PID 3843 | 18:38:41 INFO - PID 3843 | [#9] json-stringify-tinderbox Cycles:10 Average:57.30 Median:57.00 stddev:2.54 (4.5%) stddev-sans-first:2.65 18:38:41 INFO - PID 3843 | Values: 56.0 57.0 58.0 58.0 64.0 57.0 56.0 55.0 56.0 56.0 18:38:41 INFO - PID 3843 | 18:38:41 INFO - PID 3843 | [#10] stanford-crypto-aes Cycles:10 Average:94.60 Median:88.50 stddev:12.19 (13.8%) stddev-sans-first:12.62 18:38:41 INFO - PID 3843 | Values: 87.0 87.0 90.0 106.0 91.0 86.0 94.0 93.0 125.0 87.0 18:38:41 INFO - PID 3843 | 18:38:41 INFO - PID 3843 | [#11] stanford-crypto-ccm Cycles:10 Average:135.10 Median:138.00 stddev:3.90 (2.8%) stddev-sans-first:3.87 18:38:41 INFO - PID 3843 | Values: 139.0 140.0 138.0 134.0 130.0 132.0 132.0 130.0 138.0 138.0 18:38:41 INFO - PID 3843 | 18:38:41 INFO - PID 3843 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.70 Median:195.50 stddev:4.97 (2.5%) stddev-sans-first:4.42 18:38:41 INFO - PID 3843 | Values: 187.0 205.0 198.0 196.0 190.0 195.0 197.0 191.0 193.0 195.0 18:38:41 INFO - PID 3843 | 18:38:41 INFO - PID 3843 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:75.00 stddev:2.55 (3.4%) stddev-sans-first:2.70 18:38:41 INFO - PID 3843 | Values: 75.0 75.0 75.0 76.0 75.0 75.0 72.0 72.0 80.0 71.0 18:38:41 INFO - PID 3843 | -------- Summary: end -------- 18:38:41 INFO - PID 3843 | 18:38:43 INFO - TEST-INFO | 3843: exit 0 18:38:43 INFO - TEST-OK | kraken | took 93058ms 18:38:43 INFO - SUITE-END | took 1240s 18:38:43 INFO - Completed test suite (00:20:41) 18:38:43 INFO - javascript benchmark 18:38:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6625.574188146949, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2731.9043833465826, 2743.6570428696414, 2765.6404667393235, 2784.095169070052, 2785.9721402785967, 5108.540231379176, 5288.814891478799, 5327.706976116317, 5335.866603334909, 5361.276227709258, 5209.661372010816, 5240.580753539717, 5251.159814429692, 5376.704281264529, 5407.83776486706, 4733.313669517918, 4748.145333839908, 4768.022555376157, 4781.45013323467, 4810.831620893269, 4735.526447355272, 4751.287306903958, 4836.274558816171, 4840.419149702041, 4870.610351171916, 4614.077184563067, 4649.18639238132, 4759.262314341283, 4771.4512831024185, 4837.758112094399, 4665.486796452387, 4722.905541889178, 4752.144613969484, 4757.500462451462, 4772.451168115676, 4706.505816889212, 4716.292556116576, 4727.196376615949, 4730.881727956794, 4769.117713223065, 5264.631475796696, 5283.86790330241, 5328.040952628526, 5335.946640533583, 5365.570754339644, 5581.832545023656, 5668.319801623831, 5695.943040569583, 5740.799072032501, 5766.0197766379815, 5843.328017278025, 5846.561507886883, 5849.532037437038, 5850.180974663551, 5916.437938395846, 5378.139497680352, 5394.271773310592, 5396.244525766396, 5398.325209348832, 5400.405955344909, 5749.770009199585, 5817.185594016841, 5858.326292476335, 5986.49114825236, 5996.430339117776, 5588.1059030555725, 5639.577031722637, 5640.661560306395, 5643.435656434323, 5679.261695979579, 5746.712664366765, 5792.333881603669, 5798.88402231953, 5800.88398232033, 5807.506361959281, 5522.171674248814, 5609.80365687199, 5752.741126649311, 5754.856128596819, 5755.510781583613, 5616.382197958222, 5639.379668236491, 5674.858128546737, 5683.715814209273, 5722.885542289131, 4800.927986080212, 4801.4958429365115, 4805.207140821725, 4809.591184749335, 4854.466008739036, 4109.301418758818, 4112.485939257593, 4122.6083522065355, 4157.355609880473, 4184.66522678185, 4756.1438940990265, 4801.639877009238, 4819.614430845524, 4869.172240719086, 4888.902221955612, 5825.446582574648, 5831.271091113611, 5848.5321174305955, 5861.120831875168, 5871.178035075093, 4884.462709101996, 4895.902081958341, 4899.755012249373, 4913.361263035782, 4933.9506604933495, 4956.603471722254, 5123.3339665843205, 5126.769295381717, 5131.61512886535, 5140.974295128501, 5262.315898933114, 5304.151335786256, 5382.703951282717, 5385.461453854583, 5409.78360865561, 5649.54803615718, 5694.715264236689, 5795.7828855940725, 5810.331811841524, 5821.27234095738, 5291.523762861361, 5307.57539396855, 5317.680939143664, 5383.300170977748, 5416.133418652997, 5669.801556945652, 5675.0068737971515, 5678.20505129274, 5679.233303503974, 5715.828525144252, 5618.2415373924, 5683.8863222736145, 5696.772129114789, 5806.912896306474, 5817.825465236049, 5449.536789372789, 5466.644668096561, 5563.805266815642, 5577.8047768327915, 5593.272874526286, 5609.887802244014, 5609.943900560942, 5615.494605485526, 5635.6618602883955, 5668.206451096932, 5474.7810087597645, 5519.3652729936575, 5545.279113715191, 5549.722513874371, 5551.611387202857, 5476.09644408684, 5572.275604171432, 5627.7467513961155, 5654.830355089354, 5683.943160568341, 5528.530074943675, 5531.695756733418, 5534.1145416733125, 5572.164175373727, 5572.192032155396], "value": 5207.631446023626, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.1789584061518, 666.2138676361892, 680.6426626021338, 1046.7487802927299, 1080.5461706083445, 29904.25239369014, 30986.845065774694, 31082.844585777097, 31084.84457577712, 31121.533177002308, 29762.172593603627, 29959.251018724488, 29974.55038174429, 30050.699493005064, 30095.548566771515, 6406.647634380119, 6555.213374395079, 6609.107770451, 6835.7607483738075, 6838.14523184602, 6727.360900714424, 6823.283555226704, 6829.931700683004, 6838.042674025641, 6842.726290948356, 6803.65981700913, 6818.386345228929, 6826.965865170667, 6853.828654283658, 6857.348551887562, 6818.9659051704675, 6838.521303508756, 6843.452523798084, 6846.6576671166495, 6856.6228857412825, 6728.697208625624, 6758.966205168943, 6769.187697476285, 6789.18529776425, 6795.898061529081, 28453.430931381463, 28612.713872861423, 28630.71369286322, 28636.427271454664, 28641.427171456664, 2715.470483255766, 2732.8770205340807, 2739.7123302053196, 2741.1228406909795, 2746.0, 22625.773742262696, 22632.0, 22883.656745148837, 22885.885570572205, 22931.77068229313, 3011.3224524482034, 3026.8940587079346, 3031.10582378199, 3055.2972816252386, 3072.032309822399, 149353.0, 149509.25245373813, 149690.0, 155910.0, 161148.99999999884, 34504.30991380158, 34584.82707586446, 34629.134271642906, 34698.47952280718, 34737.478937815955, 35762.46356304658, 35839.4624080639, 35884.0, 38783.31558501938, 39439.40840887389, 11572.59495917639, 11648.825267620992, 11660.88339116615, 11675.299482031105, 11682.591109311134, 9413.246940244764, 9415.905840941503, 9427.387219830689, 9449.149576538144, 9456.290778191664, 11860.94069529647, 11946.581869634521, 11967.222130561486, 11992.160548761503, 12094.939525302318, 4634.096351211481, 4721.716696998191, 4723.267893476516, 4801.231802911518, 4844.297576851407, 811.5617566514017, 824.7814329202766, 826.0789220019635, 831.0442990560904, 840.7225615546855, 19807.20771169137, 20261.290854820305, 20376.49058773513, 20949.79050209509, 21665.67501487479, 877.4515927545284, 881.9250363719027, 889.9065598112235, 897.4974014551741, 900.8918929728475, 10322.793544129076, 10625.9468702656, 10699.732506687395, 10835.349879007284, 10851.51168197433, 169264.0, 169877.0, 170422.0, 170611.0, 170975.0, 35102.824485877914, 35303.0, 35305.470417943754, 35306.11734706653, 35368.646313536534, 1045.6706137566641, 1089.9400532970762, 1090.705509512443, 1091.5906535049357, 1100.9889901100887, 18719.719204211677, 22218.77781222167, 23593.76406235984, 23597.646035309142, 23644.172453964027, 35653.64346356607, 35892.461613076346, 35911.64088359083, 35958.101047474025, 36043.27913441664, 164197.0, 166357.0, 166413.16793415954, 166623.1668841648, 166801.0, 27526.724732753217, 27771.722282777722, 30121.849390752905, 30933.226669333446, 30946.0, 32062.35875282528, 32083.679163208068, 32089.358212835145, 32092.67907320897, 32222.83888580542, 23805.64291535663, 25016.37459063538, 25260.242192734248, 25317.746822532277, 25467.490650186523, 24768.752312477365, 25105.87447062753, 25239.0, 26159.476810463304, 26422.07522736695, 30357.696423035486, 30439.695603044573, 30583.694163058084, 30865.382692346477, 30943.381132377675, 23484.06063757499, 24090.879545602158, 24726.302002620163, 24746.381340466633, 25909.870450647628, 19116.0, 22075.66886496736, 22177.445563861034, 22275.220367287067, 22382.776172238722], "value": 13767.104028635147, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.25005349509576, 382.6441409489176, 384.31783584138134, 388.06282826972864, 395.3575439910146, 12897.0, 13284.402201900913, 16595.58511037223, 17244.0, 17303.65392692147, 13230.735385292288, 16465.588360291, 16474.505764827045, 16486.83513164868, 16512.58718532037, 5178.430372659004, 5315.840524784243, 5316.12283973144, 5330.733463326818, 5331.920021199685, 5204.973975130138, 5272.23552584875, 5279.445658205891, 5280.260763493114, 5281.841544753664, 5251.527362537371, 5259.342582177228, 5265.499777521149, 5269.920951185735, 5291.417944026154, 4953.455119936804, 5260.263563101169, 5260.631755777097, 5268.341457317835, 5272.551833094191, 4624.329472226542, 4639.048994956026, 4645.256758918591, 4645.512221216757, 4648.558386953234, 20567.5886482271, 20827.5834483311, 20947.68578471324, 20966.790332096636, 20972.16111355544, 1608.123572652907, 1623.845734655206, 1628.9429869954495, 1630.7716919631143, 1634.3462614953994, 14020.649483762885, 14103.153810771386, 14178.574642760734, 14189.43242270308, 14250.501232456814, 1960.5098725318671, 2026.5845501672122, 2055.7122002919605, 2061.8969051547365, 2077.7610574783944, 107088.4645576775, 109399.45300273447, 112006.43996779964, 114123.85876141215, 114442.0, 10139.290249682452, 10232.283740138118, 10395.16838652921, 10420.603261249955, 10855.837162442569, 14178.645533861736, 14184.574462766133, 14196.432142714175, 14201.431942722176, 14208.857911420753, 6929.930700693029, 6973.616451095137, 7111.395531379787, 7160.785176444715, 7191.460640451883, 6701.765438209639, 6807.421369183675, 6868.313168683092, 6922.7923162305215, 6942.201646810681, 6348.761991411723, 6501.309659488567, 6538.215414150332, 6570.507211959122, 6625.3043430440075, 1808.5117018404958, 1816.8826171904184, 1821.4444594398572, 1821.4535639308156, 2020.7474065741783, 770.9537427754352, 792.6353877216545, 813.4793732011517, 823.6746485138336, 837.4849467577396, 16538.751918721227, 16660.833391666172, 16774.41289554884, 16967.490975270513, 17239.655206895794, 796.5181065455432, 803.5901690138072, 810.4326971120239, 811.2050190812919, 836.8953880764905, 9129.81740365189, 9178.770530736785, 9418.623255069857, 9524.809503809885, 9684.612615495442, 330207.0, 332051.0, 332567.0, 337079.0, 339075.0, 87503.56248218846, 88506.55746721225, 89668.0, 90436.5478172618, 93195.53402233082, 840.9789755256045, 876.8640860666607, 938.77000134966, 940.703678341334, 990.1880458024351, 17348.04585747796, 17470.0, 17681.469555913343, 18111.0, 18667.439976800717, 43612.56387436212, 44423.777881110385, 45087.098258034, 45156.548434515236, 45612.77193614011, 56333.43666563446, 56513.0, 56518.7174064127, 56642.0, 56706.716466417405, 8687.565621718762, 8993.775155621162, 9056.637734490547, 9075.364724469224, 9085.318601104811, 15383.846161538242, 15403.383864645288, 15429.0, 15437.2281385928, 15487.690246195238, 12818.0, 12924.353782310658, 12927.5475358362, 12999.415026324028, 13163.53927612529, 11151.665450036511, 11980.221285616755, 12015.0, 12055.75888482243, 12474.5010199591, 12184.147109702235, 12416.0, 12445.62663120108, 12446.128770986306, 12461.813072803734, 8577.699780507652, 8585.570721464026, 8595.785105372166, 8612.698555550525, 8650.221480066824, 12106.697332566757, 12113.576024839089, 12134.93932530367, 12169.81745273804, 13056.281904495345], "value": 8833.00198108767, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1049.8635177426934, 1084.7613525024492, 1091.7161538000119, 1094.0, 1095.594629986905, 8654.783630409243, 8930.508822014786, 9898.0, 10384.532696028687, 10387.792244155113, 9873.210143188546, 10149.391036537794, 10208.540615672295, 10223.948880255606, 10229.846552301702, 2167.1331467413, 2183.9344819655435, 2196.560687862434, 2205.3163519308987, 2205.878676672782, 2015.5062009807543, 2067.607154640621, 2101.05452546354, 2104.7895210478905, 2138.7433507979063, 2145.2813307541915, 2151.268568686646, 2165.7834216578294, 2169.403414061138, 2172.250573552122, 2017.535966727661, 2031.451508092814, 2057.4856285928518, 2097.3498215553077, 2101.401100686297, 1992.8106829851286, 2018.2431588154443, 2019.1519561784087, 2019.8687085339407, 2027.472857057161, 9838.212942964547, 10088.344257623232, 10102.797944041078, 10109.39343639384, 10140.391576505433, 5214.895702085975, 5361.490658387447, 5388.5958553108285, 5396.757145928443, 5402.405735369106, 3126.3278395144926, 3172.254520187754, 3236.4821628539557, 3241.2221066944, 3270.5421241026274, 1060.194252368198, 1072.6728347853903, 1081.1620993729844, 1091.0671375973586, 1099.7580532282884, 15481.5355539334, 15677.686446271126, 15697.921510392489, 15780.921095394679, 15790.68418631621, 4319.654427645781, 4424.977875110604, 4525.909481810345, 4572.245579479349, 4578.702384345073, 10649.84025239622, 10662.89337106619, 10666.14670826332, 10669.626563070255, 10682.893171068345, 5107.157319042316, 5291.153415453509, 5296.655717378358, 5314.441983591744, 5326.680399176062, 4738.5261473853025, 4898.657094003385, 4900.852974410774, 4905.896173360965, 4914.975425122851, 3586.9820650896577, 3596.82015899204, 3660.5424321959754, 3666.8533258669886, 3695.5380577427823, 951.6050838901916, 971.2230215827451, 1003.117256813999, 1025.6051420203275, 1047.1936608811325, 616.0635833533005, 619.9442050215412, 619.9523646825191, 623.4731651754261, 655.5116438253436, 5632.464915832989, 5693.629914055573, 5702.0, 5813.314138899672, 5931.584789064724, 764.6826566974754, 782.6751897962282, 784.8901153838467, 791.3431851563189, 809.9838003239902, 3495.7378196635354, 3557.2529768748336, 3648.0633090361985, 3659.9817000914827, 3732.0, 13693.657658558417, 14047.85952140486, 14073.929630351782, 14100.435982560788, 14101.435942562182, 13445.798313025312, 13625.0, 13668.863311366958, 13894.791578126336, 13894.861051389558, 7275.435781307045, 7397.149327827261, 7406.222346653632, 7418.443616728767, 7435.851282974419, 5533.170024496358, 5574.9442505574425, 5587.329520457572, 5691.658500489983, 5812.273465816773, 12468.438920248793, 12474.18917770342, 12495.0, 12552.121351505308, 12761.170523915916, 12350.505979760708, 12732.0, 12775.0, 12844.743105138032, 12982.285974271506, 8218.876716849372, 8273.503589784632, 8357.289630381485, 8391.748247552583, 8397.580120993804, 9165.77085572866, 9305.906940930505, 9311.953440232755, 9354.064593540592, 9432.151106400457, 8050.194980501903, 8071.798205044921, 8090.635921383434, 8138.738495533202, 8364.707235246737, 8024.077231118263, 8100.108988011196, 8141.8778718320455, 8198.0, 8229.917700822914, 6965.860682786417, 7188.388986936169, 7221.0, 7446.478746487694, 7525.397968162643, 5069.746512674278, 5094.617903657315, 5129.153689641167, 5180.119379705384, 5237.198099017008, 5191.351081114861, 5200.427952925251, 5280.128778751463, 5297.894042119059, 5333.040052790535], "value": 4606.06476468241, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.83905805684225, 335.8455110649101, 350.30639334118445, 355.2752385134326, 355.7509743179774, 5526.364468086172, 5564.777408903639, 5597.0, 5603.523700485453, 5636.915446268309, 5428.37573679027, 5453.754581043852, 5467.152591348347, 5477.67133971962, 5490.69801160936, 3971.8609848655233, 4048.251073551388, 4058.817353219112, 4079.6328330450256, 4088.9386659199986, 4065.796710164495, 4070.267351876661, 4074.4295798588223, 4074.9592504075026, 4096.426500289962, 4019.5779443158485, 4028.919421611566, 4034.5158580970324, 4060.4924384451942, 4060.8375664973514, 4045.5954404559457, 4056.7565946043333, 4058.939115913234, 4063.3904914262803, 4076.8776936691947, 3499.737519686034, 3501.649835016478, 3510.4558793387064, 3529.400001999666, 3533.5583052118486, 5328.17413300939, 5332.973335133338, 5344.759485823109, 5349.652272602269, 5354.759035843396, 4762.1428142934255, 4793.832215872428, 4805.255185446262, 4807.894184337622, 4838.104950584118, 5799.33307669615, 5825.398015545717, 5825.854353641193, 5838.241028666246, 5839.153322768175, 3968.980155099206, 3984.9041513583707, 3989.940150897739, 3994.1013272013856, 3997.860609726214, 5839.386864379264, 6184.0, 6234.251889773256, 6264.718087686065, 6268.49852011838, 4048.2105989332385, 4059.5331536873045, 4072.165206132736, 4080.489938757655, 4085.55058943516, 4130.710850240514, 4132.91734165315, 4134.607212314825, 4150.232207041647, 4152.896177595584, 4639.257718764981, 4801.4718380978065, 4804.711717296974, 4811.133995880705, 4823.397075365579, 5799.159121927297, 5835.79574714883, 5841.539615096226, 5842.152887831241, 5871.412858714094, 1412.8022076909242, 1416.525463969561, 1418.907770994882, 1427.0, 1428.5000249912655, 918.9724308270762, 949.3259785552198, 951.7668171297938, 952.8708480450688, 960.0639376607752, 5031.22016087507, 5067.873303167376, 5070.2141168119, 5072.264521644414, 5080.7205603692155, 6008.309044459856, 6073.848153796191, 6088.847778805477, 6097.17688112108, 6098.1157732128595, 5057.207094678991, 5062.810239593692, 5065.214891691794, 5065.924011139836, 5076.670016448919, 3199.6642451010894, 3203.1831882870183, 3209.261869769966, 3222.5971753530807, 3228.8869889553753, 5592.692401917852, 5605.7197140142825, 5607.579431542651, 5626.718664066862, 5630.268065151504, 6196.47329976957, 6207.34822843604, 6219.502439804804, 6268.780592679234, 6275.748970041239, 5575.526080283222, 5613.550915926798, 5616.719164041863, 5633.3240011198095, 5646.181303710939, 6048.824367207251, 6056.878862422815, 6060.727267273071, 6067.302260240129, 6087.391260873877, 5978.910316345171, 5979.1928089707335, 5980.760769569169, 5986.036911728722, 6004.1294012368835, 5301.602379821452, 5591.524720398812, 5596.580256480862, 5613.859653508695, 5630.324361076697, 4048.781218930898, 4077.938830917479, 4079.2045551118435, 4086.4279000940487, 4099.631033207026, 6047.183630209865, 6088.5737998341465, 6090.0, 6107.9083813741945, 6110.686202466491, 5618.971905140448, 5835.124731290341, 5845.784818349805, 5859.882802343844, 5862.0, 5789.79735709265, 5826.300843898759, 5836.503897168788, 5836.854078648068, 5850.356460789225, 5772.740226689725, 5777.162311464898, 5811.082342826772, 5816.127580862904, 5837.299524056971, 5925.348211696796, 5928.466438020599, 5947.6431414115295, 5957.314908785372, 5957.4042595740075, 5734.827955161351, 5742.598018138858, 5758.712064396847, 5758.971205143947, 5766.798162064308], "value": 4322.649577566398, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.3855575146977, 619.374431823858, 632.1939527102944, 653.7352372289224, 655.8852200864848, 13019.414126364312, 13552.39014244359, 13558.796618050725, 14832.406703731865, 16586.25361858716, 14477.131372117654, 14633.560993170195, 14634.780478292834, 14666.340014699337, 14722.337494812733, 638.0461210490312, 661.0249881424908, 669.6885948034163, 670.7752902777576, 674.0664180110533, 641.4483544152025, 665.6072916978982, 665.8901281288581, 666.5800545656253, 673.2964052565056, 689.4966674327744, 690.9136357955256, 691.4848437913761, 693.0124572484215, 693.7710555516693, 689.8930665746817, 692.882210024297, 693.719043787267, 694.3195668245097, 695.5131408014411, 500.1172929778943, 501.64633933077096, 503.2451323015477, 503.48141414343286, 504.8081728943015, 13496.595102146854, 13523.526676566273, 13603.659908502366, 13667.384967676478, 13672.521461748891, 14705.485308014167, 15353.846461535353, 15508.612284692974, 15569.92215038929, 15626.45307414235, 11605.0, 11788.1158913081, 11820.172587918849, 11931.403429828473, 11935.701607459796, 3006.128222815381, 3012.7589792816743, 3017.321102751885, 3022.607061082067, 3032.9545056824163, 82967.5851620744, 84194.57902710569, 84484.0, 86692.56653716692, 86702.0, 11573.537058517733, 11664.708382290512, 11769.352685602204, 11811.52753889852, 11877.940610297066, 18161.273549058154, 19209.8079019208, 19358.80641193598, 19372.2251109954, 20520.0, 5892.1161825726485, 6249.812505624747, 6422.775202867877, 6425.646589437626, 6443.259025212067, 2863.742263196281, 2915.825050496977, 2925.341798095454, 2955.926101847471, 2960.7335339819087, 3279.950800737991, 3343.6154842192973, 3344.030231232964, 3351.5307856899567, 3351.8826841060445, 692.4840993459904, 693.3724978894109, 696.0220889649949, 696.4915611603558, 698.8462538241579, 510.83908568800706, 514.9304843846107, 527.8099884041742, 533.6371267538111, 534.7272890825707, 9295.442273463614, 10304.845427318596, 10508.0, 10536.841947370642, 10883.727906802393, 542.6201658838828, 546.5627498001583, 547.6686604604157, 558.8658721906713, 566.6741623566384, 4527.796249168795, 4667.926376933325, 4695.624350051988, 4793.1372352976105, 4890.755462226945, 85422.8746275213, 85459.5727021361, 85597.57201214078, 86912.56543717241, 87841.0, 74149.0, 76057.0, 77439.0, 78549.0, 78892.60553697195, 65493.34506654968, 65890.67054664696, 66161.00758488626, 67346.0, 67851.0, 9330.860037099314, 9411.858822117536, 9490.667826626312, 9497.43015419077, 9740.074692904163, 28247.57628635531, 28539.0, 28666.570001449578, 28852.134435966953, 29120.7087929118, 36863.81568092143, 52870.47129528655, 53312.0, 53342.0, 54032.72983635057, 13073.346332683517, 13401.329933503092, 13513.797293040416, 13589.388477518338, 13656.453741850215, 15314.463993760164, 15363.15502647365, 16088.839111608733, 16226.67546649084, 16399.0, 13892.444302228201, 14340.569782906112, 14659.921416502228, 14745.778813317595, 14770.0, 14553.708925821637, 14637.780433293721, 14774.77837832412, 14893.702125957638, 15050.322735476711, 13346.799798002843, 13370.264635445144, 13416.597502074954, 13490.662733431744, 13585.116967397087, 10233.897661023593, 10435.51671053279, 10962.780744384909, 10964.945175274073, 11012.119030477383, 11083.50124244427, 11903.523859045541, 11930.105242106703, 11968.0, 12097.879021209676], "value": 6708.718834525314, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 109.0, 109.0, 113.0, 112.0, 111.0, 111.0, 112.0, 110.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 122.0, 135.0, 176.0, 125.0, 124.0, 123.0, 126.0, 148.0, 125.0], "value": 135.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 164.0, 167.0, 171.0, 168.0, 173.0, 167.0, 162.0, 164.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 106.0, 75.0, 73.0, 74.0, 75.0, 98.0, 79.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 115.0, 83.0, 84.0, 82.0, 100.0, 83.0, 84.0, 107.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 114.0, 115.0, 114.0, 115.0, 115.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 152.0, 156.0, 151.0, 151.0, 150.0, 150.0, 149.0, 151.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 97.0, 99.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 56.0, 55.0, 60.0, 55.0, 60.0, 60.0, 56.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 58.0, 58.0, 64.0, 57.0, 56.0, 55.0, 56.0, 56.0], "value": 57.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 90.0, 106.0, 91.0, 86.0, 94.0, 93.0, 125.0, 87.0], "value": 94.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 138.0, 134.0, 130.0, 132.0, 132.0, 130.0, 138.0, 138.0], "value": 135.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 205.0, 198.0, 196.0, 190.0, 195.0, 197.0, 191.0, 193.0, 195.0], "value": 194.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 76.0, 75.0, 75.0, 72.0, 72.0, 80.0, 71.0], "value": 74.6, "unit": "score"}]}]} 18:38:43 INFO - Return code: 0 18:38:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:38:43 INFO - # TBPL SUCCESS # 18:38:43 INFO - Running post-action listener: _resource_record_post_action 18:38:43 INFO - [mozharness: 2017-05-31 01:38:43.667831Z] Finished run-tests step (success) 18:38:43 INFO - Running post-run listener: _resource_record_post_run 18:38:43 INFO - Total resource usage - Wall time: 1257s; CPU: 13.0%; Read bytes: 0; Write bytes: 410992640; Read time: 0; Write time: 223292 18:38:43 INFO - TinderboxPrint: CPU usage
12.7% 18:38:43 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 18:38:43 INFO - TinderboxPrint: I/O write bytes / time
410,992,640 / 223,292 18:38:43 INFO - TinderboxPrint: CPU idle
8,760.2 (87.3%) 18:38:43 INFO - TinderboxPrint: CPU user
1,221.8 (12.2%) 18:38:43 INFO - TinderboxPrint: Swap in / out
0 / 0 18:38:43 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99606528; Read time: 0; Write time: 62916 18:38:43 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:38:43 INFO - run-tests - Wall time: 1242s; CPU: 13.0%; Read bytes: 0; Write bytes: 311386112; Read time: 0; Write time: 160376 18:38:44 INFO - Running post-run listener: _upload_blobber_files 18:38:44 INFO - Blob upload gear active. 18:38:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:38:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:38:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:38:44 INFO - (blobuploader) - INFO - Open directory for files ... 18:38:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:38:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:38:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:38:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:38:45 INFO - (blobuploader) - INFO - Done attempting. 18:38:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:38:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:38:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:38:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:38:46 INFO - (blobuploader) - INFO - Done attempting. 18:38:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:38:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:38:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:38:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:38:47 INFO - (blobuploader) - INFO - Done attempting. 18:38:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:38:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:38:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:38:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:38:54 INFO - (blobuploader) - INFO - Done attempting. 18:38:54 INFO - (blobuploader) - INFO - Iteration through files over. 18:38:54 INFO - Return code: 0 18:38:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:38:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:38:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da96ff9dced0ebd2bbc6bd88237964dada582820732e7634ee4e6270175e0d2876e5cf70d9e503a7920cf2db586444af4eb56ae9b2f70bc7dd7600be7dd75325", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a6025145b81a45a160e91259927e33f5c045db9b2f3015c4c09e722d4dc1981fb501617bee3cdeffcaa1eefea983dc39cbec2b72077953dfffceb07d41b3473", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3dd47742414b5d9c2169dab8f410ac6342c4b6d9029c095f49061407fa59c2b72b00d69069d6fb9c3b1b92f45e9eafed9796c23e2866b5ac9b4a9243c0b441b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60b1c043ec2f103bfa1839f8c9687365c91913cd581aa259e18b7287a763712b6ee713d185e7f318e437dc41e6464e27425c78917c332bf3020e55b47285e07a"} 18:38:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:38:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:38:54 INFO - Contents: 18:38:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da96ff9dced0ebd2bbc6bd88237964dada582820732e7634ee4e6270175e0d2876e5cf70d9e503a7920cf2db586444af4eb56ae9b2f70bc7dd7600be7dd75325", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a6025145b81a45a160e91259927e33f5c045db9b2f3015c4c09e722d4dc1981fb501617bee3cdeffcaa1eefea983dc39cbec2b72077953dfffceb07d41b3473", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3dd47742414b5d9c2169dab8f410ac6342c4b6d9029c095f49061407fa59c2b72b00d69069d6fb9c3b1b92f45e9eafed9796c23e2866b5ac9b4a9243c0b441b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60b1c043ec2f103bfa1839f8c9687365c91913cd581aa259e18b7287a763712b6ee713d185e7f318e437dc41e6464e27425c78917c332bf3020e55b47285e07a"} 18:38:54 INFO - Running post-run listener: copy_logs_to_upload_dir 18:38:54 INFO - Copying logs to upload dir... 18:38:54 INFO - mkdir: /builds/slave/test/build/upload/logs 18:38:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1323.618163 ========= master_lag: 0.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 3 secs) (at 2017-05-30 18:38:53.249596) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 18:38:53.254389) ========= 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=2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da96ff9dced0ebd2bbc6bd88237964dada582820732e7634ee4e6270175e0d2876e5cf70d9e503a7920cf2db586444af4eb56ae9b2f70bc7dd7600be7dd75325", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a6025145b81a45a160e91259927e33f5c045db9b2f3015c4c09e722d4dc1981fb501617bee3cdeffcaa1eefea983dc39cbec2b72077953dfffceb07d41b3473", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3dd47742414b5d9c2169dab8f410ac6342c4b6d9029c095f49061407fa59c2b72b00d69069d6fb9c3b1b92f45e9eafed9796c23e2866b5ac9b4a9243c0b441b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60b1c043ec2f103bfa1839f8c9687365c91913cd581aa259e18b7287a763712b6ee713d185e7f318e437dc41e6464e27425c78917c332bf3020e55b47285e07a"} build_url:https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/B3CJPPp4Srq-sORFAT76XQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da96ff9dced0ebd2bbc6bd88237964dada582820732e7634ee4e6270175e0d2876e5cf70d9e503a7920cf2db586444af4eb56ae9b2f70bc7dd7600be7dd75325", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a6025145b81a45a160e91259927e33f5c045db9b2f3015c4c09e722d4dc1981fb501617bee3cdeffcaa1eefea983dc39cbec2b72077953dfffceb07d41b3473", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3dd47742414b5d9c2169dab8f410ac6342c4b6d9029c095f49061407fa59c2b72b00d69069d6fb9c3b1b92f45e9eafed9796c23e2866b5ac9b4a9243c0b441b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60b1c043ec2f103bfa1839f8c9687365c91913cd581aa259e18b7287a763712b6ee713d185e7f318e437dc41e6464e27425c78917c332bf3020e55b47285e07a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 18:38:53.281361) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 18:38:53.281679) ========= 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=2432103b8b3de4003b23cad4000001c2-1496190409.409155-1236164978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 18:38:53.361686) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 18:38:53.365028) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 18:38:53.365339) ========= ========= Total master_lag: 0.62 =========