builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1496014928.45 results: success (0) revision: 51d220b260d8d52a41b65aae2c5d74be99c2d59e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-28 16:42:08.451409) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-28 16:42:08.451851) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-28 16:42:08.452115) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-28 16:42:08.476262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:42:08.476535) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-28 16:42:08-- 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% 110M=0s 2017-05-28 16:42:09 (110 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.336607 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:42:08.826002) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:42:08.826306) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017601 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:42:08.875579) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:42:08.875918) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 51d220b260d8d52a41b65aae2c5d74be99c2d59e --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 51d220b260d8d52a41b65aae2c5d74be99c2d59e --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-28 16:42:09,438 truncating revision to first 12 chars 2017-05-28 16:42:09,438 Setting DEBUG logging. 2017-05-28 16:42:09,438 attempt 1/10 2017-05-28 16:42:09,438 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/51d220b260d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-28 16:42:09,951 unpacking tar archive at: mozilla-central-51d220b260d8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.818479 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:42:09.706456) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-28 16:42:09.706770) ========= script_repo_revision: 51d220b260d8d52a41b65aae2c5d74be99c2d59e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-28 16:42:09.707125) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-28 16:42:09.707382) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-28 16:42:09.715997) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2017-05-28 16:42:09.716336) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:42:10 INFO - MultiFileLogger online at 20170528 16:42:10 in /builds/slave/test 16:42:10 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 16:42:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:42:10 INFO - {'append_to_log': False, 16:42:10 INFO - 'base_work_dir': '/builds/slave/test', 16:42:10 INFO - 'blob_upload_branch': 'Firefox', 16:42:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:42:10 INFO - 'branch': 'Firefox', 16:42:10 INFO - 'buildbot_json_path': 'buildprops.json', 16:42:10 INFO - 'config_files': ('talos/linux_config.py',), 16:42:10 INFO - 'default_actions': ('clobber', 16:42:10 INFO - 'read-buildbot-config', 16:42:10 INFO - 'download-and-extract', 16:42:10 INFO - 'populate-webroot', 16:42:10 INFO - 'create-virtualenv', 16:42:10 INFO - 'install', 16:42:10 INFO - 'setup-mitmproxy', 16:42:10 INFO - 'run-tests'), 16:42:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:42:10 INFO - 'download_minidump_stackwalk': True, 16:42:10 INFO - 'download_symbols': 'ondemand', 16:42:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:42:10 INFO - 'tooltool.py': '/tools/tooltool.py', 16:42:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:42:10 INFO - '/tools/misc-python/virtualenv.py')}, 16:42:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:42:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:42:10 INFO - 'gecko_profile': False, 16:42:10 INFO - 'gecko_profile_interval': 0, 16:42:10 INFO - 'installer_path': 'installer.exe', 16:42:10 INFO - 'log_level': 'info', 16:42:10 INFO - 'log_name': 'talos', 16:42:10 INFO - 'log_to_console': True, 16:42:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:42:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:42:10 INFO - 'opt_config_files': (), 16:42:10 INFO - 'pip_index': False, 16:42:10 INFO - 'suite': 'dromaeojs-e10s', 16:42:10 INFO - 'system_bits': '32', 16:42:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:42:10 INFO - 'title': 'talos-linux64-ix-064', 16:42:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:42:10 INFO - 'use_talos_json': True, 16:42:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:42:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:42:10 INFO - 'work_dir': 'build'} 16:42:10 INFO - [mozharness: 2017-05-28 23:42:10.386373Z] Running clobber step. 16:42:10 INFO - Running pre-action listener: _resource_record_pre_action 16:42:10 INFO - Running main action method: clobber 16:42:10 INFO - rmtree: /builds/slave/test/build 16:42:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:42:11 INFO - Running post-action listener: _resource_record_post_action 16:42:11 INFO - [mozharness: 2017-05-28 23:42:11.906706Z] Finished clobber step (success) 16:42:11 INFO - [mozharness: 2017-05-28 23:42:11.906806Z] Running read-buildbot-config step. 16:42:11 INFO - Running pre-action listener: _resource_record_pre_action 16:42:11 INFO - Running main action method: read_buildbot_config 16:42:11 INFO - Using buildbot properties: 16:42:11 INFO - { 16:42:11 INFO - "project": "", 16:42:11 INFO - "product": "firefox", 16:42:11 INFO - "who": "archaeopteryx@coole-files.de", 16:42:11 INFO - "installer_path": "public/build/target.tar.bz2", 16:42:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 16:42:11 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:42:11 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 16:42:11 INFO - "stage_platform": "linux64-stylo", 16:42:11 INFO - "basedir": "/builds/slave/test", 16:42:11 INFO - "buildnumber": 116, 16:42:11 INFO - "platform": "ubuntu64_hw_stylo", 16:42:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:42:11 INFO - "slavebuilddir": "test", 16:42:11 INFO - "taskId": "DPIu5gPmRNyQjptBXA2iSw", 16:42:11 INFO - "branch": "mozilla-central", 16:42:11 INFO - "script_repo_revision": "production", 16:42:11 INFO - "revision": "51d220b260d8d52a41b65aae2c5d74be99c2d59e", 16:42:11 INFO - "slavename": "talos-linux64-ix-064", 16:42:11 INFO - "repo_path": "mozilla-central" 16:42:11 INFO - } 16:42:11 INFO - Finding installer, test and symbols from parent task. 16:42:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DPIu5gPmRNyQjptBXA2iSw'}, attempt #1 16:42:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DPIu5gPmRNyQjptBXA2iSw'}, attempt #1 16:42:12 INFO - Task dependencies: f7sj5ddSS_i0aPQv11q_Cg 16:42:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg'}, attempt #1 16:42:13 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.tar.bz2 16:42:13 INFO - Set test_url: https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/test_packages.json 16:42:13 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.crashreporter-symbols.zip 16:42:13 INFO - Running post-action listener: _resource_record_post_action 16:42:13 INFO - [mozharness: 2017-05-28 23:42:13.274003Z] Finished read-buildbot-config step (success) 16:42:13 INFO - [mozharness: 2017-05-28 23:42:13.274224Z] Running download-and-extract step. 16:42:13 INFO - Running pre-action listener: _resource_record_pre_action 16:42:13 INFO - Running main action method: download_and_extract 16:42:13 INFO - mkdir: /builds/slave/test/build/tests 16:42:13 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')]} 16:42:13 INFO - trying https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.test_packages.json 16:42:13 INFO - Downloading https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:42:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:42:13 INFO - Downloaded 986 bytes. 16:42:13 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:42:13 INFO - Using the following test package requirements: 16:42:13 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:42:13 INFO - u'common': [u'target.common.tests.zip'], 16:42:13 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:42:13 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:42:13 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:42:13 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:42:13 INFO - u'mozbase': [u'target.common.tests.zip'], 16:42:13 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:42:13 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:42:13 INFO - u'web-platform': [u'target.common.tests.zip', 16:42:13 INFO - u'target.web-platform.tests.zip'], 16:42:13 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:42:13 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:42:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.common.tests.zip 16:42:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:42:13 INFO - Fetch https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.common.tests.zip into memory 16:42:14 INFO - Content-Length response header: 63527020 16:42:14 INFO - Bytes received: 63527020 16:42:26 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:42:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.common.tests.zip 16:42:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:42:26 INFO - Fetch https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.common.tests.zip into memory 16:42:27 INFO - Content-Length response header: 63527020 16:42:27 INFO - Bytes received: 63527020 16:42:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.talos.tests.zip 16:42:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:42:39 INFO - Fetch https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.talos.tests.zip into memory 16:42:39 INFO - Content-Length response header: 14447425 16:42:39 INFO - Bytes received: 14447425 16:42: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')]} 16:42:40 INFO - trying https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.tar.bz2 16:42:40 INFO - Downloading https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:42:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:42:41 INFO - Downloaded 55816609 bytes. 16:42:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.tar.bz2 16:42:41 INFO - mkdir: /builds/slave/test/properties 16:42:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:42:41 INFO - Writing to file /builds/slave/test/properties/build_url 16:42:41 INFO - Contents: 16:42:41 INFO - build_url:https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.tar.bz2 16:42:41 INFO - Running post-action listener: _resource_record_post_action 16:42:41 INFO - Running post-action listener: set_extra_try_arguments 16:42:41 INFO - [mozharness: 2017-05-28 23:42:41.662555Z] Finished download-and-extract step (success) 16:42:41 INFO - [mozharness: 2017-05-28 23:42:41.662667Z] Running populate-webroot step. 16:42:41 INFO - Running pre-action listener: _resource_record_pre_action 16:42:41 INFO - Running main action method: populate_webroot 16:42:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:42:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:42:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:42:41 INFO - '--tppagecycles', 16:42:41 INFO - '7'], 16:42:41 INFO - 'tests': ['tsvgm']}}, 16:42:41 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:42:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:42:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:42:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:42:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:42:41 INFO - 'talos_options': ['--disable-e10s'], 16:42:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:42:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:42:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:42:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:42:41 INFO - 'talos_options': ['--disable-e10s'], 16:42:41 INFO - 'tests': ['damp', 'tps']}, 16:42:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:42:41 INFO - 'tests': ['damp', 'tps']}, 16:42:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:42:41 INFO - 'tests': ['dromaeo_dom']}, 16:42:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:42:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:42:41 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:42:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:42:41 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:42:41 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:42:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:42:41 INFO - 'tests': ['a11yr', 16:42:41 INFO - 'ts_paint', 16:42:41 INFO - 'tpaint', 16:42:41 INFO - 'sessionrestore', 16:42:41 INFO - 'sessionrestore_no_auto_restore', 16:42:41 INFO - 'tabpaint']}, 16:42:41 INFO - 'other-e10s': {'tests': ['a11yr', 16:42:41 INFO - 'ts_paint', 16:42:41 INFO - 'tpaint', 16:42:41 INFO - 'sessionrestore', 16:42:41 INFO - 'sessionrestore_no_auto_restore', 16:42:41 INFO - 'tabpaint']}, 16:42:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:42:41 INFO - 'ts_paint', 16:42:41 INFO - 'tpaint', 16:42:41 INFO - 'sessionrestore', 16:42:41 INFO - 'sessionrestore_no_auto_restore', 16:42:41 INFO - 'tabpaint']}, 16:42:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:42:41 INFO - 'ts_paint', 16:42:41 INFO - 'tpaint', 16:42:41 INFO - 'sessionrestore', 16:42:41 INFO - 'sessionrestore_no_auto_restore', 16:42:41 INFO - 'tabpaint']}, 16:42:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:42:41 INFO - 'tests': ['a11yr', 16:42:41 INFO - 'ts_paint', 16:42:41 INFO - 'tpaint', 16:42:41 INFO - 'sessionrestore', 16:42:41 INFO - 'sessionrestore_no_auto_restore', 16:42:41 INFO - 'tabpaint']}, 16:42:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:42:41 INFO - 'tests': ['a11yr', 16:42:41 INFO - 'ts_paint', 16:42:41 INFO - 'tpaint', 16:42:41 INFO - 'sessionrestore', 16:42:41 INFO - 'sessionrestore_no_auto_restore', 16:42:41 INFO - 'tabpaint']}, 16:42:41 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:42:41 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:42:41 INFO - 'bloom_basic_ref']}, 16:42:41 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 16:42:41 INFO - 'talos_options': ['--mitmproxy', 16:42:41 INFO - 'mitmproxy-recording-1.mp', 16:42:41 INFO - '--firstNonBlankPaint'], 16:42:41 INFO - 'tests': ['Quantum_1']}, 16:42:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:42:41 INFO - 'tests': ['tsvgx', 16:42:41 INFO - 'tsvgr_opacity', 16:42:41 INFO - 'tart', 16:42:41 INFO - 'tscrollx', 16:42:41 INFO - 'cart', 16:42:41 INFO - 'tsvg_static']}, 16:42:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:42:41 INFO - 'tsvgr_opacity', 16:42:41 INFO - 'tart', 16:42:41 INFO - 'tscrollx', 16:42:41 INFO - 'cart', 16:42:41 INFO - 'tsvg_static']}, 16:42:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:42:41 INFO - 'talos_options': ['--disable-e10s'], 16:42:41 INFO - 'tests': ['tp5o']}, 16:42:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:42:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:42:41 INFO - 'talos_options': ['--disable-e10s', 16:42:41 INFO - '--xperf_path', 16:42:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:42:41 INFO - 'tests': ['tp5n']}, 16:42:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:42:41 INFO - 'talos_options': ['--xperf_path', 16:42:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:42:41 INFO - 'tests': ['tp5n']}}, 16:42:41 INFO - 'talos.zip': {'path': '', 16:42:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:42:41 INFO - Running post-action listener: _resource_record_post_action 16:42:41 INFO - [mozharness: 2017-05-28 23:42:41.678229Z] Finished populate-webroot step (success) 16:42:41 INFO - [mozharness: 2017-05-28 23:42:41.678325Z] Running create-virtualenv step. 16:42:41 INFO - Running pre-action listener: _resource_record_pre_action 16:42:41 INFO - Running main action method: create_virtualenv 16:42:41 INFO - Creating virtualenv /builds/slave/test/build/venv 16:42:41 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 16:42:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:42:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:42:41 INFO - Using real prefix '/usr' 16:42:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:42:42 INFO - Installing distribute.............................................................................................................................................................................................done. 16:42:44 INFO - Installing pip.................done. 16:42:44 INFO - Return code: 0 16:42:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:42:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:42:44 INFO - Reading from file tmpfile_stdout 16:42:44 INFO - Output received: 16:42:44 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) 16:42:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:42:44 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')]} 16:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:44 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')]} 16:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:44 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 0x19903b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0def0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ae40>, '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 0x1d0bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451', '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 16:42:44 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 16:42:44 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 16:42:44 INFO - Using env: {'DISPLAY': ':0', 16:42:44 INFO - 'HOME': '/home/cltbld', 16:42:44 INFO - 'LANG': 'en_US.UTF-8', 16:42:44 INFO - 'LANGUAGE': 'en_US:en', 16:42:44 INFO - 'LOGNAME': 'cltbld', 16:42:44 INFO - 'MAIL': '/var/mail/cltbld', 16:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:44 INFO - 'MOZ_NO_REMOTE': '1', 16:42:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:44 INFO - 'NO_EM_RESTART': '1', 16:42:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:44 INFO - 'PWD': '/builds/slave/test', 16:42:44 INFO - 'SHELL': '/bin/bash', 16:42:44 INFO - 'SHLVL': '1', 16:42:44 INFO - 'TERM': 'linux', 16:42:44 INFO - 'TMOUT': '86400', 16:42:44 INFO - 'USER': 'cltbld', 16:42:44 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451', 16:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:44 INFO - '_': '/tools/buildbot/bin/python'} 16:42:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:44 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 16:42:44 INFO - Cleaning up... 16:42:44 INFO - Return code: 0 16:42:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:42:44 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')]} 16:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:44 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')]} 16:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:44 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 0x19903b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0def0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ae40>, '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 0x1d0bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451', '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 16:42:44 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 16:42:44 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 16:42:44 INFO - Using env: {'DISPLAY': ':0', 16:42:44 INFO - 'HOME': '/home/cltbld', 16:42:44 INFO - 'LANG': 'en_US.UTF-8', 16:42:44 INFO - 'LANGUAGE': 'en_US:en', 16:42:44 INFO - 'LOGNAME': 'cltbld', 16:42:44 INFO - 'MAIL': '/var/mail/cltbld', 16:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:44 INFO - 'MOZ_NO_REMOTE': '1', 16:42:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:44 INFO - 'NO_EM_RESTART': '1', 16:42:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:44 INFO - 'PWD': '/builds/slave/test', 16:42:44 INFO - 'SHELL': '/bin/bash', 16:42:44 INFO - 'SHLVL': '1', 16:42:44 INFO - 'TERM': 'linux', 16:42:44 INFO - 'TMOUT': '86400', 16:42:44 INFO - 'USER': 'cltbld', 16:42:44 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451', 16:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:44 INFO - '_': '/tools/buildbot/bin/python'} 16:42:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:44 INFO - Downloading/unpacking psutil>=3.1.1 16:42:44 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 16:42:44 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 16:42:44 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 16:42:44 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 16:42:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:42:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:42:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:42:46 INFO - Installing collected packages: psutil 16:42:46 INFO - Running setup.py install for psutil 16:42:46 INFO - building 'psutil._psutil_linux' extension 16:42:46 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 16:42:46 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 16:42:46 INFO - building 'psutil._psutil_posix' extension 16:42:46 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 16:42:46 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 16:42:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:42:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:42:46 INFO - Successfully installed psutil 16:42:46 INFO - Cleaning up... 16:42:46 INFO - Return code: 0 16:42:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:42:46 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')]} 16:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:46 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')]} 16:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:46 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 0x19903b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0def0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ae40>, '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 0x1d0bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451', '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 16:42:46 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 16:42:46 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 16:42:46 INFO - Using env: {'DISPLAY': ':0', 16:42:46 INFO - 'HOME': '/home/cltbld', 16:42:46 INFO - 'LANG': 'en_US.UTF-8', 16:42:46 INFO - 'LANGUAGE': 'en_US:en', 16:42:46 INFO - 'LOGNAME': 'cltbld', 16:42:46 INFO - 'MAIL': '/var/mail/cltbld', 16:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:46 INFO - 'MOZ_NO_REMOTE': '1', 16:42:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:46 INFO - 'NO_EM_RESTART': '1', 16:42:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:46 INFO - 'PWD': '/builds/slave/test', 16:42:46 INFO - 'SHELL': '/bin/bash', 16:42:46 INFO - 'SHLVL': '1', 16:42:46 INFO - 'TERM': 'linux', 16:42:46 INFO - 'TMOUT': '86400', 16:42:46 INFO - 'USER': 'cltbld', 16:42:46 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451', 16:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:46 INFO - '_': '/tools/buildbot/bin/python'} 16:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:42:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:42:47 INFO - Installing collected packages: mozsystemmonitor 16:42:47 INFO - Running setup.py install for mozsystemmonitor 16:42:48 INFO - Successfully installed mozsystemmonitor 16:42:48 INFO - Cleaning up... 16:42:48 INFO - Return code: 0 16:42:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:42:48 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')]} 16:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:48 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')]} 16:42:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x19903b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0def0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ae40>, '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 0x1d0bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451', '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 16:42:48 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 16:42:48 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 16:42:48 INFO - Using env: {'DISPLAY': ':0', 16:42:48 INFO - 'HOME': '/home/cltbld', 16:42:48 INFO - 'LANG': 'en_US.UTF-8', 16:42:48 INFO - 'LANGUAGE': 'en_US:en', 16:42:48 INFO - 'LOGNAME': 'cltbld', 16:42:48 INFO - 'MAIL': '/var/mail/cltbld', 16:42:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:48 INFO - 'MOZ_NO_REMOTE': '1', 16:42:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:48 INFO - 'NO_EM_RESTART': '1', 16:42:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:48 INFO - 'PWD': '/builds/slave/test', 16:42:48 INFO - 'SHELL': '/bin/bash', 16:42:48 INFO - 'SHLVL': '1', 16:42:48 INFO - 'TERM': 'linux', 16:42:48 INFO - 'TMOUT': '86400', 16:42:48 INFO - 'USER': 'cltbld', 16:42:48 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451', 16:42:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:48 INFO - '_': '/tools/buildbot/bin/python'} 16:42:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:48 INFO - Downloading/unpacking jsonschema==2.5.1 16:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:42:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:42:49 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 16:42:49 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 16:42:49 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 16:42:49 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 16:42:49 INFO - Downloading functools32-3.2.3-2.tar.gz 16:42:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:42:49 INFO - warning: no files found matching '*.txt' 16:42:49 INFO - no previously-included directories found matching 'build' 16:42:49 INFO - no previously-included directories found matching 'dist' 16:42:49 INFO - no previously-included directories found matching '.git*' 16:42:49 INFO - Installing collected packages: jsonschema, functools32 16:42:49 INFO - Running setup.py install for functools32 16:42:49 INFO - warning: no files found matching '*.txt' 16:42:49 INFO - no previously-included directories found matching 'build' 16:42:49 INFO - no previously-included directories found matching 'dist' 16:42:49 INFO - no previously-included directories found matching '.git*' 16:42:49 INFO - Successfully installed jsonschema functools32 16:42:49 INFO - Cleaning up... 16:42:49 INFO - Return code: 0 16:42:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:42:49 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')]} 16:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:49 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')]} 16:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:49 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 0x19903b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0def0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ae40>, '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 0x1d0bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451', '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 16:42:49 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 16:42:49 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 16:42:49 INFO - Using env: {'DISPLAY': ':0', 16:42:49 INFO - 'HOME': '/home/cltbld', 16:42:49 INFO - 'LANG': 'en_US.UTF-8', 16:42:49 INFO - 'LANGUAGE': 'en_US:en', 16:42:49 INFO - 'LOGNAME': 'cltbld', 16:42:49 INFO - 'MAIL': '/var/mail/cltbld', 16:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:49 INFO - 'MOZ_NO_REMOTE': '1', 16:42:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:49 INFO - 'NO_EM_RESTART': '1', 16:42:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:49 INFO - 'PWD': '/builds/slave/test', 16:42:49 INFO - 'SHELL': '/bin/bash', 16:42:49 INFO - 'SHLVL': '1', 16:42:49 INFO - 'TERM': 'linux', 16:42:49 INFO - 'TMOUT': '86400', 16:42:49 INFO - 'USER': 'cltbld', 16:42:49 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451', 16:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:49 INFO - '_': '/tools/buildbot/bin/python'} 16:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:42:49 INFO - Cleaning up... 16:42:49 INFO - Return code: 0 16:42:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:42:49 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')]} 16:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:49 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')]} 16:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:50 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 0x19903b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0def0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ae40>, '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 0x1d0bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451', '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 16:42:50 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 16:42:50 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 16:42:50 INFO - Using env: {'DISPLAY': ':0', 16:42:50 INFO - 'HOME': '/home/cltbld', 16:42:50 INFO - 'LANG': 'en_US.UTF-8', 16:42:50 INFO - 'LANGUAGE': 'en_US:en', 16:42:50 INFO - 'LOGNAME': 'cltbld', 16:42:50 INFO - 'MAIL': '/var/mail/cltbld', 16:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:50 INFO - 'MOZ_NO_REMOTE': '1', 16:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:50 INFO - 'NO_EM_RESTART': '1', 16:42:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:50 INFO - 'PWD': '/builds/slave/test', 16:42:50 INFO - 'SHELL': '/bin/bash', 16:42:50 INFO - 'SHLVL': '1', 16:42:50 INFO - 'TERM': 'linux', 16:42:50 INFO - 'TMOUT': '86400', 16:42:50 INFO - 'USER': 'cltbld', 16:42:50 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451', 16:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:50 INFO - '_': '/tools/buildbot/bin/python'} 16:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:50 INFO - Downloading/unpacking blobuploader==1.2.4 16:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:51 INFO - Downloading blobuploader-1.2.4.tar.gz 16:42:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:42:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:42:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:51 INFO - Downloading docopt-0.6.1.tar.gz 16:42:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:42:51 INFO - Installing collected packages: blobuploader, requests, docopt 16:42:51 INFO - Running setup.py install for blobuploader 16:42:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:42:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:42:51 INFO - Running setup.py install for requests 16:42:52 INFO - Running setup.py install for docopt 16:42:52 INFO - Successfully installed blobuploader requests docopt 16:42:52 INFO - Cleaning up... 16:42:52 INFO - Return code: 0 16:42:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:42:52 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')]} 16:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:52 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')]} 16:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:52 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 0x19903b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0def0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ae40>, '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 0x1d0bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451', '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 16:42:52 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 16:42:52 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 16:42:52 INFO - Using env: {'DISPLAY': ':0', 16:42:52 INFO - 'HOME': '/home/cltbld', 16:42:52 INFO - 'LANG': 'en_US.UTF-8', 16:42:52 INFO - 'LANGUAGE': 'en_US:en', 16:42:52 INFO - 'LOGNAME': 'cltbld', 16:42:52 INFO - 'MAIL': '/var/mail/cltbld', 16:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:52 INFO - 'MOZ_NO_REMOTE': '1', 16:42:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:52 INFO - 'NO_EM_RESTART': '1', 16:42:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:52 INFO - 'PWD': '/builds/slave/test', 16:42:52 INFO - 'SHELL': '/bin/bash', 16:42:52 INFO - 'SHLVL': '1', 16:42:52 INFO - 'TERM': 'linux', 16:42:52 INFO - 'TMOUT': '86400', 16:42:52 INFO - 'USER': 'cltbld', 16:42:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451', 16:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:52 INFO - '_': '/tools/buildbot/bin/python'} 16:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:42:52 INFO - Running setup.py (path:/tmp/pip-GGH9WN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:42:52 INFO - Running setup.py (path:/tmp/pip-F3ApFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:42:52 INFO - Running setup.py (path:/tmp/pip-1M5R6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:42:52 INFO - Running setup.py (path:/tmp/pip-_DP2n6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:42:52 INFO - Running setup.py (path:/tmp/pip-sSP01S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:42:53 INFO - Running setup.py (path:/tmp/pip-6XJ4vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:42:53 INFO - Running setup.py (path:/tmp/pip-pKuUZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:42:53 INFO - Running setup.py (path:/tmp/pip-q1Akwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:42:53 INFO - Running setup.py (path:/tmp/pip-bWoOTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:42:53 INFO - Running setup.py (path:/tmp/pip-uxaQlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:42:53 INFO - Running setup.py (path:/tmp/pip-270O9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:42:53 INFO - Running setup.py (path:/tmp/pip-q2ZGmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:42:53 INFO - Running setup.py (path:/tmp/pip-bB_BjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:42:53 INFO - Running setup.py (path:/tmp/pip-UlayBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:42:53 INFO - Running setup.py (path:/tmp/pip-UPvbcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:42:53 INFO - Running setup.py (path:/tmp/pip-PbvLnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:42:53 INFO - Running setup.py (path:/tmp/pip-LNLut5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:42:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:42:53 INFO - Running setup.py install for manifestparser 16:42:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:42:54 INFO - Running setup.py install for mozcrash 16:42:54 INFO - Running setup.py install for mozdebug 16:42:54 INFO - Running setup.py install for mozdevice 16:42:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:42:54 INFO - Running setup.py install for mozfile 16:42:54 INFO - Running setup.py install for mozhttpd 16:42:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:42:54 INFO - Running setup.py install for mozinfo 16:42:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:42:54 INFO - Running setup.py install for mozInstall 16:42:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:42:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:42:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:42:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:42:54 INFO - Running setup.py install for mozleak 16:42:54 INFO - Running setup.py install for mozlog 16:42:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:42:54 INFO - Running setup.py install for moznetwork 16:42:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:42:55 INFO - Running setup.py install for mozprocess 16:42:55 INFO - Running setup.py install for mozprofile 16:42:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:42:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:42:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:42:55 INFO - Running setup.py install for mozrunner 16:42:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:42:55 INFO - Running setup.py install for mozscreenshot 16:42:55 INFO - Running setup.py install for moztest 16:42:55 INFO - Running setup.py install for mozversion 16:42:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:42:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:42:55 INFO - Cleaning up... 16:42:55 INFO - Return code: 0 16:42:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:42:55 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')]} 16:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:55 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')]} 16:42:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:55 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 0x19903b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0def0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ae40>, '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 0x1d0bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451', '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 16:42:55 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 16:42:55 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 16:42:55 INFO - Using env: {'DISPLAY': ':0', 16:42:55 INFO - 'HOME': '/home/cltbld', 16:42:55 INFO - 'LANG': 'en_US.UTF-8', 16:42:55 INFO - 'LANGUAGE': 'en_US:en', 16:42:55 INFO - 'LOGNAME': 'cltbld', 16:42:55 INFO - 'MAIL': '/var/mail/cltbld', 16:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:55 INFO - 'MOZ_NO_REMOTE': '1', 16:42:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:55 INFO - 'NO_EM_RESTART': '1', 16:42:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:55 INFO - 'PWD': '/builds/slave/test', 16:42:55 INFO - 'SHELL': '/bin/bash', 16:42:55 INFO - 'SHLVL': '1', 16:42:55 INFO - 'TERM': 'linux', 16:42:55 INFO - 'TMOUT': '86400', 16:42:55 INFO - 'USER': 'cltbld', 16:42:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451', 16:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:55 INFO - '_': '/tools/buildbot/bin/python'} 16:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:42:55 INFO - Running setup.py (path:/tmp/pip-KD3oaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:42:55 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)) 16:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:42:55 INFO - Running setup.py (path:/tmp/pip-Hx98Wm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:42:56 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)) 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:42:56 INFO - Running setup.py (path:/tmp/pip-x2Adg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:42:56 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)) 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:42:56 INFO - Running setup.py (path:/tmp/pip-vJzHRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:42:56 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)) 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:42:56 INFO - Running setup.py (path:/tmp/pip-hzbo_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:42:56 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)) 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:42:56 INFO - Running setup.py (path:/tmp/pip-uljC3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:42:56 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)) 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:42:56 INFO - Running setup.py (path:/tmp/pip-PQm08W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:42:56 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)) 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:42:56 INFO - Running setup.py (path:/tmp/pip-w6nQSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:42:56 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)) 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:42:56 INFO - Running setup.py (path:/tmp/pip-3gdIvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:42:56 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)) 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:42:56 INFO - Running setup.py (path:/tmp/pip-11TyKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:42:56 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)) 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:42:56 INFO - Running setup.py (path:/tmp/pip-5qxDdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:42:56 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)) 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:42:56 INFO - Running setup.py (path:/tmp/pip-J6iCiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:42:56 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)) 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:42:56 INFO - Running setup.py (path:/tmp/pip-seaBmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:42:56 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)) 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:42:56 INFO - Running setup.py (path:/tmp/pip-AkMBia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:42:56 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)) 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:42:56 INFO - Running setup.py (path:/tmp/pip-_lgo1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:42:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:42:56 INFO - Running setup.py (path:/tmp/pip-rZn8LR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:42:57 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)) 16:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:42:57 INFO - Running setup.py (path:/tmp/pip-IveTwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:42:57 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)) 16:42:57 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)) 16:42:57 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)) 16:42:57 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)) 16:42:57 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)) 16:42:57 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)) 16:42:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:58 INFO - Downloading blessings-1.6.tar.gz 16:42:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:42:58 INFO - Installing collected packages: blessings 16:42:58 INFO - Running setup.py install for blessings 16:42:58 INFO - Successfully installed blessings 16:42:58 INFO - Cleaning up... 16:42:58 INFO - Return code: 0 16:42:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:42:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:42:58 INFO - Reading from file tmpfile_stdout 16:42:58 INFO - Current package versions: 16:42:58 INFO - argparse == 1.2.1 16:42:58 INFO - blessings == 1.6 16:42:58 INFO - blobuploader == 1.2.4 16:42:58 INFO - docopt == 0.6.1 16:42:58 INFO - functools32 == 3.2.3-2 16:42:58 INFO - jsonschema == 2.5.1 16:42:58 INFO - manifestparser == 1.1 16:42:58 INFO - mozInstall == 1.12 16:42:58 INFO - mozcrash == 1.0 16:42:58 INFO - mozdebug == 0.1 16:42:58 INFO - mozdevice == 0.51 16:42:58 INFO - mozfile == 1.2 16:42:58 INFO - mozhttpd == 0.7 16:42:58 INFO - mozinfo == 0.9 16:42:58 INFO - mozleak == 0.1 16:42:58 INFO - mozlog == 3.4 16:42:58 INFO - moznetwork == 0.27 16:42:58 INFO - mozprocess == 0.25 16:42:58 INFO - mozprofile == 0.28 16:42:58 INFO - mozrunner == 6.13 16:42:58 INFO - mozscreenshot == 0.1 16:42:58 INFO - mozsystemmonitor == 0.3 16:42:58 INFO - moztest == 0.8 16:42:58 INFO - mozversion == 1.4 16:42:58 INFO - psutil == 3.1.1 16:42:58 INFO - requests == 1.2.3 16:42:58 INFO - wsgiref == 0.1.2 16:42:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:42:58 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')]} 16:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:58 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')]} 16:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x19903b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0def0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ae40>, '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 0x1d0bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451', '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 16:42:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:42:58 INFO - Using env: {'DISPLAY': ':0', 16:42:58 INFO - 'HOME': '/home/cltbld', 16:42:58 INFO - 'LANG': 'en_US.UTF-8', 16:42:58 INFO - 'LANGUAGE': 'en_US:en', 16:42:58 INFO - 'LOGNAME': 'cltbld', 16:42:58 INFO - 'MAIL': '/var/mail/cltbld', 16:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:58 INFO - 'MOZ_NO_REMOTE': '1', 16:42:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:58 INFO - 'NO_EM_RESTART': '1', 16:42:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:58 INFO - 'PWD': '/builds/slave/test', 16:42:58 INFO - 'SHELL': '/bin/bash', 16:42:58 INFO - 'SHLVL': '1', 16:42:58 INFO - 'TERM': 'linux', 16:42:58 INFO - 'TMOUT': '86400', 16:42:58 INFO - 'USER': 'cltbld', 16:42:58 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451', 16:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:58 INFO - '_': '/tools/buildbot/bin/python'} 16:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:42:58 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:59 INFO - Downloading marionette_driver-1.4.0.tar.gz 16:42:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 16:43:00 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)) 16:43:00 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)) 16:43:00 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)) 16:43:00 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)) 16:43:00 INFO - Installing collected packages: marionette-driver 16:43:00 INFO - Running setup.py install for marionette-driver 16:43:00 INFO - Successfully installed marionette-driver 16:43:00 INFO - Cleaning up... 16:43:00 INFO - Return code: 0 16:43:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:43:00 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')]} 16:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:00 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')]} 16:43:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:00 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 0x19903b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0def0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ae40>, '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 0x1d0bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451', '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 16:43:00 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 16:43:00 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 16:43:00 INFO - Using env: {'DISPLAY': ':0', 16:43:00 INFO - 'HOME': '/home/cltbld', 16:43:00 INFO - 'LANG': 'en_US.UTF-8', 16:43:00 INFO - 'LANGUAGE': 'en_US:en', 16:43:00 INFO - 'LOGNAME': 'cltbld', 16:43:00 INFO - 'MAIL': '/var/mail/cltbld', 16:43:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:00 INFO - 'MOZ_NO_REMOTE': '1', 16:43:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:00 INFO - 'NO_EM_RESTART': '1', 16:43:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:00 INFO - 'PWD': '/builds/slave/test', 16:43:00 INFO - 'SHELL': '/bin/bash', 16:43:00 INFO - 'SHLVL': '1', 16:43:00 INFO - 'TERM': 'linux', 16:43:00 INFO - 'TMOUT': '86400', 16:43:00 INFO - 'USER': 'cltbld', 16:43:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451', 16:43:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:00 INFO - '_': '/tools/buildbot/bin/python'} 16:43:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:43:00 INFO - Cleaning up... 16:43:00 INFO - Return code: 0 16:43:00 INFO - Running post-action listener: _resource_record_post_action 16:43:00 INFO - Running post-action listener: _start_resource_monitoring 16:43:00 INFO - Starting resource monitoring. 16:43:00 INFO - [mozharness: 2017-05-28 23:43:00.428023Z] Finished create-virtualenv step (success) 16:43:00 INFO - [mozharness: 2017-05-28 23:43:00.428532Z] Running install step. 16:43:00 INFO - Running pre-action listener: _resource_record_pre_action 16:43:00 INFO - Running main action method: install 16:43:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:43:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:43:00 INFO - Reading from file tmpfile_stdout 16:43:00 INFO - Detecting whether we're running mozinstall >=1.0... 16:43:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:43:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:43:00 INFO - Reading from file tmpfile_stdout 16:43:00 INFO - Output received: 16:43:00 INFO - Usage: mozinstall [options] installer 16:43:00 INFO - Options: 16:43:00 INFO - -h, --help show this help message and exit 16:43:00 INFO - -d DEST, --destination=DEST 16:43:00 INFO - Directory to install application into. [default: 16:43:00 INFO - "/builds/slave/test"] 16:43:00 INFO - --app=APP Application being installed. [default: firefox] 16:43:00 INFO - mkdir: /builds/slave/test/build/application 16:43:00 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'] 16:43:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:43:16 INFO - Reading from file tmpfile_stdout 16:43:16 INFO - Output received: 16:43:16 INFO - /builds/slave/test/build/application/firefox/firefox 16:43:16 INFO - Running post-action listener: _resource_record_post_action 16:43:16 INFO - [mozharness: 2017-05-28 23:43:16.744058Z] Finished install step (success) 16:43:16 INFO - [mozharness: 2017-05-28 23:43:16.744334Z] Running setup-mitmproxy step. 16:43:16 INFO - Running pre-action listener: _resource_record_pre_action 16:43:16 INFO - Running main action method: setup_mitmproxy 16:43:16 INFO - Skipping: mitmproxy is not required 16:43:16 INFO - Running post-action listener: _resource_record_post_action 16:43:16 INFO - [mozharness: 2017-05-28 23:43:16.745445Z] Finished setup-mitmproxy step (success) 16:43:16 INFO - [mozharness: 2017-05-28 23:43:16.745735Z] Running run-tests step. 16:43:16 INFO - Running pre-action listener: _resource_record_pre_action 16:43:16 INFO - Running main action method: run_tests 16:43:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:43:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:43:16 INFO - Python 2.7.3 16:43:16 INFO - Return code: 0 16:43:16 INFO - grabbing minidump binary from tooltool 16:43:16 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')]} 16:43:16 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 0x1d0ae40>, '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 0x1d0bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:43:16 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 16:43:16 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 16:43:16 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 16:43:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:43:16 INFO - Return code: 0 16:43:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:43:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:43:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:43:16 INFO - ENV: RUST_BACKTRACE is now 1 16:43:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:43:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:43:16 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/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:43:16 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/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:43:16 INFO - Using env: {'DISPLAY': ':0', 16:43:16 INFO - 'HOME': '/home/cltbld', 16:43:16 INFO - 'LANG': 'en_US.UTF-8', 16:43:16 INFO - 'LANGUAGE': 'en_US:en', 16:43:16 INFO - 'LOGNAME': 'cltbld', 16:43:16 INFO - 'MAIL': '/var/mail/cltbld', 16:43:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:43:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:16 INFO - 'MOZ_NO_REMOTE': '1', 16:43:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:43:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:16 INFO - 'NO_EM_RESTART': '1', 16:43:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:16 INFO - 'PWD': '/builds/slave/test', 16:43:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:43:16 INFO - 'RUST_BACKTRACE': '1', 16:43:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:43:16 INFO - 'SHELL': '/bin/bash', 16:43:16 INFO - 'SHLVL': '1', 16:43:16 INFO - 'TERM': 'linux', 16:43:16 INFO - 'TMOUT': '86400', 16:43:16 INFO - 'USER': 'cltbld', 16:43:16 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451', 16:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:16 INFO - '_': '/tools/buildbot/bin/python'} 16:43:16 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/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:43:17 INFO - mozversion application_buildid: 20170528224948 16:43:17 INFO - mozversion application_changeset: 51d220b260d8d52a41b65aae2c5d74be99c2d59e 16:43:17 INFO - mozversion application_display_name: Nightly 16:43:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:43:17 INFO - mozversion application_name: Firefox 16:43:17 INFO - mozversion application_remotingname: firefox 16:43:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:43:17 INFO - mozversion application_vendor: Mozilla 16:43:17 INFO - mozversion application_version: 55.0a1 16:43:17 INFO - mozversion platform_buildid: 20170528224948 16:43:17 INFO - mozversion platform_changeset: 51d220b260d8d52a41b65aae2c5d74be99c2d59e 16:43:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:43:17 INFO - mozversion platform_version: 55.0a1 16:43:17 INFO - using testdate: 1496014997 16:43:17 INFO - actual date: 1496014997 16:43:17 INFO - starting webserver on 'localhost:41994' 16:43:17 INFO - SUITE-START | Running 2 tests 16:43:17 INFO - TEST-START | dromaeo_css 16:43:17 INFO - operating with platform_type : linux_ 16:43:17 INFO - Initialising browser for dromaeo_css test... 16:43:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41994/getInfo.html -profile /tmp/tmpZMjqqH/profile 16:43:17 INFO - TEST-INFO | started process 14526 (/builds/slave/test/build/application/firefox/firefox http://localhost:41994/getInfo.html) 16:43:52 INFO - TEST-INFO | 14526: killed by SIGTERM 16:43:52 INFO - Browser initialized. 16:43:52 INFO - Running cycle 1/1 for dromaeo_css test... 16:43:52 INFO - TEST-INFO | started process 14748 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZMjqqH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:44:04 INFO - PID 14748 | RSS: Main: 187465728 16:44:04 INFO - PID 14748 | 16:47:09 INFO - PID 14748 | Cycle 1(1): loaded http://localhost:41994/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41994/tests/dromaeo/cssquery-ext.html) 16:47:11 INFO - PID 14748 | RSS: Main: 182448128 16:47:11 INFO - PID 14748 | 16:50:13 INFO - PID 14748 | Cycle 1(1): loaded http://localhost:41994/tests/dromaeo/cssquery-ext.html (next: http://localhost:41994/tests/dromaeo/cssquery-jquery.html) 16:50:14 INFO - PID 14748 | RSS: Main: 187924480 16:50:14 INFO - PID 14748 | 16:53:15 INFO - PID 14748 | Cycle 1(1): loaded http://localhost:41994/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41994/tests/dromaeo/cssquery-mootools.html) 16:53:16 INFO - PID 14748 | RSS: Main: 185995264 16:53:16 INFO - PID 14748 | 16:56:18 INFO - PID 14748 | Cycle 1(1): loaded http://localhost:41994/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41994/tests/dromaeo/cssquery-prototype.html) 16:56:18 INFO - PID 14748 | RSS: Main: 191467520 16:56:18 INFO - PID 14748 | 16:59:21 INFO - PID 14748 | Cycle 1(1): loaded http://localhost:41994/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41994/tests/dromaeo/cssquery-yui.html) 16:59:22 INFO - PID 14748 | RSS: Main: 188276736 16:59:22 INFO - PID 14748 | 17:02:24 INFO - PID 14748 | Cycle 1(1): loaded http://localhost:41994/tests/dromaeo/cssquery-yui.html (next: http://localhost:41994/tests/dromaeo/cssquery-dojo.html) 17:02:24 INFO - PID 14748 | RSS: Main: 187088896 17:02:24 INFO - PID 14748 | 17:02:24 INFO - PID 14748 | __start_tp_report 17:02:24 INFO - PID 14748 | _x_x_mozilla_page_load 17:02:24 INFO - PID 14748 | _x_x_mozilla_page_load_details 17:02:24 INFO - PID 14748 | |i|pagename|runs| 17:02:24 INFO - PID 14748 | |0;dojo.html;2742.616033755274;2758;2770.1135636596287;2805.565137403702;2808.3961948181136;5139.203423469359;5214.217867319904;5217.973910130453;5256.579473642109;5270.8418747437545;5143.408508021569;5202.0376230397405;5210.583153347723;5277.445868183843;5305.575553955684;4647.047355292157;4651.953480465186;4663.906721865552;4709.599684026862;4713.43438787346;4645.187092258858;4664.207084795576;4712.552307530779;4770.284457331393;4781.90436191276;4599.563041511051;4621.098885717286;4705.788239529229;4726.054789042171;4741.075490279397;4601.976990115028;4696.694714843558;4697.459792123916;4710.788014539354;4745.525447455261;4599.08018396322;4613.515580863995;4631.4673812511655;4646.674732768707;4659.231226847566;5061.367329083864;5144.331236939174;5202.4537423570355;5209.296744939423;5216.947830521684;5590.133529302964;5641.5204707599905;5652.8869422611315;5659.943400565983;5722.771089156428;5632.267805185341;5662.37713851476;5670.631408958405;5687.431256874321;5691.4024027476935;5198.376194856566;5286.9471305287225;5292.285541451932;5311.49540793624;5352.304200453916;5752.798652047159;5757;5767.653940763567;5783.161441590946;5789.971050144806;5560.2493663355735;5561.63849349791;5562.499375056264;5563.693996830132;5566.192902029264;5576.079946808731;5587.078132108157;5590.720463976866;5593.664380137205;5657.4908258256955;5483.945160548423;5583.664980101207;5586.273784408082;5593.496585307342;5616.045272303718;5502.862428439241;5571.375140256826;5586.022446071921;5588.580856435784;5665.801696940587;4638.350630911675;4643.86068417948;4645.953540464619;4667.416572928384;4680.134175177603;4038.2327357801923;4041.191761647682;4063.309237429644;4084.571120032354;4096.672266218696;4704.788284527204;4760.309755085563;4765.285207218945;4770.880727981758;4838.129136755418;5614.410486898899;5638.379778224392;5667.093265077568;5698.287714035746;5704.058830293038;4699.577038066591;4746.833860814855;4751.738654374042;4754.809807607726;4809.398825146856;4867.415910090812;4912.164931961575;4937.086638971802;4982.676126051795;5006.799728010911;5295.4969277918535;5313.52178303939;5374.435684253097;5388.110961691277;5389.973050134724;5546.223528706065;5693.772249109989;5705.22979397776;5717.3996730342715;5772.509336706427;5171;5288.365396152486;5294.602904782234;5315.176147697113;5318.57451403879;5413.56691464674;5476.616636835383;5529.695866727368;5533.501984821385;5577.77688892456;5549.889002220014;5630.8029218977135;5644.943550564606;5652.547796176378;5678.375378708256;5460.290162278879;5483.451654834645;5524.723763811874;5536;5547.33431988164;5466.207399926909;5467.589930755289;5467.617266791286;5475.698836564027;5500.4499550044675;5311.867203319948;5347.117725575236;5415.48552887475;5421.132618780976;5472.452754724496;5498.285222920995;5513.58648101402;5570.777168913198;5590;5591.580631452576;5404.32445944257;5416.133418652997;5428.809991650273;5432.7555260012605;5467.234587157881 17:02:24 INFO - PID 14748 | |1;ext.html;663.7743167323113;705.9258777828328;736.451343748907;1153.6481373181182;1194.7132688154834;33612;34266.65733342669;34295.142621434476;34311.142221444476;34418;32657.020289391297;32958;32983.835080824625;33018.17454563637;33060.83469582655;6515.739370425177;6593.769218077368;6722.294159113296;6839.965800170992;6863.073485079501;6818;6909.2745261747295;6914.861702765942;6932.0641713368805;6950.756723514678;6942.479314051441;6993.89509157363;7001.789946301619;7006.264342244068;7016.649167541603;6885.793426197222;6921;6936.72253109875;6938.236793952711;6949.096617439751;6782.694778734969;6842.076319696827;6848.794536163923;6851.897221541681;6859.382655560974;31356.843215783774;31761.523577146363;31823.363532729447;31829.363412731847;31870.681293187234;2925.2979284971666;2931.457680329146;2941.897033603835;2942.7498662613702;2944.9705502945126;24427.267181984567;24452.633210501856;24496.877515612487;24542.263732088068;24611.753882461304;3036.969630303713;3044.3911217756536;3059.4034163338156;3078.830664313462;3096.380723855238;129826.350868246;132841;149950;151218.1708188964;152096;37078.62921370806;37725.43411848824;37881.81059094687;37890.8105459471;37898.24203515914;39334.80332598376;39672;39676;39750.40374394386;39760.80119599441;11499;11627.709307267216;11628.825567616492;11640.35978021217;11654.067674586013;9268.675596354231;9279.396839205565;9280.164785169367;9284.72145835626;9341.579628916716;11840.703982400337;11876.34680092586;11878.88121118795;11940.343281119449;12137.271763694207;4920.40955085392;4954.232094025432;4956.826511072168;4963.776630051656;5007.24891266313;768.8961990131261;789.7433334166304;795.745361484331;803.4416080823888;810.7121971700079;18507.44477665645;18575.16411761474;18770.624587508173;18778.718319225223;19533.706994395096;848.6775025490398;858.4291446188215;866.8223014282057;876.0669886570781;885.9025507194203;13759;14064.578062658136;14365.497207597684;14448;14465.85534144666;181331;182051;182293;182448;182607;43196;43241.567584323755;43308.78345608315;43492.565074349484;43558.564414356086;1135.1316243074054;1166.690826930864;1171.291368721928;1176.4764679717614;1182.5388098641536;23690.763092368856;24595;25089.372765681004;25209.495810084063;25487;29248.41503169967;29260.853695731385;29287.414251715272;29447.26381840471;29657.40685186241;164866;165199;165275;165597;166022;24754.50490990206;25216.873915630305;26506.337341566614;28597.14208573663;28795.712042879302;32020.5196922051;32765.50851737178;33070.66929330676;33274.83362583268;33639;25099.74900251047;25347.89273556182;25514.489710206064;26152;26860;24918.75081249237;25940.48119037571;26714.59928101119;27037.324066897698;27796.166115016582;31150.688493115686;31265.8436707815;31288.530672039484;31295.687043130187;31538;26450.338741531617;26492.082522846424;27545.44909101767;28102.156935291972;28531.572026420035;20026.399208023784;22424.439389015406;22506.549869002854;22707;22786.43033924165 17:02:24 INFO - PID 14748 | |2;jquery.html;402.762370201581;403.6548750818051;419.3227936881935;428.1159405826967;430.3265389665174;13038;16863.831361686378;16999.915000424997;17685.91157044216;17694.646107077868;16803.24385402657;16858;17034.318627254925;17112.229949652265;17196.39812606559;5490.368607610116;5633.971830140864;5694.145878118295;5707.258056452655;5713.457221563945;5272.551833094191;5381.67709937403;5412.134058550632;5412.648177868446;5417.891642167155;5335.359756829186;5361.51746342829;5365.597580181482;5367.382750983647;5377.059014672417;5229.921551176735;5459.181122831567;5478.233047373371;5501.284832971688;5519.39286678465;4964.255361695775;4968.850934471971;4978.079055374731;4981.551660350549;4988.276699878534;20728.378148655564;20880.164793408396;20969.16123355064;20985.79014209869;21349.146034158613;1624.7075526405242;1626.219414680948;1647.3163637090593;1655.9006459612342;1660.4271526323398;13793.172409655352;14007.649808754863;14194.574162775134;14376.209308488134;14425.855741442556;1987.7316562264054;2030.5532782787911;2058.9485262868398;2063.4119276006268;2085.301424022954;83042;83344.58327708383;84095.15904840996;84347;84756.57621711852;10578.153747700166;10940.945295273472;11135.498902549405;11241.550337986553;11280.830787538194;13450.865491345157;15127.16800575979;15197.848021519865;15218.391264349302;15265;6613.173353330833;7158.677859496335;7305.963470182615;7446.702131914771;7471.887921681179;6642.202935647753;6670.266270710218;6794.320567943265;6852.246252912176;6856.24581296057;6729.899051514231;6878.931210687929;6879.380855722909;6893.414059804973;6926.515143939977;1958.5886963737776;1994.6110508451004;1998.2107067708173;2020.7170996060563;2031.4311992642083;768.5772824946257;791.2601717394255;795.2127393880132;808.5593351623262;810.8094597769519;16205.189740512928;16426.83573164277;16748.162591870358;17076.060816655205;17208;802.7110240313483;807.3016840432983;822.6914906909909;824.5464994253136;832.4256263178388;9088.727338179866;9141.63433462654;9348.626054957726;9432.292578056537;9544.570494327772;336604;337763;340536;345458;346241;76454;77251.99999999888;77620;77835.22164778392;78831;955.5126885288553;989.2284018465608;1006.7030226083176;1013.4071568132578;1017.0693815159194;14123.858761412253;14435.061720988522;14513.709725805636;14583.125012499284;15041.6991660164;36735.61218520788;36856.26287474289;37056.25887482289;37197.628023719415;37700.43449348207;50627;51598.74200628973;51724.482755171965;51935.70160746011;52016.739916300176;8193.631286591999;8216.137305582828;8331.750047498585;8442.746717598482;8703.651853925772;12396.31820249895;12449.190802597803;12627.93686031564;12656.303903285409;12847.614571562868;10458.320209186379;10472.68581942543;10803.00144473275;11003.834942476029;11222.775544489228;9534.85697714521;9617.951910240405;9646.565904534173;9855.802883942137;9986;10907.83638245411;11001.726170637292;11105.611303604659;11380.886191138314;11387.886121138683;8128.878066828884;8147.470414423044;8319.875201871855;8384.790380240298;8594.957025214833;10960.725981850517;10976.176786740867;10983.39591322485;11244.381559014006;11428.142889283503 17:02:24 INFO - PID 14748 | |3;mootools.html;1166.5217260923023;1203.187848202463;1218.2386008744534;1221.2855479544469;1227.7851376009203;8968.461892286467;9282.628694852214;9688.61245550178;10205.795884082314;10273.332233404823;9991.650292239772;10098.091171794536;10199.235057370708;10285.794284114332;10287.63993260236;2177.912883484663;2220.733511978565;2221.178164079293;2223.7776222377715;2226.031676220841;1867.5331167208199;1937.602791427754;2131.488442773739;2163.350994701583;2190.605690975624;2107.1044805957486;2174.402039439159;2181.0512427094186;2181.3892110209167;2185.2133232036454;2168.327818376308;2168.6855405966126;2177.172674383724;2187.223535644847;2190.9561808763815;2075.6886467029917;2094.937151885446;2099.6955441460905;2104.9368518944457;2113.9788602113936;9971.152452041586;10017.597536344918;10100.090991810772;10106.696799096038;10120.240981926385;5392.703401312926;5594.580406469531;5602.187682786014;5603.7478313475585;5610.410906854803;3210.165357007195;3377.290768938526;3451.240727040072;3458.15275257561;3469.6356882527225;1108.5953626926114;1110.3670907582682;1130.9321440713502;1132.4507613807298;1137.8919002694731;15090.54728358162;15198.696026079528;15205.923970380189;15207.543773686808;15236.619084522865;4558.293464513005;4729.385179926588;4816.614670826326;4882.926756098661;4888.120138375127;11680.824787628193;11793.933577269972;11805.704857378634;11813.291202527877;11839.704007399712;5559.360673522516;5567.805126820623;5569.777208911679;5586.636868603528;5592.5805564582815;4893.828715994923;4962.354893863847;5018.949810501921;5057.418396884405;5164.3802743671;3785.242951409674;3873.3996230584303;3945.368741001426;3947.4670919426085;3966.801659916993;1069.1446842525947;1089.330062011857;1093.8960798724108;1095.5453486803046;1102.2890235797865;595.3659352789266;648.5265755998148;652.0545209446321;652.1098700274092;657.9144711187515;5267.947320526822;5466.180072989084;5480.862978425571;5545.445455454423;5657.858553536194;524.8425472358277;529.375337102223;530.3291336459382;532.3425569421761;648.4909346163239;3181.6341120770944;3268.297316077055;3294;3441.500982357544;3526.559180102487;13112.672183195496;13502.189868607915;13646.24945628;13657.863421365857;13684.794728079087;12772.10595258323;13543.864561354458;13558.050936434553;13564.05051646395;13584.252866092262;7439.962800186073;7621.961890190513;7650.73222437212;7692.76921692339;7721.7683469496005;5077.492250774893;5113.437521872516;5155.2782610433815;5182.714950677749;5422.539084177889;11909.166358355178;12105.152639315163;12155.088368372231;12278.508859645513;12286.385680716106;12263.141580089308;12347.62957111288;12470.937645311715;12552.372381381078;12697.365131743562;7410.8147296315865;7439.330460258603;7446.4042876568665;7480.401567874448;7518.135414427411;9066.456012639263;9114.36199466031;9206.769830754285;9213.723588292361;9219.539023048956;7972;8080.919190808252;8120.878186827321;8154.429189956646;8354.540500272544;7842.64708088126;7932.722354717557;7942.324902383362;7996.760097197093;8034.674278744175;6914.859048256982;6934.8613027740175;6962.060121883481;6972.1981972071835;7020.613866237406;4814.253790662453;4935.235038569028;4960.206366981266;5016.197408414636;5098.286239926488;4864.902701946012;4988.850334489971;4998.2002879539095;5054.974725126351;5199.63602547818 17:02:24 INFO - PID 14748 | |4;prototype.html;365.7293602733976;379.4460088271124;380.9904752381192;388.7278904766664;389.42559724406505;5290.470952904708;5493.011257973573;5493.45065493451;5500.534663162207;5507.705689163044;5265.3155089838365;5319.707416092114;5345.97952157031;5362.731863406833;5367.329083864517;4090.529589097262;4095.262852686515;4099.159672267186;4106.9794651026705;4111.48606424197;3986.800659967005;4065.512138543379;4092.3452247640384;4100.077482566414;4100.774457404841;4031.2945234583976;4047.7976101194968;4049.210403971212;4062.573429789874;4065.6950728695465;4023.1350259694304;4039.3537034074407;4046.5548789633117;4050.675945924319;4069.776162311072;3466.2547552276383;3550.414181660023;3553.4136867416846;3561.5370001899846;3567.571891373026;5276.709780962045;5317.388500322474;5332;5338.359396872362;5347.572194224453;4770.212914869043;4770.260609605517;4792.161371759928;4792.586187074821;4802.59177969873;5563.304586926634;5649.152627105926;5709.62887412321;5741.167530708066;5754.654720716729;3950.3679411294056;3951.822168002418;3969.8809035728973;3986.7009974252046;3993.880183594497;5803.593748437611;5923.407659234128;5956.404359564052;6050.366401071686;6103.1455596216565;4061.89845253871;4106.589341065929;4116.855910043134;4122.752634841859;4123.628873401348;4131.215069136854;4136.379543068504;4138.79306034697;4146.067134894624;4152.979235103866;4699.694519856198;4761.928571071437;4762.476127625959;4784.880377990578;4792.586187074821;5721.170430287585;5726.570507211975;5735.799247026334;5745.971270143623;5754.136879468113;1412.2021058102346;1421.5593166118535;1422.253317008558;1430.7925350824073;1433.5770947570493;898.8921329440509;957.913787759105;959.510649568725;959.5777857742571;960.2366118935463;4932.334134891744;4946.3817022872145;4957.702537847741;4959.900801984012;4962.578180854595;5904.925601335065;5916.7041647918295;5921.765937354726;5954.106883967353;5964;4825.1555977703765;4879.658423910363;4922.630802689812;4951.282064100686;4966.927119761761;3106.254498920243;3136.811791292484;3140.905772826819;3141.4763839537804;3152.085895090444;5498.890022199534;5573.331200255995;5584.832455026356;5592.972035139798;5608.158776183605;6048.909266361008;6071.726772295257;6081.695915204222;6111.602745821508;6113.57204995646;5598.524125449301;5598.720063996784;5604.103343465107;5613.803516876889;5615.7192140392;5804.780936129387;5847.742735311758;5854.092615644411;5909.320428150818;5943.316518600416;5838.970805146117;5839.153322768259;5843.2695913010875;5855.268091488564;5861.120831875252;5315.813946512008;5453.700046497481;5513.145462453326;5561.777528898799;5634.6337488063145;4053.1285773557647;4105;4117.835286588623;4134.214499245134;4136.234796562646;6015.699215039318;6021.7591296347655;6028.125921741411;6037.728302226323;6046.516278697605;5771.451712087345;5780.826575202751;5784.2769653793275;5789.102689083199;5808.332041815076;5602.831915042555;5711.8000869969355;5754.165645981393;5793.8551536211935;5796.971015144897;5684.346300175533;5692.971535142297;5718.599698021265;5734.111212762028;5743.511801496919;5791.189233507228;5825.300963884191;5851.765929362778;5852.092925596539;5860.589758717019;5657.3792772626375;5671.943280567141;5687.345955215038;5695.800646977502;5696.344920334049 17:02:24 INFO - PID 14748 | |5;yui.html;683.3542302524116;690.6684791300179;707.3845754193852;711.8647456983173;723.1394640377952;13495.705730025882;13513.7972930406;13898.93050534747;15480;16418;14816.185109818956;15070.061338039086;15096.698066038673;15102.018368806048;15104.093754374719;762.1045271805634;779.2752739951843;783.0485959559135;784.925432083954;787.2678409079554;748.4611080022376;781.316348195329;789.0216131996312;802.59468968171;806.8628333183373;830.6884918155691;836.2515548584014;836.6318819719335;838.3795990966702;839.6431516605448;822.473616885197;823.9453499520623;825.2160447574828;826.2687521543418;827.7889138269763;602.448759385162;607.2166904692941;607.6445279511491;608.7869245763992;608.9360617135181;13228.603141905758;13548.59354219375;13618.795718064237;13656;13668.65828354289;15329.386824527006;16185.514434566981;16285;16320.265588048565;16340.673186536322;12713.745725085446;12825.615231543068;12859.035572332112;13006.154599950973;13029.087963842534;2997.1607949774098;3018.411409775095;3018.4566777979953;3021.7129372709555;3036.4534383810906;78977;80395;80671;80790.99999999942;81050;11854;11886.821697674543;11988.460519276654;12002.579909703118;12102.031837452983;22096.2266320678;22422.887885560467;22439.88780056122;22751.317460476213;22755.08979640829;5893.734781934823;5893.970530147321;5900.144479050514;5944.970275148683;5971.343152253248;3062.4946883764374;3064.310530130703;3069.8465076746074;3131.232847952266;3143.072793525915;3789.204267103939;3986.581408952018;3995.780232087263;4000.8399664013696;4018.5981401860163;753.600591686407;757.2994979643918;773.6325245508339;773.9883901741366;778.5484419036945;575.8416435480276;584.2463222443001;590.539379284159;599.9910001349983;612.6936531734133;9511.714648560554;9915.702528924145;10096.899031009743;10358.689239322832;10778.78442431147;566.1422944239481;571.4828080586992;577.0593931890991;584.0246787864191;602.0607851751195;4179.91640167195;4799.496052914464;4846.442659094178;4884.267359896044;5000.149974504343;84062;85570;86001.11991040701;86672;87213;71980;73190;76112;76376.61811690906;76417.61791191119;61707.6914615424;64310.356896430436;66690.66654666793;67570.32429675739;68649.31350686429;8992;9002.86495702578;9065.184133428023;9134.451932884049;9438.197753191056;28071.087559676565;28420.28949276202;28530.57204141981;28904.42191156123;29186.416271674872;52142.47857521528;52868.73565632301;53172.20241696455;53684.73157634187;54471.45528544664;14360.281985900872;14533.85466145325;14537.491187808377;14614.269286535418;14739.115653060851;16566.42017529429;16871;17433.47699569015;17581.384651537133;17734.379296724554;14264.572062838131;14631.487897923522;14914.328855201758;15275.388984440498;15395.307211175748;15271.61820954485;15516.301766420313;15758;15762.290696918437;16009.279582419053;13198;13299.135556188818;13326.800097998732;13977.301134943416;14685.19231442281;9844.2124630028;9939.869800725595;10133.18934485254;10299.845502317621;10486.947565262124;10539.26225164231;10753.731156721145;10873.78252434931;10886;10989.890101099207 17:02:24 INFO - PID 14748 | __end_tp_report 17:02:24 INFO - PID 14748 | __start_cc_report 17:02:24 INFO - PID 14748 | _x_x_mozilla_cycle_collect,375 17:02:24 INFO - PID 14748 | __end_cc_report 17:02:24 INFO - PID 14748 | __startTimestamp1496016144400__endTimestamp 17:02:24 INFO - PID 14748 | 17:02:24 INFO - PID 14748 | ------- Summary: start ------- 17:02:24 INFO - PID 14748 | Number of tests: 6 17:02:24 INFO - PID 14748 | 17:02:24 INFO - PID 14748 | [#0] dojo.html Cycles:165 Average:5155.92 Median:5347.12 stddev:598.74 (11.2%) stddev-sans-first:569.86 17:02:24 INFO - PID 14748 | Values: 2742.6 2758.0 2770.1 2805.6 2808.4 5139.2 5214.2 5218.0 5256.6 5270.8 5143.4 5202.0 5210.6 5277.4 5305.6 4647.0 4652.0 4663.9 4709.6 4713.4 4645.2 4664.2 4712.6 4770.3 4781.9 4599.6 4621.1 4705.8 4726.1 4741.1 4602.0 4696.7 4697.5 4710.8 4745.5 4599.1 4613.5 4631.5 4646.7 4659.2 5061.4 5144.3 5202.5 5209.3 5216.9 5590.1 5641.5 5652.9 5659.9 5722.8 5632.3 5662.4 5670.6 5687.4 5691.4 5198.4 5286.9 5292.3 5311.5 5352.3 5752.8 5757.0 5767.7 5783.2 5790.0 5560.2 5561.6 5562.5 5563.7 5566.2 5576.1 5587.1 5590.7 5593.7 5657.5 5483.9 5583.7 5586.3 5593.5 5616.0 5502.9 5571.4 5586.0 5588.6 5665.8 4638.4 4643.9 4646.0 4667.4 4680.1 4038.2 4041.2 4063.3 4084.6 4096.7 4704.8 4760.3 4765.3 4770.9 4838.1 5614.4 5638.4 5667.1 5698.3 5704.1 4699.6 4746.8 4751.7 4754.8 4809.4 4867.4 4912.2 4937.1 4982.7 5006.8 5295.5 5313.5 5374.4 5388.1 5390.0 5546.2 5693.8 5705.2 5717.4 5772.5 5171.0 5288.4 5294.6 5315.2 5318.6 5413.6 5476.6 5529.7 5533.5 5577.8 5549.9 5630.8 5644.9 5652.5 5678.4 5460.3 5483.5 5524.7 5536.0 5547.3 5466.2 5467.6 5467.6 5475.7 5500.4 5311.9 5347.1 5415.5 5421.1 5472.5 5498.3 5513.6 5570.8 5590.0 5591.6 5404.3 5416.1 5428.8 5432.8 5467.2 17:02:24 INFO - PID 14748 | 17:02:24 INFO - PID 14748 | [#1] ext.html Cycles:180 Average:30464.59 Median:3087.61 stddev:42455.81 (1375.0%) stddev-sans-first:42515.94 17:02:24 INFO - PID 14748 | Values: 663.8 705.9 736.5 1153.6 1194.7 33612.0 34266.7 34295.1 34311.1 34418.0 32657.0 32958.0 32983.8 33018.2 33060.8 6515.7 6593.8 6722.3 6840.0 6863.1 6818.0 6909.3 6914.9 6932.1 6950.8 6942.5 6993.9 7001.8 7006.3 7016.6 6885.8 6921.0 6936.7 6938.2 6949.1 6782.7 6842.1 6848.8 6851.9 6859.4 31356.8 31761.5 31823.4 31829.4 31870.7 2925.3 2931.5 2941.9 2942.7 2945.0 24427.3 24452.6 24496.9 24542.3 24611.8 3037.0 3044.4 3059.4 3078.8 3096.4 129826.4 132841.0 149950.0 151218.2 152096.0 37078.6 37725.4 37881.8 37890.8 37898.2 39334.8 39672.0 39676.0 39750.4 39760.8 11499.0 11627.7 11628.8 11640.4 11654.1 9268.7 9279.4 9280.2 9284.7 9341.6 11840.7 11876.3 11878.9 11940.3 12137.3 4920.4 4954.2 4956.8 4963.8 5007.2 768.9 789.7 795.7 803.4 810.7 18507.4 18575.2 18770.6 18778.7 19533.7 848.7 858.4 866.8 876.1 885.9 13759.0 14064.6 14365.5 14448.0 14465.9 181331.0 182051.0 182293.0 182448.0 182607.0 43196.0 43241.6 43308.8 43492.6 43558.6 1135.1 1166.7 1171.3 1176.5 1182.5 23690.8 24595.0 25089.4 25209.5 25487.0 29248.4 29260.9 29287.4 29447.3 29657.4 164866.0 165199.0 165275.0 165597.0 166022.0 24754.5 25216.9 26506.3 28597.1 28795.7 32020.5 32765.5 33070.7 33274.8 33639.0 25099.7 25347.9 25514.5 26152.0 26860.0 24918.8 25940.5 26714.6 27037.3 27796.2 31150.7 31265.8 31288.5 31295.7 31538.0 26450.3 26492.1 27545.4 28102.2 28531.6 20026.4 22424.4 22506.5 22707.0 22786.4 17:02:24 INFO - PID 14748 | 17:02:24 INFO - PID 14748 | [#2] jquery.html Cycles:180 Average:23750.58 Median:423.72 stddev:57044.25 (13462.7%) stddev-sans-first:57177.34 17:02:24 INFO - PID 14748 | Values: 402.8 403.7 419.3 428.1 430.3 13038.0 16863.8 16999.9 17685.9 17694.6 16803.2 16858.0 17034.3 17112.2 17196.4 5490.4 5634.0 5694.1 5707.3 5713.5 5272.6 5381.7 5412.1 5412.6 5417.9 5335.4 5361.5 5365.6 5367.4 5377.1 5229.9 5459.2 5478.2 5501.3 5519.4 4964.3 4968.9 4978.1 4981.6 4988.3 20728.4 20880.2 20969.2 20985.8 21349.1 1624.7 1626.2 1647.3 1655.9 1660.4 13793.2 14007.6 14194.6 14376.2 14425.9 1987.7 2030.6 2058.9 2063.4 2085.3 83042.0 83344.6 84095.2 84347.0 84756.6 10578.2 10940.9 11135.5 11241.6 11280.8 13450.9 15127.2 15197.8 15218.4 15265.0 6613.2 7158.7 7306.0 7446.7 7471.9 6642.2 6670.3 6794.3 6852.2 6856.2 6729.9 6878.9 6879.4 6893.4 6926.5 1958.6 1994.6 1998.2 2020.7 2031.4 768.6 791.3 795.2 808.6 810.8 16205.2 16426.8 16748.2 17076.1 17208.0 802.7 807.3 822.7 824.5 832.4 9088.7 9141.6 9348.6 9432.3 9544.6 336604.0 337763.0 340536.0 345458.0 346241.0 76454.0 77252.0 77620.0 77835.2 78831.0 955.5 989.2 1006.7 1013.4 1017.1 14123.9 14435.1 14513.7 14583.1 15041.7 36735.6 36856.3 37056.3 37197.6 37700.4 50627.0 51598.7 51724.5 51935.7 52016.7 8193.6 8216.1 8331.8 8442.7 8703.7 12396.3 12449.2 12627.9 12656.3 12847.6 10458.3 10472.7 10803.0 11003.8 11222.8 9534.9 9618.0 9646.6 9855.8 9986.0 10907.8 11001.7 11105.6 11380.9 11387.9 8128.9 8147.5 8319.9 8384.8 8595.0 10960.7 10976.2 10983.4 11244.4 11428.1 17:02:24 INFO - PID 14748 | 17:02:24 INFO - PID 14748 | [#3] mootools.html Cycles:180 Average:6202.45 Median:3829.32 stddev:4118.68 (107.6%) stddev-sans-first:4112.85 17:02:24 INFO - PID 14748 | Values: 1166.5 1203.2 1218.2 1221.3 1227.8 8968.5 9282.6 9688.6 10205.8 10273.3 9991.7 10098.1 10199.2 10285.8 10287.6 2177.9 2220.7 2221.2 2223.8 2226.0 1867.5 1937.6 2131.5 2163.4 2190.6 2107.1 2174.4 2181.1 2181.4 2185.2 2168.3 2168.7 2177.2 2187.2 2191.0 2075.7 2094.9 2099.7 2104.9 2114.0 9971.2 10017.6 10100.1 10106.7 10120.2 5392.7 5594.6 5602.2 5603.7 5610.4 3210.2 3377.3 3451.2 3458.2 3469.6 1108.6 1110.4 1130.9 1132.5 1137.9 15090.5 15198.7 15205.9 15207.5 15236.6 4558.3 4729.4 4816.6 4882.9 4888.1 11680.8 11793.9 11805.7 11813.3 11839.7 5559.4 5567.8 5569.8 5586.6 5592.6 4893.8 4962.4 5018.9 5057.4 5164.4 3785.2 3873.4 3945.4 3947.5 3966.8 1069.1 1089.3 1093.9 1095.5 1102.3 595.4 648.5 652.1 652.1 657.9 5267.9 5466.2 5480.9 5545.4 5657.9 524.8 529.4 530.3 532.3 648.5 3181.6 3268.3 3294.0 3441.5 3526.6 13112.7 13502.2 13646.2 13657.9 13684.8 12772.1 13543.9 13558.1 13564.1 13584.3 7440.0 7622.0 7650.7 7692.8 7721.8 5077.5 5113.4 5155.3 5182.7 5422.5 11909.2 12105.2 12155.1 12278.5 12286.4 12263.1 12347.6 12470.9 12552.4 12697.4 7410.8 7439.3 7446.4 7480.4 7518.1 9066.5 9114.4 9206.8 9213.7 9219.5 7972.0 8080.9 8120.9 8154.4 8354.5 7842.6 7932.7 7942.3 7996.8 8034.7 6914.9 6934.9 6962.1 6972.2 7020.6 4814.3 4935.2 4960.2 5016.2 5098.3 4864.9 4988.9 4998.2 5055.0 5199.6 17:02:24 INFO - PID 14748 | 17:02:24 INFO - PID 14748 | [#4] prototype.html Cycles:180 Average:4725.56 Median:5365.03 stddev:1410.45 (26.3%) stddev-sans-first:1375.92 17:02:24 INFO - PID 14748 | Values: 365.7 379.4 381.0 388.7 389.4 5290.5 5493.0 5493.5 5500.5 5507.7 5265.3 5319.7 5346.0 5362.7 5367.3 4090.5 4095.3 4099.2 4107.0 4111.5 3986.8 4065.5 4092.3 4100.1 4100.8 4031.3 4047.8 4049.2 4062.6 4065.7 4023.1 4039.4 4046.6 4050.7 4069.8 3466.3 3550.4 3553.4 3561.5 3567.6 5276.7 5317.4 5332.0 5338.4 5347.6 4770.2 4770.3 4792.2 4792.6 4802.6 5563.3 5649.2 5709.6 5741.2 5754.7 3950.4 3951.8 3969.9 3986.7 3993.9 5803.6 5923.4 5956.4 6050.4 6103.1 4061.9 4106.6 4116.9 4122.8 4123.6 4131.2 4136.4 4138.8 4146.1 4153.0 4699.7 4761.9 4762.5 4784.9 4792.6 5721.2 5726.6 5735.8 5746.0 5754.1 1412.2 1421.6 1422.3 1430.8 1433.6 898.9 957.9 959.5 959.6 960.2 4932.3 4946.4 4957.7 4959.9 4962.6 5904.9 5916.7 5921.8 5954.1 5964.0 4825.2 4879.7 4922.6 4951.3 4966.9 3106.3 3136.8 3140.9 3141.5 3152.1 5498.9 5573.3 5584.8 5593.0 5608.2 6048.9 6071.7 6081.7 6111.6 6113.6 5598.5 5598.7 5604.1 5613.8 5615.7 5804.8 5847.7 5854.1 5909.3 5943.3 5839.0 5839.2 5843.3 5855.3 5861.1 5315.8 5453.7 5513.1 5561.8 5634.6 4053.1 4105.0 4117.8 4134.2 4136.2 6015.7 6021.8 6028.1 6037.7 6046.5 5771.5 5780.8 5784.3 5789.1 5808.3 5602.8 5711.8 5754.2 5793.9 5797.0 5684.3 5693.0 5718.6 5734.1 5743.5 5791.2 5825.3 5851.8 5852.1 5860.6 5657.4 5671.9 5687.3 5695.8 5696.3 17:02:24 INFO - PID 14748 | 17:02:24 INFO - PID 14748 | [#5] yui.html Cycles:180 Average:17745.11 Median:4099.26 stddev:23316.22 (568.8%) stddev-sans-first:23346.43 17:02:24 INFO - PID 14748 | Values: 683.4 690.7 707.4 711.9 723.1 13495.7 13513.8 13898.9 15480.0 16418.0 14816.2 15070.1 15096.7 15102.0 15104.1 762.1 779.3 783.0 784.9 787.3 748.5 781.3 789.0 802.6 806.9 830.7 836.3 836.6 838.4 839.6 822.5 823.9 825.2 826.3 827.8 602.4 607.2 607.6 608.8 608.9 13228.6 13548.6 13618.8 13656.0 13668.7 15329.4 16185.5 16285.0 16320.3 16340.7 12713.7 12825.6 12859.0 13006.2 13029.1 2997.2 3018.4 3018.5 3021.7 3036.5 78977.0 80395.0 80671.0 80791.0 81050.0 11854.0 11886.8 11988.5 12002.6 12102.0 22096.2 22422.9 22439.9 22751.3 22755.1 5893.7 5894.0 5900.1 5945.0 5971.3 3062.5 3064.3 3069.8 3131.2 3143.1 3789.2 3986.6 3995.8 4000.8 4018.6 753.6 757.3 773.6 774.0 778.5 575.8 584.2 590.5 600.0 612.7 9511.7 9915.7 10096.9 10358.7 10778.8 566.1 571.5 577.1 584.0 602.1 4179.9 4799.5 4846.4 4884.3 5000.1 84062.0 85570.0 86001.1 86672.0 87213.0 71980.0 73190.0 76112.0 76376.6 76417.6 61707.7 64310.4 66690.7 67570.3 68649.3 8992.0 9002.9 9065.2 9134.5 9438.2 28071.1 28420.3 28530.6 28904.4 29186.4 52142.5 52868.7 53172.2 53684.7 54471.5 14360.3 14533.9 14537.5 14614.3 14739.1 16566.4 16871.0 17433.5 17581.4 17734.4 14264.6 14631.5 14914.3 15275.4 15395.3 15271.6 15516.3 15758.0 15762.3 16009.3 13198.0 13299.1 13326.8 13977.3 14685.2 9844.2 9939.9 10133.2 10299.8 10486.9 10539.3 10753.7 10873.8 10886.0 10989.9 17:02:24 INFO - PID 14748 | -------- Summary: end -------- 17:02:24 INFO - PID 14748 | 17:02:25 INFO - TEST-INFO | 14748: exit 0 17:02:25 INFO - TEST-OK | dromaeo_css | took 1148291ms 17:02:25 INFO - TEST-START | kraken 17:02:25 INFO - operating with platform_type : linux_ 17:02:25 INFO - Initialising browser for kraken test... 17:02:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41994/getInfo.html -profile /tmp/tmpe6Ms7S/profile 17:02:25 INFO - TEST-INFO | started process 15169 (/builds/slave/test/build/application/firefox/firefox http://localhost:41994/getInfo.html) 17:03:00 INFO - TEST-INFO | 15169: killed by SIGTERM 17:03:00 INFO - Browser initialized. 17:03:00 INFO - Running cycle 1/1 for kraken test... 17:03:00 INFO - TEST-INFO | started process 15392 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe6Ms7S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:03:13 INFO - PID 15392 | RSS: Main: 187510784 17:03:13 INFO - PID 15392 | 17:03:15 INFO - PID 15392 | Cycle 1(1): loaded http://localhost:41994/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41994/tests/kraken/driver.html?testName=audio-beat-detection) 17:03:16 INFO - PID 15392 | RSS: Main: 190656512 17:03:16 INFO - PID 15392 | 17:03:19 INFO - PID 15392 | Cycle 1(1): loaded http://localhost:41994/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41994/tests/kraken/driver.html?testName=audio-dft) 17:03:19 INFO - PID 15392 | RSS: Main: 189444096 17:03:19 INFO - PID 15392 | 17:03:22 INFO - PID 15392 | Cycle 1(1): loaded http://localhost:41994/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41994/tests/kraken/driver.html?testName=audio-fft) 17:03:23 INFO - PID 15392 | RSS: Main: 185876480 17:03:23 INFO - PID 15392 | 17:03:25 INFO - PID 15392 | Cycle 1(1): loaded http://localhost:41994/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41994/tests/kraken/driver.html?testName=audio-oscillator) 17:03:26 INFO - PID 15392 | RSS: Main: 186331136 17:03:26 INFO - PID 15392 | 17:03:28 INFO - PID 15392 | Cycle 1(1): loaded http://localhost:41994/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41994/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:03:29 INFO - PID 15392 | RSS: Main: 186740736 17:03:29 INFO - PID 15392 | 17:03:32 INFO - PID 15392 | Cycle 1(1): loaded http://localhost:41994/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41994/tests/kraken/driver.html?testName=imaging-darkroom) 17:03:33 INFO - PID 15392 | RSS: Main: 191225856 17:03:33 INFO - PID 15392 | 17:03:36 INFO - PID 15392 | Cycle 1(1): loaded http://localhost:41994/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41994/tests/kraken/driver.html?testName=imaging-desaturate) 17:03:37 INFO - PID 15392 | RSS: Main: 186712064 17:03:37 INFO - PID 15392 | 17:03:40 INFO - PID 15392 | Cycle 1(1): loaded http://localhost:41994/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41994/tests/kraken/driver.html?testName=json-parse-financial) 17:03:40 INFO - PID 15392 | RSS: Main: 187510784 17:03:40 INFO - PID 15392 | 17:03:42 INFO - PID 15392 | Cycle 1(1): loaded http://localhost:41994/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41994/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:03:43 INFO - PID 15392 | RSS: Main: 187756544 17:03:43 INFO - PID 15392 | 17:03:44 INFO - PID 15392 | Cycle 1(1): loaded http://localhost:41994/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41994/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:03:45 INFO - PID 15392 | RSS: Main: 187265024 17:03:45 INFO - PID 15392 | 17:03:47 INFO - PID 15392 | Cycle 1(1): loaded http://localhost:41994/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41994/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:03:48 INFO - PID 15392 | RSS: Main: 187248640 17:03:48 INFO - PID 15392 | 17:03:51 INFO - PID 15392 | Cycle 1(1): loaded http://localhost:41994/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41994/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:03:52 INFO - PID 15392 | RSS: Main: 187428864 17:03:52 INFO - PID 15392 | 17:03:55 INFO - PID 15392 | Cycle 1(1): loaded http://localhost:41994/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41994/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:03:55 INFO - PID 15392 | RSS: Main: 187183104 17:03:55 INFO - PID 15392 | 17:03:57 INFO - PID 15392 | Cycle 1(1): loaded http://localhost:41994/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41994/tests/kraken/driver.html?testName=ai-astar) 17:03:57 INFO - PID 15392 | RSS: Main: 187994112 17:03:57 INFO - PID 15392 | 17:03:57 INFO - PID 15392 | __start_tp_report 17:03:57 INFO - PID 15392 | _x_x_mozilla_page_load 17:03:57 INFO - PID 15392 | _x_x_mozilla_page_load_details 17:03:57 INFO - PID 15392 | |i|pagename|runs| 17:03:57 INFO - PID 15392 | |0;ai-astar;102;110;110;114;110;116;112;111;115;113 17:03:57 INFO - PID 15392 | |1;audio-beat-detection;159;124;123;176;123;123;130;130;144;124 17:03:57 INFO - PID 15392 | |2;audio-dft;164;169;167;171;169;180;162;166;168;164 17:03:57 INFO - PID 15392 | |3;audio-fft;74;76;76;104;74;77;75;76;98;77 17:03:57 INFO - PID 15392 | |4;audio-oscillator;83;84;111;82;83;83;96;84;84;112 17:03:57 INFO - PID 15392 | |5;imaging-gaussian-blur;114;114;115;114;114;115;114;113;115;115 17:03:57 INFO - PID 15392 | |6;imaging-darkroom;154;152;151;152;151;151;150;151;151;150 17:03:57 INFO - PID 15392 | |7;imaging-desaturate;95;96;94;95;94;95;94;94;98;94 17:03:57 INFO - PID 15392 | |8;json-parse-financial;56;57;60;55;56;60;59;61;63;57 17:03:57 INFO - PID 15392 | |9;json-stringify-tinderbox;56;56;55;56;56;56;57;56;57;56 17:03:57 INFO - PID 15392 | |10;stanford-crypto-aes;89;88;88;88;88;88;88;89;128;87 17:03:57 INFO - PID 15392 | |11;stanford-crypto-ccm;133;138;134;138;136;133;142;140;139;147 17:03:57 INFO - PID 15392 | |12;stanford-crypto-pbkdf2;185;192;200;198;186;195;201;201;199;184 17:03:57 INFO - PID 15392 | |13;stanford-crypto-sha256-iterative;74;73;72;76;72;71;73;71;76;72 17:03:57 INFO - PID 15392 | __end_tp_report 17:03:57 INFO - PID 15392 | __start_cc_report 17:03:57 INFO - PID 15392 | _x_x_mozilla_cycle_collect,1026 17:03:57 INFO - PID 15392 | __end_cc_report 17:03:57 INFO - PID 15392 | __startTimestamp1496016237963__endTimestamp 17:03:57 INFO - PID 15392 | 17:03:57 INFO - PID 15392 | ------- Summary: start ------- 17:03:57 INFO - PID 15392 | Number of tests: 14 17:03:57 INFO - PID 15392 | 17:03:57 INFO - PID 15392 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.50 stddev:3.92 (3.5%) stddev-sans-first:2.29 17:03:57 INFO - PID 15392 | Values: 102.0 110.0 110.0 114.0 110.0 116.0 112.0 111.0 115.0 113.0 17:03:57 INFO - PID 15392 | 17:03:57 INFO - PID 15392 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:130.00 stddev:18.43 (14.2%) stddev-sans-first:17.50 17:03:57 INFO - PID 15392 | Values: 159.0 124.0 123.0 176.0 123.0 123.0 130.0 130.0 144.0 124.0 17:03:57 INFO - PID 15392 | 17:03:57 INFO - PID 15392 | [#2] audio-dft Cycles:10 Average:168.00 Median:168.50 stddev:5.03 (3.0%) stddev-sans-first:5.13 17:03:57 INFO - PID 15392 | Values: 164.0 169.0 167.0 171.0 169.0 180.0 162.0 166.0 168.0 164.0 17:03:57 INFO - PID 15392 | 17:03:57 INFO - PID 15392 | [#3] audio-fft Cycles:10 Average:80.70 Median:76.00 stddev:10.84 (14.3%) stddev-sans-first:11.23 17:03:57 INFO - PID 15392 | Values: 74.0 76.0 76.0 104.0 74.0 77.0 75.0 76.0 98.0 77.0 17:03:57 INFO - PID 15392 | 17:03:57 INFO - PID 15392 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:83.50 stddev:11.92 (14.3%) stddev-sans-first:12.36 17:03:57 INFO - PID 15392 | Values: 83.0 84.0 111.0 82.0 83.0 83.0 96.0 84.0 84.0 112.0 17:03:57 INFO - PID 15392 | 17:03:57 INFO - PID 15392 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 17:03:57 INFO - PID 15392 | Values: 114.0 114.0 115.0 114.0 114.0 115.0 114.0 113.0 115.0 115.0 17:03:57 INFO - PID 15392 | 17:03:57 INFO - PID 15392 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:151.00 stddev:1.16 (0.8%) stddev-sans-first:0.71 17:03:57 INFO - PID 15392 | Values: 154.0 152.0 151.0 152.0 151.0 151.0 150.0 151.0 151.0 150.0 17:03:57 INFO - PID 15392 | 17:03:57 INFO - PID 15392 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:1.29 (1.4%) stddev-sans-first:1.36 17:03:57 INFO - PID 15392 | Values: 95.0 96.0 94.0 95.0 94.0 95.0 94.0 94.0 98.0 94.0 17:03:57 INFO - PID 15392 | 17:03:57 INFO - PID 15392 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:59.50 stddev:2.59 (4.4%) stddev-sans-first:2.60 17:03:57 INFO - PID 15392 | Values: 56.0 57.0 60.0 55.0 56.0 60.0 59.0 61.0 63.0 57.0 17:03:57 INFO - PID 15392 | 17:03:57 INFO - PID 15392 | [#9] json-stringify-tinderbox Cycles:10 Average:56.10 Median:56.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 17:03:57 INFO - PID 15392 | Values: 56.0 56.0 55.0 56.0 56.0 56.0 57.0 56.0 57.0 56.0 17:03:57 INFO - PID 15392 | 17:03:57 INFO - PID 15392 | [#10] stanford-crypto-aes Cycles:10 Average:92.10 Median:88.00 stddev:12.63 (14.3%) stddev-sans-first:13.34 17:03:57 INFO - PID 15392 | Values: 89.0 88.0 88.0 88.0 88.0 88.0 88.0 89.0 128.0 87.0 17:03:57 INFO - PID 15392 | 17:03:57 INFO - PID 15392 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:138.50 stddev:4.37 (3.2%) stddev-sans-first:4.25 17:03:57 INFO - PID 15392 | Values: 133.0 138.0 134.0 138.0 136.0 133.0 142.0 140.0 139.0 147.0 17:03:57 INFO - PID 15392 | 17:03:57 INFO - PID 15392 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.10 Median:198.50 stddev:6.87 (3.5%) stddev-sans-first:6.45 17:03:57 INFO - PID 15392 | Values: 185.0 192.0 200.0 198.0 186.0 195.0 201.0 201.0 199.0 184.0 17:03:57 INFO - PID 15392 | 17:03:57 INFO - PID 15392 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:73.00 stddev:1.83 (2.5%) stddev-sans-first:1.90 17:03:57 INFO - PID 15392 | Values: 74.0 73.0 72.0 76.0 72.0 71.0 73.0 71.0 76.0 72.0 17:03:57 INFO - PID 15392 | -------- Summary: end -------- 17:03:57 INFO - PID 15392 | 17:03:59 INFO - TEST-INFO | 15392: exit 0 17:03:59 INFO - TEST-OK | kraken | took 93779ms 17:03:59 INFO - SUITE-END | took 1242s 17:03:59 INFO - Completed test suite (00:20:42) 17:03:59 INFO - javascript benchmark 17:03:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6652.799623189404, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2742.616033755274, 2758.0, 2770.1135636596287, 2805.565137403702, 2808.3961948181136, 5139.203423469359, 5214.217867319904, 5217.973910130453, 5256.579473642109, 5270.8418747437545, 5143.408508021569, 5202.0376230397405, 5210.583153347723, 5277.445868183843, 5305.575553955684, 4647.047355292157, 4651.953480465186, 4663.906721865552, 4709.599684026862, 4713.43438787346, 4645.187092258858, 4664.207084795576, 4712.552307530779, 4770.284457331393, 4781.90436191276, 4599.563041511051, 4621.098885717286, 4705.788239529229, 4726.054789042171, 4741.075490279397, 4601.976990115028, 4696.694714843558, 4697.459792123916, 4710.788014539354, 4745.525447455261, 4599.08018396322, 4613.515580863995, 4631.4673812511655, 4646.674732768707, 4659.231226847566, 5061.367329083864, 5144.331236939174, 5202.4537423570355, 5209.296744939423, 5216.947830521684, 5590.133529302964, 5641.5204707599905, 5652.8869422611315, 5659.943400565983, 5722.771089156428, 5632.267805185341, 5662.37713851476, 5670.631408958405, 5687.431256874321, 5691.4024027476935, 5198.376194856566, 5286.9471305287225, 5292.285541451932, 5311.49540793624, 5352.304200453916, 5752.798652047159, 5757.0, 5767.653940763567, 5783.161441590946, 5789.971050144806, 5560.2493663355735, 5561.63849349791, 5562.499375056264, 5563.693996830132, 5566.192902029264, 5576.079946808731, 5587.078132108157, 5590.720463976866, 5593.664380137205, 5657.4908258256955, 5483.945160548423, 5583.664980101207, 5586.273784408082, 5593.496585307342, 5616.045272303718, 5502.862428439241, 5571.375140256826, 5586.022446071921, 5588.580856435784, 5665.801696940587, 4638.350630911675, 4643.86068417948, 4645.953540464619, 4667.416572928384, 4680.134175177603, 4038.2327357801923, 4041.191761647682, 4063.309237429644, 4084.571120032354, 4096.672266218696, 4704.788284527204, 4760.309755085563, 4765.285207218945, 4770.880727981758, 4838.129136755418, 5614.410486898899, 5638.379778224392, 5667.093265077568, 5698.287714035746, 5704.058830293038, 4699.577038066591, 4746.833860814855, 4751.738654374042, 4754.809807607726, 4809.398825146856, 4867.415910090812, 4912.164931961575, 4937.086638971802, 4982.676126051795, 5006.799728010911, 5295.4969277918535, 5313.52178303939, 5374.435684253097, 5388.110961691277, 5389.973050134724, 5546.223528706065, 5693.772249109989, 5705.22979397776, 5717.3996730342715, 5772.509336706427, 5171.0, 5288.365396152486, 5294.602904782234, 5315.176147697113, 5318.57451403879, 5413.56691464674, 5476.616636835383, 5529.695866727368, 5533.501984821385, 5577.77688892456, 5549.889002220014, 5630.8029218977135, 5644.943550564606, 5652.547796176378, 5678.375378708256, 5460.290162278879, 5483.451654834645, 5524.723763811874, 5536.0, 5547.33431988164, 5466.207399926909, 5467.589930755289, 5467.617266791286, 5475.698836564027, 5500.4499550044675, 5311.867203319948, 5347.117725575236, 5415.48552887475, 5421.132618780976, 5472.452754724496, 5498.285222920995, 5513.58648101402, 5570.777168913198, 5590.0, 5591.580631452576, 5404.32445944257, 5416.133418652997, 5428.809991650273, 5432.7555260012605, 5467.234587157881], "value": 5113.351428375057, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.7743167323113, 705.9258777828328, 736.451343748907, 1153.6481373181182, 1194.7132688154834, 33612.0, 34266.65733342669, 34295.142621434476, 34311.142221444476, 34418.0, 32657.020289391297, 32958.0, 32983.835080824625, 33018.17454563637, 33060.83469582655, 6515.739370425177, 6593.769218077368, 6722.294159113296, 6839.965800170992, 6863.073485079501, 6818.0, 6909.2745261747295, 6914.861702765942, 6932.0641713368805, 6950.756723514678, 6942.479314051441, 6993.89509157363, 7001.789946301619, 7006.264342244068, 7016.649167541603, 6885.793426197222, 6921.0, 6936.72253109875, 6938.236793952711, 6949.096617439751, 6782.694778734969, 6842.076319696827, 6848.794536163923, 6851.897221541681, 6859.382655560974, 31356.843215783774, 31761.523577146363, 31823.363532729447, 31829.363412731847, 31870.681293187234, 2925.2979284971666, 2931.457680329146, 2941.897033603835, 2942.7498662613702, 2944.9705502945126, 24427.267181984567, 24452.633210501856, 24496.877515612487, 24542.263732088068, 24611.753882461304, 3036.969630303713, 3044.3911217756536, 3059.4034163338156, 3078.830664313462, 3096.380723855238, 129826.350868246, 132841.0, 149950.0, 151218.1708188964, 152096.0, 37078.62921370806, 37725.43411848824, 37881.81059094687, 37890.8105459471, 37898.24203515914, 39334.80332598376, 39672.0, 39676.0, 39750.40374394386, 39760.80119599441, 11499.0, 11627.709307267216, 11628.825567616492, 11640.35978021217, 11654.067674586013, 9268.675596354231, 9279.396839205565, 9280.164785169367, 9284.72145835626, 9341.579628916716, 11840.703982400337, 11876.34680092586, 11878.88121118795, 11940.343281119449, 12137.271763694207, 4920.40955085392, 4954.232094025432, 4956.826511072168, 4963.776630051656, 5007.24891266313, 768.8961990131261, 789.7433334166304, 795.745361484331, 803.4416080823888, 810.7121971700079, 18507.44477665645, 18575.16411761474, 18770.624587508173, 18778.718319225223, 19533.706994395096, 848.6775025490398, 858.4291446188215, 866.8223014282057, 876.0669886570781, 885.9025507194203, 13759.0, 14064.578062658136, 14365.497207597684, 14448.0, 14465.85534144666, 181331.0, 182051.0, 182293.0, 182448.0, 182607.0, 43196.0, 43241.567584323755, 43308.78345608315, 43492.565074349484, 43558.564414356086, 1135.1316243074054, 1166.690826930864, 1171.291368721928, 1176.4764679717614, 1182.5388098641536, 23690.763092368856, 24595.0, 25089.372765681004, 25209.495810084063, 25487.0, 29248.41503169967, 29260.853695731385, 29287.414251715272, 29447.26381840471, 29657.40685186241, 164866.0, 165199.0, 165275.0, 165597.0, 166022.0, 24754.50490990206, 25216.873915630305, 26506.337341566614, 28597.14208573663, 28795.712042879302, 32020.5196922051, 32765.50851737178, 33070.66929330676, 33274.83362583268, 33639.0, 25099.74900251047, 25347.89273556182, 25514.489710206064, 26152.0, 26860.0, 24918.75081249237, 25940.48119037571, 26714.59928101119, 27037.324066897698, 27796.166115016582, 31150.688493115686, 31265.8436707815, 31288.530672039484, 31295.687043130187, 31538.0, 26450.338741531617, 26492.082522846424, 27545.44909101767, 28102.156935291972, 28531.572026420035, 20026.399208023784, 22424.439389015406, 22506.549869002854, 22707.0, 22786.43033924165], "value": 14251.115316646192, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.762370201581, 403.6548750818051, 419.3227936881935, 428.1159405826967, 430.3265389665174, 13038.0, 16863.831361686378, 16999.915000424997, 17685.91157044216, 17694.646107077868, 16803.24385402657, 16858.0, 17034.318627254925, 17112.229949652265, 17196.39812606559, 5490.368607610116, 5633.971830140864, 5694.145878118295, 5707.258056452655, 5713.457221563945, 5272.551833094191, 5381.67709937403, 5412.134058550632, 5412.648177868446, 5417.891642167155, 5335.359756829186, 5361.51746342829, 5365.597580181482, 5367.382750983647, 5377.059014672417, 5229.921551176735, 5459.181122831567, 5478.233047373371, 5501.284832971688, 5519.39286678465, 4964.255361695775, 4968.850934471971, 4978.079055374731, 4981.551660350549, 4988.276699878534, 20728.378148655564, 20880.164793408396, 20969.16123355064, 20985.79014209869, 21349.146034158613, 1624.7075526405242, 1626.219414680948, 1647.3163637090593, 1655.9006459612342, 1660.4271526323398, 13793.172409655352, 14007.649808754863, 14194.574162775134, 14376.209308488134, 14425.855741442556, 1987.7316562264054, 2030.5532782787911, 2058.9485262868398, 2063.4119276006268, 2085.301424022954, 83042.0, 83344.58327708383, 84095.15904840996, 84347.0, 84756.57621711852, 10578.153747700166, 10940.945295273472, 11135.498902549405, 11241.550337986553, 11280.830787538194, 13450.865491345157, 15127.16800575979, 15197.848021519865, 15218.391264349302, 15265.0, 6613.173353330833, 7158.677859496335, 7305.963470182615, 7446.702131914771, 7471.887921681179, 6642.202935647753, 6670.266270710218, 6794.320567943265, 6852.246252912176, 6856.24581296057, 6729.899051514231, 6878.931210687929, 6879.380855722909, 6893.414059804973, 6926.515143939977, 1958.5886963737776, 1994.6110508451004, 1998.2107067708173, 2020.7170996060563, 2031.4311992642083, 768.5772824946257, 791.2601717394255, 795.2127393880132, 808.5593351623262, 810.8094597769519, 16205.189740512928, 16426.83573164277, 16748.162591870358, 17076.060816655205, 17208.0, 802.7110240313483, 807.3016840432983, 822.6914906909909, 824.5464994253136, 832.4256263178388, 9088.727338179866, 9141.63433462654, 9348.626054957726, 9432.292578056537, 9544.570494327772, 336604.0, 337763.0, 340536.0, 345458.0, 346241.0, 76454.0, 77251.99999999888, 77620.0, 77835.22164778392, 78831.0, 955.5126885288553, 989.2284018465608, 1006.7030226083176, 1013.4071568132578, 1017.0693815159194, 14123.858761412253, 14435.061720988522, 14513.709725805636, 14583.125012499284, 15041.6991660164, 36735.61218520788, 36856.26287474289, 37056.25887482289, 37197.628023719415, 37700.43449348207, 50627.0, 51598.74200628973, 51724.482755171965, 51935.70160746011, 52016.739916300176, 8193.631286591999, 8216.137305582828, 8331.750047498585, 8442.746717598482, 8703.651853925772, 12396.31820249895, 12449.190802597803, 12627.93686031564, 12656.303903285409, 12847.614571562868, 10458.320209186379, 10472.68581942543, 10803.00144473275, 11003.834942476029, 11222.775544489228, 9534.85697714521, 9617.951910240405, 9646.565904534173, 9855.802883942137, 9986.0, 10907.83638245411, 11001.726170637292, 11105.611303604659, 11380.886191138314, 11387.886121138683, 8128.878066828884, 8147.470414423044, 8319.875201871855, 8384.790380240298, 8594.957025214833, 10960.725981850517, 10976.176786740867, 10983.39591322485, 11244.381559014006, 11428.142889283503], "value": 8580.142821389916, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1166.5217260923023, 1203.187848202463, 1218.2386008744534, 1221.2855479544469, 1227.7851376009203, 8968.461892286467, 9282.628694852214, 9688.61245550178, 10205.795884082314, 10273.332233404823, 9991.650292239772, 10098.091171794536, 10199.235057370708, 10285.794284114332, 10287.63993260236, 2177.912883484663, 2220.733511978565, 2221.178164079293, 2223.7776222377715, 2226.031676220841, 1867.5331167208199, 1937.602791427754, 2131.488442773739, 2163.350994701583, 2190.605690975624, 2107.1044805957486, 2174.402039439159, 2181.0512427094186, 2181.3892110209167, 2185.2133232036454, 2168.327818376308, 2168.6855405966126, 2177.172674383724, 2187.223535644847, 2190.9561808763815, 2075.6886467029917, 2094.937151885446, 2099.6955441460905, 2104.9368518944457, 2113.9788602113936, 9971.152452041586, 10017.597536344918, 10100.090991810772, 10106.696799096038, 10120.240981926385, 5392.703401312926, 5594.580406469531, 5602.187682786014, 5603.7478313475585, 5610.410906854803, 3210.165357007195, 3377.290768938526, 3451.240727040072, 3458.15275257561, 3469.6356882527225, 1108.5953626926114, 1110.3670907582682, 1130.9321440713502, 1132.4507613807298, 1137.8919002694731, 15090.54728358162, 15198.696026079528, 15205.923970380189, 15207.543773686808, 15236.619084522865, 4558.293464513005, 4729.385179926588, 4816.614670826326, 4882.926756098661, 4888.120138375127, 11680.824787628193, 11793.933577269972, 11805.704857378634, 11813.291202527877, 11839.704007399712, 5559.360673522516, 5567.805126820623, 5569.777208911679, 5586.636868603528, 5592.5805564582815, 4893.828715994923, 4962.354893863847, 5018.949810501921, 5057.418396884405, 5164.3802743671, 3785.242951409674, 3873.3996230584303, 3945.368741001426, 3947.4670919426085, 3966.801659916993, 1069.1446842525947, 1089.330062011857, 1093.8960798724108, 1095.5453486803046, 1102.2890235797865, 595.3659352789266, 648.5265755998148, 652.0545209446321, 652.1098700274092, 657.9144711187515, 5267.947320526822, 5466.180072989084, 5480.862978425571, 5545.445455454423, 5657.858553536194, 524.8425472358277, 529.375337102223, 530.3291336459382, 532.3425569421761, 648.4909346163239, 3181.6341120770944, 3268.297316077055, 3294.0, 3441.500982357544, 3526.559180102487, 13112.672183195496, 13502.189868607915, 13646.24945628, 13657.863421365857, 13684.794728079087, 12772.10595258323, 13543.864561354458, 13558.050936434553, 13564.05051646395, 13584.252866092262, 7439.962800186073, 7621.961890190513, 7650.73222437212, 7692.76921692339, 7721.7683469496005, 5077.492250774893, 5113.437521872516, 5155.2782610433815, 5182.714950677749, 5422.539084177889, 11909.166358355178, 12105.152639315163, 12155.088368372231, 12278.508859645513, 12286.385680716106, 12263.141580089308, 12347.62957111288, 12470.937645311715, 12552.372381381078, 12697.365131743562, 7410.8147296315865, 7439.330460258603, 7446.4042876568665, 7480.401567874448, 7518.135414427411, 9066.456012639263, 9114.36199466031, 9206.769830754285, 9213.723588292361, 9219.539023048956, 7972.0, 8080.919190808252, 8120.878186827321, 8154.429189956646, 8354.540500272544, 7842.64708088126, 7932.722354717557, 7942.324902383362, 7996.760097197093, 8034.674278744175, 6914.859048256982, 6934.8613027740175, 6962.060121883481, 6972.1981972071835, 7020.613866237406, 4814.253790662453, 4935.235038569028, 4960.206366981266, 5016.197408414636, 5098.286239926488, 4864.902701946012, 4988.850334489971, 4998.2002879539095, 5054.974725126351, 5199.63602547818], "value": 4583.224597109528, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.7293602733976, 379.4460088271124, 380.9904752381192, 388.7278904766664, 389.42559724406505, 5290.470952904708, 5493.011257973573, 5493.45065493451, 5500.534663162207, 5507.705689163044, 5265.3155089838365, 5319.707416092114, 5345.97952157031, 5362.731863406833, 5367.329083864517, 4090.529589097262, 4095.262852686515, 4099.159672267186, 4106.9794651026705, 4111.48606424197, 3986.800659967005, 4065.512138543379, 4092.3452247640384, 4100.077482566414, 4100.774457404841, 4031.2945234583976, 4047.7976101194968, 4049.210403971212, 4062.573429789874, 4065.6950728695465, 4023.1350259694304, 4039.3537034074407, 4046.5548789633117, 4050.675945924319, 4069.776162311072, 3466.2547552276383, 3550.414181660023, 3553.4136867416846, 3561.5370001899846, 3567.571891373026, 5276.709780962045, 5317.388500322474, 5332.0, 5338.359396872362, 5347.572194224453, 4770.212914869043, 4770.260609605517, 4792.161371759928, 4792.586187074821, 4802.59177969873, 5563.304586926634, 5649.152627105926, 5709.62887412321, 5741.167530708066, 5754.654720716729, 3950.3679411294056, 3951.822168002418, 3969.8809035728973, 3986.7009974252046, 3993.880183594497, 5803.593748437611, 5923.407659234128, 5956.404359564052, 6050.366401071686, 6103.1455596216565, 4061.89845253871, 4106.589341065929, 4116.855910043134, 4122.752634841859, 4123.628873401348, 4131.215069136854, 4136.379543068504, 4138.79306034697, 4146.067134894624, 4152.979235103866, 4699.694519856198, 4761.928571071437, 4762.476127625959, 4784.880377990578, 4792.586187074821, 5721.170430287585, 5726.570507211975, 5735.799247026334, 5745.971270143623, 5754.136879468113, 1412.2021058102346, 1421.5593166118535, 1422.253317008558, 1430.7925350824073, 1433.5770947570493, 898.8921329440509, 957.913787759105, 959.510649568725, 959.5777857742571, 960.2366118935463, 4932.334134891744, 4946.3817022872145, 4957.702537847741, 4959.900801984012, 4962.578180854595, 5904.925601335065, 5916.7041647918295, 5921.765937354726, 5954.106883967353, 5964.0, 4825.1555977703765, 4879.658423910363, 4922.630802689812, 4951.282064100686, 4966.927119761761, 3106.254498920243, 3136.811791292484, 3140.905772826819, 3141.4763839537804, 3152.085895090444, 5498.890022199534, 5573.331200255995, 5584.832455026356, 5592.972035139798, 5608.158776183605, 6048.909266361008, 6071.726772295257, 6081.695915204222, 6111.602745821508, 6113.57204995646, 5598.524125449301, 5598.720063996784, 5604.103343465107, 5613.803516876889, 5615.7192140392, 5804.780936129387, 5847.742735311758, 5854.092615644411, 5909.320428150818, 5943.316518600416, 5838.970805146117, 5839.153322768259, 5843.2695913010875, 5855.268091488564, 5861.120831875252, 5315.813946512008, 5453.700046497481, 5513.145462453326, 5561.777528898799, 5634.6337488063145, 4053.1285773557647, 4105.0, 4117.835286588623, 4134.214499245134, 4136.234796562646, 6015.699215039318, 6021.7591296347655, 6028.125921741411, 6037.728302226323, 6046.516278697605, 5771.451712087345, 5780.826575202751, 5784.2769653793275, 5789.102689083199, 5808.332041815076, 5602.831915042555, 5711.8000869969355, 5754.165645981393, 5793.8551536211935, 5796.971015144897, 5684.346300175533, 5692.971535142297, 5718.599698021265, 5734.111212762028, 5743.511801496919, 5791.189233507228, 5825.300963884191, 5851.765929362778, 5852.092925596539, 5860.589758717019, 5657.3792772626375, 5671.943280567141, 5687.345955215038, 5695.800646977502, 5696.344920334049], "value": 4289.422973128722, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [683.3542302524116, 690.6684791300179, 707.3845754193852, 711.8647456983173, 723.1394640377952, 13495.705730025882, 13513.7972930406, 13898.93050534747, 15480.0, 16418.0, 14816.185109818956, 15070.061338039086, 15096.698066038673, 15102.018368806048, 15104.093754374719, 762.1045271805634, 779.2752739951843, 783.0485959559135, 784.925432083954, 787.2678409079554, 748.4611080022376, 781.316348195329, 789.0216131996312, 802.59468968171, 806.8628333183373, 830.6884918155691, 836.2515548584014, 836.6318819719335, 838.3795990966702, 839.6431516605448, 822.473616885197, 823.9453499520623, 825.2160447574828, 826.2687521543418, 827.7889138269763, 602.448759385162, 607.2166904692941, 607.6445279511491, 608.7869245763992, 608.9360617135181, 13228.603141905758, 13548.59354219375, 13618.795718064237, 13656.0, 13668.65828354289, 15329.386824527006, 16185.514434566981, 16285.0, 16320.265588048565, 16340.673186536322, 12713.745725085446, 12825.615231543068, 12859.035572332112, 13006.154599950973, 13029.087963842534, 2997.1607949774098, 3018.411409775095, 3018.4566777979953, 3021.7129372709555, 3036.4534383810906, 78977.0, 80395.0, 80671.0, 80790.99999999942, 81050.0, 11854.0, 11886.821697674543, 11988.460519276654, 12002.579909703118, 12102.031837452983, 22096.2266320678, 22422.887885560467, 22439.88780056122, 22751.317460476213, 22755.08979640829, 5893.734781934823, 5893.970530147321, 5900.144479050514, 5944.970275148683, 5971.343152253248, 3062.4946883764374, 3064.310530130703, 3069.8465076746074, 3131.232847952266, 3143.072793525915, 3789.204267103939, 3986.581408952018, 3995.780232087263, 4000.8399664013696, 4018.5981401860163, 753.600591686407, 757.2994979643918, 773.6325245508339, 773.9883901741366, 778.5484419036945, 575.8416435480276, 584.2463222443001, 590.539379284159, 599.9910001349983, 612.6936531734133, 9511.714648560554, 9915.702528924145, 10096.899031009743, 10358.689239322832, 10778.78442431147, 566.1422944239481, 571.4828080586992, 577.0593931890991, 584.0246787864191, 602.0607851751195, 4179.91640167195, 4799.496052914464, 4846.442659094178, 4884.267359896044, 5000.149974504343, 84062.0, 85570.0, 86001.11991040701, 86672.0, 87213.0, 71980.0, 73190.0, 76112.0, 76376.61811690906, 76417.61791191119, 61707.6914615424, 64310.356896430436, 66690.66654666793, 67570.32429675739, 68649.31350686429, 8992.0, 9002.86495702578, 9065.184133428023, 9134.451932884049, 9438.197753191056, 28071.087559676565, 28420.28949276202, 28530.57204141981, 28904.42191156123, 29186.416271674872, 52142.47857521528, 52868.73565632301, 53172.20241696455, 53684.73157634187, 54471.45528544664, 14360.281985900872, 14533.85466145325, 14537.491187808377, 14614.269286535418, 14739.115653060851, 16566.42017529429, 16871.0, 17433.47699569015, 17581.384651537133, 17734.379296724554, 14264.572062838131, 14631.487897923522, 14914.328855201758, 15275.388984440498, 15395.307211175748, 15271.61820954485, 15516.301766420313, 15758.0, 15762.290696918437, 16009.279582419053, 13198.0, 13299.135556188818, 13326.800097998732, 13977.301134943416, 14685.19231442281, 9844.2124630028, 9939.869800725595, 10133.18934485254, 10299.845502317621, 10486.947565262124, 10539.26225164231, 10753.731156721145, 10873.78252434931, 10886.0, 10989.890101099207], "value": 7053.029756311686, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1557.9999999999995, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 110.0, 114.0, 110.0, 116.0, 112.0, 111.0, 115.0, 113.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 124.0, 123.0, 176.0, 123.0, 123.0, 130.0, 130.0, 144.0, 124.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 169.0, 167.0, 171.0, 169.0, 180.0, 162.0, 166.0, 168.0, 164.0], "value": 168.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 104.0, 74.0, 77.0, 75.0, 76.0, 98.0, 77.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 111.0, 82.0, 83.0, 83.0, 96.0, 84.0, 84.0, 112.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 114.0, 115.0, 114.0, 113.0, 115.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 152.0, 151.0, 152.0, 151.0, 151.0, 150.0, 151.0, 151.0, 150.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 98.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 60.0, 55.0, 56.0, 60.0, 59.0, 61.0, 63.0, 57.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 56.0, 56.0, 56.0, 57.0, 56.0, 57.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 88.0, 88.0, 88.0, 88.0, 88.0, 89.0, 128.0, 87.0], "value": 92.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 138.0, 134.0, 138.0, 136.0, 133.0, 142.0, 140.0, 139.0, 147.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 192.0, 200.0, 198.0, 186.0, 195.0, 201.0, 201.0, 199.0, 184.0], "value": 194.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 72.0, 76.0, 72.0, 71.0, 73.0, 71.0, 76.0, 72.0], "value": 73.0, "unit": "score"}]}]} 17:03:59 INFO - Return code: 0 17:03:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:03:59 INFO - # TBPL SUCCESS # 17:03:59 INFO - Running post-action listener: _resource_record_post_action 17:03:59 INFO - [mozharness: 2017-05-29 00:03:59.749800Z] Finished run-tests step (success) 17:03:59 INFO - Running post-run listener: _resource_record_post_run 17:03:59 INFO - Total resource usage - Wall time: 1259s; CPU: 13.0%; Read bytes: 884736; Write bytes: 408363008; Read time: 124; Write time: 333912 17:03:59 INFO - TinderboxPrint: CPU usage
12.7% 17:03:59 INFO - TinderboxPrint: I/O read bytes / time
884,736 / 124 17:03:59 INFO - TinderboxPrint: I/O write bytes / time
408,363,008 / 333,912 17:03:59 INFO - TinderboxPrint: CPU idle
8,772.2 (87.3%) 17:03:59 INFO - TinderboxPrint: CPU user
1,222.8 (12.2%) 17:03:59 INFO - TinderboxPrint: Swap in / out
0 / 0 17:03:59 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 98922496; Read time: 0; Write time: 98884 17:03:59 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:03:59 INFO - run-tests - Wall time: 1243s; CPU: 13.0%; Read bytes: 880640; Write bytes: 309436416; Read time: 112; Write time: 234736 17:04:00 INFO - Running post-run listener: _upload_blobber_files 17:04:00 INFO - Blob upload gear active. 17:04:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:04:00 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 17:04:00 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'] 17:04:00 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 17:04:00 INFO - (blobuploader) - INFO - Open directory for files ... 17:04:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:04:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:04:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:01 INFO - (blobuploader) - INFO - Done attempting. 17:04:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:04:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:04:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:02 INFO - (blobuploader) - INFO - Done attempting. 17:04:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:04:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:04:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:10 INFO - (blobuploader) - INFO - Done attempting. 17:04:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:04:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:04:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:10 INFO - (blobuploader) - INFO - Done attempting. 17:04:10 INFO - (blobuploader) - INFO - Iteration through files over. 17:04:10 INFO - Return code: 0 17:04:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:04:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:04:10 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88ca27b4d713c368bb6e29f32bdc68dc91ff979bcf70cf8648fb6047a0cd14039f590471df7051e0e81965e849ee2d41e08002c30180a8f3e7029d9cde5303aa", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bac98217360c88854da9e0677b107f0257aab50bf4bf5522b544ba8f2a5a9ae6eb0966b2f39434c569ac327ea93d8538529d9c97331a4aa39660d8fe757b2636", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07b0e63dd247d4d5ca19c2476c6bf3c127540e87f23a57b7e9eec936cc9e21735c8832cfd4f26f97bd1ee8c714bb0b309e18ea8ac493bb504bd021294821d409", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3abf5b77e5992db3aa5ccaaebb07ea6411ddb543ac492fde503e04fddf8cdd9395eaf4159c2b561778ef3ce55215d994f76f28568377ab47f425deb902d137ad"} 17:04:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:04:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:04:10 INFO - Contents: 17:04:10 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88ca27b4d713c368bb6e29f32bdc68dc91ff979bcf70cf8648fb6047a0cd14039f590471df7051e0e81965e849ee2d41e08002c30180a8f3e7029d9cde5303aa", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bac98217360c88854da9e0677b107f0257aab50bf4bf5522b544ba8f2a5a9ae6eb0966b2f39434c569ac327ea93d8538529d9c97331a4aa39660d8fe757b2636", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07b0e63dd247d4d5ca19c2476c6bf3c127540e87f23a57b7e9eec936cc9e21735c8832cfd4f26f97bd1ee8c714bb0b309e18ea8ac493bb504bd021294821d409", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3abf5b77e5992db3aa5ccaaebb07ea6411ddb543ac492fde503e04fddf8cdd9395eaf4159c2b561778ef3ce55215d994f76f28568377ab47f425deb902d137ad"} 17:04:10 INFO - Running post-run listener: copy_logs_to_upload_dir 17:04:10 INFO - Copying logs to upload dir... 17:04:10 INFO - mkdir: /builds/slave/test/build/upload/logs 17:04:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1320.702614 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2017-05-28 17:04:10.407457) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-28 17:04:10.411096) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88ca27b4d713c368bb6e29f32bdc68dc91ff979bcf70cf8648fb6047a0cd14039f590471df7051e0e81965e849ee2d41e08002c30180a8f3e7029d9cde5303aa", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bac98217360c88854da9e0677b107f0257aab50bf4bf5522b544ba8f2a5a9ae6eb0966b2f39434c569ac327ea93d8538529d9c97331a4aa39660d8fe757b2636", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07b0e63dd247d4d5ca19c2476c6bf3c127540e87f23a57b7e9eec936cc9e21735c8832cfd4f26f97bd1ee8c714bb0b309e18ea8ac493bb504bd021294821d409", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3abf5b77e5992db3aa5ccaaebb07ea6411ddb543ac492fde503e04fddf8cdd9395eaf4159c2b561778ef3ce55215d994f76f28568377ab47f425deb902d137ad"} build_url:https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88ca27b4d713c368bb6e29f32bdc68dc91ff979bcf70cf8648fb6047a0cd14039f590471df7051e0e81965e849ee2d41e08002c30180a8f3e7029d9cde5303aa", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bac98217360c88854da9e0677b107f0257aab50bf4bf5522b544ba8f2a5a9ae6eb0966b2f39434c569ac327ea93d8538529d9c97331a4aa39660d8fe757b2636", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07b0e63dd247d4d5ca19c2476c6bf3c127540e87f23a57b7e9eec936cc9e21735c8832cfd4f26f97bd1ee8c714bb0b309e18ea8ac493bb504bd021294821d409", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3abf5b77e5992db3aa5ccaaebb07ea6411ddb543ac492fde503e04fddf8cdd9395eaf4159c2b561778ef3ce55215d994f76f28568377ab47f425deb902d137ad"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-28 17:04:10.435215) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 17:04:10.435528) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1496014757.716679-1654164451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 17:04:10.517577) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-28 17:04:10.517897) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-28 17:04:10.518183) ========= ========= Total master_lag: 0.14 =========