builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-084 starttime: 1503934308.15 results: success (0) revision: d5b6d113cf17f4c91b574eaa2d077a233bc4bc69 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-28 08:31:48.153668) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-28 08:31:48.154259) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-28 08:31:48.154609) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-28 08:31:48.221371) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-28 08:31:48.221841) ========= 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=ea65d483da93c827905c2090000001f5-1503934306.647693-818300802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-28 08:31:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.8M=0s 2017-08-28 08:31:48 (89.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.195828 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-28 08:31:48.434484) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-28 08:31:48.434921) ========= 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=ea65d483da93c827905c2090000001f5-1503934306.647693-818300802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015369 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-28 08:31:48.485446) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 26 secs) (at 2017-08-28 08:31:48.485863) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d5b6d113cf17f4c91b574eaa2d077a233bc4bc69 --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 d5b6d113cf17f4c91b574eaa2d077a233bc4bc69 --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=ea65d483da93c827905c2090000001f5-1503934306.647693-818300802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-28 08:31:48,421 truncating revision to first 12 chars 2017-08-28 08:31:48,421 Setting DEBUG logging. 2017-08-28 08:31:48,421 attempt 1/10 2017-08-28 08:31:48,421 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d5b6d113cf17?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-28 08:31:49,243 attempt 1/10 2017-08-28 08:31:49,760 current task status: no status available at this point. state: PENDING 2017-08-28 08:31:49,760 sleeping for 9.00s (attempt 1/10) 2017-08-28 08:31:58,770 attempt 2/10 2017-08-28 08:31:59,295 current task status: no status available at this point. state: PENDING 2017-08-28 08:31:59,295 sleeping for 14.50s (attempt 2/10) 2017-08-28 08:32:13,810 attempt 3/10 2017-08-28 08:32:14,141 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-28 08:32:14,385 unpacking tar archive at: mozilla-central-d5b6d113cf17/testing/mozharness/ program finished with exit code 0 elapsedTime=26.282557 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 26 secs) (at 2017-08-28 08:32:14.784259) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-28 08:32:14.784778) ========= script_repo_revision: d5b6d113cf17f4c91b574eaa2d077a233bc4bc69 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-28 08:32:14.785330) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-28 08:32:14.785743) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-28 08:32:14.800161) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-08-28 08:32:14.800677) ========= /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=ea65d483da93c827905c2090000001f5-1503934306.647693-818300802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:32:14 INFO - MultiFileLogger online at 20170828 08:32:14 in /builds/slave/test 08:32:14 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 08:32:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:32:14 INFO - {'append_to_log': False, 08:32:14 INFO - 'base_work_dir': '/builds/slave/test', 08:32:14 INFO - 'blob_upload_branch': 'Firefox', 08:32:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:32:14 INFO - 'branch': 'Firefox', 08:32:14 INFO - 'buildbot_json_path': 'buildprops.json', 08:32:14 INFO - 'code_coverage': False, 08:32:14 INFO - 'config_files': ('talos/linux_config.py',), 08:32:14 INFO - 'default_actions': ('clobber', 08:32:14 INFO - 'read-buildbot-config', 08:32:14 INFO - 'download-and-extract', 08:32:14 INFO - 'populate-webroot', 08:32:14 INFO - 'create-virtualenv', 08:32:14 INFO - 'install', 08:32:14 INFO - 'setup-mitmproxy', 08:32:14 INFO - 'run-tests'), 08:32:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:32:14 INFO - 'disable_ccov_upload': False, 08:32:14 INFO - 'download_minidump_stackwalk': True, 08:32:14 INFO - 'download_symbols': 'ondemand', 08:32:14 INFO - 'enable_stylo': False, 08:32:14 INFO - 'enable_webrender': False, 08:32:14 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 08:32:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:32:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:32:14 INFO - 'gecko_profile': False, 08:32:14 INFO - 'gecko_profile_interval': 0, 08:32:14 INFO - 'installer_path': 'installer.exe', 08:32:14 INFO - 'log_level': 'info', 08:32:14 INFO - 'log_name': 'talos', 08:32:14 INFO - 'log_to_console': True, 08:32:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:32:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:32:14 INFO - 'opt_config_files': (), 08:32:14 INFO - 'pip_index': False, 08:32:14 INFO - 'suite': 'dromaeojs-e10s', 08:32:14 INFO - 'system_bits': '32', 08:32:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:32:14 INFO - 'title': 'talos-linux64-ix-084', 08:32:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:32:14 INFO - 'use_talos_json': True, 08:32:14 INFO - 'verify': 'False', 08:32:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:32:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:32:14 INFO - 'work_dir': 'build'} 08:32:14 INFO - [mozharness: 2017-08-28 15:32:14.977913Z] Running clobber step. 08:32:14 INFO - Running pre-action listener: _resource_record_pre_action 08:32:14 INFO - Running main action method: clobber 08:32:14 INFO - rmtree: /builds/slave/test/build 08:32:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:32:15 INFO - Running post-action listener: _resource_record_post_action 08:32:15 INFO - [mozharness: 2017-08-28 15:32:15.940108Z] Finished clobber step (success) 08:32:15 INFO - [mozharness: 2017-08-28 15:32:15.940263Z] Running read-buildbot-config step. 08:32:15 INFO - Running pre-action listener: _resource_record_pre_action 08:32:15 INFO - Running main action method: read_buildbot_config 08:32:15 INFO - Using buildbot properties: 08:32:15 INFO - { 08:32:15 INFO - "project": "", 08:32:15 INFO - "product": "firefox", 08:32:15 INFO - "who": "archaeopteryx@coole-files.de", 08:32:15 INFO - "installer_path": "public/build/target.tar.bz2", 08:32:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 08:32:15 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 08:32:15 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 08:32:15 INFO - "stage_platform": "linux64-qr", 08:32:15 INFO - "basedir": "/builds/slave/test", 08:32:15 INFO - "buildnumber": 19, 08:32:15 INFO - "platform": "ubuntu64_hw_qr", 08:32:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:32:15 INFO - "slavebuilddir": "test", 08:32:15 INFO - "taskId": "ZP36Knd2S-6Ila_CR8vg0w", 08:32:15 INFO - "branch": "mozilla-central", 08:32:15 INFO - "script_repo_revision": "production", 08:32:15 INFO - "revision": "d5b6d113cf17f4c91b574eaa2d077a233bc4bc69", 08:32:15 INFO - "slavename": "talos-linux64-ix-084", 08:32:15 INFO - "repo_path": "mozilla-central" 08:32:15 INFO - } 08:32:15 INFO - Finding installer, test and symbols from parent task. 08:32:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZP36Knd2S-6Ila_CR8vg0w'}, attempt #1 08:32:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZP36Knd2S-6Ila_CR8vg0w'}, attempt #1 08:32:16 INFO - Task dependencies: Sv4qr0ycSAaRWiVssPK9WA 08:32:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sv4qr0ycSAaRWiVssPK9WA'}, attempt #1 08:32:17 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.tar.bz2 08:32:17 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.test_packages.json 08:32:17 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.crashreporter-symbols.zip 08:32:17 INFO - Running post-action listener: _resource_record_post_action 08:32:17 INFO - [mozharness: 2017-08-28 15:32:17.324423Z] Finished read-buildbot-config step (success) 08:32:17 INFO - [mozharness: 2017-08-28 15:32:17.324640Z] Running download-and-extract step. 08:32:17 INFO - Running pre-action listener: _resource_record_pre_action 08:32:17 INFO - Running main action method: download_and_extract 08:32:17 INFO - mkdir: /builds/slave/test/build/tests 08:32:17 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')]} 08:32:17 INFO - trying https://queue.taskcluster.net/v1/task/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.test_packages.json 08:32:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:32:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:32:17 INFO - Downloaded 989 bytes. 08:32:17 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:32:17 INFO - Using the following test package requirements: 08:32:17 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:32:17 INFO - u'common': [u'target.common.tests.zip'], 08:32:17 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:32:17 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:32:17 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:32:17 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:32:17 INFO - u'mozbase': [u'target.common.tests.zip'], 08:32:17 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:32:17 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:32:17 INFO - u'web-platform': [u'target.common.tests.zip', 08:32:17 INFO - u'target.web-platform.tests.tar.gz'], 08:32:17 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:32:17 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:32:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.common.tests.zip 08:32:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:32:17 INFO - Fetch https://queue.taskcluster.net/v1/task/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.common.tests.zip into memory 08:32:19 INFO - Content-Length response header: 54977971 08:32:19 INFO - Bytes received: 54977971 08:32:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:32:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.common.tests.zip 08:32:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:32:30 INFO - Fetch https://queue.taskcluster.net/v1/task/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.common.tests.zip into memory 08:32:31 INFO - Content-Length response header: 54977971 08:32:31 INFO - Bytes received: 54977971 08:32:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.talos.tests.zip 08:32:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:32:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.talos.tests.zip into memory 08:32:45 INFO - Content-Length response header: 14496611 08:32:45 INFO - Bytes received: 14496611 08:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:45 INFO - trying https://queue.taskcluster.net/v1/task/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.tar.bz2 08:32:45 INFO - Downloading https://queue.taskcluster.net/v1/task/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:32:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:32:46 INFO - Downloaded 61081399 bytes. 08:32:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.tar.bz2 08:32:46 INFO - mkdir: /builds/slave/test/properties 08:32:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:32:46 INFO - Writing to file /builds/slave/test/properties/build_url 08:32:46 INFO - Contents: 08:32:46 INFO - build_url:https://queue.taskcluster.net/v1/task/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.tar.bz2 08:32:46 INFO - Running post-action listener: _resource_record_post_action 08:32:46 INFO - Running post-action listener: find_tests_for_verification 08:32:46 INFO - Running post-action listener: set_extra_try_arguments 08:32:46 INFO - [mozharness: 2017-08-28 15:32:46.693655Z] Finished download-and-extract step (success) 08:32:46 INFO - [mozharness: 2017-08-28 15:32:46.693752Z] Running populate-webroot step. 08:32:46 INFO - Running pre-action listener: _resource_record_pre_action 08:32:46 INFO - Running main action method: populate_webroot 08:32:46 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:32:46 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 08:32:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:32:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:32:46 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 08:32:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:32:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:32:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:46 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:32:46 INFO - 'talos_options': ['--stylo'], 08:32:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:32:46 INFO - 'tests': ['damp', 'tps']}, 08:32:46 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:32:46 INFO - 'talos_options': ['--stylo'], 08:32:46 INFO - 'tests': ['damp', 'tps']}, 08:32:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:32:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:32:46 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 08:32:46 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:32:46 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:32:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:32:46 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:32:46 INFO - 'talos_options': ['--stylo'], 08:32:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:32:46 INFO - 'other-e10s': {'tests': ['a11yr', 08:32:46 INFO - 'ts_paint', 08:32:46 INFO - 'tpaint', 08:32:46 INFO - 'sessionrestore', 08:32:46 INFO - 'sessionrestore_many_windows', 08:32:46 INFO - 'sessionrestore_no_auto_restore', 08:32:46 INFO - 'tabpaint']}, 08:32:46 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 08:32:46 INFO - 'tests': ['a11yr', 08:32:46 INFO - 'ts_paint', 08:32:46 INFO - 'tpaint', 08:32:46 INFO - 'sessionrestore', 08:32:46 INFO - 'sessionrestore_many_windows', 08:32:46 INFO - 'sessionrestore_no_auto_restore', 08:32:46 INFO - 'tabpaint']}, 08:32:46 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:32:46 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 08:32:46 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 08:32:46 INFO - 'tests': ['bloom_basic_singleton']}, 08:32:46 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 08:32:46 INFO - 'tests': ['bloom_basic']}, 08:32:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:32:46 INFO - 'tsvgr_opacity', 08:32:46 INFO - 'tart', 08:32:46 INFO - 'tscrollx', 08:32:46 INFO - 'tsvg_static']}, 08:32:46 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 08:32:46 INFO - 'tests': ['tsvgx', 08:32:46 INFO - 'tsvgr_opacity', 08:32:46 INFO - 'tart', 08:32:46 INFO - 'tscrollx', 08:32:46 INFO - 'tsvg_static']}, 08:32:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:32:46 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:32:46 INFO - 'talos_options': ['--stylo'], 08:32:46 INFO - 'tests': ['tp5o']}, 08:32:46 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:32:46 INFO - 'talos_options': ['--mitmproxy', 08:32:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:32:46 INFO - '--firstNonBlankPaint'], 08:32:46 INFO - 'tests': ['tp6_google', 08:32:46 INFO - 'tp6_youtube', 08:32:46 INFO - 'tp6_amazon', 08:32:46 INFO - 'tp6_facebook']}, 08:32:46 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:32:46 INFO - 'talos_options': ['--stylo', 08:32:46 INFO - '--mitmproxy', 08:32:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:32:46 INFO - '--firstNonBlankPaint'], 08:32:46 INFO - 'tests': ['tp6_google', 08:32:46 INFO - 'tp6_youtube', 08:32:46 INFO - 'tp6_amazon', 08:32:46 INFO - 'tp6_facebook']}, 08:32:46 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:32:46 INFO - 'talos_options': ['--stylo', 08:32:46 INFO - '--stylo-threads=1', 08:32:46 INFO - '--mitmproxy', 08:32:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:32:46 INFO - '--firstNonBlankPaint'], 08:32:46 INFO - 'tests': ['tp6_google', 08:32:46 INFO - 'tp6_youtube', 08:32:46 INFO - 'tp6_amazon', 08:32:46 INFO - 'tp6_facebook']}, 08:32:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:32:46 INFO - 'talos_options': ['--xperf_path', 08:32:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:46 INFO - 'tests': ['tp5n']}, 08:32:46 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:32:46 INFO - 'talos_options': ['--stylo', 08:32:46 INFO - '--xperf_path', 08:32:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:46 INFO - 'tests': ['tp5n']}}} 08:32:46 INFO - Running post-action listener: _resource_record_post_action 08:32:46 INFO - [mozharness: 2017-08-28 15:32:46.707801Z] Finished populate-webroot step (success) 08:32:46 INFO - [mozharness: 2017-08-28 15:32:46.707908Z] Running create-virtualenv step. 08:32:46 INFO - Running pre-action listener: _resource_record_pre_action 08:32:46 INFO - Running main action method: create_virtualenv 08:32:46 INFO - Creating virtualenv /builds/slave/test/build/venv 08:32:46 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:32:46 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 08:32:46 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:32:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:32:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:32:47 INFO - Installing distribute.............................................................................................................................................................................................done. 08:32:47 INFO - Installing pip...............done. 08:32:47 INFO - Return code: 0 08:32:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:32:48 INFO - Reading from file tmpfile_stdout 08:32:48 INFO - Output received: 08:32:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 08:32:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:32: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')]} 08:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32: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')]} 08:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2561a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2704f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2702130>, '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 0x2703030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27034c0>, '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': 'ea65d483da93c827905c2090000001f5-1503934306.647693-818300802', '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 08:32: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', 'pip>=1.5'] in /builds/slave/test/build 08:32: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 pip>=1.5 08:32:48 INFO - Using env: {'DISPLAY': ':0', 08:32:48 INFO - 'HOME': '/home/cltbld', 08:32:48 INFO - 'LANG': 'en_US.UTF-8', 08:32:48 INFO - 'LANGUAGE': 'en_US:en', 08:32:48 INFO - 'LOGNAME': 'cltbld', 08:32:48 INFO - 'MAIL': '/var/mail/cltbld', 08:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:48 INFO - 'MOZ_NO_REMOTE': '1', 08:32:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:48 INFO - 'NO_EM_RESTART': '1', 08:32:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:48 INFO - 'PWD': '/builds/slave/test', 08:32:48 INFO - 'SHELL': '/bin/bash', 08:32:48 INFO - 'SHLVL': '1', 08:32:48 INFO - 'TERM': 'linux', 08:32:48 INFO - 'TMOUT': '86400', 08:32:48 INFO - 'USER': 'cltbld', 08:32:48 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1503934306.647693-818300802', 08:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:48 INFO - '_': '/tools/buildbot/bin/python'} 08:32:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 08:32:50 INFO - Downloading/unpacking pip>=1.5 08:32:50 INFO - Running setup.py egg_info for package pip 08:32:50 INFO - warning: no files found matching 'pip/cacert.pem' 08:32:50 INFO - warning: no files found matching '*.html' under directory 'docs' 08:32:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:32:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:32:50 INFO - Installing collected packages: pip 08:32:50 INFO - Found existing installation: pip 1.1 08:32:50 INFO - Uninstalling pip: 08:32:50 INFO - Successfully uninstalled pip 08:32:50 INFO - Running setup.py install for pip 08:32:50 INFO - warning: no files found matching 'pip/cacert.pem' 08:32:50 INFO - warning: no files found matching '*.html' under directory 'docs' 08:32:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:32:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:32:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 08:32:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 08:32:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 08:32:50 INFO - Successfully installed pip 08:32:50 INFO - Cleaning up... 08:32:50 INFO - Return code: 0 08:32:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:32:50 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')]} 08:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:50 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')]} 08:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32: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', '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 0x23961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2561a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2704f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2702130>, '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 0x2703030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27034c0>, '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': 'ea65d483da93c827905c2090000001f5-1503934306.647693-818300802', '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 08:32: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:32: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 psutil>=3.1.1 08:32:50 INFO - Using env: {'DISPLAY': ':0', 08:32:50 INFO - 'HOME': '/home/cltbld', 08:32:50 INFO - 'LANG': 'en_US.UTF-8', 08:32:50 INFO - 'LANGUAGE': 'en_US:en', 08:32:50 INFO - 'LOGNAME': 'cltbld', 08:32:50 INFO - 'MAIL': '/var/mail/cltbld', 08:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:50 INFO - 'MOZ_NO_REMOTE': '1', 08:32:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:50 INFO - 'NO_EM_RESTART': '1', 08:32:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:50 INFO - 'PWD': '/builds/slave/test', 08:32:50 INFO - 'SHELL': '/bin/bash', 08:32:50 INFO - 'SHLVL': '1', 08:32:50 INFO - 'TERM': 'linux', 08:32:50 INFO - 'TMOUT': '86400', 08:32:50 INFO - 'USER': 'cltbld', 08:32:50 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1503934306.647693-818300802', 08:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:50 INFO - '_': '/tools/buildbot/bin/python'} 08:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:50 INFO - Downloading/unpacking psutil>=3.1.1 08:32: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 08:32: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 08:32: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 08:32: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 08:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:32:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:32:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:32:51 INFO - Installing collected packages: psutil 08:32:51 INFO - Running setup.py install for psutil 08:32:51 INFO - building 'psutil._psutil_linux' extension 08:32:51 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 08:32:52 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 08:32:52 INFO - building 'psutil._psutil_posix' extension 08:32:52 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 08:32:53 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 08:32:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:32:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:32:53 INFO - Successfully installed psutil 08:32:53 INFO - Cleaning up... 08:32:53 INFO - Return code: 0 08:32:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:53 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 0x23961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2561a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2704f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2702130>, '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 0x2703030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27034c0>, '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': 'ea65d483da93c827905c2090000001f5-1503934306.647693-818300802', '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 08:32:53 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 08:32:53 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 08:32:53 INFO - Using env: {'DISPLAY': ':0', 08:32:53 INFO - 'HOME': '/home/cltbld', 08:32:53 INFO - 'LANG': 'en_US.UTF-8', 08:32:53 INFO - 'LANGUAGE': 'en_US:en', 08:32:53 INFO - 'LOGNAME': 'cltbld', 08:32:53 INFO - 'MAIL': '/var/mail/cltbld', 08:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:53 INFO - 'MOZ_NO_REMOTE': '1', 08:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:53 INFO - 'NO_EM_RESTART': '1', 08:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:53 INFO - 'PWD': '/builds/slave/test', 08:32:53 INFO - 'SHELL': '/bin/bash', 08:32:53 INFO - 'SHLVL': '1', 08:32:53 INFO - 'TERM': 'linux', 08:32:53 INFO - 'TMOUT': '86400', 08:32:53 INFO - 'USER': 'cltbld', 08:32:53 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1503934306.647693-818300802', 08:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:53 INFO - '_': '/tools/buildbot/bin/python'} 08:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:32:53 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 08:32:53 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 08:32:53 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 08:32:53 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 08:32:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:32:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:32:54 INFO - Installing collected packages: mozsystemmonitor 08:32:54 INFO - Running setup.py install for mozsystemmonitor 08:32:54 INFO - Successfully installed mozsystemmonitor 08:32:54 INFO - Cleaning up... 08:32:54 INFO - Return code: 0 08:32:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:32:54 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')]} 08:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:54 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')]} 08:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x23961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2561a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2704f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2702130>, '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 0x2703030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27034c0>, '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': 'ea65d483da93c827905c2090000001f5-1503934306.647693-818300802', '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 08:32:54 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 08:32:54 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 08:32:54 INFO - Using env: {'DISPLAY': ':0', 08:32:54 INFO - 'HOME': '/home/cltbld', 08:32:54 INFO - 'LANG': 'en_US.UTF-8', 08:32:54 INFO - 'LANGUAGE': 'en_US:en', 08:32:54 INFO - 'LOGNAME': 'cltbld', 08:32:54 INFO - 'MAIL': '/var/mail/cltbld', 08:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:54 INFO - 'MOZ_NO_REMOTE': '1', 08:32:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:54 INFO - 'NO_EM_RESTART': '1', 08:32:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:54 INFO - 'PWD': '/builds/slave/test', 08:32:54 INFO - 'SHELL': '/bin/bash', 08:32:54 INFO - 'SHLVL': '1', 08:32:54 INFO - 'TERM': 'linux', 08:32:54 INFO - 'TMOUT': '86400', 08:32:54 INFO - 'USER': 'cltbld', 08:32:54 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1503934306.647693-818300802', 08:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:54 INFO - '_': '/tools/buildbot/bin/python'} 08:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:54 INFO - Downloading/unpacking jsonschema==2.5.1 08:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:32:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:56 INFO - Downloading functools32-3.2.3-2.tar.gz 08:32:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:32:56 INFO - warning: no files found matching '*.txt' 08:32:56 INFO - no previously-included directories found matching 'build' 08:32:56 INFO - no previously-included directories found matching 'dist' 08:32:56 INFO - no previously-included directories found matching '.git*' 08:32:56 INFO - Installing collected packages: jsonschema, functools32 08:32:56 INFO - Running setup.py install for functools32 08:32:56 INFO - warning: no files found matching '*.txt' 08:32:56 INFO - no previously-included directories found matching 'build' 08:32:56 INFO - no previously-included directories found matching 'dist' 08:32:56 INFO - no previously-included directories found matching '.git*' 08:32:56 INFO - Successfully installed jsonschema functools32 08:32:56 INFO - Cleaning up... 08:32:56 INFO - Return code: 0 08:32:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:32:56 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')]} 08:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:56 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')]} 08:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:56 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 0x23961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2561a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2704f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2702130>, '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 0x2703030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27034c0>, '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': 'ea65d483da93c827905c2090000001f5-1503934306.647693-818300802', '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 08:32:56 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 08:32:56 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 08:32:56 INFO - Using env: {'DISPLAY': ':0', 08:32:56 INFO - 'HOME': '/home/cltbld', 08:32:56 INFO - 'LANG': 'en_US.UTF-8', 08:32:56 INFO - 'LANGUAGE': 'en_US:en', 08:32:56 INFO - 'LOGNAME': 'cltbld', 08:32:56 INFO - 'MAIL': '/var/mail/cltbld', 08:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:56 INFO - 'MOZ_NO_REMOTE': '1', 08:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:56 INFO - 'NO_EM_RESTART': '1', 08:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:56 INFO - 'PWD': '/builds/slave/test', 08:32:56 INFO - 'SHELL': '/bin/bash', 08:32:56 INFO - 'SHLVL': '1', 08:32:56 INFO - 'TERM': 'linux', 08:32:56 INFO - 'TMOUT': '86400', 08:32:56 INFO - 'USER': 'cltbld', 08:32:56 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1503934306.647693-818300802', 08:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:56 INFO - '_': '/tools/buildbot/bin/python'} 08:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:32:56 INFO - Cleaning up... 08:32:56 INFO - Return code: 0 08:32:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:32:56 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')]} 08:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:56 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')]} 08:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:56 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 0x23961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2561a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2704f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2702130>, '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 0x2703030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27034c0>, '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': 'ea65d483da93c827905c2090000001f5-1503934306.647693-818300802', '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 08:32:56 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 08:32:56 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 08:32:56 INFO - Using env: {'DISPLAY': ':0', 08:32:56 INFO - 'HOME': '/home/cltbld', 08:32:56 INFO - 'LANG': 'en_US.UTF-8', 08:32:56 INFO - 'LANGUAGE': 'en_US:en', 08:32:56 INFO - 'LOGNAME': 'cltbld', 08:32:56 INFO - 'MAIL': '/var/mail/cltbld', 08:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:56 INFO - 'MOZ_NO_REMOTE': '1', 08:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:56 INFO - 'NO_EM_RESTART': '1', 08:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:56 INFO - 'PWD': '/builds/slave/test', 08:32:56 INFO - 'SHELL': '/bin/bash', 08:32:56 INFO - 'SHLVL': '1', 08:32:56 INFO - 'TERM': 'linux', 08:32:56 INFO - 'TMOUT': '86400', 08:32:56 INFO - 'USER': 'cltbld', 08:32:56 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1503934306.647693-818300802', 08:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:56 INFO - '_': '/tools/buildbot/bin/python'} 08:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:56 INFO - Downloading/unpacking blobuploader==1.2.4 08:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:57 INFO - Downloading blobuploader-1.2.4.tar.gz 08:32:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:32:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:32: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 08:32: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 08:32: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 08:32: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 08:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:32:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:32: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 08:32: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 08:32: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 08:32: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 08:32:58 INFO - Downloading docopt-0.6.1.tar.gz 08:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:32:58 INFO - Installing collected packages: blobuploader, requests, docopt 08:32:58 INFO - Running setup.py install for blobuploader 08:32:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:32:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:32:58 INFO - Running setup.py install for requests 08:32:58 INFO - Running setup.py install for docopt 08:32:59 INFO - Successfully installed blobuploader requests docopt 08:32:59 INFO - Cleaning up... 08:32:59 INFO - Return code: 0 08:32:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32:59 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')]} 08:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:59 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')]} 08:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:59 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 0x23961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2561a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2704f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2702130>, '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 0x2703030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27034c0>, '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': 'ea65d483da93c827905c2090000001f5-1503934306.647693-818300802', '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 08:32:59 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 08:32:59 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 08:32:59 INFO - Using env: {'DISPLAY': ':0', 08:32:59 INFO - 'HOME': '/home/cltbld', 08:32:59 INFO - 'LANG': 'en_US.UTF-8', 08:32:59 INFO - 'LANGUAGE': 'en_US:en', 08:32:59 INFO - 'LOGNAME': 'cltbld', 08:32:59 INFO - 'MAIL': '/var/mail/cltbld', 08:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:59 INFO - 'MOZ_NO_REMOTE': '1', 08:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:59 INFO - 'NO_EM_RESTART': '1', 08:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:59 INFO - 'PWD': '/builds/slave/test', 08:32:59 INFO - 'SHELL': '/bin/bash', 08:32:59 INFO - 'SHLVL': '1', 08:32:59 INFO - 'TERM': 'linux', 08:32:59 INFO - 'TMOUT': '86400', 08:32:59 INFO - 'USER': 'cltbld', 08:32:59 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1503934306.647693-818300802', 08:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:59 INFO - '_': '/tools/buildbot/bin/python'} 08:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:32:59 INFO - Running setup.py (path:/tmp/pip-wH9lls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:32:59 INFO - Running setup.py (path:/tmp/pip-gzpA0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:32:59 INFO - Running setup.py (path:/tmp/pip-pomatZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:32:59 INFO - Running setup.py (path:/tmp/pip-vM8cGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:32:59 INFO - Running setup.py (path:/tmp/pip-IrUIJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:32:59 INFO - Running setup.py (path:/tmp/pip-mZfSdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:32:59 INFO - Running setup.py (path:/tmp/pip-fjk6cV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:32:59 INFO - Running setup.py (path:/tmp/pip-oH_Cx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:32:59 INFO - Running setup.py (path:/tmp/pip-5nZkXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:32:59 INFO - Running setup.py (path:/tmp/pip-hGs4JE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:33:00 INFO - Running setup.py (path:/tmp/pip-ayoPHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:33:00 INFO - Running setup.py (path:/tmp/pip-tVBhYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:33:00 INFO - Running setup.py (path:/tmp/pip-Gv2QWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:33:00 INFO - Running setup.py (path:/tmp/pip-QHiAFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:00 INFO - Running setup.py (path:/tmp/pip-7VXm2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:33:00 INFO - Running setup.py (path:/tmp/pip-_GIOpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:33:00 INFO - Running setup.py (path:/tmp/pip-UkJaqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:33:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:33:00 INFO - Running setup.py install for manifestparser 08:33:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:33:00 INFO - Running setup.py install for mozcrash 08:33:00 INFO - Running setup.py install for mozdebug 08:33:00 INFO - Running setup.py install for mozdevice 08:33:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:33:00 INFO - Running setup.py install for mozfile 08:33:01 INFO - Running setup.py install for mozhttpd 08:33:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:33:01 INFO - Running setup.py install for mozinfo 08:33:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:33:01 INFO - Running setup.py install for mozInstall 08:33:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:33:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:33:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:33:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:33:01 INFO - Running setup.py install for mozleak 08:33:01 INFO - Running setup.py install for mozlog 08:33:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:33:01 INFO - Running setup.py install for moznetwork 08:33:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:33:01 INFO - Running setup.py install for mozprocess 08:33:01 INFO - Running setup.py install for mozprofile 08:33:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:33:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:33:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:33:01 INFO - Running setup.py install for mozrunner 08:33:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:33:02 INFO - Running setup.py install for mozscreenshot 08:33:02 INFO - Running setup.py install for moztest 08:33:02 INFO - Running setup.py install for mozversion 08:33:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:33:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:33:02 INFO - Cleaning up... 08:33:02 INFO - Return code: 0 08:33:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:02 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')]} 08:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:02 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')]} 08:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:02 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 0x23961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2561a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2704f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2702130>, '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 0x2703030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27034c0>, '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': 'ea65d483da93c827905c2090000001f5-1503934306.647693-818300802', '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 08:33:02 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 08:33:02 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 08:33:02 INFO - Using env: {'DISPLAY': ':0', 08:33:02 INFO - 'HOME': '/home/cltbld', 08:33:02 INFO - 'LANG': 'en_US.UTF-8', 08:33:02 INFO - 'LANGUAGE': 'en_US:en', 08:33:02 INFO - 'LOGNAME': 'cltbld', 08:33:02 INFO - 'MAIL': '/var/mail/cltbld', 08:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:02 INFO - 'MOZ_NO_REMOTE': '1', 08:33:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:02 INFO - 'NO_EM_RESTART': '1', 08:33:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:02 INFO - 'PWD': '/builds/slave/test', 08:33:02 INFO - 'SHELL': '/bin/bash', 08:33:02 INFO - 'SHLVL': '1', 08:33:02 INFO - 'TERM': 'linux', 08:33:02 INFO - 'TMOUT': '86400', 08:33:02 INFO - 'USER': 'cltbld', 08:33:02 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1503934306.647693-818300802', 08:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:02 INFO - '_': '/tools/buildbot/bin/python'} 08:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:33:02 INFO - Running setup.py (path:/tmp/pip-MfCET8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:33:02 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)) 08:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:33:02 INFO - Running setup.py (path:/tmp/pip-ical3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:33:02 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)) 08:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:33:02 INFO - Running setup.py (path:/tmp/pip-R_i5jz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:33:02 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)) 08:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:33:02 INFO - Running setup.py (path:/tmp/pip-v3u3oz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:33:02 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)) 08:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:33:02 INFO - Running setup.py (path:/tmp/pip-MDrISO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:33:02 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)) 08:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:33:02 INFO - Running setup.py (path:/tmp/pip-Tf_qgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:33:02 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)) 08:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:33:02 INFO - Running setup.py (path:/tmp/pip-I9tqSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 08:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:33:03 INFO - Running setup.py (path:/tmp/pip-wLbpB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 08:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:33:03 INFO - Running setup.py (path:/tmp/pip-XV5g6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:33:03 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)) 08:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:33:03 INFO - Running setup.py (path:/tmp/pip-MrtXop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 08:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:33:03 INFO - Running setup.py (path:/tmp/pip-hYkOAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:33:03 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)) 08:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:33:03 INFO - Running setup.py (path:/tmp/pip-v9lXss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:33:03 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)) 08:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:33:03 INFO - Running setup.py (path:/tmp/pip-meZARK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:33:03 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)) 08:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:33:03 INFO - Running setup.py (path:/tmp/pip-u6PeIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:33:03 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)) 08:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:03 INFO - Running setup.py (path:/tmp/pip-OhY2NK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:03 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)) 08:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:33:03 INFO - Running setup.py (path:/tmp/pip-J1f4nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:33:03 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)) 08:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:33:03 INFO - Running setup.py (path:/tmp/pip-dFTKkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:33:03 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)) 08:33:03 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)) 08:33:03 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)) 08:33:03 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)) 08:33:03 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)) 08:33:03 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)) 08:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:33:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:04 INFO - Downloading blessings-1.6.tar.gz 08:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:33:04 INFO - Installing collected packages: blessings 08:33:04 INFO - Running setup.py install for blessings 08:33:05 INFO - Successfully installed blessings 08:33:05 INFO - Cleaning up... 08:33:05 INFO - Return code: 0 08:33:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:33:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:33:05 INFO - Reading from file tmpfile_stdout 08:33:05 INFO - Current package versions: 08:33:05 INFO - argparse == 1.2.1 08:33:05 INFO - blessings == 1.6 08:33:05 INFO - blobuploader == 1.2.4 08:33:05 INFO - docopt == 0.6.1 08:33:05 INFO - functools32 == 3.2.3-2 08:33:05 INFO - jsonschema == 2.5.1 08:33:05 INFO - manifestparser == 1.1 08:33:05 INFO - mozInstall == 1.13 08:33:05 INFO - mozcrash == 1.0 08:33:05 INFO - mozdebug == 0.1 08:33:05 INFO - mozdevice == 0.51 08:33:05 INFO - mozfile == 1.2 08:33:05 INFO - mozhttpd == 0.7 08:33:05 INFO - mozinfo == 0.10 08:33:05 INFO - mozleak == 0.1 08:33:05 INFO - mozlog == 3.5 08:33:05 INFO - moznetwork == 0.27 08:33:05 INFO - mozprocess == 0.25 08:33:05 INFO - mozprofile == 0.28 08:33:05 INFO - mozrunner == 6.13 08:33:05 INFO - mozscreenshot == 0.1 08:33:05 INFO - mozsystemmonitor == 0.3 08:33:05 INFO - moztest == 0.8 08:33:05 INFO - mozversion == 1.4 08:33:05 INFO - psutil == 3.1.1 08:33:05 INFO - requests == 1.2.3 08:33:05 INFO - wsgiref == 0.1.2 08:33:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:05 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')]} 08:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:05 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')]} 08:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:05 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 0x23961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2561a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2704f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2702130>, '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 0x2703030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27034c0>, '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': 'ea65d483da93c827905c2090000001f5-1503934306.647693-818300802', '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 08:33:05 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 08:33:05 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 08:33:05 INFO - Using env: {'DISPLAY': ':0', 08:33:05 INFO - 'HOME': '/home/cltbld', 08:33:05 INFO - 'LANG': 'en_US.UTF-8', 08:33:05 INFO - 'LANGUAGE': 'en_US:en', 08:33:05 INFO - 'LOGNAME': 'cltbld', 08:33:05 INFO - 'MAIL': '/var/mail/cltbld', 08:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:05 INFO - 'MOZ_NO_REMOTE': '1', 08:33:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:05 INFO - 'NO_EM_RESTART': '1', 08:33:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:05 INFO - 'PWD': '/builds/slave/test', 08:33:05 INFO - 'SHELL': '/bin/bash', 08:33:05 INFO - 'SHLVL': '1', 08:33:05 INFO - 'TERM': 'linux', 08:33:05 INFO - 'TMOUT': '86400', 08:33:05 INFO - 'USER': 'cltbld', 08:33:05 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1503934306.647693-818300802', 08:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:05 INFO - '_': '/tools/buildbot/bin/python'} 08:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:05 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)) 08:33:05 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)) 08:33:05 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)) 08:33:05 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)) 08:33:05 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)) 08:33:05 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)) 08:33:05 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)) 08:33:05 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)) 08:33:05 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)) 08:33:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:33:05 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 08:33:05 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 08:33:05 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 08:33:05 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 08:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:33:06 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)) 08:33:06 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)) 08:33:06 INFO - Installing collected packages: simplejson 08:33:06 INFO - Running setup.py install for simplejson 08:33:06 INFO - building 'simplejson._speedups' extension 08:33:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 08:33:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 08:33:07 INFO - Successfully installed simplejson 08:33:07 INFO - Cleaning up... 08:33:07 INFO - Return code: 0 08:33:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:33:07 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')]} 08:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:07 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')]} 08:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x23961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2561a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2704f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2702130>, '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 0x2703030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27034c0>, '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': 'ea65d483da93c827905c2090000001f5-1503934306.647693-818300802', '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 08:33:07 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 08:33:07 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 08:33:07 INFO - Using env: {'DISPLAY': ':0', 08:33:07 INFO - 'HOME': '/home/cltbld', 08:33:07 INFO - 'LANG': 'en_US.UTF-8', 08:33:07 INFO - 'LANGUAGE': 'en_US:en', 08:33:07 INFO - 'LOGNAME': 'cltbld', 08:33:07 INFO - 'MAIL': '/var/mail/cltbld', 08:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:07 INFO - 'MOZ_NO_REMOTE': '1', 08:33:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:07 INFO - 'NO_EM_RESTART': '1', 08:33:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:07 INFO - 'PWD': '/builds/slave/test', 08:33:07 INFO - 'SHELL': '/bin/bash', 08:33:07 INFO - 'SHLVL': '1', 08:33:07 INFO - 'TERM': 'linux', 08:33:07 INFO - 'TMOUT': '86400', 08:33:07 INFO - 'USER': 'cltbld', 08:33:07 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1503934306.647693-818300802', 08:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:07 INFO - '_': '/tools/buildbot/bin/python'} 08:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:33:08 INFO - Cleaning up... 08:33:08 INFO - Return code: 0 08:33:08 INFO - Running post-action listener: _resource_record_post_action 08:33:08 INFO - Running post-action listener: _start_resource_monitoring 08:33:08 INFO - Starting resource monitoring. 08:33:08 INFO - [mozharness: 2017-08-28 15:33:08.211633Z] Finished create-virtualenv step (success) 08:33:08 INFO - [mozharness: 2017-08-28 15:33:08.212721Z] Running install step. 08:33:08 INFO - Running pre-action listener: _resource_record_pre_action 08:33:08 INFO - Running main action method: install 08:33:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:33:08 INFO - Reading from file tmpfile_stdout 08:33:08 INFO - Detecting whether we're running mozinstall >=1.0... 08:33:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:33:08 INFO - Reading from file tmpfile_stdout 08:33:08 INFO - Output received: 08:33:08 INFO - Usage: mozinstall [options] installer 08:33:08 INFO - Options: 08:33:08 INFO - -h, --help show this help message and exit 08:33:08 INFO - -d DEST, --destination=DEST 08:33:08 INFO - Directory to install application into. [default: 08:33:08 INFO - "/builds/slave/test"] 08:33:08 INFO - --app=APP Application being installed. [default: firefox] 08:33:08 INFO - mkdir: /builds/slave/test/build/application 08:33:08 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'] 08:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:33:26 INFO - Reading from file tmpfile_stdout 08:33:26 INFO - Output received: 08:33:26 INFO - /builds/slave/test/build/application/firefox/firefox 08:33:26 INFO - Running post-action listener: _resource_record_post_action 08:33:26 INFO - [mozharness: 2017-08-28 15:33:26.385061Z] Finished install step (success) 08:33:26 INFO - [mozharness: 2017-08-28 15:33:26.385345Z] Running setup-mitmproxy step. 08:33:26 INFO - Running pre-action listener: _resource_record_pre_action 08:33:26 INFO - Running main action method: setup_mitmproxy 08:33:26 INFO - Skipping: mitmproxy is not required 08:33:26 INFO - Running post-action listener: _resource_record_post_action 08:33:26 INFO - [mozharness: 2017-08-28 15:33:26.386459Z] Finished setup-mitmproxy step (success) 08:33:26 INFO - [mozharness: 2017-08-28 15:33:26.386677Z] Running run-tests step. 08:33:26 INFO - Running pre-action listener: _resource_record_pre_action 08:33:26 INFO - Running pre-action listener: _set_gcov_prefix 08:33:26 INFO - Running main action method: run_tests 08:33:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:33:26 INFO - Python 2.7.3 08:33:26 INFO - Return code: 0 08:33:26 INFO - grabbing minidump binary from tooltool 08:33:26 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')]} 08:33:26 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x2702130>, '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 0x2703030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27034c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:33:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 08:33:26 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:33:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 08:33:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:33:26 INFO - Return code: 0 08:33:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:33:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:33:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:33:26 INFO - ENV: RUST_BACKTRACE is now full 08:33:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:33:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:33:26 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/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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 08:33:26 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/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-084 --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 08:33:26 INFO - Using env: {'DISPLAY': ':0', 08:33:26 INFO - 'HOME': '/home/cltbld', 08:33:26 INFO - 'LANG': 'en_US.UTF-8', 08:33:26 INFO - 'LANGUAGE': 'en_US:en', 08:33:26 INFO - 'LOGNAME': 'cltbld', 08:33:26 INFO - 'MAIL': '/var/mail/cltbld', 08:33:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:33:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:33:26 INFO - 'MOZ_ACCELERATED': '1', 08:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:26 INFO - 'MOZ_NO_REMOTE': '1', 08:33:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:33:26 INFO - 'MOZ_WEBRENDER': '1', 08:33:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:26 INFO - 'NO_EM_RESTART': '1', 08:33:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:26 INFO - 'PWD': '/builds/slave/test', 08:33:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:33:26 INFO - 'RUST_BACKTRACE': 'full', 08:33:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:33:26 INFO - 'SHELL': '/bin/bash', 08:33:26 INFO - 'SHLVL': '1', 08:33:26 INFO - 'TERM': 'linux', 08:33:26 INFO - 'TMOUT': '86400', 08:33:26 INFO - 'USER': 'cltbld', 08:33:26 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1503934306.647693-818300802', 08:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:26 INFO - '_': '/tools/buildbot/bin/python'} 08:33:26 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/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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 08:33:26 INFO - mozversion application_buildid: 20170828144704 08:33:26 INFO - mozversion application_changeset: d5b6d113cf17f4c91b574eaa2d077a233bc4bc69 08:33:26 INFO - mozversion application_display_name: Nightly 08:33:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:33:26 INFO - mozversion application_name: Firefox 08:33:26 INFO - mozversion application_remotingname: firefox 08:33:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:33:26 INFO - mozversion application_vendor: Mozilla 08:33:26 INFO - mozversion application_version: 57.0a1 08:33:26 INFO - mozversion platform_buildid: 20170828144704 08:33:26 INFO - mozversion platform_changeset: d5b6d113cf17f4c91b574eaa2d077a233bc4bc69 08:33:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:33:26 INFO - mozversion platform_version: 57.0a1 08:33:26 INFO - using testdate: 1503934406 08:33:26 INFO - actual date: 1503934406 08:33:26 INFO - starting webserver on 'localhost:41340' 08:33:26 INFO - SUITE-START | Running 2 tests 08:33:26 INFO - TEST-START | dromaeo_css 08:33:26 INFO - Initialising browser for dromaeo_css test... 08:33:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41340/getInfo.html -profile /tmp/tmpBaUpDG/profile 08:33:26 INFO - TEST-INFO | started process 3429 (/builds/slave/test/build/application/firefox/firefox http://localhost:41340/getInfo.html) 08:33:37 INFO - TEST-INFO | 3429: exit 0 08:33:37 INFO - Browser initialized. 08:33:37 INFO - Running cycle 1/1 for dromaeo_css test... 08:33:37 INFO - Using env: {'DISPLAY': ':0', 08:33:37 INFO - 'HOME': '/home/cltbld', 08:33:37 INFO - 'JSGC_DISABLE_POISONING': '1', 08:33:37 INFO - 'LANG': 'en_US.UTF-8', 08:33:37 INFO - 'LANGUAGE': 'en_US:en', 08:33:37 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:33:37 INFO - 'LOGNAME': 'cltbld', 08:33:37 INFO - 'MAIL': '/var/mail/cltbld', 08:33:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:33:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:33:37 INFO - 'MOZ_ACCELERATED': '1', 08:33:37 INFO - 'MOZ_CRASHREPORTER': '1', 08:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:37 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:33:37 INFO - 'MOZ_NO_REMOTE': '1', 08:33:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:33:37 INFO - 'MOZ_WEBRENDER': '1', 08:33:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:37 INFO - 'NO_EM_RESTART': '1', 08:33:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:37 INFO - 'PWD': '/builds/slave/test', 08:33:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:33:37 INFO - 'RUST_BACKTRACE': 'full', 08:33:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:33:37 INFO - 'SHELL': '/bin/bash', 08:33:37 INFO - 'SHLVL': '1', 08:33:37 INFO - 'TERM': 'linux', 08:33:37 INFO - 'TMOUT': '86400', 08:33:37 INFO - 'USER': 'cltbld', 08:33:37 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1503934306.647693-818300802', 08:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:37 INFO - '_': '/tools/buildbot/bin/python'} 08:33:37 INFO - TEST-INFO | started process 3609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBaUpDG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:33:38 INFO - PID 3609 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 08:33:38 INFO - PID 3609 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 08:33:38 INFO - PID 3609 | 08:33:38 INFO - PID 3609 | (/builds/slave/test/build/application/firefox/firefox:3669): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:33:38 INFO - PID 3609 | 08:33:49 INFO - PID 3609 | RSS: Main: 206737408 08:33:49 INFO - PID 3609 | 08:33:52 INFO - PID 3609 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 08:36:47 INFO - PID 3609 | Cycle 1(1): loaded http://localhost:41340/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41340/tests/dromaeo/cssquery-ext.html) 08:36:49 INFO - PID 3609 | RSS: Main: 216199168 08:36:49 INFO - PID 3609 | 08:39:52 INFO - PID 3609 | Cycle 1(1): loaded http://localhost:41340/tests/dromaeo/cssquery-ext.html (next: http://localhost:41340/tests/dromaeo/cssquery-jquery.html) 08:39:52 INFO - PID 3609 | RSS: Main: 215961600 08:39:52 INFO - PID 3609 | 08:42:54 INFO - PID 3609 | Cycle 1(1): loaded http://localhost:41340/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41340/tests/dromaeo/cssquery-mootools.html) 08:42:55 INFO - PID 3609 | RSS: Main: 215437312 08:42:55 INFO - PID 3609 | 08:45:57 INFO - PID 3609 | Cycle 1(1): loaded http://localhost:41340/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41340/tests/dromaeo/cssquery-prototype.html) 08:45:58 INFO - PID 3609 | RSS: Main: 216924160 08:45:58 INFO - PID 3609 | 08:49:01 INFO - PID 3609 | Cycle 1(1): loaded http://localhost:41340/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41340/tests/dromaeo/cssquery-yui.html) 08:49:02 INFO - PID 3609 | RSS: Main: 215142400 08:49:02 INFO - PID 3609 | 08:52:04 INFO - PID 3609 | Cycle 1(1): loaded http://localhost:41340/tests/dromaeo/cssquery-yui.html (next: http://localhost:41340/tests/dromaeo/cssquery-dojo.html) 08:52:04 INFO - PID 3609 | RSS: Main: 221331456 08:52:04 INFO - PID 3609 | 08:52:04 INFO - PID 3609 | __start_tp_report 08:52:04 INFO - PID 3609 | _x_x_mozilla_page_load 08:52:04 INFO - PID 3609 | _x_x_mozilla_page_load_details 08:52:04 INFO - PID 3609 | |i|pagename|runs| 08:52:04 INFO - PID 3609 | |0;dojo.html;3320.1201681554394;3326.434506133957;3332.5501057357255;3336.199312165081;3352.3127758809414;6167;6293.937060629398;6303.3381494943005;6338.619682819029;6353.745850165999;6250.5937114087665;6253.155823963763;6272.749090036393;6283.780067697631;6317.494600431966;5720.1991721159075;5728.68492232927;5746.425357464262;5773.826785196451;5833.766649334021;5861.824145275648;5880.97059514704;5894.056950887859;5897.587168898157;5902.468777809996;5816.302043754756;5859.560532960024;5906.793262235823;5915.556333275;5951.077582974624;1.1760928548830794;5355.518003379714;5698.40166782486;5768.826935191909;5926.229590153295;5734.082546792493;5782.768689252425;5789.594728369016;5856.326522449887;5866.794662186846;6204.193454850885;6257.342978987186;6317.368263173692;6424.743010279583;6424.839379015515;6798.66006699663;6825.078614387044;6897;6901.654917254117;6904.10246667935;6862.965685171592;6879.105716256905;6884.449244060464;6986;6986.336298051728;6228.408301211378;6345;6373.7450501979865;6439.678016099177;6442.838929026765;6970.721171153097;6973.686184121727;6979.127609048869;6980.057692211588;6984.196817365966;6589;6662.933370666328;6678;6678.966605166943;6682.599044057372;6044.399168046189;6738;6759.695813688396;6765.695543700545;6789.694463749044;6703.865922681519;6711.362420570038;6750.966245168743;6816.284290149463;6872.244053154149;6799.286074962157;6805.081314022643;6875;6881.208661003949;6883.449324054063;5328.626996110313;5330.360356757214;5397.811076612378;5407.540359069523;5412.269343638637;4774.379330686988;4791.137595232822;4813.109574728686;4822.469528351879;4841.104395686809;6000.489958353502;6006.249218847644;6006.339302676702;6021.819345419644;6048.909266361008;6794.8641027180165;6825.283345248777;6841.281665425158;6918.169819621678;6950.930490695028;5866.472017518444;5893.057110862242;5970.373110823388;6031.276246850406;6040.124181993587;5790.392008839011;5829.213056237439;5863.67749773758;5912.3496415394275;5922.644641321534;6445.452136568444;6565.474762019027;6575.572587781779;6576.8355791105605;6610.8016759497295;6772;6794.966025169842;6822.351876571718;6847.554908930903;6906.06768086312;6438.871222575429;6512.185976752906;6521.34786521363;6608.4052435281055;6608.735650574115;6588.308227636221;6646.966765166143;6648.9002664961035;6652.567583107082;6669.46644268467;6720.798376048726;6764.120664313607;6792.796216113525;6808.62552559614;6810.727570897108;6557.114789503356;6569.638669873203;6580.80257592273;6620.602763834186;6624.867502650017;6556.508261880283;6587.868242635216;6596.208454985433;6619.0733297339375;6699.5310328276555;6388.8083357499345;6502.252240992347;6542.051402546699;6644.368784965421;6666.500012498985;6408.743650253938;6580.440662543738;6635.63504007265;6760.357766012221;6770.796876093725;6442.935570644234;6452.290248072803;6526.575772574767;6545.247296560957;6549.934500654933 08:52:04 INFO - PID 3609 | |1;ext.html;649.2792999770254;729.2598013016789;746.4737360161085;748.9812754681136;750.5721738608995;30712.692873071264;31595.21011974702;39241.803790981074;40172.397414038816;40235.79882100593;40122;40204.19591608166;40553.39169912446;40591.59408405915;40676.18647627046;7588.848223035536;7655.08139023318;7658.655360508763;7838.804029899241;7882.921170788276;7738.226177382273;7853.293203611674;7878.527288362688;7880.093789214227;7881.881771773428;7784.299413052824;7810.921890781105;7840.176781437953;7920.960395198016;7928.524288542677;7784.532928024309;7790.688372465152;7805.687772489094;7810.297073263405;7826.882596761053;7725.188855170239;7783.922160778377;7790.143084260783;7799.805004874866;7799.805004874866;36543.81728091369;36594.81702591496;36985;37001.62998370035;37024.25951480982;3384.4923261510726;3399.1841957930164;3448.2413868948793;3451.861925522976;3459.066052165926;30127.849360753054;30408.695913040807;30449.391012179854;30453.390932181454;30465;5021.57316628087;5126.436092029874;5156.793728250866;5164.922526162073;5206.557442617382;174918;175523;177019.11490442595;177682;178002;45684.314735279;45984.5401545987;45987.77006114948;46006.76996615063;46007.53992460033;48140.518594814304;48176.5182348172;50768.74615626898;51638.22542661863;51784.74107629438;16158.192090395432;16173.110478923772;16237.67524649524;16246.106464144586;16275.348986040663;11642.068634509218;11813.88186118145;13201.405936732677;13334.133281336683;13360.665983350495;13990.440382384591;14047.508337208354;14073.085249458753;14095.859041409454;14246.928765356313;5343.171808369709;5431.755570999315;5617.943820561742;5657.32112146545;5705.4579814917515;966.7534778631544;979.4368238263028;990.1781521337273;1008.0927165550917;1011.8633984412011;21917.890410547847;21958.780412195993;22147.224847130274;22185.889070554545;22320.10719571199;1065.8241390170535;1074.4466599701161;1077.380506208933;1101.9504122314515;1114.0586204657052;11886.643400697993;11907.642770716893;11939.164258501822;11967.162298639187;12057.276563406223;231207;232141;233199;233445;234057;50188;50332.74833625808;50429.74785126124;50461;50592.24111638328;1371.136184203945;1421.047897908404;1431.3701971132668;1438.539667306452;1438.5612388221693;21470.570588587827;21649.13403463844;21650.891745541172;21784.564308714052;22082.22712205065;36289.092772680895;36376.09059773527;36409.45385819162;36454.08864778402;36525.63474365223;185511;186431;186686;186869;188900;33209.33581328311;34338.656613433544;36298.27403451969;36425.817870910476;36554.26891462209;43422.34866477069;44511.10977780491;44604.77697611491;44740.77629611831;44806.55193448154;32537.349253014334;32767.50848737223;33119;33311.50032749559;33826.15434614154;32315.35369292648;32328.83835580807;32336.191595210308;32880.83559582187;32943.50584741183;35565.64434355623;36835.815820920725;36914;37040.62959370372;37179;31687.890923817555;31750.841245793625;31949;32068.83965580157;32521.674783252813;19878.701819473008;20320.369788000884;20352.69470957907;20699.8965005174;21095.367138985854 08:52:04 INFO - PID 3609 | |2;jquery.html;559.203135531867;562.6174201542955;565.7114871415577;568.20735074571;578.7829563913532;21489.24787632433;21776.237831675895;22568.21011264602;22773.658395124086;22820.20129295473;23977.640335394983;24271.393215169628;24338;24402.145924892633;24491.510169796595;6409.551331406815;6558.901616475757;6570.967145164267;6573.57271777333;6580.967095164518;6281;6525.706343214543;6552.082708420801;6581.01284807278;6592.241892182413;6532.379423954717;6548.5088618353575;6555.868882622344;6572.07990881277;6589.143411356517;6579.374959378852;6583.9670801645925;6588.538802283842;6593.67031648418;6597.439217666456;6055.212822333113;6065.332813390523;6065.423784740443;6079.240094988127;6101.816945491642;28588.14235572936;28640.283992900135;28864.711352886414;29038.419231615462;29381.559276610653;2067.1937944201773;2090.278853795438;2102.4743814046487;2103.200783702199;2103.831693464519;19043.80956190434;19594.41216763485;19625;19656.70514942277;19673.704894426595;2381.521068450071;2420.189236605739;2425.745296743834;2443.853368797878;2468.5309791139625;136586.31706841404;137657;139480;139725;140177;14624.853751462562;14912.135983001908;15287.5476829701;15454.768178477332;16133.67732645364;22954.540909181724;23046.53906921852;23075.307740767803;23091.88454057719;23146;10025.799484010278;10237.539310731036;10272.691819245434;10324.483775811179;10531;9627.037296270317;9649.951750241344;9658.275629327689;9710.70867873965;9990.600375985025;7694.230576942373;8899.243564296978;9019.413738107001;9030.232430243503;9055;2664.9467010659678;2680.088769818271;2716.6332545106156;2745.9038933637225;2760.1857452051695;934.9205317547949;961.1925982174866;967.2793768642266;967.7483854197818;977.3500622086233;19446.319378821674;19617.117229724696;19895.303664371677;19895.801041989685;20169.798302016792;1024.8565200871883;1026.3226270661328;1027.2809033676456;1029.6705054382526;1035.7514196592763;10670.893291067145;10712.785744285227;10733.302335348177;10872.293300935415;10901.563937442414;489077;563749;565476;567508;568639;115018.42490787493;121367;124672;125447.3727631356;127523.36238318935;1157.4907040901976;1212.9878701213051;1216.9634910952686;1218.8171774233936;1223.7246619510718;20974;21214.575708486052;21243.256486022914;21269.89365053165;21385;57595.71202143963;58499.4150058494;59208.70395647994;59591.702041489516;60523.394766053534;73089;73452;74017.62991185009;74081.6295918517;74270.62864685642;12252.142350035412;12692.746145077232;14172.503962361268;14434.494792682206;14496.565103046925;17141;18880.811191887904;18896;22960.311190664306;23405.180818671266;16981.066041367845;16993.745093823356;17196;17279;17329;15173.16547589849;15806.9209653951;15903.52289431319;16042.759358609863;16531.33874645001;17633.20650570753;17760.555986099935;18443.631127377645;18568.44294671162;18655.72016419782;13878.375473103937;13887.861121388656;13967.161970281815;14028.719425611635;14181.078229915023;18018.36935707244;18178.90910545439;18386;18892.716609251147;19146.329878454188 08:52:04 INFO - PID 3609 | |3;mootools.html;1278.1180985120266;1297.4291311822803;1306.1836352279824;1308.8560258371583;1329.434990129195;14380.784288235685;14863.925680371583;15022.849771502282;15042.548723538284;15056.096634201942;14894.851051489482;15433.074015559074;15445.382184712626;15524.767128493053;15538.689226215469;2760.3789147441867;2797.398559309748;2806.775457963358;2808.5365914624163;2822.0122956965;2682.6646669166353;2716.877740501682;2747.4917140329003;2775.4310366374843;2818.689944106147;2781.123945957027;2807.719228077186;2808.747212750852;2809.7330753578376;2810.12886005338;2708.5801700736415;2714.4571085782727;2716.497447972122;2732.808703390773;2738.904138355168;2627.1855724725206;2633.4206474575562;2689.3276680829795;2704.0806125917284;2707.905223317194;14584.927075364662;14748.557543273611;14859;14877.628059298604;14947.775783363259;7787.688492460295;8078.35373170145;8081;8081.989751281089;8089.271965523072;5172.2588824885825;5339.5728341732565;5366.731663416814;5522.475364840334;5621.381648018714;1834.1287888253107;1908.961820763577;2162.859414138092;2430.428849220432;2452.3869032741813;25455;25592.74407255922;25633.48733025329;25651.486970260492;25732.09937652173;6411.358864113551;6536.803895883131;6645.235797883209;6719.630420326929;6791.388775010273;16443.506694799176;16466.917665411594;16497.83502164987;16509;16514;7621.961890190624;7807.180246074194;7830.960845195851;7866.646000929972;7868.881966770503;7143;7256.383207427428;7280.563166210044;7333.2666733327305;7334.48658593904;5183.14478111115;5205.817796377184;5309.070912590359;5399.4600539945695;5482.616216864782;1526.4809964612086;1541.1600677630718;1542.4447199008348;1544.7914531538324;1554.5103292463064;833.9624716887633;858.9699360522477;863.53369180643;868.3747701654798;879.6657270237397;7214.74748383804;7301.269873012656;7315.195328513859;7337.156227033959;7368.15266244378;678.725116327888;684.9828754281083;695.422799076765;697.8778713725078;702.9736584586459;4216.135692183095;4657;5033.219850923039;5066.695998240118;5113.590912726973;19876.90061549683;20512.38462846117;20613.381598552067;20616.58766824655;20923;18715.71926421105;20375.184992600425;20487.18051277962;20841.583168336547;21023.78976210249;10242.692719218436;10358.119559837347;10645.574177032831;10890.61882834097;10922.672319830259;8015.318697910743;8162.142974987778;8166.918330816616;8246.3815213858;8272;17478.388256410966;17946.37187698424;18146.72779908276;18379.90810045941;18479.353222637143;18508.629827403645;18513.72229416587;18528.790082000196;19133.8086619132;19641.508962276057;11760.294382337088;11961.342126182795;11962.521499139937;11971.221870578385;12009.339486327986;13135.868641313464;13664;13753.449862005407;13753.656158595715;13770.449182032606;10364.585416583554;10564.735881603021;10965.232433729881;11022.283551569122;11052.613158539412;10041.899581004389;10604.363738175734;10661.466926653482;10692.465376731288;10696.090832279344;8944.239739622206;8986.19124278818;8986.775330616787;9017.864732029157;9100.044495327895;6614.107095542233;6638.402543770891;6746.763863264762;6768.2216545097945;6852.862942741018;6484.773032943825;6632.158524277208;6654.367835055662;6657.633830139195;6664.500162487736 08:52:04 INFO - PID 3609 | |4;prototype.html;498.0412705541831;502.2315856739189;513.9357580302462;519.9116150254458;527.4382782336811;6290.465310448617;6304.527160462966;6341.239051313843;6379.808605741835;6398.680065996699;6208.906866397007;6251.6874156292115;6302.495800335973;6317.399847014526;6340.651264180468;5143.562797162245;5161.922571161435;5167.354080739908;5178.456262092483;5193.428722840485;4882.145624515713;4958.504149585049;5000.749962501878;5007.32401125847;5034.974825125869;4849.078675051729;4926.827561035365;4950.207966725325;4970.6520543561965;4972.701637901738;4922.178793846299;4942.3327850740225;4950.504949505057;5006.123928312567;5018.347614810052;4350.564943505656;4357.455318085239;4394.582514661102;4417.315316126005;4464.464264288274;6204.81385558434;6222.284437289724;6241.750329986795;6272.2786879508985;6289.559730818844;5515.669059856422;5729.93722259986;5745.8563535911935;5767.740451679684;5778.8266352009505;6536.77121300757;6546.6726663667105;6567.770128045543;6579.17760279965;6628.900566491507;4766.833160839354;4770.260609605517;4796.952030479721;4832.830850920201;4836.758162091881;6685.298043705438;6829.453643708492;6852.862942741167;6891.689873955684;7046.823829404255;4917.950820491821;4946.183879659816;4954.801807927643;4958.404991400983;5021.799128034838;5041.395032596112;5063.164577844688;5063.164577844688;5067.949320506821;5083.872903177376;5656.727236371866;5696.572757043238;5702.230198923092;5734.913976290276;5739.483446489752;6667.466602671775;6699.799006029827;6731.394174524316;6744.325567443217;6791.966040169767;1734.3842935757878;1755.2540170427517;1758.7273972534279;1762.2950819671978;1780.8486278666198;1129.615930583589;1181.4565299961941;1195.5277665322324;1204.3315959642482;1220.8046712526132;5806.158107074535;5828.941710582924;5881.735321910524;5913.142594323799;5925.940740592625;6752.257251702407;6765.154355705537;6770.1537307836525;6820.965895170492;6859.330258311779;5844.561657875676;5845.240118784531;5877.441643043904;5893.675847828325;5983.341832398432;3602.963970360263;3637.254362855608;3643.2349206666895;3659.853605855736;3667.5232219811255;6524.184476940382;6551.770688025991;6566.901496477557;6577.473802095821;6653.168353955755;6953.33943275388;6966.442684585221;6969.337912898267;6987.650617469208;7044.753433629799;6532.346765323429;6546.378094081245;6560.900511836262;6579.638119903451;6630.867382652416;6225.875482490415;6798.660066996729;6802.829929251809;6850.657467126524;6856.417204537471;6569.489017526092;6684.598924064571;6756.628385438848;6761.492888033319;6781.11845460087;6463.385978332051;6525.543211975116;6543.836404089936;6544.3966228272475;6556.606603603799;4764.714117152982;4921.975390123026;4939.259111133359;4961.5534601886;5003.924941125813;6456.515761318014;6663.267040625624;6690.632015239208;6803.421709154777;6812.14848143982;6535.640539770358;6549.672516374067;6551.737930482727;6559.6064236145985;6584;6537.346265373425;6565.376289252514;6586.176727909012;6599.835004124935;6627.834304142435;6558.967205163944;6606.8348291293105;6628;6631.171103612049;6673.1992160941;6713.462922966249;6719.731210751515;6721.495887808532;6728.158980127484;6751.02110194029;6410.294867564471;6452.838679033061;6459.5478316519275;6473.64394958263;6508.511861610493 08:52:04 INFO - PID 3609 | |5;yui.html;865.2472349056322;887.8446271902417;893.5308962794528;898.5821592959272;913.4519288426944;15111;17322;18495.167717452714;18528.258869645197;18603.25586976521;16244.269007894643;16960.575985600368;17119.828801711978;17228.569285767862;17446.38937637183;900.4057322167371;920.2683866326287;922.3405265235356;924.1774820409807;925.9675911343104;686.3822559696264;923.8891333040044;932;932.8740620016279;935.4387367579432;773.8297574533593;783.2832957843594;935.3779736475236;966.6036924860808;972.1008067537534;957.6887511558737;962.9903700963006;963.4026903319916;963.6771681486711;965.1844191658073;703.4618516834626;705.2031204738613;705.8164877131932;707.056080133023;711.2638419236117;15601.375944962188;16104.19479026044;16224.513264602081;16241;16322.75515867263;20021.399358019284;20125.5974880503;20391.592168156552;20440.693389599168;20493.4876628084;15477;15674.137922414262;15683.607909802233;15746.842531574652;15748.291326890318;3515.437529995214;3662.468942003421;3692.4461330800327;3702.38910579754;3713.2016616427327;124997;128727;128891;128934;130349;14597.489087881873;14715.264236788118;14998.47505337308;15114.168720720467;15154.318055687521;28156;29961.700382995892;30047.399052019275;30093;30345.848270758506;6927.688254028581;8306.584670766437;8475.618597163142;8583.527905965107;8634.568271586395;4122.876313710593;4155.480564929384;4191.161767646483;4227.915441691211;4231.661467082626;4746.145693775154;4835.298881662139;4844.927326090112;4881.487443818419;4915.95084049155;984.6159997600942;1001.3941565352857;1004.1213937804421;1015.7562185075528;1017.0287375556326;668.8896332105148;678.7590405406108;684.2815044203567;706.1490903461316;708.6952610377588;10420.943789243416;10945.671629851116;11040.486113193254;11067.833982490269;11113.944430277797;690.4096997067435;692.0864458914285;702.1433850702135;708.2103454648134;715.1275443958363;5526.917096243559;5585.469380408936;5628.212050312959;5675.858103547362;5701.230333904953;101417.49291253496;101881;105659;106422.46788766007;108069;89110;90205;91555.54222228979;94391;95034.52482737681;82248.17751822405;83158;85575;85936.828212332;86287;11899.405029748305;12030.699232518908;12039.879601204226;12203.877961220629;12246.75506489883;37653.2469350606;38126.42810357791;38720.2255954885;40042.1991560173;40059.59940400559;47851.5214847861;50073.24890126724;50104.248436272755;50614.49385506245;50897.491025090756;16078.839211607734;16323.755143673092;16339.836601634306;16479.83520164783;16765.077920714477;19294;19837.603247934672;19911.10400032031;19997.800021999592;20126;15730.056196628238;15759.763603545727;15778;15785.526434206991;17763.200655970253;16860.494185174466;17298.481045568653;17380;17443.215055322285;17459.30162793474;16509.33962641481;16707.832921670626;16982.83017169862;17139.314427422763;17850.732239016164;11740.58907938218;12107.455164517442;12862.807057894326;12873.16324438946;12946.705329466979;12195.817062743889;13003.08978371505;13201.801972970605;13422.39599218057;13540.119892206974 08:52:04 INFO - PID 3609 | __end_tp_report 08:52:04 INFO - PID 3609 | __start_cc_report 08:52:04 INFO - PID 3609 | _x_x_mozilla_cycle_collect,354 08:52:04 INFO - PID 3609 | __end_cc_report 08:52:04 INFO - PID 3609 | __startTimestamp1503935524794__endTimestamp 08:52:04 INFO - PID 3609 | 08:52:04 INFO - PID 3609 | ------- Summary: start ------- 08:52:04 INFO - PID 3609 | Number of tests: 6 08:52:04 INFO - PID 3609 | 08:52:04 INFO - PID 3609 | [#0] dojo.html Cycles:165 Average:6220.13 Median:6502.25 stddev:868.86 (13.4%) stddev-sans-first:841.21 08:52:04 INFO - PID 3609 | Values: 3320.1 3326.4 3332.6 3336.2 3352.3 6167.0 6293.9 6303.3 6338.6 6353.7 6250.6 6253.2 6272.7 6283.8 6317.5 5720.2 5728.7 5746.4 5773.8 5833.8 5861.8 5881.0 5894.1 5897.6 5902.5 5816.3 5859.6 5906.8 5915.6 5951.1 1.2 5355.5 5698.4 5768.8 5926.2 5734.1 5782.8 5789.6 5856.3 5866.8 6204.2 6257.3 6317.4 6424.7 6424.8 6798.7 6825.1 6897.0 6901.7 6904.1 6863.0 6879.1 6884.4 6986.0 6986.3 6228.4 6345.0 6373.7 6439.7 6442.8 6970.7 6973.7 6979.1 6980.1 6984.2 6589.0 6662.9 6678.0 6679.0 6682.6 6044.4 6738.0 6759.7 6765.7 6789.7 6703.9 6711.4 6751.0 6816.3 6872.2 6799.3 6805.1 6875.0 6881.2 6883.4 5328.6 5330.4 5397.8 5407.5 5412.3 4774.4 4791.1 4813.1 4822.5 4841.1 6000.5 6006.2 6006.3 6021.8 6048.9 6794.9 6825.3 6841.3 6918.2 6950.9 5866.5 5893.1 5970.4 6031.3 6040.1 5790.4 5829.2 5863.7 5912.3 5922.6 6445.5 6565.5 6575.6 6576.8 6610.8 6772.0 6795.0 6822.4 6847.6 6906.1 6438.9 6512.2 6521.3 6608.4 6608.7 6588.3 6647.0 6648.9 6652.6 6669.5 6720.8 6764.1 6792.8 6808.6 6810.7 6557.1 6569.6 6580.8 6620.6 6624.9 6556.5 6587.9 6596.2 6619.1 6699.5 6388.8 6502.3 6542.1 6644.4 6666.5 6408.7 6580.4 6635.6 6760.4 6770.8 6442.9 6452.3 6526.6 6545.2 6549.9 08:52:04 INFO - PID 3609 | 08:52:04 INFO - PID 3609 | [#1] ext.html Cycles:180 Average:36498.31 Median:19512.36 stddev:51889.64 (265.9%) stddev-sans-first:51965.38 08:52:04 INFO - PID 3609 | Values: 649.3 729.3 746.5 749.0 750.6 30712.7 31595.2 39241.8 40172.4 40235.8 40122.0 40204.2 40553.4 40591.6 40676.2 7588.8 7655.1 7658.7 7838.8 7882.9 7738.2 7853.3 7878.5 7880.1 7881.9 7784.3 7810.9 7840.2 7921.0 7928.5 7784.5 7790.7 7805.7 7810.3 7826.9 7725.2 7783.9 7790.1 7799.8 7799.8 36543.8 36594.8 36985.0 37001.6 37024.3 3384.5 3399.2 3448.2 3451.9 3459.1 30127.8 30408.7 30449.4 30453.4 30465.0 5021.6 5126.4 5156.8 5164.9 5206.6 174918.0 175523.0 177019.1 177682.0 178002.0 45684.3 45984.5 45987.8 46006.8 46007.5 48140.5 48176.5 50768.7 51638.2 51784.7 16158.2 16173.1 16237.7 16246.1 16275.3 11642.1 11813.9 13201.4 13334.1 13360.7 13990.4 14047.5 14073.1 14095.9 14246.9 5343.2 5431.8 5617.9 5657.3 5705.5 966.8 979.4 990.2 1008.1 1011.9 21917.9 21958.8 22147.2 22185.9 22320.1 1065.8 1074.4 1077.4 1102.0 1114.1 11886.6 11907.6 11939.2 11967.2 12057.3 231207.0 232141.0 233199.0 233445.0 234057.0 50188.0 50332.7 50429.7 50461.0 50592.2 1371.1 1421.0 1431.4 1438.5 1438.6 21470.6 21649.1 21650.9 21784.6 22082.2 36289.1 36376.1 36409.5 36454.1 36525.6 185511.0 186431.0 186686.0 186869.0 188900.0 33209.3 34338.7 36298.3 36425.8 36554.3 43422.3 44511.1 44604.8 44740.8 44806.6 32537.3 32767.5 33119.0 33311.5 33826.2 32315.4 32328.8 32336.2 32880.8 32943.5 35565.6 36835.8 36914.0 37040.6 37179.0 31687.9 31750.8 31949.0 32068.8 32521.7 19878.7 20320.4 20352.7 20699.9 21095.4 08:52:04 INFO - PID 3609 | 08:52:04 INFO - PID 3609 | [#2] jquery.html Cycles:180 Average:36669.02 Median:22670.93 stddev:92432.92 (407.7%) stddev-sans-first:92652.45 08:52:04 INFO - PID 3609 | Values: 559.2 562.6 565.7 568.2 578.8 21489.2 21776.2 22568.2 22773.7 22820.2 23977.6 24271.4 24338.0 24402.1 24491.5 6409.6 6558.9 6571.0 6573.6 6581.0 6281.0 6525.7 6552.1 6581.0 6592.2 6532.4 6548.5 6555.9 6572.1 6589.1 6579.4 6584.0 6588.5 6593.7 6597.4 6055.2 6065.3 6065.4 6079.2 6101.8 28588.1 28640.3 28864.7 29038.4 29381.6 2067.2 2090.3 2102.5 2103.2 2103.8 19043.8 19594.4 19625.0 19656.7 19673.7 2381.5 2420.2 2425.7 2443.9 2468.5 136586.3 137657.0 139480.0 139725.0 140177.0 14624.9 14912.1 15287.5 15454.8 16133.7 22954.5 23046.5 23075.3 23091.9 23146.0 10025.8 10237.5 10272.7 10324.5 10531.0 9627.0 9650.0 9658.3 9710.7 9990.6 7694.2 8899.2 9019.4 9030.2 9055.0 2664.9 2680.1 2716.6 2745.9 2760.2 934.9 961.2 967.3 967.7 977.4 19446.3 19617.1 19895.3 19895.8 20169.8 1024.9 1026.3 1027.3 1029.7 1035.8 10670.9 10712.8 10733.3 10872.3 10901.6 489077.0 563749.0 565476.0 567508.0 568639.0 115018.4 121367.0 124672.0 125447.4 127523.4 1157.5 1213.0 1217.0 1218.8 1223.7 20974.0 21214.6 21243.3 21269.9 21385.0 57595.7 58499.4 59208.7 59591.7 60523.4 73089.0 73452.0 74017.6 74081.6 74270.6 12252.1 12692.7 14172.5 14434.5 14496.6 17141.0 18880.8 18896.0 22960.3 23405.2 16981.1 16993.7 17196.0 17279.0 17329.0 15173.2 15806.9 15903.5 16042.8 16531.3 17633.2 17760.6 18443.6 18568.4 18655.7 13878.4 13887.9 13967.2 14028.7 14181.1 18018.4 18178.9 18386.0 18892.7 19146.3 08:52:04 INFO - PID 3609 | 08:52:04 INFO - PID 3609 | [#3] mootools.html Cycles:180 Average:9049.11 Median:2708.24 stddev:6434.31 (237.6%) stddev-sans-first:6425.87 08:52:04 INFO - PID 3609 | Values: 1278.1 1297.4 1306.2 1308.9 1329.4 14380.8 14863.9 15022.8 15042.5 15056.1 14894.9 15433.1 15445.4 15524.8 15538.7 2760.4 2797.4 2806.8 2808.5 2822.0 2682.7 2716.9 2747.5 2775.4 2818.7 2781.1 2807.7 2808.7 2809.7 2810.1 2708.6 2714.5 2716.5 2732.8 2738.9 2627.2 2633.4 2689.3 2704.1 2707.9 14584.9 14748.6 14859.0 14877.6 14947.8 7787.7 8078.4 8081.0 8082.0 8089.3 5172.3 5339.6 5366.7 5522.5 5621.4 1834.1 1909.0 2162.9 2430.4 2452.4 25455.0 25592.7 25633.5 25651.5 25732.1 6411.4 6536.8 6645.2 6719.6 6791.4 16443.5 16466.9 16497.8 16509.0 16514.0 7622.0 7807.2 7831.0 7866.6 7868.9 7143.0 7256.4 7280.6 7333.3 7334.5 5183.1 5205.8 5309.1 5399.5 5482.6 1526.5 1541.2 1542.4 1544.8 1554.5 834.0 859.0 863.5 868.4 879.7 7214.7 7301.3 7315.2 7337.2 7368.2 678.7 685.0 695.4 697.9 703.0 4216.1 4657.0 5033.2 5066.7 5113.6 19876.9 20512.4 20613.4 20616.6 20923.0 18715.7 20375.2 20487.2 20841.6 21023.8 10242.7 10358.1 10645.6 10890.6 10922.7 8015.3 8162.1 8166.9 8246.4 8272.0 17478.4 17946.4 18146.7 18379.9 18479.4 18508.6 18513.7 18528.8 19133.8 19641.5 11760.3 11961.3 11962.5 11971.2 12009.3 13135.9 13664.0 13753.4 13753.7 13770.4 10364.6 10564.7 10965.2 11022.3 11052.6 10041.9 10604.4 10661.5 10692.5 10696.1 8944.2 8986.2 8986.8 9017.9 9100.0 6614.1 6638.4 6746.8 6768.2 6852.9 6484.8 6632.2 6654.4 6657.6 6664.5 08:52:04 INFO - PID 3609 | 08:52:04 INFO - PID 3609 | [#4] prototype.html Cycles:180 Average:5555.34 Median:6261.98 stddev:1574.76 (25.1%) stddev-sans-first:1532.75 08:52:04 INFO - PID 3609 | Values: 498.0 502.2 513.9 519.9 527.4 6290.5 6304.5 6341.2 6379.8 6398.7 6208.9 6251.7 6302.5 6317.4 6340.7 5143.6 5161.9 5167.4 5178.5 5193.4 4882.1 4958.5 5000.7 5007.3 5035.0 4849.1 4926.8 4950.2 4970.7 4972.7 4922.2 4942.3 4950.5 5006.1 5018.3 4350.6 4357.5 4394.6 4417.3 4464.5 6204.8 6222.3 6241.8 6272.3 6289.6 5515.7 5729.9 5745.9 5767.7 5778.8 6536.8 6546.7 6567.8 6579.2 6628.9 4766.8 4770.3 4797.0 4832.8 4836.8 6685.3 6829.5 6852.9 6891.7 7046.8 4918.0 4946.2 4954.8 4958.4 5021.8 5041.4 5063.2 5063.2 5067.9 5083.9 5656.7 5696.6 5702.2 5734.9 5739.5 6667.5 6699.8 6731.4 6744.3 6792.0 1734.4 1755.3 1758.7 1762.3 1780.8 1129.6 1181.5 1195.5 1204.3 1220.8 5806.2 5828.9 5881.7 5913.1 5925.9 6752.3 6765.2 6770.2 6821.0 6859.3 5844.6 5845.2 5877.4 5893.7 5983.3 3603.0 3637.3 3643.2 3659.9 3667.5 6524.2 6551.8 6566.9 6577.5 6653.2 6953.3 6966.4 6969.3 6987.7 7044.8 6532.3 6546.4 6560.9 6579.6 6630.9 6225.9 6798.7 6802.8 6850.7 6856.4 6569.5 6684.6 6756.6 6761.5 6781.1 6463.4 6525.5 6543.8 6544.4 6556.6 4764.7 4922.0 4939.3 4961.6 5003.9 6456.5 6663.3 6690.6 6803.4 6812.1 6535.6 6549.7 6551.7 6559.6 6584.0 6537.3 6565.4 6586.2 6599.8 6627.8 6559.0 6606.8 6628.0 6631.2 6673.2 6713.5 6719.7 6721.5 6728.2 6751.0 6410.3 6452.8 6459.5 6473.6 6508.5 08:52:04 INFO - PID 3609 | 08:52:04 INFO - PID 3609 | [#5] yui.html Cycles:180 Average:22204.10 Median:30004.55 stddev:30929.82 (103.1%) stddev-sans-first:30975.08 08:52:04 INFO - PID 3609 | Values: 865.2 887.8 893.5 898.6 913.5 15111.0 17322.0 18495.2 18528.3 18603.3 16244.3 16960.6 17119.8 17228.6 17446.4 900.4 920.3 922.3 924.2 926.0 686.4 923.9 932.0 932.9 935.4 773.8 783.3 935.4 966.6 972.1 957.7 963.0 963.4 963.7 965.2 703.5 705.2 705.8 707.1 711.3 15601.4 16104.2 16224.5 16241.0 16322.8 20021.4 20125.6 20391.6 20440.7 20493.5 15477.0 15674.1 15683.6 15746.8 15748.3 3515.4 3662.5 3692.4 3702.4 3713.2 124997.0 128727.0 128891.0 128934.0 130349.0 14597.5 14715.3 14998.5 15114.2 15154.3 28156.0 29961.7 30047.4 30093.0 30345.8 6927.7 8306.6 8475.6 8583.5 8634.6 4122.9 4155.5 4191.2 4227.9 4231.7 4746.1 4835.3 4844.9 4881.5 4916.0 984.6 1001.4 1004.1 1015.8 1017.0 668.9 678.8 684.3 706.1 708.7 10420.9 10945.7 11040.5 11067.8 11113.9 690.4 692.1 702.1 708.2 715.1 5526.9 5585.5 5628.2 5675.9 5701.2 101417.5 101881.0 105659.0 106422.5 108069.0 89110.0 90205.0 91555.5 94391.0 95034.5 82248.2 83158.0 85575.0 85936.8 86287.0 11899.4 12030.7 12039.9 12203.9 12246.8 37653.2 38126.4 38720.2 40042.2 40059.6 47851.5 50073.2 50104.2 50614.5 50897.5 16078.8 16323.8 16339.8 16479.8 16765.1 19294.0 19837.6 19911.1 19997.8 20126.0 15730.1 15759.8 15778.0 15785.5 17763.2 16860.5 17298.5 17380.0 17443.2 17459.3 16509.3 16707.8 16982.8 17139.3 17850.7 11740.6 12107.5 12862.8 12873.2 12946.7 12195.8 13003.1 13201.8 13422.4 13540.1 08:52:04 INFO - PID 3609 | -------- Summary: end -------- 08:52:04 INFO - PID 3609 | 08:52:05 INFO - TEST-INFO | 3609: exit 0 08:52:05 INFO - TEST-OK | dromaeo_css | took 1118890ms 08:52:05 INFO - TEST-START | kraken 08:52:05 INFO - Initialising browser for kraken test... 08:52:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41340/getInfo.html -profile /tmp/tmpRUGVzo/profile 08:52:05 INFO - TEST-INFO | started process 3984 (/builds/slave/test/build/application/firefox/firefox http://localhost:41340/getInfo.html) 08:52:12 INFO - TEST-INFO | 3984: exit 0 08:52:12 INFO - Browser initialized. 08:52:12 INFO - Running cycle 1/1 for kraken test... 08:52:12 INFO - Using env: {'DISPLAY': ':0', 08:52:12 INFO - 'HOME': '/home/cltbld', 08:52:12 INFO - 'JSGC_DISABLE_POISONING': '1', 08:52:12 INFO - 'LANG': 'en_US.UTF-8', 08:52:12 INFO - 'LANGUAGE': 'en_US:en', 08:52:12 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:52:12 INFO - 'LOGNAME': 'cltbld', 08:52:12 INFO - 'MAIL': '/var/mail/cltbld', 08:52:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:52:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:52:12 INFO - 'MOZ_ACCELERATED': '1', 08:52:12 INFO - 'MOZ_CRASHREPORTER': '1', 08:52:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:12 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:52:12 INFO - 'MOZ_NO_REMOTE': '1', 08:52:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:52:12 INFO - 'MOZ_WEBRENDER': '1', 08:52:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:12 INFO - 'NO_EM_RESTART': '1', 08:52:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:12 INFO - 'PWD': '/builds/slave/test', 08:52:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:52:12 INFO - 'RUST_BACKTRACE': 'full', 08:52:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:52:12 INFO - 'SHELL': '/bin/bash', 08:52:12 INFO - 'SHLVL': '1', 08:52:12 INFO - 'TERM': 'linux', 08:52:12 INFO - 'TMOUT': '86400', 08:52:12 INFO - 'USER': 'cltbld', 08:52:12 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1503934306.647693-818300802', 08:52:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:12 INFO - '_': '/tools/buildbot/bin/python'} 08:52:12 INFO - TEST-INFO | started process 4171 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRUGVzo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:52:13 INFO - PID 4171 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 08:52:13 INFO - PID 4171 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 08:52:13 INFO - PID 4171 | 08:52:13 INFO - PID 4171 | (/builds/slave/test/build/application/firefox/firefox:4231): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:52:13 INFO - PID 4171 | 08:52:24 INFO - PID 4171 | RSS: Main: 200716288 08:52:24 INFO - PID 4171 | 08:52:26 INFO - PID 4171 | Cycle 1(1): loaded http://localhost:41340/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41340/tests/kraken/driver.html?testName=audio-beat-detection) 08:52:27 INFO - PID 4171 | RSS: Main: 206602240 08:52:27 INFO - PID 4171 | 08:52:30 INFO - PID 4171 | Cycle 1(1): loaded http://localhost:41340/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41340/tests/kraken/driver.html?testName=audio-dft) 08:52:30 INFO - PID 4171 | RSS: Main: 207347712 08:52:30 INFO - PID 4171 | 08:52:33 INFO - PID 4171 | Cycle 1(1): loaded http://localhost:41340/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41340/tests/kraken/driver.html?testName=audio-fft) 08:52:34 INFO - PID 4171 | RSS: Main: 201936896 08:52:34 INFO - PID 4171 | 08:52:36 INFO - PID 4171 | Cycle 1(1): loaded http://localhost:41340/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41340/tests/kraken/driver.html?testName=audio-oscillator) 08:52:37 INFO - PID 4171 | RSS: Main: 202551296 08:52:37 INFO - PID 4171 | 08:52:39 INFO - PID 4171 | Cycle 1(1): loaded http://localhost:41340/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41340/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:52:40 INFO - PID 4171 | RSS: Main: 202297344 08:52:40 INFO - PID 4171 | 08:52:43 INFO - PID 4171 | Cycle 1(1): loaded http://localhost:41340/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41340/tests/kraken/driver.html?testName=imaging-darkroom) 08:52:44 INFO - PID 4171 | RSS: Main: 205299712 08:52:44 INFO - PID 4171 | 08:52:47 INFO - PID 4171 | Cycle 1(1): loaded http://localhost:41340/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41340/tests/kraken/driver.html?testName=imaging-desaturate) 08:52:48 INFO - PID 4171 | RSS: Main: 204402688 08:52:48 INFO - PID 4171 | 08:52:51 INFO - PID 4171 | Cycle 1(1): loaded http://localhost:41340/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41340/tests/kraken/driver.html?testName=json-parse-financial) 08:52:51 INFO - PID 4171 | RSS: Main: 205217792 08:52:51 INFO - PID 4171 | 08:52:53 INFO - PID 4171 | Cycle 1(1): loaded http://localhost:41340/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41340/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:52:54 INFO - PID 4171 | RSS: Main: 205529088 08:52:54 INFO - PID 4171 | 08:52:55 INFO - PID 4171 | Cycle 1(1): loaded http://localhost:41340/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41340/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:52:56 INFO - PID 4171 | RSS: Main: 206442496 08:52:56 INFO - PID 4171 | 08:52:58 INFO - PID 4171 | Cycle 1(1): loaded http://localhost:41340/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41340/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:52:59 INFO - PID 4171 | RSS: Main: 205287424 08:52:59 INFO - PID 4171 | 08:53:01 INFO - PID 4171 | Cycle 1(1): loaded http://localhost:41340/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41340/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:53:02 INFO - PID 4171 | RSS: Main: 206229504 08:53:02 INFO - PID 4171 | 08:53:05 INFO - PID 4171 | Cycle 1(1): loaded http://localhost:41340/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41340/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:53:06 INFO - PID 4171 | RSS: Main: 206663680 08:53:06 INFO - PID 4171 | 08:53:08 INFO - PID 4171 | Cycle 1(1): loaded http://localhost:41340/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41340/tests/kraken/driver.html?testName=ai-astar) 08:53:08 INFO - PID 4171 | RSS: Main: 209940480 08:53:08 INFO - PID 4171 | 08:53:08 INFO - PID 4171 | __start_tp_report 08:53:08 INFO - PID 4171 | _x_x_mozilla_page_load 08:53:08 INFO - PID 4171 | _x_x_mozilla_page_load_details 08:53:08 INFO - PID 4171 | |i|pagename|runs| 08:53:08 INFO - PID 4171 | |0;ai-astar;105;107;100;107;116;120;108;99;111;109 08:53:08 INFO - PID 4171 | |1;audio-beat-detection;150;122;147;180;118;151;159;119;173;121 08:53:08 INFO - PID 4171 | |2;audio-dft;164;163;164;167;168;163;166;166;163;171 08:53:08 INFO - PID 4171 | |3;audio-fft;90;82;74;168;80;74;74;75;171;74 08:53:08 INFO - PID 4171 | |4;audio-oscillator;87;80;129;81;84;80;130;81;85;137 08:53:08 INFO - PID 4171 | |5;imaging-gaussian-blur;119;126;115;121;115;123;114;114;115;118 08:53:08 INFO - PID 4171 | |6;imaging-darkroom;151;151;156;148;151;149;150;149;151;158 08:53:08 INFO - PID 4171 | |7;imaging-desaturate;100;94;94;97;95;94;95;95;101;94 08:53:08 INFO - PID 4171 | |8;json-parse-financial;55;51;56;55;54;51;52;58;51;52 08:53:08 INFO - PID 4171 | |9;json-stringify-tinderbox;44;42;40;40;39;47;39;47;39;51 08:53:08 INFO - PID 4171 | |10;stanford-crypto-aes;75;87;81;80;76;79;76;76;76;85 08:53:08 INFO - PID 4171 | |11;stanford-crypto-ccm;136;120;135;123;135;127;128;125;126;162 08:53:08 INFO - PID 4171 | |12;stanford-crypto-pbkdf2;174;174;178;182;174;173;180;171;180;182 08:53:08 INFO - PID 4171 | |13;stanford-crypto-sha256-iterative;65;65;63;64;65;71;65;67;62;72 08:53:08 INFO - PID 4171 | __end_tp_report 08:53:08 INFO - PID 4171 | __start_cc_report 08:53:08 INFO - PID 4171 | _x_x_mozilla_cycle_collect,933 08:53:08 INFO - PID 4171 | __end_cc_report 08:53:08 INFO - PID 4171 | __startTimestamp1503935588308__endTimestamp 08:53:08 INFO - PID 4171 | 08:53:08 INFO - PID 4171 | ------- Summary: start ------- 08:53:08 INFO - PID 4171 | Number of tests: 14 08:53:08 INFO - PID 4171 | 08:53:08 INFO - PID 4171 | [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:6.44 (5.9%) stddev-sans-first:6.73 08:53:08 INFO - PID 4171 | Values: 105.0 107.0 100.0 107.0 116.0 120.0 108.0 99.0 111.0 109.0 08:53:08 INFO - PID 4171 | 08:53:08 INFO - PID 4171 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:150.50 stddev:23.02 (15.3%) stddev-sans-first:24.32 08:53:08 INFO - PID 4171 | Values: 150.0 122.0 147.0 180.0 118.0 151.0 159.0 119.0 173.0 121.0 08:53:08 INFO - PID 4171 | 08:53:08 INFO - PID 4171 | [#2] audio-dft Cycles:10 Average:165.50 Median:166.00 stddev:2.64 (1.6%) stddev-sans-first:2.74 08:53:08 INFO - PID 4171 | Values: 164.0 163.0 164.0 167.0 168.0 163.0 166.0 166.0 163.0 171.0 08:53:08 INFO - PID 4171 | 08:53:08 INFO - PID 4171 | [#3] audio-fft Cycles:10 Average:96.20 Median:74.50 stddev:38.98 (52.3%) stddev-sans-first:41.28 08:53:08 INFO - PID 4171 | Values: 90.0 82.0 74.0 168.0 80.0 74.0 74.0 75.0 171.0 74.0 08:53:08 INFO - PID 4171 | 08:53:08 INFO - PID 4171 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:81.00 stddev:24.07 (29.7%) stddev-sans-first:25.23 08:53:08 INFO - PID 4171 | Values: 87.0 80.0 129.0 81.0 84.0 80.0 130.0 81.0 85.0 137.0 08:53:08 INFO - PID 4171 | 08:53:08 INFO - PID 4171 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.50 stddev:4.19 (3.5%) stddev-sans-first:4.43 08:53:08 INFO - PID 4171 | Values: 119.0 126.0 115.0 121.0 115.0 123.0 114.0 114.0 115.0 118.0 08:53:08 INFO - PID 4171 | 08:53:08 INFO - PID 4171 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:151.00 stddev:3.17 (2.1%) stddev-sans-first:3.36 08:53:08 INFO - PID 4171 | Values: 151.0 151.0 156.0 148.0 151.0 149.0 150.0 149.0 151.0 158.0 08:53:08 INFO - PID 4171 | 08:53:08 INFO - PID 4171 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:94.50 stddev:2.60 (2.8%) stddev-sans-first:2.30 08:53:08 INFO - PID 4171 | Values: 100.0 94.0 94.0 97.0 95.0 94.0 95.0 95.0 101.0 94.0 08:53:08 INFO - PID 4171 | 08:53:08 INFO - PID 4171 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:54.50 stddev:2.46 (4.5%) stddev-sans-first:2.55 08:53:08 INFO - PID 4171 | Values: 55.0 51.0 56.0 55.0 54.0 51.0 52.0 58.0 51.0 52.0 08:53:08 INFO - PID 4171 | 08:53:08 INFO - PID 4171 | [#9] json-stringify-tinderbox Cycles:10 Average:42.80 Median:43.00 stddev:4.26 (9.9%) stddev-sans-first:4.50 08:53:08 INFO - PID 4171 | Values: 44.0 42.0 40.0 40.0 39.0 47.0 39.0 47.0 39.0 51.0 08:53:08 INFO - PID 4171 | 08:53:08 INFO - PID 4171 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.50 stddev:4.18 (5.3%) stddev-sans-first:4.16 08:53:08 INFO - PID 4171 | Values: 75.0 87.0 81.0 80.0 76.0 79.0 76.0 76.0 76.0 85.0 08:53:08 INFO - PID 4171 | 08:53:08 INFO - PID 4171 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:131.50 stddev:11.94 (9.1%) stddev-sans-first:12.57 08:53:08 INFO - PID 4171 | Values: 136.0 120.0 135.0 123.0 135.0 127.0 128.0 125.0 126.0 162.0 08:53:08 INFO - PID 4171 | 08:53:08 INFO - PID 4171 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:179.00 stddev:4.05 (2.3%) stddev-sans-first:4.17 08:53:08 INFO - PID 4171 | Values: 174.0 174.0 178.0 182.0 174.0 173.0 180.0 171.0 180.0 182.0 08:53:08 INFO - PID 4171 | 08:53:08 INFO - PID 4171 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:65.00 stddev:3.25 (5.0%) stddev-sans-first:3.43 08:53:08 INFO - PID 4171 | Values: 65.0 65.0 63.0 64.0 65.0 71.0 65.0 67.0 62.0 72.0 08:53:08 INFO - PID 4171 | -------- Summary: end -------- 08:53:08 INFO - PID 4171 | 08:53:08 INFO - PID 4171 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:53:09 INFO - TEST-INFO | 4171: exit 0 08:53:09 INFO - TEST-OK | kraken | took 63642ms 08:53:09 INFO - SUITE-END | took 1182s 08:53:09 INFO - Completed test suite (00:19:42) 08:53:09 INFO - javascript benchmark 08:53:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8384.131177119962, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3320.1201681554394, 3326.434506133957, 3332.5501057357255, 3336.199312165081, 3352.3127758809414, 6167.0, 6293.937060629398, 6303.3381494943005, 6338.619682819029, 6353.745850165999, 6250.5937114087665, 6253.155823963763, 6272.749090036393, 6283.780067697631, 6317.494600431966, 5720.1991721159075, 5728.68492232927, 5746.425357464262, 5773.826785196451, 5833.766649334021, 5861.824145275648, 5880.97059514704, 5894.056950887859, 5897.587168898157, 5902.468777809996, 5816.302043754756, 5859.560532960024, 5906.793262235823, 5915.556333275, 5951.077582974624, 1.1760928548830794, 5355.518003379714, 5698.40166782486, 5768.826935191909, 5926.229590153295, 5734.082546792493, 5782.768689252425, 5789.594728369016, 5856.326522449887, 5866.794662186846, 6204.193454850885, 6257.342978987186, 6317.368263173692, 6424.743010279583, 6424.839379015515, 6798.66006699663, 6825.078614387044, 6897.0, 6901.654917254117, 6904.10246667935, 6862.965685171592, 6879.105716256905, 6884.449244060464, 6986.0, 6986.336298051728, 6228.408301211378, 6345.0, 6373.7450501979865, 6439.678016099177, 6442.838929026765, 6970.721171153097, 6973.686184121727, 6979.127609048869, 6980.057692211588, 6984.196817365966, 6589.0, 6662.933370666328, 6678.0, 6678.966605166943, 6682.599044057372, 6044.399168046189, 6738.0, 6759.695813688396, 6765.695543700545, 6789.694463749044, 6703.865922681519, 6711.362420570038, 6750.966245168743, 6816.284290149463, 6872.244053154149, 6799.286074962157, 6805.081314022643, 6875.0, 6881.208661003949, 6883.449324054063, 5328.626996110313, 5330.360356757214, 5397.811076612378, 5407.540359069523, 5412.269343638637, 4774.379330686988, 4791.137595232822, 4813.109574728686, 4822.469528351879, 4841.104395686809, 6000.489958353502, 6006.249218847644, 6006.339302676702, 6021.819345419644, 6048.909266361008, 6794.8641027180165, 6825.283345248777, 6841.281665425158, 6918.169819621678, 6950.930490695028, 5866.472017518444, 5893.057110862242, 5970.373110823388, 6031.276246850406, 6040.124181993587, 5790.392008839011, 5829.213056237439, 5863.67749773758, 5912.3496415394275, 5922.644641321534, 6445.452136568444, 6565.474762019027, 6575.572587781779, 6576.8355791105605, 6610.8016759497295, 6772.0, 6794.966025169842, 6822.351876571718, 6847.554908930903, 6906.06768086312, 6438.871222575429, 6512.185976752906, 6521.34786521363, 6608.4052435281055, 6608.735650574115, 6588.308227636221, 6646.966765166143, 6648.9002664961035, 6652.567583107082, 6669.46644268467, 6720.798376048726, 6764.120664313607, 6792.796216113525, 6808.62552559614, 6810.727570897108, 6557.114789503356, 6569.638669873203, 6580.80257592273, 6620.602763834186, 6624.867502650017, 6556.508261880283, 6587.868242635216, 6596.208454985433, 6619.0733297339375, 6699.5310328276555, 6388.8083357499345, 6502.252240992347, 6542.051402546699, 6644.368784965421, 6666.500012498985, 6408.743650253938, 6580.440662543738, 6635.63504007265, 6760.357766012221, 6770.796876093725, 6442.935570644234, 6452.290248072803, 6526.575772574767, 6545.247296560957, 6549.934500654933], "value": 6161.396122814131, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.2792999770254, 729.2598013016789, 746.4737360161085, 748.9812754681136, 750.5721738608995, 30712.692873071264, 31595.21011974702, 39241.803790981074, 40172.397414038816, 40235.79882100593, 40122.0, 40204.19591608166, 40553.39169912446, 40591.59408405915, 40676.18647627046, 7588.848223035536, 7655.08139023318, 7658.655360508763, 7838.804029899241, 7882.921170788276, 7738.226177382273, 7853.293203611674, 7878.527288362688, 7880.093789214227, 7881.881771773428, 7784.299413052824, 7810.921890781105, 7840.176781437953, 7920.960395198016, 7928.524288542677, 7784.532928024309, 7790.688372465152, 7805.687772489094, 7810.297073263405, 7826.882596761053, 7725.188855170239, 7783.922160778377, 7790.143084260783, 7799.805004874866, 7799.805004874866, 36543.81728091369, 36594.81702591496, 36985.0, 37001.62998370035, 37024.25951480982, 3384.4923261510726, 3399.1841957930164, 3448.2413868948793, 3451.861925522976, 3459.066052165926, 30127.849360753054, 30408.695913040807, 30449.391012179854, 30453.390932181454, 30465.0, 5021.57316628087, 5126.436092029874, 5156.793728250866, 5164.922526162073, 5206.557442617382, 174918.0, 175523.0, 177019.11490442595, 177682.0, 178002.0, 45684.314735279, 45984.5401545987, 45987.77006114948, 46006.76996615063, 46007.53992460033, 48140.518594814304, 48176.5182348172, 50768.74615626898, 51638.22542661863, 51784.74107629438, 16158.192090395432, 16173.110478923772, 16237.67524649524, 16246.106464144586, 16275.348986040663, 11642.068634509218, 11813.88186118145, 13201.405936732677, 13334.133281336683, 13360.665983350495, 13990.440382384591, 14047.508337208354, 14073.085249458753, 14095.859041409454, 14246.928765356313, 5343.171808369709, 5431.755570999315, 5617.943820561742, 5657.32112146545, 5705.4579814917515, 966.7534778631544, 979.4368238263028, 990.1781521337273, 1008.0927165550917, 1011.8633984412011, 21917.890410547847, 21958.780412195993, 22147.224847130274, 22185.889070554545, 22320.10719571199, 1065.8241390170535, 1074.4466599701161, 1077.380506208933, 1101.9504122314515, 1114.0586204657052, 11886.643400697993, 11907.642770716893, 11939.164258501822, 11967.162298639187, 12057.276563406223, 231207.0, 232141.0, 233199.0, 233445.0, 234057.0, 50188.0, 50332.74833625808, 50429.74785126124, 50461.0, 50592.24111638328, 1371.136184203945, 1421.047897908404, 1431.3701971132668, 1438.539667306452, 1438.5612388221693, 21470.570588587827, 21649.13403463844, 21650.891745541172, 21784.564308714052, 22082.22712205065, 36289.092772680895, 36376.09059773527, 36409.45385819162, 36454.08864778402, 36525.63474365223, 185511.0, 186431.0, 186686.0, 186869.0, 188900.0, 33209.33581328311, 34338.656613433544, 36298.27403451969, 36425.817870910476, 36554.26891462209, 43422.34866477069, 44511.10977780491, 44604.77697611491, 44740.77629611831, 44806.55193448154, 32537.349253014334, 32767.50848737223, 33119.0, 33311.50032749559, 33826.15434614154, 32315.35369292648, 32328.83835580807, 32336.191595210308, 32880.83559582187, 32943.50584741183, 35565.64434355623, 36835.815820920725, 36914.0, 37040.62959370372, 37179.0, 31687.890923817555, 31750.841245793625, 31949.0, 32068.83965580157, 32521.674783252813, 19878.701819473008, 20320.369788000884, 20352.69470957907, 20699.8965005174, 21095.367138985854], "value": 16740.86628538358, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.203135531867, 562.6174201542955, 565.7114871415577, 568.20735074571, 578.7829563913532, 21489.24787632433, 21776.237831675895, 22568.21011264602, 22773.658395124086, 22820.20129295473, 23977.640335394983, 24271.393215169628, 24338.0, 24402.145924892633, 24491.510169796595, 6409.551331406815, 6558.901616475757, 6570.967145164267, 6573.57271777333, 6580.967095164518, 6281.0, 6525.706343214543, 6552.082708420801, 6581.01284807278, 6592.241892182413, 6532.379423954717, 6548.5088618353575, 6555.868882622344, 6572.07990881277, 6589.143411356517, 6579.374959378852, 6583.9670801645925, 6588.538802283842, 6593.67031648418, 6597.439217666456, 6055.212822333113, 6065.332813390523, 6065.423784740443, 6079.240094988127, 6101.816945491642, 28588.14235572936, 28640.283992900135, 28864.711352886414, 29038.419231615462, 29381.559276610653, 2067.1937944201773, 2090.278853795438, 2102.4743814046487, 2103.200783702199, 2103.831693464519, 19043.80956190434, 19594.41216763485, 19625.0, 19656.70514942277, 19673.704894426595, 2381.521068450071, 2420.189236605739, 2425.745296743834, 2443.853368797878, 2468.5309791139625, 136586.31706841404, 137657.0, 139480.0, 139725.0, 140177.0, 14624.853751462562, 14912.135983001908, 15287.5476829701, 15454.768178477332, 16133.67732645364, 22954.540909181724, 23046.53906921852, 23075.307740767803, 23091.88454057719, 23146.0, 10025.799484010278, 10237.539310731036, 10272.691819245434, 10324.483775811179, 10531.0, 9627.037296270317, 9649.951750241344, 9658.275629327689, 9710.70867873965, 9990.600375985025, 7694.230576942373, 8899.243564296978, 9019.413738107001, 9030.232430243503, 9055.0, 2664.9467010659678, 2680.088769818271, 2716.6332545106156, 2745.9038933637225, 2760.1857452051695, 934.9205317547949, 961.1925982174866, 967.2793768642266, 967.7483854197818, 977.3500622086233, 19446.319378821674, 19617.117229724696, 19895.303664371677, 19895.801041989685, 20169.798302016792, 1024.8565200871883, 1026.3226270661328, 1027.2809033676456, 1029.6705054382526, 1035.7514196592763, 10670.893291067145, 10712.785744285227, 10733.302335348177, 10872.293300935415, 10901.563937442414, 489077.0, 563749.0, 565476.0, 567508.0, 568639.0, 115018.42490787493, 121367.0, 124672.0, 125447.3727631356, 127523.36238318935, 1157.4907040901976, 1212.9878701213051, 1216.9634910952686, 1218.8171774233936, 1223.7246619510718, 20974.0, 21214.575708486052, 21243.256486022914, 21269.89365053165, 21385.0, 57595.71202143963, 58499.4150058494, 59208.70395647994, 59591.702041489516, 60523.394766053534, 73089.0, 73452.0, 74017.62991185009, 74081.6295918517, 74270.62864685642, 12252.142350035412, 12692.746145077232, 14172.503962361268, 14434.494792682206, 14496.565103046925, 17141.0, 18880.811191887904, 18896.0, 22960.311190664306, 23405.180818671266, 16981.066041367845, 16993.745093823356, 17196.0, 17279.0, 17329.0, 15173.16547589849, 15806.9209653951, 15903.52289431319, 16042.759358609863, 16531.33874645001, 17633.20650570753, 17760.555986099935, 18443.631127377645, 18568.44294671162, 18655.72016419782, 13878.375473103937, 13887.861121388656, 13967.161970281815, 14028.719425611635, 14181.078229915023, 18018.36935707244, 18178.90910545439, 18386.0, 18892.716609251147, 19146.329878454188], "value": 11969.7946376135, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1278.1180985120266, 1297.4291311822803, 1306.1836352279824, 1308.8560258371583, 1329.434990129195, 14380.784288235685, 14863.925680371583, 15022.849771502282, 15042.548723538284, 15056.096634201942, 14894.851051489482, 15433.074015559074, 15445.382184712626, 15524.767128493053, 15538.689226215469, 2760.3789147441867, 2797.398559309748, 2806.775457963358, 2808.5365914624163, 2822.0122956965, 2682.6646669166353, 2716.877740501682, 2747.4917140329003, 2775.4310366374843, 2818.689944106147, 2781.123945957027, 2807.719228077186, 2808.747212750852, 2809.7330753578376, 2810.12886005338, 2708.5801700736415, 2714.4571085782727, 2716.497447972122, 2732.808703390773, 2738.904138355168, 2627.1855724725206, 2633.4206474575562, 2689.3276680829795, 2704.0806125917284, 2707.905223317194, 14584.927075364662, 14748.557543273611, 14859.0, 14877.628059298604, 14947.775783363259, 7787.688492460295, 8078.35373170145, 8081.0, 8081.989751281089, 8089.271965523072, 5172.2588824885825, 5339.5728341732565, 5366.731663416814, 5522.475364840334, 5621.381648018714, 1834.1287888253107, 1908.961820763577, 2162.859414138092, 2430.428849220432, 2452.3869032741813, 25455.0, 25592.74407255922, 25633.48733025329, 25651.486970260492, 25732.09937652173, 6411.358864113551, 6536.803895883131, 6645.235797883209, 6719.630420326929, 6791.388775010273, 16443.506694799176, 16466.917665411594, 16497.83502164987, 16509.0, 16514.0, 7621.961890190624, 7807.180246074194, 7830.960845195851, 7866.646000929972, 7868.881966770503, 7143.0, 7256.383207427428, 7280.563166210044, 7333.2666733327305, 7334.48658593904, 5183.14478111115, 5205.817796377184, 5309.070912590359, 5399.4600539945695, 5482.616216864782, 1526.4809964612086, 1541.1600677630718, 1542.4447199008348, 1544.7914531538324, 1554.5103292463064, 833.9624716887633, 858.9699360522477, 863.53369180643, 868.3747701654798, 879.6657270237397, 7214.74748383804, 7301.269873012656, 7315.195328513859, 7337.156227033959, 7368.15266244378, 678.725116327888, 684.9828754281083, 695.422799076765, 697.8778713725078, 702.9736584586459, 4216.135692183095, 4657.0, 5033.219850923039, 5066.695998240118, 5113.590912726973, 19876.90061549683, 20512.38462846117, 20613.381598552067, 20616.58766824655, 20923.0, 18715.71926421105, 20375.184992600425, 20487.18051277962, 20841.583168336547, 21023.78976210249, 10242.692719218436, 10358.119559837347, 10645.574177032831, 10890.61882834097, 10922.672319830259, 8015.318697910743, 8162.142974987778, 8166.918330816616, 8246.3815213858, 8272.0, 17478.388256410966, 17946.37187698424, 18146.72779908276, 18379.90810045941, 18479.353222637143, 18508.629827403645, 18513.72229416587, 18528.790082000196, 19133.8086619132, 19641.508962276057, 11760.294382337088, 11961.342126182795, 11962.521499139937, 11971.221870578385, 12009.339486327986, 13135.868641313464, 13664.0, 13753.449862005407, 13753.656158595715, 13770.449182032606, 10364.585416583554, 10564.735881603021, 10965.232433729881, 11022.283551569122, 11052.613158539412, 10041.899581004389, 10604.363738175734, 10661.466926653482, 10692.465376731288, 10696.090832279344, 8944.239739622206, 8986.19124278818, 8986.775330616787, 9017.864732029157, 9100.044495327895, 6614.107095542233, 6638.402543770891, 6746.763863264762, 6768.2216545097945, 6852.862942741018, 6484.773032943825, 6632.158524277208, 6654.367835055662, 6657.633830139195, 6664.500162487736], "value": 6476.513906571938, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.0412705541831, 502.2315856739189, 513.9357580302462, 519.9116150254458, 527.4382782336811, 6290.465310448617, 6304.527160462966, 6341.239051313843, 6379.808605741835, 6398.680065996699, 6208.906866397007, 6251.6874156292115, 6302.495800335973, 6317.399847014526, 6340.651264180468, 5143.562797162245, 5161.922571161435, 5167.354080739908, 5178.456262092483, 5193.428722840485, 4882.145624515713, 4958.504149585049, 5000.749962501878, 5007.32401125847, 5034.974825125869, 4849.078675051729, 4926.827561035365, 4950.207966725325, 4970.6520543561965, 4972.701637901738, 4922.178793846299, 4942.3327850740225, 4950.504949505057, 5006.123928312567, 5018.347614810052, 4350.564943505656, 4357.455318085239, 4394.582514661102, 4417.315316126005, 4464.464264288274, 6204.81385558434, 6222.284437289724, 6241.750329986795, 6272.2786879508985, 6289.559730818844, 5515.669059856422, 5729.93722259986, 5745.8563535911935, 5767.740451679684, 5778.8266352009505, 6536.77121300757, 6546.6726663667105, 6567.770128045543, 6579.17760279965, 6628.900566491507, 4766.833160839354, 4770.260609605517, 4796.952030479721, 4832.830850920201, 4836.758162091881, 6685.298043705438, 6829.453643708492, 6852.862942741167, 6891.689873955684, 7046.823829404255, 4917.950820491821, 4946.183879659816, 4954.801807927643, 4958.404991400983, 5021.799128034838, 5041.395032596112, 5063.164577844688, 5063.164577844688, 5067.949320506821, 5083.872903177376, 5656.727236371866, 5696.572757043238, 5702.230198923092, 5734.913976290276, 5739.483446489752, 6667.466602671775, 6699.799006029827, 6731.394174524316, 6744.325567443217, 6791.966040169767, 1734.3842935757878, 1755.2540170427517, 1758.7273972534279, 1762.2950819671978, 1780.8486278666198, 1129.615930583589, 1181.4565299961941, 1195.5277665322324, 1204.3315959642482, 1220.8046712526132, 5806.158107074535, 5828.941710582924, 5881.735321910524, 5913.142594323799, 5925.940740592625, 6752.257251702407, 6765.154355705537, 6770.1537307836525, 6820.965895170492, 6859.330258311779, 5844.561657875676, 5845.240118784531, 5877.441643043904, 5893.675847828325, 5983.341832398432, 3602.963970360263, 3637.254362855608, 3643.2349206666895, 3659.853605855736, 3667.5232219811255, 6524.184476940382, 6551.770688025991, 6566.901496477557, 6577.473802095821, 6653.168353955755, 6953.33943275388, 6966.442684585221, 6969.337912898267, 6987.650617469208, 7044.753433629799, 6532.346765323429, 6546.378094081245, 6560.900511836262, 6579.638119903451, 6630.867382652416, 6225.875482490415, 6798.660066996729, 6802.829929251809, 6850.657467126524, 6856.417204537471, 6569.489017526092, 6684.598924064571, 6756.628385438848, 6761.492888033319, 6781.11845460087, 6463.385978332051, 6525.543211975116, 6543.836404089936, 6544.3966228272475, 6556.606603603799, 4764.714117152982, 4921.975390123026, 4939.259111133359, 4961.5534601886, 5003.924941125813, 6456.515761318014, 6663.267040625624, 6690.632015239208, 6803.421709154777, 6812.14848143982, 6535.640539770358, 6549.672516374067, 6551.737930482727, 6559.6064236145985, 6584.0, 6537.346265373425, 6565.376289252514, 6586.176727909012, 6599.835004124935, 6627.834304142435, 6558.967205163944, 6606.8348291293105, 6628.0, 6631.171103612049, 6673.1992160941, 6713.462922966249, 6719.731210751515, 6721.495887808532, 6728.158980127484, 6751.02110194029, 6410.294867564471, 6452.838679033061, 6459.5478316519275, 6473.64394958263, 6508.511861610493], "value": 5087.89687121412, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [865.2472349056322, 887.8446271902417, 893.5308962794528, 898.5821592959272, 913.4519288426944, 15111.0, 17322.0, 18495.167717452714, 18528.258869645197, 18603.25586976521, 16244.269007894643, 16960.575985600368, 17119.828801711978, 17228.569285767862, 17446.38937637183, 900.4057322167371, 920.2683866326287, 922.3405265235356, 924.1774820409807, 925.9675911343104, 686.3822559696264, 923.8891333040044, 932.0, 932.8740620016279, 935.4387367579432, 773.8297574533593, 783.2832957843594, 935.3779736475236, 966.6036924860808, 972.1008067537534, 957.6887511558737, 962.9903700963006, 963.4026903319916, 963.6771681486711, 965.1844191658073, 703.4618516834626, 705.2031204738613, 705.8164877131932, 707.056080133023, 711.2638419236117, 15601.375944962188, 16104.19479026044, 16224.513264602081, 16241.0, 16322.75515867263, 20021.399358019284, 20125.5974880503, 20391.592168156552, 20440.693389599168, 20493.4876628084, 15477.0, 15674.137922414262, 15683.607909802233, 15746.842531574652, 15748.291326890318, 3515.437529995214, 3662.468942003421, 3692.4461330800327, 3702.38910579754, 3713.2016616427327, 124997.0, 128727.0, 128891.0, 128934.0, 130349.0, 14597.489087881873, 14715.264236788118, 14998.47505337308, 15114.168720720467, 15154.318055687521, 28156.0, 29961.700382995892, 30047.399052019275, 30093.0, 30345.848270758506, 6927.688254028581, 8306.584670766437, 8475.618597163142, 8583.527905965107, 8634.568271586395, 4122.876313710593, 4155.480564929384, 4191.161767646483, 4227.915441691211, 4231.661467082626, 4746.145693775154, 4835.298881662139, 4844.927326090112, 4881.487443818419, 4915.95084049155, 984.6159997600942, 1001.3941565352857, 1004.1213937804421, 1015.7562185075528, 1017.0287375556326, 668.8896332105148, 678.7590405406108, 684.2815044203567, 706.1490903461316, 708.6952610377588, 10420.943789243416, 10945.671629851116, 11040.486113193254, 11067.833982490269, 11113.944430277797, 690.4096997067435, 692.0864458914285, 702.1433850702135, 708.2103454648134, 715.1275443958363, 5526.917096243559, 5585.469380408936, 5628.212050312959, 5675.858103547362, 5701.230333904953, 101417.49291253496, 101881.0, 105659.0, 106422.46788766007, 108069.0, 89110.0, 90205.0, 91555.54222228979, 94391.0, 95034.52482737681, 82248.17751822405, 83158.0, 85575.0, 85936.828212332, 86287.0, 11899.405029748305, 12030.699232518908, 12039.879601204226, 12203.877961220629, 12246.75506489883, 37653.2469350606, 38126.42810357791, 38720.2255954885, 40042.1991560173, 40059.59940400559, 47851.5214847861, 50073.24890126724, 50104.248436272755, 50614.49385506245, 50897.491025090756, 16078.839211607734, 16323.755143673092, 16339.836601634306, 16479.83520164783, 16765.077920714477, 19294.0, 19837.603247934672, 19911.10400032031, 19997.800021999592, 20126.0, 15730.056196628238, 15759.763603545727, 15778.0, 15785.526434206991, 17763.200655970253, 16860.494185174466, 17298.481045568653, 17380.0, 17443.215055322285, 17459.30162793474, 16509.33962641481, 16707.832921670626, 16982.83017169862, 17139.314427422763, 17850.732239016164, 11740.58907938218, 12107.455164517442, 12862.807057894326, 12873.16324438946, 12946.705329466979, 12195.817062743889, 13003.08978371505, 13201.801972970605, 13422.39599218057, 13540.119892206974], "value": 8536.892882698345, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1526.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 107.0, 100.0, 107.0, 116.0, 120.0, 108.0, 99.0, 111.0, 109.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 122.0, 147.0, 180.0, 118.0, 151.0, 159.0, 119.0, 173.0, 121.0], "value": 144.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 167.0, 168.0, 163.0, 166.0, 166.0, 163.0, 171.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 82.0, 74.0, 168.0, 80.0, 74.0, 74.0, 75.0, 171.0, 74.0], "value": 96.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 80.0, 129.0, 81.0, 84.0, 80.0, 130.0, 81.0, 85.0, 137.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 126.0, 115.0, 121.0, 115.0, 123.0, 114.0, 114.0, 115.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 156.0, 148.0, 151.0, 149.0, 150.0, 149.0, 151.0, 158.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 94.0, 94.0, 97.0, 95.0, 94.0, 95.0, 95.0, 101.0, 94.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 51.0, 56.0, 55.0, 54.0, 51.0, 52.0, 58.0, 51.0, 52.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 42.0, 40.0, 40.0, 39.0, 47.0, 39.0, 47.0, 39.0, 51.0], "value": 42.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 87.0, 81.0, 80.0, 76.0, 79.0, 76.0, 76.0, 76.0, 85.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 120.0, 135.0, 123.0, 135.0, 127.0, 128.0, 125.0, 126.0, 162.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 178.0, 182.0, 174.0, 173.0, 180.0, 171.0, 180.0, 182.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 63.0, 64.0, 65.0, 71.0, 65.0, 67.0, 62.0, 72.0], "value": 65.9, "unit": "score"}]}]} 08:53:09 INFO - Return code: 0 08:53:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:53:09 INFO - # TBPL SUCCESS # 08:53:09 INFO - Running post-action listener: _package_coverage_data 08:53:09 INFO - Running post-action listener: _resource_record_post_action 08:53:09 INFO - [mozharness: 2017-08-28 15:53:09.573995Z] Finished run-tests step (success) 08:53:09 INFO - Running post-run listener: _resource_record_post_run 08:53:09 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 12550144; Write bytes: 439615488; Read time: 5104; Write time: 575572 08:53:09 INFO - TinderboxPrint: CPU usage
13.3% 08:53:09 INFO - TinderboxPrint: I/O read bytes / time
12,550,144 / 5,104 08:53:09 INFO - TinderboxPrint: I/O write bytes / time
439,615,488 / 575,572 08:53:09 INFO - TinderboxPrint: CPU idle
8,299.3 (86.7%) 08:53:09 INFO - TinderboxPrint: CPU user
1,201.2 (12.6%) 08:53:09 INFO - TinderboxPrint: Swap in / out
0 / 0 08:53:09 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 105541632; Read time: 60; Write time: 110008 08:53:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:53:09 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 10313728; Write bytes: 320434176; Read time: 4876; Write time: 450224 08:53:10 INFO - Running post-run listener: _upload_blobber_files 08:53:10 INFO - Blob upload gear active. 08:53:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:53:10 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 08:53:10 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'] 08:53:10 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 08:53:10 INFO - (blobuploader) - INFO - Open directory for files ... 08:53:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:53:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:53:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:11 INFO - (blobuploader) - INFO - Done attempting. 08:53:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:53:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:53:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:18 INFO - (blobuploader) - INFO - Done attempting. 08:53:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:53:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:53:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:19 INFO - (blobuploader) - INFO - Done attempting. 08:53:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:53:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:53:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:20 INFO - (blobuploader) - INFO - Done attempting. 08:53:20 INFO - (blobuploader) - INFO - Iteration through files over. 08:53:20 INFO - Return code: 0 08:53:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:53:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:53:20 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e760d31cb88d9dbabeedc56da1771d79d98a029a584c18123ced819438f27c54efbb22972d07cedfb1e64074384a596bcf1b2c710652874829de64f99ef2073", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8cfe7af2d4dac06070f8b92bb33394bfa41c3e613cfcdc19fb779fe64444e3133c9bfc382bf7be1dc57f4968abd9db4f605e953a7565cfb04540a070db96506", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43d4100ad4355041ce503082ccfb678658f101dde908ce0abd137c3a5e5a99bbe52859bfac2ae7ac5085baeea70c0c6d4d4a961ee4c9bb55d06d0f23db41deac", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8dad425fe02f7b798af858733e6ef216b885f9b0d9e401be1ebe85350d59646b6dc0367b3627516387d03d3793639ff1f4b4c356070aac13535e978aecb9f29"} 08:53:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:53:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:53:20 INFO - Contents: 08:53:20 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e760d31cb88d9dbabeedc56da1771d79d98a029a584c18123ced819438f27c54efbb22972d07cedfb1e64074384a596bcf1b2c710652874829de64f99ef2073", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8cfe7af2d4dac06070f8b92bb33394bfa41c3e613cfcdc19fb779fe64444e3133c9bfc382bf7be1dc57f4968abd9db4f605e953a7565cfb04540a070db96506", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43d4100ad4355041ce503082ccfb678658f101dde908ce0abd137c3a5e5a99bbe52859bfac2ae7ac5085baeea70c0c6d4d4a961ee4c9bb55d06d0f23db41deac", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8dad425fe02f7b798af858733e6ef216b885f9b0d9e401be1ebe85350d59646b6dc0367b3627516387d03d3793639ff1f4b4c356070aac13535e978aecb9f29"} 08:53:20 INFO - Running post-run listener: copy_logs_to_upload_dir 08:53:20 INFO - Copying logs to upload dir... 08:53:20 INFO - mkdir: /builds/slave/test/build/upload/logs 08:53:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.004724 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-08-28 08:53:20.866909) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-28 08:53:20.870967) ========= 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=ea65d483da93c827905c2090000001f5-1503934306.647693-818300802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e760d31cb88d9dbabeedc56da1771d79d98a029a584c18123ced819438f27c54efbb22972d07cedfb1e64074384a596bcf1b2c710652874829de64f99ef2073", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8cfe7af2d4dac06070f8b92bb33394bfa41c3e613cfcdc19fb779fe64444e3133c9bfc382bf7be1dc57f4968abd9db4f605e953a7565cfb04540a070db96506", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43d4100ad4355041ce503082ccfb678658f101dde908ce0abd137c3a5e5a99bbe52859bfac2ae7ac5085baeea70c0c6d4d4a961ee4c9bb55d06d0f23db41deac", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8dad425fe02f7b798af858733e6ef216b885f9b0d9e401be1ebe85350d59646b6dc0367b3627516387d03d3793639ff1f4b4c356070aac13535e978aecb9f29"} build_url:https://queue.taskcluster.net/v1/task/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011675 build_url: 'https://queue.taskcluster.net/v1/task/Sv4qr0ycSAaRWiVssPK9WA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e760d31cb88d9dbabeedc56da1771d79d98a029a584c18123ced819438f27c54efbb22972d07cedfb1e64074384a596bcf1b2c710652874829de64f99ef2073", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8cfe7af2d4dac06070f8b92bb33394bfa41c3e613cfcdc19fb779fe64444e3133c9bfc382bf7be1dc57f4968abd9db4f605e953a7565cfb04540a070db96506", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43d4100ad4355041ce503082ccfb678658f101dde908ce0abd137c3a5e5a99bbe52859bfac2ae7ac5085baeea70c0c6d4d4a961ee4c9bb55d06d0f23db41deac", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8dad425fe02f7b798af858733e6ef216b885f9b0d9e401be1ebe85350d59646b6dc0367b3627516387d03d3793639ff1f4b4c356070aac13535e978aecb9f29"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-28 08:53:20.898732) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-28 08:53:20.899149) ========= 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=ea65d483da93c827905c2090000001f5-1503934306.647693-818300802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-28 08:53:20.983339) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-28 08:53:20.983713) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-28 08:53:20.984145) ========= ========= Total master_lag: 0.23 =========