builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-045 starttime: 1501408880.28 results: success (0) revision: 6ee53b46474f74c231b1b569e8f2ecd9d0948a8f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:20.283300) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:20.283858) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:20.284142) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:20.333040) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:20.333324) ========= 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=4300f881736b422476174874000001bc-1501408804.72125-1684044571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-30 03:01:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 159M=0s 2017-07-30 03:01:20 (159 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.200587 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:20.572277) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:20.572559) ========= 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=4300f881736b422476174874000001bc-1501408804.72125-1684044571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019803 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:20.623660) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-07-30 03:01:20.623973) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6ee53b46474f74c231b1b569e8f2ecd9d0948a8f --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 6ee53b46474f74c231b1b569e8f2ecd9d0948a8f --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=4300f881736b422476174874000001bc-1501408804.72125-1684044571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-30 03:01:20,656 truncating revision to first 12 chars 2017-07-30 03:01:20,656 Setting DEBUG logging. 2017-07-30 03:01:20,656 attempt 1/10 2017-07-30 03:01:20,656 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6ee53b46474f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-30 03:01:21,313 sleeping for 10.00s (attempt 1/10) 2017-07-30 03:01:31,324 attempt 2/10 2017-07-30 03:01:31,324 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6ee53b46474f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-30 03:01:32,499 unpacking tar archive at: mozilla-central-6ee53b46474f/testing/mozharness/ program finished with exit code 0 elapsedTime=12.177039 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-07-30 03:01:32.807220) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:32.807554) ========= script_repo_revision: 6ee53b46474f74c231b1b569e8f2ecd9d0948a8f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:32.807961) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:32.808229) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:32.815269) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-07-30 03:01:32.815581) ========= /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=4300f881736b422476174874000001bc-1501408804.72125-1684044571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:01:33 INFO - MultiFileLogger online at 20170730 03:01:33 in /builds/slave/test 03:01:33 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 03:01:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:01:33 INFO - {'append_to_log': False, 03:01:33 INFO - 'base_work_dir': '/builds/slave/test', 03:01:33 INFO - 'blob_upload_branch': 'Firefox', 03:01:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:01:33 INFO - 'branch': 'Firefox', 03:01:33 INFO - 'buildbot_json_path': 'buildprops.json', 03:01:33 INFO - 'code_coverage': False, 03:01:33 INFO - 'config_files': ('talos/linux_config.py',), 03:01:33 INFO - 'default_actions': ('clobber', 03:01:33 INFO - 'read-buildbot-config', 03:01:33 INFO - 'download-and-extract', 03:01:33 INFO - 'populate-webroot', 03:01:33 INFO - 'create-virtualenv', 03:01:33 INFO - 'install', 03:01:33 INFO - 'setup-mitmproxy', 03:01:33 INFO - 'run-tests'), 03:01:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:01:33 INFO - 'disable_ccov_upload': False, 03:01:33 INFO - 'download_minidump_stackwalk': True, 03:01:33 INFO - 'download_symbols': 'ondemand', 03:01:33 INFO - 'enable_stylo': False, 03:01:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:01:33 INFO - 'tooltool.py': '/tools/tooltool.py', 03:01:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:01:33 INFO - '/tools/misc-python/virtualenv.py')}, 03:01:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:01:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:01:33 INFO - 'gecko_profile': False, 03:01:33 INFO - 'gecko_profile_interval': 0, 03:01:33 INFO - 'installer_path': 'installer.exe', 03:01:33 INFO - 'log_level': 'info', 03:01:33 INFO - 'log_name': 'talos', 03:01:33 INFO - 'log_to_console': True, 03:01:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:01:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:01:33 INFO - 'opt_config_files': (), 03:01:33 INFO - 'pip_index': False, 03:01:33 INFO - 'suite': 'dromaeojs-e10s', 03:01:33 INFO - 'system_bits': '32', 03:01:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:01:33 INFO - 'title': 'talos-linux64-ix-045', 03:01:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:01:33 INFO - 'use_talos_json': True, 03:01:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:01:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:01:33 INFO - 'work_dir': 'build'} 03:01:33 INFO - [mozharness: 2017-07-30 10:01:33.031738Z] Running clobber step. 03:01:33 INFO - Running pre-action listener: _resource_record_pre_action 03:01:33 INFO - Running main action method: clobber 03:01:33 INFO - rmtree: /builds/slave/test/build 03:01:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:01:34 INFO - Running post-action listener: _resource_record_post_action 03:01:34 INFO - [mozharness: 2017-07-30 10:01:34.012484Z] Finished clobber step (success) 03:01:34 INFO - [mozharness: 2017-07-30 10:01:34.012587Z] Running read-buildbot-config step. 03:01:34 INFO - Running pre-action listener: _resource_record_pre_action 03:01:34 INFO - Running main action method: read_buildbot_config 03:01:34 INFO - Using buildbot properties: 03:01:34 INFO - { 03:01:34 INFO - "project": "", 03:01:34 INFO - "product": "firefox", 03:01:34 INFO - "who": "archaeopteryx@coole-files.de", 03:01:34 INFO - "installer_path": "public/build/target.tar.bz2", 03:01:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 03:01:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:01:34 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 03:01:34 INFO - "stage_platform": "linux64-stylosequential", 03:01:34 INFO - "basedir": "/builds/slave/test", 03:01:34 INFO - "buildnumber": 157, 03:01:34 INFO - "platform": "ubuntu64_hw_styloseq", 03:01:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:01:34 INFO - "slavebuilddir": "test", 03:01:34 INFO - "taskId": "DMRAC8NcRMa7_YmVEjv_Wg", 03:01:34 INFO - "branch": "mozilla-central", 03:01:34 INFO - "script_repo_revision": "production", 03:01:34 INFO - "revision": "6ee53b46474f74c231b1b569e8f2ecd9d0948a8f", 03:01:34 INFO - "slavename": "talos-linux64-ix-045", 03:01:34 INFO - "repo_path": "mozilla-central" 03:01:34 INFO - } 03:01:34 INFO - Finding installer, test and symbols from parent task. 03:01:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DMRAC8NcRMa7_YmVEjv_Wg'}, attempt #1 03:01:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DMRAC8NcRMa7_YmVEjv_Wg'}, attempt #1 03:01:34 INFO - Task dependencies: Ci-E2TbxTwSnTt2-E0Fjxw 03:01:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw'}, attempt #1 03:01:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.tar.bz2 03:01:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.test_packages.json 03:01:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.crashreporter-symbols.zip 03:01:35 INFO - Running post-action listener: _resource_record_post_action 03:01:35 INFO - [mozharness: 2017-07-30 10:01:35.404473Z] Finished read-buildbot-config step (success) 03:01:35 INFO - [mozharness: 2017-07-30 10:01:35.404694Z] Running download-and-extract step. 03:01:35 INFO - Running pre-action listener: _resource_record_pre_action 03:01:35 INFO - Running main action method: download_and_extract 03:01:35 INFO - mkdir: /builds/slave/test/build/tests 03:01:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:35 INFO - trying https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.test_packages.json 03:01:35 INFO - Downloading https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:01:35 INFO - Downloaded 989 bytes. 03:01:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:01:35 INFO - Using the following test package requirements: 03:01:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:01:35 INFO - u'common': [u'target.common.tests.zip'], 03:01:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:01:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:01:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:01:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:01:35 INFO - u'mozbase': [u'target.common.tests.zip'], 03:01:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:01:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:01:35 INFO - u'web-platform': [u'target.common.tests.zip', 03:01:35 INFO - u'target.web-platform.tests.tar.gz'], 03:01:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:01:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:01:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.common.tests.zip 03:01:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:01:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.common.tests.zip into memory 03:01:38 INFO - Content-Length response header: 72565221 03:01:38 INFO - Bytes received: 72565221 03:01:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:01:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.common.tests.zip 03:01:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:01:50 INFO - Fetch https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.common.tests.zip into memory 03:01:53 INFO - Content-Length response header: 72565221 03:01:53 INFO - Bytes received: 72565221 03:02:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.talos.tests.zip 03:02:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:02:05 INFO - Fetch https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.talos.tests.zip into memory 03:02:06 INFO - Content-Length response header: 14496686 03:02:06 INFO - Bytes received: 14496686 03:02:06 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')]} 03:02:06 INFO - trying https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.tar.bz2 03:02:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:02:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:02:08 INFO - Downloaded 62258448 bytes. 03:02:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.tar.bz2 03:02:08 INFO - mkdir: /builds/slave/test/properties 03:02:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:02:08 INFO - Writing to file /builds/slave/test/properties/build_url 03:02:08 INFO - Contents: 03:02:08 INFO - build_url:https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.tar.bz2 03:02:08 INFO - Running post-action listener: _resource_record_post_action 03:02:08 INFO - Running post-action listener: set_extra_try_arguments 03:02:08 INFO - [mozharness: 2017-07-30 10:02:08.225125Z] Finished download-and-extract step (success) 03:02:08 INFO - [mozharness: 2017-07-30 10:02:08.225384Z] Running populate-webroot step. 03:02:08 INFO - Running pre-action listener: _resource_record_pre_action 03:02:08 INFO - Running main action method: populate_webroot 03:02:08 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:02:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:02:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:02:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:02:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:02:08 INFO - 'tests': ['damp', 'tps']}, 03:02:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:02:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:02:08 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:02:08 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:02:08 INFO - 'other-e10s': {'tests': ['a11yr', 03:02:08 INFO - 'ts_paint', 03:02:08 INFO - 'tpaint', 03:02:08 INFO - 'sessionrestore', 03:02:08 INFO - 'sessionrestore_many_windows', 03:02:08 INFO - 'sessionrestore_no_auto_restore', 03:02:08 INFO - 'tabpaint']}, 03:02:08 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:02:08 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:02:08 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:02:08 INFO - 'talos_options': ['--mitmproxy', 03:02:08 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:02:08 INFO - '--firstNonBlankPaint'], 03:02:08 INFO - 'tests': ['quantum_pageload_google', 03:02:08 INFO - 'quantum_pageload_youtube', 03:02:08 INFO - 'quantum_pageload_amazon', 03:02:08 INFO - 'quantum_pageload_facebook']}, 03:02:08 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:02:08 INFO - 'talos_options': ['--stylo', 03:02:08 INFO - '--mitmproxy', 03:02:08 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:02:08 INFO - '--firstNonBlankPaint'], 03:02:08 INFO - 'tests': ['quantum_pageload_google', 03:02:08 INFO - 'quantum_pageload_youtube', 03:02:08 INFO - 'quantum_pageload_amazon', 03:02:08 INFO - 'quantum_pageload_facebook']}, 03:02:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:02:08 INFO - 'tsvgr_opacity', 03:02:08 INFO - 'tart', 03:02:08 INFO - 'tscrollx', 03:02:08 INFO - 'cart', 03:02:08 INFO - 'tsvg_static']}, 03:02:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:02:08 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:02:08 INFO - 'talos_options': ['--stylo', 03:02:08 INFO - '--stylo-threads=1', 03:02:08 INFO - '--mitmproxy', 03:02:08 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:02:08 INFO - '--firstNonBlankPaint'], 03:02:08 INFO - 'tests': ['tp6_google', 03:02:08 INFO - 'tp6_youtube', 03:02:08 INFO - 'tp6_amazon', 03:02:08 INFO - 'tp6_facebook']}, 03:02:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:02:08 INFO - 'talos_options': ['--xperf_path', 03:02:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:02:08 INFO - 'tests': ['tp5n']}}} 03:02:08 INFO - Running post-action listener: _resource_record_post_action 03:02:08 INFO - [mozharness: 2017-07-30 10:02:08.241546Z] Finished populate-webroot step (success) 03:02:08 INFO - [mozharness: 2017-07-30 10:02:08.241637Z] Running create-virtualenv step. 03:02:08 INFO - Running pre-action listener: _resource_record_pre_action 03:02:08 INFO - Running main action method: create_virtualenv 03:02:08 INFO - Creating virtualenv /builds/slave/test/build/venv 03:02:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:02:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:02:08 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:02:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:02:08 INFO - Using real prefix '/usr' 03:02:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:02:08 INFO - Installing distribute.............................................................................................................................................................................................done. 03:02:10 INFO - Installing pip.................done. 03:02:10 INFO - Return code: 0 03:02:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:02:11 INFO - Reading from file tmpfile_stdout 03:02:11 INFO - Output received: 03:02:11 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:02:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:02:11 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')]} 03:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:11 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')]} 03:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:11 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 0x1c2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f98eb0>, '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 0x1f99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a240>, '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': '4300f881736b422476174874000001bc-1501408804.72125-1684044571', '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 03:02:11 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 03:02:11 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 03:02:11 INFO - Using env: {'DISPLAY': ':0', 03:02:11 INFO - 'HOME': '/home/cltbld', 03:02:11 INFO - 'LANG': 'en_US.UTF-8', 03:02:11 INFO - 'LANGUAGE': 'en_US:en', 03:02:11 INFO - 'LOGNAME': 'cltbld', 03:02:11 INFO - 'MAIL': '/var/mail/cltbld', 03:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:11 INFO - 'MOZ_NO_REMOTE': '1', 03:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:11 INFO - 'NO_EM_RESTART': '1', 03:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:11 INFO - 'PWD': '/builds/slave/test', 03:02:11 INFO - 'SHELL': '/bin/bash', 03:02:11 INFO - 'SHLVL': '1', 03:02:11 INFO - 'TERM': 'linux', 03:02:11 INFO - 'TMOUT': '86400', 03:02:11 INFO - 'USER': 'cltbld', 03:02:11 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1501408804.72125-1684044571', 03:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:11 INFO - '_': '/tools/buildbot/bin/python'} 03:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:02:11 INFO - Cleaning up... 03:02:11 INFO - Return code: 0 03:02:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:02:11 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')]} 03:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:11 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')]} 03:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:11 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 0x1c2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f98eb0>, '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 0x1f99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a240>, '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': '4300f881736b422476174874000001bc-1501408804.72125-1684044571', '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 03:02:11 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 03:02:11 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 03:02:11 INFO - Using env: {'DISPLAY': ':0', 03:02:11 INFO - 'HOME': '/home/cltbld', 03:02:11 INFO - 'LANG': 'en_US.UTF-8', 03:02:11 INFO - 'LANGUAGE': 'en_US:en', 03:02:11 INFO - 'LOGNAME': 'cltbld', 03:02:11 INFO - 'MAIL': '/var/mail/cltbld', 03:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:11 INFO - 'MOZ_NO_REMOTE': '1', 03:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:11 INFO - 'NO_EM_RESTART': '1', 03:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:11 INFO - 'PWD': '/builds/slave/test', 03:02:11 INFO - 'SHELL': '/bin/bash', 03:02:11 INFO - 'SHLVL': '1', 03:02:11 INFO - 'TERM': 'linux', 03:02:11 INFO - 'TMOUT': '86400', 03:02:11 INFO - 'USER': 'cltbld', 03:02:11 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1501408804.72125-1684044571', 03:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:11 INFO - '_': '/tools/buildbot/bin/python'} 03:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:11 INFO - Downloading/unpacking psutil>=3.1.1 03:02:11 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 03:02:11 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 03:02:11 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 03:02:11 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 03:02:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:02:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:02:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:02:12 INFO - Installing collected packages: psutil 03:02:12 INFO - Running setup.py install for psutil 03:02:12 INFO - building 'psutil._psutil_linux' extension 03:02:12 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 03:02:13 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 03:02:13 INFO - building 'psutil._psutil_posix' extension 03:02:13 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 03:02:14 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 03:02:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:02:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:02:14 INFO - Successfully installed psutil 03:02:14 INFO - Cleaning up... 03:02:14 INFO - Return code: 0 03:02:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:02:14 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')]} 03:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:14 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')]} 03:02:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1c2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f98eb0>, '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 0x1f99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a240>, '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': '4300f881736b422476174874000001bc-1501408804.72125-1684044571', '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 03:02:14 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 03:02:14 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 03:02:14 INFO - Using env: {'DISPLAY': ':0', 03:02:14 INFO - 'HOME': '/home/cltbld', 03:02:14 INFO - 'LANG': 'en_US.UTF-8', 03:02:14 INFO - 'LANGUAGE': 'en_US:en', 03:02:14 INFO - 'LOGNAME': 'cltbld', 03:02:14 INFO - 'MAIL': '/var/mail/cltbld', 03:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:14 INFO - 'MOZ_NO_REMOTE': '1', 03:02:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:14 INFO - 'NO_EM_RESTART': '1', 03:02:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:14 INFO - 'PWD': '/builds/slave/test', 03:02:14 INFO - 'SHELL': '/bin/bash', 03:02:14 INFO - 'SHLVL': '1', 03:02:14 INFO - 'TERM': 'linux', 03:02:14 INFO - 'TMOUT': '86400', 03:02:14 INFO - 'USER': 'cltbld', 03:02:14 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1501408804.72125-1684044571', 03:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:14 INFO - '_': '/tools/buildbot/bin/python'} 03:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:02:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:02:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:02:15 INFO - Installing collected packages: mozsystemmonitor 03:02:15 INFO - Running setup.py install for mozsystemmonitor 03:02:15 INFO - Successfully installed mozsystemmonitor 03:02:15 INFO - Cleaning up... 03:02:15 INFO - Return code: 0 03:02:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:02:15 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')]} 03:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:15 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')]} 03:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:15 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 0x1c2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f98eb0>, '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 0x1f99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a240>, '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': '4300f881736b422476174874000001bc-1501408804.72125-1684044571', '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 03:02:15 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 03:02:15 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 03:02:15 INFO - Using env: {'DISPLAY': ':0', 03:02:15 INFO - 'HOME': '/home/cltbld', 03:02:15 INFO - 'LANG': 'en_US.UTF-8', 03:02:15 INFO - 'LANGUAGE': 'en_US:en', 03:02:15 INFO - 'LOGNAME': 'cltbld', 03:02:15 INFO - 'MAIL': '/var/mail/cltbld', 03:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:15 INFO - 'MOZ_NO_REMOTE': '1', 03:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:15 INFO - 'NO_EM_RESTART': '1', 03:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:15 INFO - 'PWD': '/builds/slave/test', 03:02:15 INFO - 'SHELL': '/bin/bash', 03:02:15 INFO - 'SHLVL': '1', 03:02:15 INFO - 'TERM': 'linux', 03:02:15 INFO - 'TMOUT': '86400', 03:02:15 INFO - 'USER': 'cltbld', 03:02:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1501408804.72125-1684044571', 03:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:15 INFO - '_': '/tools/buildbot/bin/python'} 03:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:15 INFO - Downloading/unpacking jsonschema==2.5.1 03:02:15 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 03:02:15 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 03:02:15 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 03:02:15 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 03:02:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:02:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:17 INFO - Downloading functools32-3.2.3-2.tar.gz 03:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:02:17 INFO - warning: no files found matching '*.txt' 03:02:17 INFO - no previously-included directories found matching 'build' 03:02:17 INFO - no previously-included directories found matching 'dist' 03:02:17 INFO - no previously-included directories found matching '.git*' 03:02:17 INFO - Installing collected packages: jsonschema, functools32 03:02:17 INFO - Running setup.py install for functools32 03:02:17 INFO - warning: no files found matching '*.txt' 03:02:17 INFO - no previously-included directories found matching 'build' 03:02:17 INFO - no previously-included directories found matching 'dist' 03:02:17 INFO - no previously-included directories found matching '.git*' 03:02:17 INFO - Successfully installed jsonschema functools32 03:02:17 INFO - Cleaning up... 03:02:17 INFO - Return code: 0 03:02:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:02: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')]} 03:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02: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')]} 03:02:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:17 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 0x1c2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f98eb0>, '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 0x1f99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a240>, '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': '4300f881736b422476174874000001bc-1501408804.72125-1684044571', '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 03:02:17 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 03:02:17 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 03:02:17 INFO - Using env: {'DISPLAY': ':0', 03:02:17 INFO - 'HOME': '/home/cltbld', 03:02:17 INFO - 'LANG': 'en_US.UTF-8', 03:02:17 INFO - 'LANGUAGE': 'en_US:en', 03:02:17 INFO - 'LOGNAME': 'cltbld', 03:02:17 INFO - 'MAIL': '/var/mail/cltbld', 03:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:17 INFO - 'MOZ_NO_REMOTE': '1', 03:02:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:17 INFO - 'NO_EM_RESTART': '1', 03:02:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:17 INFO - 'PWD': '/builds/slave/test', 03:02:17 INFO - 'SHELL': '/bin/bash', 03:02:17 INFO - 'SHLVL': '1', 03:02:17 INFO - 'TERM': 'linux', 03:02:17 INFO - 'TMOUT': '86400', 03:02:17 INFO - 'USER': 'cltbld', 03:02:17 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1501408804.72125-1684044571', 03:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:17 INFO - '_': '/tools/buildbot/bin/python'} 03:02:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:02:17 INFO - Cleaning up... 03:02:17 INFO - Return code: 0 03:02:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:02: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')]} 03:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02: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')]} 03:02:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:17 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 0x1c2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f98eb0>, '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 0x1f99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a240>, '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': '4300f881736b422476174874000001bc-1501408804.72125-1684044571', '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 03:02:17 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 03:02:17 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 03:02:17 INFO - Using env: {'DISPLAY': ':0', 03:02:17 INFO - 'HOME': '/home/cltbld', 03:02:17 INFO - 'LANG': 'en_US.UTF-8', 03:02:17 INFO - 'LANGUAGE': 'en_US:en', 03:02:17 INFO - 'LOGNAME': 'cltbld', 03:02:17 INFO - 'MAIL': '/var/mail/cltbld', 03:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:17 INFO - 'MOZ_NO_REMOTE': '1', 03:02:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:17 INFO - 'NO_EM_RESTART': '1', 03:02:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:17 INFO - 'PWD': '/builds/slave/test', 03:02:17 INFO - 'SHELL': '/bin/bash', 03:02:17 INFO - 'SHLVL': '1', 03:02:17 INFO - 'TERM': 'linux', 03:02:17 INFO - 'TMOUT': '86400', 03:02:17 INFO - 'USER': 'cltbld', 03:02:17 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1501408804.72125-1684044571', 03:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:17 INFO - '_': '/tools/buildbot/bin/python'} 03:02:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:17 INFO - Downloading/unpacking blobuploader==1.2.4 03:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:18 INFO - Downloading blobuploader-1.2.4.tar.gz 03:02:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:02:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:02:18 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 03:02:18 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 03:02:18 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 03:02:18 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 03:02:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:02:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:02:19 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 03:02:19 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 03:02:19 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 03:02:19 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 03:02:19 INFO - Downloading docopt-0.6.1.tar.gz 03:02:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:02:19 INFO - Installing collected packages: blobuploader, requests, docopt 03:02:19 INFO - Running setup.py install for blobuploader 03:02:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:02:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:02:19 INFO - Running setup.py install for requests 03:02:19 INFO - Running setup.py install for docopt 03:02:19 INFO - Successfully installed blobuploader requests docopt 03:02:19 INFO - Cleaning up... 03:02:19 INFO - Return code: 0 03:02:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02:19 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')]} 03:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:19 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')]} 03:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:20 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 0x1c2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f98eb0>, '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 0x1f99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a240>, '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': '4300f881736b422476174874000001bc-1501408804.72125-1684044571', '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 03:02:20 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 03:02:20 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 03:02:20 INFO - Using env: {'DISPLAY': ':0', 03:02:20 INFO - 'HOME': '/home/cltbld', 03:02:20 INFO - 'LANG': 'en_US.UTF-8', 03:02:20 INFO - 'LANGUAGE': 'en_US:en', 03:02:20 INFO - 'LOGNAME': 'cltbld', 03:02:20 INFO - 'MAIL': '/var/mail/cltbld', 03:02:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:20 INFO - 'MOZ_NO_REMOTE': '1', 03:02:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:20 INFO - 'NO_EM_RESTART': '1', 03:02:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:20 INFO - 'PWD': '/builds/slave/test', 03:02:20 INFO - 'SHELL': '/bin/bash', 03:02:20 INFO - 'SHLVL': '1', 03:02:20 INFO - 'TERM': 'linux', 03:02:20 INFO - 'TMOUT': '86400', 03:02:20 INFO - 'USER': 'cltbld', 03:02:20 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1501408804.72125-1684044571', 03:02:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:20 INFO - '_': '/tools/buildbot/bin/python'} 03:02:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:02:20 INFO - Running setup.py (path:/tmp/pip-zPRvFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:02:20 INFO - Running setup.py (path:/tmp/pip-vredMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:02:20 INFO - Running setup.py (path:/tmp/pip-VD7W4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:02:20 INFO - Running setup.py (path:/tmp/pip-B3ziZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:02:20 INFO - Running setup.py (path:/tmp/pip-lmEf_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:02:20 INFO - Running setup.py (path:/tmp/pip-SQ57wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:02:20 INFO - Running setup.py (path:/tmp/pip-dQqUks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:02:20 INFO - Running setup.py (path:/tmp/pip-V2b53s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:02:20 INFO - Running setup.py (path:/tmp/pip-0sZD2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:02:20 INFO - Running setup.py (path:/tmp/pip-7PNFlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:02:20 INFO - Running setup.py (path:/tmp/pip-wBuSYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:02:21 INFO - Running setup.py (path:/tmp/pip-Xvz7xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:02:21 INFO - Running setup.py (path:/tmp/pip-yk03_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:02:21 INFO - Running setup.py (path:/tmp/pip-5gSGgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:21 INFO - Running setup.py (path:/tmp/pip-ZvIS33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:02:21 INFO - Running setup.py (path:/tmp/pip-3ffFqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:02:21 INFO - Running setup.py (path:/tmp/pip-ecUTvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:02:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:02:21 INFO - Running setup.py install for manifestparser 03:02:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:02:21 INFO - Running setup.py install for mozcrash 03:02:21 INFO - Running setup.py install for mozdebug 03:02:21 INFO - Running setup.py install for mozdevice 03:02:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:02:21 INFO - Running setup.py install for mozfile 03:02:21 INFO - Running setup.py install for mozhttpd 03:02:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:02:22 INFO - Running setup.py install for mozinfo 03:02:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:02:22 INFO - Running setup.py install for mozInstall 03:02:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:02:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:02:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:02:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:02:22 INFO - Running setup.py install for mozleak 03:02:22 INFO - Running setup.py install for mozlog 03:02:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:02:22 INFO - Running setup.py install for moznetwork 03:02:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:02:22 INFO - Running setup.py install for mozprocess 03:02:22 INFO - Running setup.py install for mozprofile 03:02:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:02:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:02:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:02:22 INFO - Running setup.py install for mozrunner 03:02:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:02:22 INFO - Running setup.py install for mozscreenshot 03:02:22 INFO - Running setup.py install for moztest 03:02:23 INFO - Running setup.py install for mozversion 03:02:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:02:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:02:23 INFO - Cleaning up... 03:02:23 INFO - Return code: 0 03:02:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:23 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 0x1c2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f98eb0>, '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 0x1f99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a240>, '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': '4300f881736b422476174874000001bc-1501408804.72125-1684044571', '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 03:02:23 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 03:02:23 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 03:02:23 INFO - Using env: {'DISPLAY': ':0', 03:02:23 INFO - 'HOME': '/home/cltbld', 03:02:23 INFO - 'LANG': 'en_US.UTF-8', 03:02:23 INFO - 'LANGUAGE': 'en_US:en', 03:02:23 INFO - 'LOGNAME': 'cltbld', 03:02:23 INFO - 'MAIL': '/var/mail/cltbld', 03:02:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:23 INFO - 'MOZ_NO_REMOTE': '1', 03:02:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:23 INFO - 'NO_EM_RESTART': '1', 03:02:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:23 INFO - 'PWD': '/builds/slave/test', 03:02:23 INFO - 'SHELL': '/bin/bash', 03:02:23 INFO - 'SHLVL': '1', 03:02:23 INFO - 'TERM': 'linux', 03:02:23 INFO - 'TMOUT': '86400', 03:02:23 INFO - 'USER': 'cltbld', 03:02:23 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1501408804.72125-1684044571', 03:02:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:23 INFO - '_': '/tools/buildbot/bin/python'} 03:02:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:02:23 INFO - Running setup.py (path:/tmp/pip-tsLE_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:02:23 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)) 03:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:02:23 INFO - Running setup.py (path:/tmp/pip-UcQ9_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:02:23 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)) 03:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:02:23 INFO - Running setup.py (path:/tmp/pip-ie7OEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:02:23 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)) 03:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:02:23 INFO - Running setup.py (path:/tmp/pip-SCnezT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:02:23 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)) 03:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:02:23 INFO - Running setup.py (path:/tmp/pip-mspr3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:02:23 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)) 03:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:02:23 INFO - Running setup.py (path:/tmp/pip-Uf7PPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:02:23 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)) 03:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:02:23 INFO - Running setup.py (path:/tmp/pip-IYM3XM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:02:23 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)) 03:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:02:23 INFO - Running setup.py (path:/tmp/pip-DuZuur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:02:24 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)) 03:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:02:24 INFO - Running setup.py (path:/tmp/pip-gEwR04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:02:24 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)) 03:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:02:24 INFO - Running setup.py (path:/tmp/pip-O73Xes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:02:24 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)) 03:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:02:24 INFO - Running setup.py (path:/tmp/pip-e8yymG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:02:24 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)) 03:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:02:24 INFO - Running setup.py (path:/tmp/pip-lyy6aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:02:24 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)) 03:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:02:24 INFO - Running setup.py (path:/tmp/pip-BOgbWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:02:24 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)) 03:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:02:24 INFO - Running setup.py (path:/tmp/pip-gzZa1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:02:24 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)) 03:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:24 INFO - Running setup.py (path:/tmp/pip-l2GHxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:24 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)) 03:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:02:24 INFO - Running setup.py (path:/tmp/pip-HlzEaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:02:24 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)) 03:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:02:24 INFO - Running setup.py (path:/tmp/pip-AcwOhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:02:24 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)) 03:02:24 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)) 03:02:24 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)) 03:02:24 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)) 03:02:24 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)) 03:02:24 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)) 03:02:24 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)) 03:02:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:02:24 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 03:02:24 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 03:02:24 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 03:02:24 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 03:02:25 INFO - Downloading blessings-1.6.tar.gz 03:02:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:02:25 INFO - Installing collected packages: blessings 03:02:25 INFO - Running setup.py install for blessings 03:02:25 INFO - Successfully installed blessings 03:02:25 INFO - Cleaning up... 03:02:26 INFO - Return code: 0 03:02:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:02:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:02:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:02:26 INFO - Reading from file tmpfile_stdout 03:02:26 INFO - Current package versions: 03:02:26 INFO - argparse == 1.2.1 03:02:26 INFO - blessings == 1.6 03:02:26 INFO - blobuploader == 1.2.4 03:02:26 INFO - docopt == 0.6.1 03:02:26 INFO - functools32 == 3.2.3-2 03:02:26 INFO - jsonschema == 2.5.1 03:02:26 INFO - manifestparser == 1.1 03:02:26 INFO - mozInstall == 1.13 03:02:26 INFO - mozcrash == 1.0 03:02:26 INFO - mozdebug == 0.1 03:02:26 INFO - mozdevice == 0.51 03:02:26 INFO - mozfile == 1.2 03:02:26 INFO - mozhttpd == 0.7 03:02:26 INFO - mozinfo == 0.10 03:02:26 INFO - mozleak == 0.1 03:02:26 INFO - mozlog == 3.5 03:02:26 INFO - moznetwork == 0.27 03:02:26 INFO - mozprocess == 0.25 03:02:26 INFO - mozprofile == 0.28 03:02:26 INFO - mozrunner == 6.13 03:02:26 INFO - mozscreenshot == 0.1 03:02:26 INFO - mozsystemmonitor == 0.3 03:02:26 INFO - moztest == 0.8 03:02:26 INFO - mozversion == 1.4 03:02:26 INFO - psutil == 3.1.1 03:02:26 INFO - requests == 1.2.3 03:02:26 INFO - wsgiref == 0.1.2 03:02:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02: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')]} 03:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02: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')]} 03:02:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:26 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 0x1c2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f98eb0>, '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 0x1f99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a240>, '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': '4300f881736b422476174874000001bc-1501408804.72125-1684044571', '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 03:02:26 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 03:02:26 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 03:02:26 INFO - Using env: {'DISPLAY': ':0', 03:02:26 INFO - 'HOME': '/home/cltbld', 03:02:26 INFO - 'LANG': 'en_US.UTF-8', 03:02:26 INFO - 'LANGUAGE': 'en_US:en', 03:02:26 INFO - 'LOGNAME': 'cltbld', 03:02:26 INFO - 'MAIL': '/var/mail/cltbld', 03:02:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:26 INFO - 'MOZ_NO_REMOTE': '1', 03:02:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:26 INFO - 'NO_EM_RESTART': '1', 03:02:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:26 INFO - 'PWD': '/builds/slave/test', 03:02:26 INFO - 'SHELL': '/bin/bash', 03:02:26 INFO - 'SHLVL': '1', 03:02:26 INFO - 'TERM': 'linux', 03:02:26 INFO - 'TMOUT': '86400', 03:02:26 INFO - 'USER': 'cltbld', 03:02:26 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1501408804.72125-1684044571', 03:02:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:26 INFO - '_': '/tools/buildbot/bin/python'} 03:02:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:26 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)) 03:02:26 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)) 03:02:26 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)) 03:02:26 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)) 03:02:26 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)) 03:02:26 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)) 03:02:26 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)) 03:02:26 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)) 03:02:26 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)) 03:02:26 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:02:26 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 03:02:26 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 03:02:26 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 03:02:26 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 03:02:27 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:02:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:02:27 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 03:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:02:27 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)) 03:02:27 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)) 03:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:02:27 INFO - Installing collected packages: marionette-driver, simplejson 03:02:27 INFO - Running setup.py install for marionette-driver 03:02:27 INFO - Running setup.py install for simplejson 03:02:28 INFO - building 'simplejson._speedups' extension 03:02:28 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 03:02:28 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 03:02:28 INFO - Successfully installed marionette-driver simplejson 03:02:28 INFO - Cleaning up... 03:02:28 INFO - Return code: 0 03:02:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:02:28 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')]} 03:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:28 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')]} 03:02:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1c2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f98eb0>, '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 0x1f99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a240>, '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': '4300f881736b422476174874000001bc-1501408804.72125-1684044571', '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 03:02:28 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 03:02:28 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 03:02:28 INFO - Using env: {'DISPLAY': ':0', 03:02:28 INFO - 'HOME': '/home/cltbld', 03:02:28 INFO - 'LANG': 'en_US.UTF-8', 03:02:28 INFO - 'LANGUAGE': 'en_US:en', 03:02:28 INFO - 'LOGNAME': 'cltbld', 03:02:28 INFO - 'MAIL': '/var/mail/cltbld', 03:02:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:28 INFO - 'MOZ_NO_REMOTE': '1', 03:02:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:28 INFO - 'NO_EM_RESTART': '1', 03:02:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:28 INFO - 'PWD': '/builds/slave/test', 03:02:28 INFO - 'SHELL': '/bin/bash', 03:02:28 INFO - 'SHLVL': '1', 03:02:28 INFO - 'TERM': 'linux', 03:02:28 INFO - 'TMOUT': '86400', 03:02:28 INFO - 'USER': 'cltbld', 03:02:28 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1501408804.72125-1684044571', 03:02:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:28 INFO - '_': '/tools/buildbot/bin/python'} 03:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:02:29 INFO - Cleaning up... 03:02:29 INFO - Return code: 0 03:02:29 INFO - Running post-action listener: _resource_record_post_action 03:02:29 INFO - Running post-action listener: _start_resource_monitoring 03:02:29 INFO - Starting resource monitoring. 03:02:29 INFO - [mozharness: 2017-07-30 10:02:29.264719Z] Finished create-virtualenv step (success) 03:02:29 INFO - [mozharness: 2017-07-30 10:02:29.265740Z] Running install step. 03:02:29 INFO - Running pre-action listener: _resource_record_pre_action 03:02:29 INFO - Running main action method: install 03:02:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:02:29 INFO - Reading from file tmpfile_stdout 03:02:29 INFO - Detecting whether we're running mozinstall >=1.0... 03:02:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:02:29 INFO - Reading from file tmpfile_stdout 03:02:29 INFO - Output received: 03:02:29 INFO - Usage: mozinstall [options] installer 03:02:29 INFO - Options: 03:02:29 INFO - -h, --help show this help message and exit 03:02:29 INFO - -d DEST, --destination=DEST 03:02:29 INFO - Directory to install application into. [default: 03:02:29 INFO - "/builds/slave/test"] 03:02:29 INFO - --app=APP Application being installed. [default: firefox] 03:02:29 INFO - mkdir: /builds/slave/test/build/application 03:02:29 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'] 03:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:02:47 INFO - Reading from file tmpfile_stdout 03:02:47 INFO - Output received: 03:02:47 INFO - /builds/slave/test/build/application/firefox/firefox 03:02:47 INFO - Running post-action listener: _resource_record_post_action 03:02:47 INFO - [mozharness: 2017-07-30 10:02:47.667908Z] Finished install step (success) 03:02:47 INFO - [mozharness: 2017-07-30 10:02:47.668162Z] Running setup-mitmproxy step. 03:02:47 INFO - Running pre-action listener: _resource_record_pre_action 03:02:47 INFO - Running main action method: setup_mitmproxy 03:02:47 INFO - Skipping: mitmproxy is not required 03:02:47 INFO - Running post-action listener: _resource_record_post_action 03:02:47 INFO - [mozharness: 2017-07-30 10:02:47.669284Z] Finished setup-mitmproxy step (success) 03:02:47 INFO - [mozharness: 2017-07-30 10:02:47.669559Z] Running run-tests step. 03:02:47 INFO - Running pre-action listener: _resource_record_pre_action 03:02:47 INFO - Running pre-action listener: _set_gcov_prefix 03:02:47 INFO - Running main action method: run_tests 03:02:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:02:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:02:47 INFO - Python 2.7.3 03:02:47 INFO - Return code: 0 03:02:47 INFO - grabbing minidump binary from tooltool 03:02:47 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')]} 03:02:47 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f98eb0>, '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 0x1f99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:02:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:02:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:02:47 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:02:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:02:47 INFO - Return code: 0 03:02:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:02:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:02:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:02:47 INFO - ENV: RUST_BACKTRACE is now 1 03:02:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:02:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:02:47 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/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 03:02:47 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/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 03:02:47 INFO - Using env: {'DISPLAY': ':0', 03:02:47 INFO - 'HOME': '/home/cltbld', 03:02:47 INFO - 'LANG': 'en_US.UTF-8', 03:02:47 INFO - 'LANGUAGE': 'en_US:en', 03:02:47 INFO - 'LOGNAME': 'cltbld', 03:02:47 INFO - 'MAIL': '/var/mail/cltbld', 03:02:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:02:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:47 INFO - 'MOZ_NO_REMOTE': '1', 03:02:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:02:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:47 INFO - 'NO_EM_RESTART': '1', 03:02:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:47 INFO - 'PWD': '/builds/slave/test', 03:02:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:02:47 INFO - 'RUST_BACKTRACE': '1', 03:02:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:02:47 INFO - 'SHELL': '/bin/bash', 03:02:47 INFO - 'SHLVL': '1', 03:02:47 INFO - 'STYLO_FORCE_ENABLED': '1', 03:02:47 INFO - 'TERM': 'linux', 03:02:47 INFO - 'TMOUT': '86400', 03:02:47 INFO - 'USER': 'cltbld', 03:02:47 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1501408804.72125-1684044571', 03:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:47 INFO - '_': '/tools/buildbot/bin/python'} 03:02:47 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/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 03:02:48 INFO - mozversion application_buildid: 20170730091350 03:02:48 INFO - mozversion application_changeset: 6ee53b46474f74c231b1b569e8f2ecd9d0948a8f 03:02:48 INFO - mozversion application_display_name: Nightly 03:02:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:02:48 INFO - mozversion application_name: Firefox 03:02:48 INFO - mozversion application_remotingname: firefox 03:02:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:02:48 INFO - mozversion application_vendor: Mozilla 03:02:48 INFO - mozversion application_version: 56.0a1 03:02:48 INFO - mozversion platform_buildid: 20170730091350 03:02:48 INFO - mozversion platform_changeset: 6ee53b46474f74c231b1b569e8f2ecd9d0948a8f 03:02:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:02:48 INFO - mozversion platform_version: 56.0a1 03:02:48 INFO - using testdate: 1501408968 03:02:48 INFO - actual date: 1501408968 03:02:48 INFO - starting webserver on 'localhost:39774' 03:02:48 INFO - SUITE-START | Running 2 tests 03:02:48 INFO - TEST-START | dromaeo_css 03:02:48 INFO - Initialising browser for dromaeo_css test... 03:02:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39774/getInfo.html -profile /tmp/tmptQHS_y/profile 03:02:48 INFO - TEST-INFO | started process 3339 (/builds/slave/test/build/application/firefox/firefox http://localhost:39774/getInfo.html) 03:02:55 INFO - TEST-INFO | 3339: exit 0 03:02:55 INFO - Browser initialized. 03:02:55 INFO - Running cycle 1/1 for dromaeo_css test... 03:02:55 INFO - TEST-INFO | started process 3565 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptQHS_y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:02:56 INFO - PID 3565 | 03:02:56 INFO - PID 3565 | (/builds/slave/test/build/application/firefox/firefox:3619): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:02:56 INFO - PID 3565 | 03:03:07 INFO - PID 3565 | RSS: Main: 174571520 03:03:07 INFO - PID 3565 | 03:06:06 INFO - PID 3565 | Cycle 1(1): loaded http://localhost:39774/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39774/tests/dromaeo/cssquery-ext.html) 03:06:08 INFO - PID 3565 | RSS: Main: 176254976 03:06:08 INFO - PID 3565 | 03:09:10 INFO - PID 3565 | Cycle 1(1): loaded http://localhost:39774/tests/dromaeo/cssquery-ext.html (next: http://localhost:39774/tests/dromaeo/cssquery-jquery.html) 03:09:10 INFO - PID 3565 | RSS: Main: 171962368 03:09:10 INFO - PID 3565 | 03:12:12 INFO - PID 3565 | Cycle 1(1): loaded http://localhost:39774/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39774/tests/dromaeo/cssquery-mootools.html) 03:12:13 INFO - PID 3565 | RSS: Main: 175759360 03:12:13 INFO - PID 3565 | 03:15:15 INFO - PID 3565 | Cycle 1(1): loaded http://localhost:39774/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39774/tests/dromaeo/cssquery-prototype.html) 03:15:15 INFO - PID 3565 | RSS: Main: 172843008 03:15:15 INFO - PID 3565 | 03:18:19 INFO - PID 3565 | Cycle 1(1): loaded http://localhost:39774/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39774/tests/dromaeo/cssquery-yui.html) 03:18:20 INFO - PID 3565 | RSS: Main: 177586176 03:18:20 INFO - PID 3565 | 03:21:22 INFO - PID 3565 | Cycle 1(1): loaded http://localhost:39774/tests/dromaeo/cssquery-yui.html (next: http://localhost:39774/tests/dromaeo/cssquery-dojo.html) 03:21:22 INFO - PID 3565 | RSS: Main: 178139136 03:21:22 INFO - PID 3565 | 03:21:22 INFO - PID 3565 | __start_tp_report 03:21:22 INFO - PID 3565 | _x_x_mozilla_page_load 03:21:22 INFO - PID 3565 | _x_x_mozilla_page_load_details 03:21:22 INFO - PID 3565 | |i|pagename|runs| 03:21:22 INFO - PID 3565 | |0;dojo.html;3157.9210519737017;3191.53722710207;3192.21790661288;3204.3270913108254;3234.5795046643934;6051.909221361683;6105.725242364093;6170.969145154268;6198.349173336803;6201.379862013797;6084.574079814415;6196.597221180631;6220.440160385564;6237.5009999200065;6251.968740156293;5682.857928551799;5693.658380497173;5695.800646977356;5708.600397972144;5727.255456790632;5641.858953526174;5711.400302968191;5719.113537401709;5725.141228815669;5728.656280623176;5745.080787074069;5757.222774925394;5782.624129431594;5793.507551858097;5820.970895145519;5736.913946290788;5768.105943578731;5788.42115788422;5837.795677151279;5857.970710146422;5509.228707980886;5636.943630563683;5642.887142257173;5708.71456427177;5728.22668939692;6020.789272375489;6140.508759299245;6153;6206.875862482771;6277.027060805583;6519.837004074889;6524.739010439576;6551.279359270477;6597.208334999783;6627.701753421107;6669.099671544376;6679.231888332855;6684.966575167093;6706.027625994252;6716.3955244028275;6155;6191.288001879751;6208.068789681539;6218.813435596894;6297.842553936188;6942.375186233162;6944.131983502062;6946.409555187764;6962.094927659372;6962.617056061864;6413.743450262031;6586.901196482057;6590.176227971504;6614.140161778938;6620.966895165589;6753.729850806011;6761;6778.932210677929;6780.627065511346;6782.084418603426;6611.86776264472;6651.068850360954;6660.666966651648;6733.764318248838;6755.088063111417;6444.387783160592;6539.542232043711;6693.631850248185;6780.796576102724;6799.388055075067;5263.34208223972;5316.973415132977;5326.813561525328;5358.169483730028;5393.78424863009;4639.188142075191;4707.270373092176;4715.080559290974;4732.053589282157;4759.785809638574;5752.482276595127;5809.419058094241;5908.291005079332;5915.112733089984;5919.082542205879;6602.438792702674;6603.537752357385;6611.702473388709;6611.768588099393;6612.537122401386;5733.741981610838;5823.272090988627;5875.236219291465;5880.7353669085;5910.024845900378;5827.184194212814;5963.463288304073;5975.43233392827;5981.551383646244;5985.970070149621;6348.143000694847;6494.902576461357;6507.707153178024;6591.011348297794;6611.206655201407;6420.582662126947;6567.9014814776865;6592.143021407186;6599.703013364314;6608.537402381787;6448.355164483514;6507.934920650922;6539.901901471387;6552.63960482159;6557.311482294481;5934.258217722785;6578.5395022347975;6587.736490540325;6697.832554186184;6698.899516507159;6656.600603963778;6657.667116644246;6738.528303018742;6753.358430949052;6819.829504262433;6342.080398342122;6456.709448074942;6484.902726459012;6545.574537655038;6554.14796076507;6488.2538508072175;6551.639659818756;6572;6576.2766095728475;6595.736170553316;6454.580452270588;6534.771283005262;6543.116679248241;6544.476441884733;6547.410733034049;6516.5112616553;6557.901631475436;6583.749087673326;6620.536562440583;6686.598804071771;6207.6585787782105;6258.874822503615;6266.185395898504;6301.590396624205;6416.165898433173 03:21:22 INFO - PID 3565 | |1;ext.html;744.6909532543995;813.3818298093449;844.489084104117;1167.620523329918;1195.7608478304342;29694;39496.40755388668;40405.79797101018;40433.59566404335;40537.79731101344;41115.79442102785;41481.17037659245;41523.377149342785;41539.792301038455;41549.7922510387;7624.580648064354;7771.689132434696;7772;7775.339096176832;7778.416618753616;7508.69965201394;7686.077670679499;7713.845723085535;7720.845583088335;7801.336886364666;7706;7737.729179478692;7748.031496062992;7752.496087754278;7757.107932587768;7629.351505122071;7651.5409075455655;7672.232776722339;7674.846503069935;7698.076230852277;7556.848863022708;7564.962175189089;7591.81020474487;7613.124490683532;7620.885686714703;37787;37922;38005.809970949966;38041.42937855935;38042.42936355957;3525.2596954639557;3526.9647303526895;3540.345036168317;3565.2512972275854;3566.821658917044;30423.391532169233;30542.236444088852;30617.38765224683;30677;30743.2314192147;4738.360321356642;4779.426468823764;4779.593734532569;4858.441279252896;4925.13810083234;186549;187178;187471;187495;188072;47862.52137478581;47921.28118078232;47927.520724793;47956.5204347959;47988.280175797394;49808.003839922996;49853.75073124684;50109;50154.49845501571;50170;16278.186090695417;16504.75242871358;16534.751978720327;16585.419510317082;16602.003879767253;11358.886411135949;13535.458581656623;13625.25061121628;13633.454661813417;13705.383257753425;12628.936855315664;14231.43074277038;14408.711825763636;14636.341364638616;14646;5753.769849206069;5901.262342207224;5915.1718759373725;5963.642181469126;5993.3706960768495;991.4745185051934;993.7863359377768;996.6163027234567;1006.225206590921;1019.3883669798062;22178.33464996053;22186.445338866335;22405.21581744631;22964.540709185723;23250.186243481396;1089.319175515303;1105.8175401058895;1107.5412584063367;1130.3211389008104;1134;11606.419679016015;12271.202371845802;12291.631251062483;12302.323372214436;12305.138640295272;222201;223496;224343;224358;224600;51544.48455515397;51955;51988.22017669738;52075;52192.47807521952;1450.3255985966366;1453.7861669746428;1466.7726502392147;1479.2529772465052;1479.393448686055;22069.779302207415;22083.44791380164;22277.774722390423;22575.548489030454;22690.773092269526;36391.63608363988;36533.634663654084;36545.81727091454;36595.634043660284;36606;182187.08906455382;183386;183954;185254;186049;32956.67043329632;33298.833505832314;33331.333373331916;33656.83171584126;33687.4946875802;45819.77090114528;46403.30395044145;46441;46529.302060469796;46725.53274467212;29932.25169370696;31198.532022019233;31626.209344766565;32414.513782293758;32515.18712032218;31236.37527249488;31643.52534711935;31761.364772703953;31949.840250798596;32300.676993230707;35204;35504;35737;35773.821130894175;35844;32229.51655725119;32348;32358.35283294368;33009.33981320408;33911.32177356489;23357.2992810216;24923.252302430956;24978.37554061163;25243;25250.74749252484 03:21:22 INFO - PID 3565 | |2;jquery.html;569.3935958204512;572.9570282228833;573.6099452372385;581.528961541152;593.5370411079358;21647.242346517876;22563.435914102156;22564.21025264116;22584.43538911528;22700;23607;24264.393390165256;25695.357616059562;25830.225093247187;25855.48289034218;6404.455621272185;6568.737250509974;6569.9014514782075;6572.244191917919;6573.57271777333;6230.221222347207;6408.935910640904;6457.6771161441975;6495.512836537278;6502.512311576627;6445.452136568398;6447.54867159299;6464.159659244292;6508.54440189187;6509.153810004716;6405.48756099511;6440.645764482952;6484.221893372825;6519.250286217075;6524.021396790472;5996.100584912255;6009.038553831409;6024.21685180928;6034.426729460694;6042.063480160582;27799.58300625492;28226.717732822613;28232.71767282342;28465;28521.71478285232;1827.7075667893207;1875.9718604220948;1878.4552479780848;1882.4164509002253;1885.754851869262;18750.624987500174;19044.143013564284;20147.39557813268;20980.685289720666;21141;2421.987890060556;2427.9150229741877;2503;2509.3475696318906;2512.786413154884;131152;136310;136505;136843;136859.31570342183;20900.790992090188;22420.55158896813;23501.529969400857;23504.294871153892;23656.40858978505;44013.559864400944;44360;44443.77778111089;44590;44806.775966120615;11450.083993280517;11569.47131125015;11721.304100056865;11726.530938762355;11962.282263064244;9590.520473976274;9717.368371055858;9775.413475191512;9792.853107203398;9846.852297215548;9204.769880753034;11648.301101933912;11963.820542691867;11986.34075125859;12172.57395991136;4289.399484072233;4386.517483076859;4397.670174736843;4414.624756895636;4550.977245113753;922.8569571716395;938.2119020023214;951.1249650321582;956.7560272130562;969.5588507229194;19576.608467830563;19812.405627831187;20360.592788144153;20372.49068773263;20635.69046464304;975.7804493988938;1002.7242508310273;1016.3038318751679;1021.1116328793996;1039.7920415916697;10790.406527641055;11264.943675281735;11376.772464550662;11464.31214127155;11485.0811935045;471547;490278;490758;493281;493612;110408.44795776131;111773;114804;116778;116797;1190.7320852808223;1201.741625550511;1218.585680868509;1220.6887243752785;1226.4235809169677;16944;17697.557561061076;17804.376846810817;18603;18668.906655466635;54025;55698.443015569326;56940.71529642325;57261.71369143128;57727.4227257722;66991.99876309403;70294;70353.64823175852;70420;71209.64395177992;12535.185212961129;13008.869911300766;14449.349779259748;14685.118892866461;15000.474983375529;23337.76662233356;23652.52694946057;23792.762072379748;24042.87978560096;24084;18432.723509147105;18588.44234672962;18676;18794.436166915013;18996.715049273997;16154.192290385668;16437.506874793777;16640.583985400463;16736;17059.147042648066;18621.44135675932;19583.216671333557;19646.901765491082;19655.70516442283;19671.60656786885;14631.85368146305;14835.777463338274;14907.627309317353;14917.552473425814;14975.326110324844;17961.461156165336;18868.43394698161;18911.148998295386;18912.716309255648;18940.715889261395 03:21:22 INFO - PID 3565 | |3;mootools.html;1361.6051345109915;1398.0497206397076;1410.6755446247362;1415.5894790510752;1420.8508106648808;13296;13907.30463476826;13929;13938.651533711662;13960.650983725413;13813.447462101503;14313.713725725505;14363.71272574548;14381.209033503153;14392.136471811698;2632.4866651003013;2698.231004163814;2698.473797609467;2703.1620197738666;2704.7700945419665;2570.0747730816893;2629.7633213010827;2679.209633158223;2681.142034548945;2687.3281679580105;2424.381782645432;2453.386653336666;2466.099873546161;2618.5548456762394;2647.2587675450904;2571.1515199984146;2582.935426614331;2588.417606038645;2601.193629974714;2609.2041927212285;2506.548821212181;2532.9493410131695;2548.2100548829735;2559.7184309726103;2565.551028569993;13420.530281440102;13615.795763063563;13638;13725.931370343083;13738.862611373957;7544.321011109027;7789.415793815487;7835.412344074217;7847.843043139163;7856.882146767803;4950.331705219785;5040.873978150539;5115.846524604268;5180.6373553851245;5191.610629202787;1733.0987886299054;1780.5993651428325;1781.6525777473398;1788.3025620008207;1791.2297711983842;21998.780012199833;22397.328080157622;22465.775342246532;22481.775182248133;22517.099316027503;6084.209052823105;6404.199475065617;6677;7141.89287160693;7153.749618763422;15868.60328491797;15972;15999.12004839745;16014.759778603331;16023.839761602234;7675;7687.385009199251;7688.654010569538;7690.884636730453;7743.419243556756;6999.370056694922;7010.894836577353;7063.2583578724525;7069.434445244368;7183.173934997542;4978.10394129053;5008.824691135866;5083.186690129635;5114.3862736471865;5114.974425127851;1466.3401469338628;1481.6666250093642;1481.8666320031034;1501.1068414293477;1505.33012809301;829.672279449614;830.5805568188026;831.9376046796515;859.4113032572708;879.7624641346929;6566.704498297588;6622.304658010936;6749.291324410866;6884.759033433906;6894.931050689429;664.1465716554204;688.9311068893171;703.7431337561856;709.6841905352069;711.4735096028901;4547.909041819145;4559.065391594715;4655.092257009918;4706.035262771192;4716.316134160527;17569.297228110732;17851.642967140586;18425.53936151607;18442.63114737698;18472.445826625222;17760.733588996176;19192.520186995156;19351.612967740846;19353.4193974181;19451.80548194528;10581.31221470602;10711.036006759428;10965.396903170402;10979.945100274606;11058.447077646086;6844.965775171092;7248.782536523912;7316.231795661592;7461.664225109775;7597.050368703912;15558.688826223639;16237.269322880735;16436.75344869804;16560.254788534785;16657.50027499177;14242.430302788187;15033.323500442724;15466.304016319067;16200.67598648044;16998.320067197175;9819.165370943265;9900.059494348025;9991.950040249752;10028.899711003089;10143.949280253551;12870.099093063396;12934.611961641165;12968.935155324163;12986.285754283228;13000.284984325954;9557.092076252746;10020.69937901835;10156.644517441853;10443.373397596168;10454.215933804842;9449.149576538144;9796.706098817047;10002.749931251778;10012.899871001197;10028.749281268027;8063.637136328762;8103.270705636521;8150.633221505165;8151.184881511801;8159.102498725017;6293.181886354744;6300.432961033529;6586.967065164644;6592.472602191718;6651.43462805667;6369.808905732835;6416.7754128605275;6455.354464553507;6504.479641628753;6583.473322134122 03:21:22 INFO - PID 3565 | |4;prototype.html;473.7394433061815;493.55953198943206;511.51150651128177;512.5643203277215;513.143051104655;6079.5136389088875;6080.442940879585;6089.238845144357;6108.328083910772;6149.723262453189;5809.854753631162;5899.699117344239;5922.644641321513;5977.7608895644125;6001.48987336077;4820.879478013043;4852.2479015752615;4855.916493026918;4859.489753575876;4883.584895283905;4820.903581928359;4841.973766396002;4857.344258525107;4901.411830580335;4904.950950490485;4704.576588107069;4789.832355867546;4799.856004319859;4841.443234028096;4853.757312134379;4762.452203034028;4773.737444440571;4830.71015739055;4877.439094504142;4882.292067650206;4296.162248361571;4306.418633484471;4307.246231909435;4367.737935723867;4402.625776808975;5808.215890854723;5885.293764748215;5937.732802023919;5973.701314934236;5987;5548.6948217848;5567.3040869891265;5580.246666699984;5584.134459158796;5637.80267690633;6359.42765151134;6394.1687580614225;6475.611463312216;6477.83805404864;6511.28375878653;4763.64272679547;4764.976175119137;4767.189577771787;4781.569658730731;4815.446223684286;6802.863942721118;6841.2132604750095;6863.828404289883;6889.862202755967;6905.792826215222;4918.3360246367;4931.260310953386;4936.3089167515855;4972.378452693413;4985.202367621163;4949.678270912379;4962.330085438492;5007.799688012512;5014.52362025607;5019.899602007939;5582.86042848932;5596.1605759136455;5614.438556144353;5640.802571909963;5646.322441307069;6397.904031439532;6425.389587989133;6436.069179246301;6500.414962653289;6666.433353164938;1623.845734655206;1661.775660285846;1675.246139237348;1685.3174464341962;1697.8217287184914;1177.3936422742295;1193.3078814287692;1205.4816428935642;1223.3149436315691;1229.7540491901655;5661.66030038199;5681.431856814285;5692.430756924275;5699;5714.514266287329;6388.39310265524;6458.773942912069;6486.2216534016225;6597.833040140759;6644.4020038196795;5651.00496736722;5655.953648575027;5677.37548869624;5688.601797874192;5775.16260142277;3477.6348483409383;3479.8782042628386;3501.9474707879403;3532.452469867175;3554.680078792921;6295.26880107974;6338.207724034496;6366.458850997625;6411.5832470889245;6419.04038991647;6766.357196066366;6785.59286442815;6789.388954994074;6831.726730930806;6832.558836756149;6260.186175797117;6286.874262514815;6344.111824344595;6356.237251529754;6497.447716944018;6421.073677896519;6527.608343499405;6552.475801935929;6558.1802274715665;6593.637349945799;6452.548321617442;6454.1609590752905;6494.253160886558;6530.47756179495;6552.232466331973;6297.338779428277;6333.90499142504;6363.61818290904;6380.266269378895;6434.099226108255;4832.598546421498;4859.489753575965;4941.209406494943;4965.950340496549;4974.711632648878;6645.734170633121;6678.3989440950545;6683.164604424447;6715.227748808754;6715.891877840297;6373.3945275198785;6414.839629009312;6423.839404014937;6426.742930282923;6474.920799896224;6295.716692748746;6308.022256550242;6392.520560957853;6410.743570257137;6432.935670643234;6131.877362452815;6158.969205153946;6215.689215539295;6217.129601855834;6444.258910225197;6416.51876109303;6425.775097871552;6509.869802603826;6539.934600653933;6541.771038013647;6151.262688103751;6178.969105154625;6220.782272620437;6256.5620406572925;6279.560430769802 03:21:22 INFO - PID 3565 | |5;yui.html;902.3728508686457;915.7023967210656;919.6597259014166;920.9769755756105;924.5377311344328;18483;19297.4210773677;19297.710534341997;19343.70984435233;19347.129379177935;19968.301109461172;21752.129914803427;21756.34730958074;21866;21883.562328753414;1033.7260625934114;1041.5781608448553;1041.7031146123356;1041.7864337810768;1044.0394836750208;997.6109317366233;1058.3015209961427;1061.3472714280701;1076.4617691154422;1080.9297395669257;1112.8887111288848;1113.6436340371085;1115.0522056252203;1117.407773879845;1119.9328040317566;1102.8676558812954;1108.2519299472904;1116.8994790468855;1117.0560876059717;1117.3966058328492;817.207308910356;819.2012787532168;820.885076089348;823.7858156879195;824.7773101262685;19325.51686207842;19718.704219436575;19856.503587410287;20030.89984550068;20197.293094741613;20531.794682053285;20564.280250191172;21148.47128821792;21177.682334764835;21220.045097970473;16069.758953615705;16505.83494165067;16632.584185395343;16657.66684666312;16707.081110538915;3498.2129020970333;3508.14050557615;3514.6133925268455;3539.929201415983;3583.964160358389;112278;115206;119576;120155;125930.37034814767;16806.495805125865;17078.914605426893;17084.658306833793;17247.827521724874;17286.740698889527;29710.702892971225;30633.08100756981;31021.534676979863;31036.53445198324;31049.223769405493;8756;8948.284137269004;8984.55077246135;9004.099590041074;9009.144131307516;4244.936325955113;4326.740395576276;4328.761918094472;4342.522322544518;4351.891202719958;4869.488703686133;5114.28400023997;5398.8920221595345;5625.690587017753;5725.3988331225455;1086.6685660873352;1107.291333546531;1121.5401685309148;1124.2186680257144;1129.3844854554288;653.2096163642046;671.4930227678071;686.0361192524512;691.8996745471878;706.6819931030954;10864.819227752536;11955.222910510789;12194.146409751233;12289.078319126102;12476.937615312047;651.7359876762695;686.2691233835949;693.5561240805888;704.5913370245348;710.1123595505618;5192.091384007784;5357.624966252325;5508.283923089973;5545.195946587723;5550.306211723535;99143;104424;104491.47754261333;106181;107253.4637326824;83873.16126838776;87131;88765.55617221873;91014;91295;80185;82056;84193;84799.57600211959;86618.13381866227;10705.9464702676;11999.40002999864;12409;12568.434420451285;12598.811017834923;33415.49876751899;35767.821160894026;36201;36526;38571.80714096524;65995.34004659893;66087.33912660812;66148;66882.33117668761;70378;19228.327008554632;19243.711344329568;19435.8056419434;19455.902720486873;19493.122809473323;18794.718079229096;18826.34107806275;18976.05119744035;18991.71512427342;21577;17418.0420076897;17486.213120409357;17565.209565569836;18038;18983.715244271072;18717.344892928682;18819.529511762317;18846.905765471634;19018.42944711661;19335.129919153955;17237.138143093045;17300;17525;19288.324908628132;19420.902895485433;12434.129610927148;12740.190053658445;13241.3379331035;13618.114822536503;13741.862581374058;13154.473821047051;14036.368363423466;14253.714925701635;14426.639334016734;14652.926735366254 03:21:22 INFO - PID 3565 | __end_tp_report 03:21:22 INFO - PID 3565 | __start_cc_report 03:21:22 INFO - PID 3565 | _x_x_mozilla_cycle_collect,346 03:21:22 INFO - PID 3565 | __end_cc_report 03:21:22 INFO - PID 3565 | __startTimestamp1501410082563__endTimestamp 03:21:22 INFO - PID 3565 | 03:21:22 INFO - PID 3565 | ------- Summary: start ------- 03:21:22 INFO - PID 3565 | Number of tests: 6 03:21:22 INFO - PID 3565 | 03:21:22 INFO - PID 3565 | [#0] dojo.html Cycles:165 Average:6150.90 Median:6413.74 stddev:714.03 (11.1%) stddev-sans-first:676.52 03:21:22 INFO - PID 3565 | Values: 3157.9 3191.5 3192.2 3204.3 3234.6 6051.9 6105.7 6171.0 6198.3 6201.4 6084.6 6196.6 6220.4 6237.5 6252.0 5682.9 5693.7 5695.8 5708.6 5727.3 5641.9 5711.4 5719.1 5725.1 5728.7 5745.1 5757.2 5782.6 5793.5 5821.0 5736.9 5768.1 5788.4 5837.8 5858.0 5509.2 5636.9 5642.9 5708.7 5728.2 6020.8 6140.5 6153.0 6206.9 6277.0 6519.8 6524.7 6551.3 6597.2 6627.7 6669.1 6679.2 6685.0 6706.0 6716.4 6155.0 6191.3 6208.1 6218.8 6297.8 6942.4 6944.1 6946.4 6962.1 6962.6 6413.7 6586.9 6590.2 6614.1 6621.0 6753.7 6761.0 6778.9 6780.6 6782.1 6611.9 6651.1 6660.7 6733.8 6755.1 6444.4 6539.5 6693.6 6780.8 6799.4 5263.3 5317.0 5326.8 5358.2 5393.8 4639.2 4707.3 4715.1 4732.1 4759.8 5752.5 5809.4 5908.3 5915.1 5919.1 6602.4 6603.5 6611.7 6611.8 6612.5 5733.7 5823.3 5875.2 5880.7 5910.0 5827.2 5963.5 5975.4 5981.6 5986.0 6348.1 6494.9 6507.7 6591.0 6611.2 6420.6 6567.9 6592.1 6599.7 6608.5 6448.4 6507.9 6539.9 6552.6 6557.3 5934.3 6578.5 6587.7 6697.8 6698.9 6656.6 6657.7 6738.5 6753.4 6819.8 6342.1 6456.7 6484.9 6545.6 6554.1 6488.3 6551.6 6572.0 6576.3 6595.7 6454.6 6534.8 6543.1 6544.5 6547.4 6516.5 6557.9 6583.7 6620.5 6686.6 6207.7 6258.9 6266.2 6301.6 6416.2 03:21:22 INFO - PID 3565 | 03:21:22 INFO - PID 3565 | [#1] ext.html Cycles:180 Average:36783.09 Median:19364.63 stddev:51567.83 (266.3%) stddev-sans-first:51641.49 03:21:22 INFO - PID 3565 | Values: 744.7 813.4 844.5 1167.6 1195.8 29694.0 39496.4 40405.8 40433.6 40537.8 41115.8 41481.2 41523.4 41539.8 41549.8 7624.6 7771.7 7772.0 7775.3 7778.4 7508.7 7686.1 7713.8 7720.8 7801.3 7706.0 7737.7 7748.0 7752.5 7757.1 7629.4 7651.5 7672.2 7674.8 7698.1 7556.8 7565.0 7591.8 7613.1 7620.9 37787.0 37922.0 38005.8 38041.4 38042.4 3525.3 3527.0 3540.3 3565.3 3566.8 30423.4 30542.2 30617.4 30677.0 30743.2 4738.4 4779.4 4779.6 4858.4 4925.1 186549.0 187178.0 187471.0 187495.0 188072.0 47862.5 47921.3 47927.5 47956.5 47988.3 49808.0 49853.8 50109.0 50154.5 50170.0 16278.2 16504.8 16534.8 16585.4 16602.0 11358.9 13535.5 13625.3 13633.5 13705.4 12628.9 14231.4 14408.7 14636.3 14646.0 5753.8 5901.3 5915.2 5963.6 5993.4 991.5 993.8 996.6 1006.2 1019.4 22178.3 22186.4 22405.2 22964.5 23250.2 1089.3 1105.8 1107.5 1130.3 1134.0 11606.4 12271.2 12291.6 12302.3 12305.1 222201.0 223496.0 224343.0 224358.0 224600.0 51544.5 51955.0 51988.2 52075.0 52192.5 1450.3 1453.8 1466.8 1479.3 1479.4 22069.8 22083.4 22277.8 22575.5 22690.8 36391.6 36533.6 36545.8 36595.6 36606.0 182187.1 183386.0 183954.0 185254.0 186049.0 32956.7 33298.8 33331.3 33656.8 33687.5 45819.8 46403.3 46441.0 46529.3 46725.5 29932.3 31198.5 31626.2 32414.5 32515.2 31236.4 31643.5 31761.4 31949.8 32300.7 35204.0 35504.0 35737.0 35773.8 35844.0 32229.5 32348.0 32358.4 33009.3 33911.3 23357.3 24923.3 24978.4 25243.0 25250.7 03:21:22 INFO - PID 3565 | 03:21:22 INFO - PID 3565 | [#2] jquery.html Cycles:180 Average:35537.36 Median:23419.65 stddev:82000.50 (350.1%) stddev-sans-first:82188.50 03:21:22 INFO - PID 3565 | Values: 569.4 573.0 573.6 581.5 593.5 21647.2 22563.4 22564.2 22584.4 22700.0 23607.0 24264.4 25695.4 25830.2 25855.5 6404.5 6568.7 6569.9 6572.2 6573.6 6230.2 6408.9 6457.7 6495.5 6502.5 6445.5 6447.5 6464.2 6508.5 6509.2 6405.5 6440.6 6484.2 6519.3 6524.0 5996.1 6009.0 6024.2 6034.4 6042.1 27799.6 28226.7 28232.7 28465.0 28521.7 1827.7 1876.0 1878.5 1882.4 1885.8 18750.6 19044.1 20147.4 20980.7 21141.0 2422.0 2427.9 2503.0 2509.3 2512.8 131152.0 136310.0 136505.0 136843.0 136859.3 20900.8 22420.6 23501.5 23504.3 23656.4 44013.6 44360.0 44443.8 44590.0 44806.8 11450.1 11569.5 11721.3 11726.5 11962.3 9590.5 9717.4 9775.4 9792.9 9846.9 9204.8 11648.3 11963.8 11986.3 12172.6 4289.4 4386.5 4397.7 4414.6 4551.0 922.9 938.2 951.1 956.8 969.6 19576.6 19812.4 20360.6 20372.5 20635.7 975.8 1002.7 1016.3 1021.1 1039.8 10790.4 11264.9 11376.8 11464.3 11485.1 471547.0 490278.0 490758.0 493281.0 493612.0 110408.4 111773.0 114804.0 116778.0 116797.0 1190.7 1201.7 1218.6 1220.7 1226.4 16944.0 17697.6 17804.4 18603.0 18668.9 54025.0 55698.4 56940.7 57261.7 57727.4 66992.0 70294.0 70353.6 70420.0 71209.6 12535.2 13008.9 14449.3 14685.1 15000.5 23337.8 23652.5 23792.8 24042.9 24084.0 18432.7 18588.4 18676.0 18794.4 18996.7 16154.2 16437.5 16640.6 16736.0 17059.1 18621.4 19583.2 19646.9 19655.7 19671.6 14631.9 14835.8 14907.6 14917.6 14975.3 17961.5 18868.4 18911.1 18912.7 18940.7 03:21:22 INFO - PID 3565 | 03:21:22 INFO - PID 3565 | [#3] mootools.html Cycles:180 Average:8366.48 Median:2594.81 stddev:5742.53 (221.3%) stddev-sans-first:5734.52 03:21:22 INFO - PID 3565 | Values: 1361.6 1398.0 1410.7 1415.6 1420.9 13296.0 13907.3 13929.0 13938.7 13960.7 13813.4 14313.7 14363.7 14381.2 14392.1 2632.5 2698.2 2698.5 2703.2 2704.8 2570.1 2629.8 2679.2 2681.1 2687.3 2424.4 2453.4 2466.1 2618.6 2647.3 2571.2 2582.9 2588.4 2601.2 2609.2 2506.5 2532.9 2548.2 2559.7 2565.6 13420.5 13615.8 13638.0 13725.9 13738.9 7544.3 7789.4 7835.4 7847.8 7856.9 4950.3 5040.9 5115.8 5180.6 5191.6 1733.1 1780.6 1781.7 1788.3 1791.2 21998.8 22397.3 22465.8 22481.8 22517.1 6084.2 6404.2 6677.0 7141.9 7153.7 15868.6 15972.0 15999.1 16014.8 16023.8 7675.0 7687.4 7688.7 7690.9 7743.4 6999.4 7010.9 7063.3 7069.4 7183.2 4978.1 5008.8 5083.2 5114.4 5115.0 1466.3 1481.7 1481.9 1501.1 1505.3 829.7 830.6 831.9 859.4 879.8 6566.7 6622.3 6749.3 6884.8 6894.9 664.1 688.9 703.7 709.7 711.5 4547.9 4559.1 4655.1 4706.0 4716.3 17569.3 17851.6 18425.5 18442.6 18472.4 17760.7 19192.5 19351.6 19353.4 19451.8 10581.3 10711.0 10965.4 10979.9 11058.4 6845.0 7248.8 7316.2 7461.7 7597.1 15558.7 16237.3 16436.8 16560.3 16657.5 14242.4 15033.3 15466.3 16200.7 16998.3 9819.2 9900.1 9992.0 10028.9 10143.9 12870.1 12934.6 12968.9 12986.3 13000.3 9557.1 10020.7 10156.6 10443.4 10454.2 9449.1 9796.7 10002.7 10012.9 10028.7 8063.6 8103.3 8150.6 8151.2 8159.1 6293.2 6300.4 6587.0 6592.5 6651.4 6369.8 6416.8 6455.4 6504.5 6583.5 03:21:22 INFO - PID 3565 | 03:21:22 INFO - PID 3565 | [#4] prototype.html Cycles:180 Average:5398.46 Median:5955.72 stddev:1521.68 (25.5%) stddev-sans-first:1480.37 03:21:22 INFO - PID 3565 | Values: 473.7 493.6 511.5 512.6 513.1 6079.5 6080.4 6089.2 6108.3 6149.7 5809.9 5899.7 5922.6 5977.8 6001.5 4820.9 4852.2 4855.9 4859.5 4883.6 4820.9 4842.0 4857.3 4901.4 4905.0 4704.6 4789.8 4799.9 4841.4 4853.8 4762.5 4773.7 4830.7 4877.4 4882.3 4296.2 4306.4 4307.2 4367.7 4402.6 5808.2 5885.3 5937.7 5973.7 5987.0 5548.7 5567.3 5580.2 5584.1 5637.8 6359.4 6394.2 6475.6 6477.8 6511.3 4763.6 4765.0 4767.2 4781.6 4815.4 6802.9 6841.2 6863.8 6889.9 6905.8 4918.3 4931.3 4936.3 4972.4 4985.2 4949.7 4962.3 5007.8 5014.5 5019.9 5582.9 5596.2 5614.4 5640.8 5646.3 6397.9 6425.4 6436.1 6500.4 6666.4 1623.8 1661.8 1675.2 1685.3 1697.8 1177.4 1193.3 1205.5 1223.3 1229.8 5661.7 5681.4 5692.4 5699.0 5714.5 6388.4 6458.8 6486.2 6597.8 6644.4 5651.0 5656.0 5677.4 5688.6 5775.2 3477.6 3479.9 3501.9 3532.5 3554.7 6295.3 6338.2 6366.5 6411.6 6419.0 6766.4 6785.6 6789.4 6831.7 6832.6 6260.2 6286.9 6344.1 6356.2 6497.4 6421.1 6527.6 6552.5 6558.2 6593.6 6452.5 6454.2 6494.3 6530.5 6552.2 6297.3 6333.9 6363.6 6380.3 6434.1 4832.6 4859.5 4941.2 4966.0 4974.7 6645.7 6678.4 6683.2 6715.2 6715.9 6373.4 6414.8 6423.8 6426.7 6474.9 6295.7 6308.0 6392.5 6410.7 6432.9 6131.9 6159.0 6215.7 6217.1 6444.3 6416.5 6425.8 6509.9 6539.9 6541.8 6151.3 6179.0 6220.8 6256.6 6279.6 03:21:22 INFO - PID 3565 | 03:21:22 INFO - PID 3565 | [#5] yui.html Cycles:180 Average:22915.46 Median:19445.85 stddev:30116.38 (154.9%) stddev-sans-first:30155.50 03:21:22 INFO - PID 3565 | Values: 902.4 915.7 919.7 921.0 924.5 18483.0 19297.4 19297.7 19343.7 19347.1 19968.3 21752.1 21756.3 21866.0 21883.6 1033.7 1041.6 1041.7 1041.8 1044.0 997.6 1058.3 1061.3 1076.5 1080.9 1112.9 1113.6 1115.1 1117.4 1119.9 1102.9 1108.3 1116.9 1117.1 1117.4 817.2 819.2 820.9 823.8 824.8 19325.5 19718.7 19856.5 20030.9 20197.3 20531.8 20564.3 21148.5 21177.7 21220.0 16069.8 16505.8 16632.6 16657.7 16707.1 3498.2 3508.1 3514.6 3539.9 3584.0 112278.0 115206.0 119576.0 120155.0 125930.4 16806.5 17078.9 17084.7 17247.8 17286.7 29710.7 30633.1 31021.5 31036.5 31049.2 8756.0 8948.3 8984.6 9004.1 9009.1 4244.9 4326.7 4328.8 4342.5 4351.9 4869.5 5114.3 5398.9 5625.7 5725.4 1086.7 1107.3 1121.5 1124.2 1129.4 653.2 671.5 686.0 691.9 706.7 10864.8 11955.2 12194.1 12289.1 12476.9 651.7 686.3 693.6 704.6 710.1 5192.1 5357.6 5508.3 5545.2 5550.3 99143.0 104424.0 104491.5 106181.0 107253.5 83873.2 87131.0 88765.6 91014.0 91295.0 80185.0 82056.0 84193.0 84799.6 86618.1 10705.9 11999.4 12409.0 12568.4 12598.8 33415.5 35767.8 36201.0 36526.0 38571.8 65995.3 66087.3 66148.0 66882.3 70378.0 19228.3 19243.7 19435.8 19455.9 19493.1 18794.7 18826.3 18976.1 18991.7 21577.0 17418.0 17486.2 17565.2 18038.0 18983.7 18717.3 18819.5 18846.9 19018.4 19335.1 17237.1 17300.0 17525.0 19288.3 19420.9 12434.1 12740.2 13241.3 13618.1 13741.9 13154.5 14036.4 14253.7 14426.6 14652.9 03:21:22 INFO - PID 3565 | -------- Summary: end -------- 03:21:22 INFO - PID 3565 | 03:21:23 INFO - TEST-INFO | 3565: exit 0 03:21:23 INFO - TEST-OK | dromaeo_css | took 1114975ms 03:21:23 INFO - TEST-START | kraken 03:21:23 INFO - Initialising browser for kraken test... 03:21:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39774/getInfo.html -profile /tmp/tmp6tQaRO/profile 03:21:23 INFO - TEST-INFO | started process 4048 (/builds/slave/test/build/application/firefox/firefox http://localhost:39774/getInfo.html) 03:21:29 INFO - TEST-INFO | 4048: exit 0 03:21:29 INFO - Browser initialized. 03:21:29 INFO - Running cycle 1/1 for kraken test... 03:21:29 INFO - TEST-INFO | started process 4272 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6tQaRO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:21:30 INFO - PID 4272 | 03:21:30 INFO - PID 4272 | (/builds/slave/test/build/application/firefox/firefox:4326): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:21:30 INFO - PID 4272 | 03:21:41 INFO - PID 4272 | RSS: Main: 174108672 03:21:41 INFO - PID 4272 | 03:21:43 INFO - PID 4272 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39774/tests/kraken/driver.html?testName=audio-beat-detection) 03:21:44 INFO - PID 4272 | RSS: Main: 179228672 03:21:44 INFO - PID 4272 | 03:21:47 INFO - PID 4272 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39774/tests/kraken/driver.html?testName=audio-dft) 03:21:48 INFO - PID 4272 | RSS: Main: 179580928 03:21:48 INFO - PID 4272 | 03:21:51 INFO - PID 4272 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39774/tests/kraken/driver.html?testName=audio-fft) 03:21:51 INFO - PID 4272 | RSS: Main: 174485504 03:21:51 INFO - PID 4272 | 03:21:54 INFO - PID 4272 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39774/tests/kraken/driver.html?testName=audio-oscillator) 03:21:54 INFO - PID 4272 | RSS: Main: 174952448 03:21:54 INFO - PID 4272 | 03:21:56 INFO - PID 4272 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39774/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:21:57 INFO - PID 4272 | RSS: Main: 175140864 03:21:57 INFO - PID 4272 | 03:22:00 INFO - PID 4272 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39774/tests/kraken/driver.html?testName=imaging-darkroom) 03:22:01 INFO - PID 4272 | RSS: Main: 177459200 03:22:01 INFO - PID 4272 | 03:22:04 INFO - PID 4272 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39774/tests/kraken/driver.html?testName=imaging-desaturate) 03:22:05 INFO - PID 4272 | RSS: Main: 177393664 03:22:05 INFO - PID 4272 | 03:22:08 INFO - PID 4272 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39774/tests/kraken/driver.html?testName=json-parse-financial) 03:22:09 INFO - PID 4272 | RSS: Main: 178012160 03:22:09 INFO - PID 4272 | 03:22:10 INFO - PID 4272 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39774/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:22:11 INFO - PID 4272 | RSS: Main: 178020352 03:22:11 INFO - PID 4272 | 03:22:13 INFO - PID 4272 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39774/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:22:13 INFO - PID 4272 | RSS: Main: 175071232 03:22:13 INFO - PID 4272 | 03:22:16 INFO - PID 4272 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39774/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:22:16 INFO - PID 4272 | RSS: Main: 175013888 03:22:16 INFO - PID 4272 | 03:22:19 INFO - PID 4272 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39774/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:22:20 INFO - PID 4272 | RSS: Main: 175468544 03:22:20 INFO - PID 4272 | 03:22:23 INFO - PID 4272 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39774/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:22:24 INFO - PID 4272 | RSS: Main: 175480832 03:22:24 INFO - PID 4272 | 03:22:26 INFO - PID 4272 | Cycle 1(1): loaded http://localhost:39774/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39774/tests/kraken/driver.html?testName=ai-astar) 03:22:26 INFO - PID 4272 | RSS: Main: 177303552 03:22:26 INFO - PID 4272 | 03:22:26 INFO - PID 4272 | __start_tp_report 03:22:26 INFO - PID 4272 | _x_x_mozilla_page_load 03:22:26 INFO - PID 4272 | _x_x_mozilla_page_load_details 03:22:26 INFO - PID 4272 | |i|pagename|runs| 03:22:26 INFO - PID 4272 | |0;ai-astar;100;114;105;108;113;110;111;101;110;109 03:22:26 INFO - PID 4272 | |1;audio-beat-detection;144;125;146;177;123;143;157;124;172;124 03:22:26 INFO - PID 4272 | |2;audio-dft;165;167;164;161;162;167;169;167;161;163 03:22:26 INFO - PID 4272 | |3;audio-fft;75;76;77;167;77;75;75;92;100;77 03:22:26 INFO - PID 4272 | |4;audio-oscillator;78;78;126;79;78;86;130;80;79;126 03:22:26 INFO - PID 4272 | |5;imaging-gaussian-blur;116;118;114;114;114;113;118;114;116;116 03:22:26 INFO - PID 4272 | |6;imaging-darkroom;153;155;156;151;150;151;150;150;150;155 03:22:26 INFO - PID 4272 | |7;imaging-desaturate;93;100;94;94;97;94;95;94;94;95 03:22:26 INFO - PID 4272 | |8;json-parse-financial;63;56;55;58;61;56;62;62;56;55 03:22:26 INFO - PID 4272 | |9;json-stringify-tinderbox;54;54;54;54;54;55;55;54;54;56 03:22:26 INFO - PID 4272 | |10;stanford-crypto-aes;84;80;82;86;81;109;81;83;81;80 03:22:26 INFO - PID 4272 | |11;stanford-crypto-ccm;135;147;130;148;127;124;148;134;129;181 03:22:26 INFO - PID 4272 | |12;stanford-crypto-pbkdf2;189;202;193;185;193;182;194;200;185;187 03:22:26 INFO - PID 4272 | |13;stanford-crypto-sha256-iterative;70;76;77;74;70;77;75;68;72;69 03:22:26 INFO - PID 4272 | __end_tp_report 03:22:26 INFO - PID 4272 | __start_cc_report 03:22:26 INFO - PID 4272 | _x_x_mozilla_cycle_collect,964 03:22:26 INFO - PID 4272 | __end_cc_report 03:22:26 INFO - PID 4272 | __startTimestamp1501410146382__endTimestamp 03:22:26 INFO - PID 4272 | 03:22:26 INFO - PID 4272 | ------- Summary: start ------- 03:22:26 INFO - PID 4272 | Number of tests: 14 03:22:26 INFO - PID 4272 | 03:22:26 INFO - PID 4272 | [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:4.72 (4.3%) stddev-sans-first:4.00 03:22:26 INFO - PID 4272 | Values: 100.0 114.0 105.0 108.0 113.0 110.0 111.0 101.0 110.0 109.0 03:22:26 INFO - PID 4272 | 03:22:26 INFO - PID 4272 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:145.00 stddev:20.13 (13.9%) stddev-sans-first:21.35 03:22:26 INFO - PID 4272 | Values: 144.0 125.0 146.0 177.0 123.0 143.0 157.0 124.0 172.0 124.0 03:22:26 INFO - PID 4272 | 03:22:26 INFO - PID 4272 | [#2] audio-dft Cycles:10 Average:164.60 Median:166.00 stddev:2.84 (1.7%) stddev-sans-first:3.00 03:22:26 INFO - PID 4272 | Values: 165.0 167.0 164.0 161.0 162.0 167.0 169.0 167.0 161.0 163.0 03:22:26 INFO - PID 4272 | 03:22:26 INFO - PID 4272 | [#3] audio-fft Cycles:10 Average:89.10 Median:76.50 stddev:28.68 (37.5%) stddev-sans-first:29.96 03:22:26 INFO - PID 4272 | Values: 75.0 76.0 77.0 167.0 77.0 75.0 75.0 92.0 100.0 77.0 03:22:26 INFO - PID 4272 | 03:22:26 INFO - PID 4272 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:78.50 stddev:23.15 (29.5%) stddev-sans-first:23.82 03:22:26 INFO - PID 4272 | Values: 78.0 78.0 126.0 79.0 78.0 86.0 130.0 80.0 79.0 126.0 03:22:26 INFO - PID 4272 | 03:22:26 INFO - PID 4272 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:116.00 stddev:1.77 (1.5%) stddev-sans-first:1.86 03:22:26 INFO - PID 4272 | Values: 116.0 118.0 114.0 114.0 114.0 113.0 118.0 114.0 116.0 116.0 03:22:26 INFO - PID 4272 | 03:22:26 INFO - PID 4272 | [#6] imaging-darkroom Cycles:10 Average:152.10 Median:152.00 stddev:2.42 (1.6%) stddev-sans-first:2.55 03:22:26 INFO - PID 4272 | Values: 153.0 155.0 156.0 151.0 150.0 151.0 150.0 150.0 150.0 155.0 03:22:26 INFO - PID 4272 | 03:22:26 INFO - PID 4272 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:94.00 stddev:2.05 (2.2%) stddev-sans-first:2.05 03:22:26 INFO - PID 4272 | Values: 93.0 100.0 94.0 94.0 97.0 94.0 95.0 94.0 94.0 95.0 03:22:26 INFO - PID 4272 | 03:22:26 INFO - PID 4272 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:59.50 stddev:3.24 (5.4%) stddev-sans-first:2.98 03:22:26 INFO - PID 4272 | Values: 63.0 56.0 55.0 58.0 61.0 56.0 62.0 62.0 56.0 55.0 03:22:26 INFO - PID 4272 | 03:22:26 INFO - PID 4272 | [#9] json-stringify-tinderbox Cycles:10 Average:54.40 Median:54.00 stddev:0.70 (1.3%) stddev-sans-first:0.73 03:22:26 INFO - PID 4272 | Values: 54.0 54.0 54.0 54.0 54.0 55.0 55.0 54.0 54.0 56.0 03:22:26 INFO - PID 4272 | 03:22:26 INFO - PID 4272 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:81.50 stddev:8.74 (10.7%) stddev-sans-first:9.27 03:22:26 INFO - PID 4272 | Values: 84.0 80.0 82.0 86.0 81.0 109.0 81.0 83.0 81.0 80.0 03:22:26 INFO - PID 4272 | 03:22:26 INFO - PID 4272 | [#11] stanford-crypto-ccm Cycles:10 Average:140.30 Median:141.00 stddev:16.88 (12.0%) stddev-sans-first:17.79 03:22:26 INFO - PID 4272 | Values: 135.0 147.0 130.0 148.0 127.0 124.0 148.0 134.0 129.0 181.0 03:22:26 INFO - PID 4272 | 03:22:26 INFO - PID 4272 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.00 Median:193.00 stddev:6.60 (3.4%) stddev-sans-first:6.96 03:22:26 INFO - PID 4272 | Values: 189.0 202.0 193.0 185.0 193.0 182.0 194.0 200.0 185.0 187.0 03:22:26 INFO - PID 4272 | 03:22:26 INFO - PID 4272 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:74.50 stddev:3.43 (4.6%) stddev-sans-first:3.48 03:22:26 INFO - PID 4272 | Values: 70.0 76.0 77.0 74.0 70.0 77.0 75.0 68.0 72.0 69.0 03:22:26 INFO - PID 4272 | -------- Summary: end -------- 03:22:26 INFO - PID 4272 | 03:22:26 INFO - PID 4272 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:22:27 INFO - TEST-INFO | 4272: exit 0 03:22:27 INFO - TEST-OK | kraken | took 63852ms 03:22:27 INFO - SUITE-END | took 1178s 03:22:27 INFO - Completed test suite (00:19:39) 03:22:27 INFO - javascript benchmark 03:22:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8442.832165607577, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3157.9210519737017, 3191.53722710207, 3192.21790661288, 3204.3270913108254, 3234.5795046643934, 6051.909221361683, 6105.725242364093, 6170.969145154268, 6198.349173336803, 6201.379862013797, 6084.574079814415, 6196.597221180631, 6220.440160385564, 6237.5009999200065, 6251.968740156293, 5682.857928551799, 5693.658380497173, 5695.800646977356, 5708.600397972144, 5727.255456790632, 5641.858953526174, 5711.400302968191, 5719.113537401709, 5725.141228815669, 5728.656280623176, 5745.080787074069, 5757.222774925394, 5782.624129431594, 5793.507551858097, 5820.970895145519, 5736.913946290788, 5768.105943578731, 5788.42115788422, 5837.795677151279, 5857.970710146422, 5509.228707980886, 5636.943630563683, 5642.887142257173, 5708.71456427177, 5728.22668939692, 6020.789272375489, 6140.508759299245, 6153.0, 6206.875862482771, 6277.027060805583, 6519.837004074889, 6524.739010439576, 6551.279359270477, 6597.208334999783, 6627.701753421107, 6669.099671544376, 6679.231888332855, 6684.966575167093, 6706.027625994252, 6716.3955244028275, 6155.0, 6191.288001879751, 6208.068789681539, 6218.813435596894, 6297.842553936188, 6942.375186233162, 6944.131983502062, 6946.409555187764, 6962.094927659372, 6962.617056061864, 6413.743450262031, 6586.901196482057, 6590.176227971504, 6614.140161778938, 6620.966895165589, 6753.729850806011, 6761.0, 6778.932210677929, 6780.627065511346, 6782.084418603426, 6611.86776264472, 6651.068850360954, 6660.666966651648, 6733.764318248838, 6755.088063111417, 6444.387783160592, 6539.542232043711, 6693.631850248185, 6780.796576102724, 6799.388055075067, 5263.34208223972, 5316.973415132977, 5326.813561525328, 5358.169483730028, 5393.78424863009, 4639.188142075191, 4707.270373092176, 4715.080559290974, 4732.053589282157, 4759.785809638574, 5752.482276595127, 5809.419058094241, 5908.291005079332, 5915.112733089984, 5919.082542205879, 6602.438792702674, 6603.537752357385, 6611.702473388709, 6611.768588099393, 6612.537122401386, 5733.741981610838, 5823.272090988627, 5875.236219291465, 5880.7353669085, 5910.024845900378, 5827.184194212814, 5963.463288304073, 5975.43233392827, 5981.551383646244, 5985.970070149621, 6348.143000694847, 6494.902576461357, 6507.707153178024, 6591.011348297794, 6611.206655201407, 6420.582662126947, 6567.9014814776865, 6592.143021407186, 6599.703013364314, 6608.537402381787, 6448.355164483514, 6507.934920650922, 6539.901901471387, 6552.63960482159, 6557.311482294481, 5934.258217722785, 6578.5395022347975, 6587.736490540325, 6697.832554186184, 6698.899516507159, 6656.600603963778, 6657.667116644246, 6738.528303018742, 6753.358430949052, 6819.829504262433, 6342.080398342122, 6456.709448074942, 6484.902726459012, 6545.574537655038, 6554.14796076507, 6488.2538508072175, 6551.639659818756, 6572.0, 6576.2766095728475, 6595.736170553316, 6454.580452270588, 6534.771283005262, 6543.116679248241, 6544.476441884733, 6547.410733034049, 6516.5112616553, 6557.901631475436, 6583.749087673326, 6620.536562440583, 6686.598804071771, 6207.6585787782105, 6258.874822503615, 6266.185395898504, 6301.590396624205, 6416.165898433173], "value": 6098.686708308513, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.6909532543995, 813.3818298093449, 844.489084104117, 1167.620523329918, 1195.7608478304342, 29694.0, 39496.40755388668, 40405.79797101018, 40433.59566404335, 40537.79731101344, 41115.79442102785, 41481.17037659245, 41523.377149342785, 41539.792301038455, 41549.7922510387, 7624.580648064354, 7771.689132434696, 7772.0, 7775.339096176832, 7778.416618753616, 7508.69965201394, 7686.077670679499, 7713.845723085535, 7720.845583088335, 7801.336886364666, 7706.0, 7737.729179478692, 7748.031496062992, 7752.496087754278, 7757.107932587768, 7629.351505122071, 7651.5409075455655, 7672.232776722339, 7674.846503069935, 7698.076230852277, 7556.848863022708, 7564.962175189089, 7591.81020474487, 7613.124490683532, 7620.885686714703, 37787.0, 37922.0, 38005.809970949966, 38041.42937855935, 38042.42936355957, 3525.2596954639557, 3526.9647303526895, 3540.345036168317, 3565.2512972275854, 3566.821658917044, 30423.391532169233, 30542.236444088852, 30617.38765224683, 30677.0, 30743.2314192147, 4738.360321356642, 4779.426468823764, 4779.593734532569, 4858.441279252896, 4925.13810083234, 186549.0, 187178.0, 187471.0, 187495.0, 188072.0, 47862.52137478581, 47921.28118078232, 47927.520724793, 47956.5204347959, 47988.280175797394, 49808.003839922996, 49853.75073124684, 50109.0, 50154.49845501571, 50170.0, 16278.186090695417, 16504.75242871358, 16534.751978720327, 16585.419510317082, 16602.003879767253, 11358.886411135949, 13535.458581656623, 13625.25061121628, 13633.454661813417, 13705.383257753425, 12628.936855315664, 14231.43074277038, 14408.711825763636, 14636.341364638616, 14646.0, 5753.769849206069, 5901.262342207224, 5915.1718759373725, 5963.642181469126, 5993.3706960768495, 991.4745185051934, 993.7863359377768, 996.6163027234567, 1006.225206590921, 1019.3883669798062, 22178.33464996053, 22186.445338866335, 22405.21581744631, 22964.540709185723, 23250.186243481396, 1089.319175515303, 1105.8175401058895, 1107.5412584063367, 1130.3211389008104, 1134.0, 11606.419679016015, 12271.202371845802, 12291.631251062483, 12302.323372214436, 12305.138640295272, 222201.0, 223496.0, 224343.0, 224358.0, 224600.0, 51544.48455515397, 51955.0, 51988.22017669738, 52075.0, 52192.47807521952, 1450.3255985966366, 1453.7861669746428, 1466.7726502392147, 1479.2529772465052, 1479.393448686055, 22069.779302207415, 22083.44791380164, 22277.774722390423, 22575.548489030454, 22690.773092269526, 36391.63608363988, 36533.634663654084, 36545.81727091454, 36595.634043660284, 36606.0, 182187.08906455382, 183386.0, 183954.0, 185254.0, 186049.0, 32956.67043329632, 33298.833505832314, 33331.333373331916, 33656.83171584126, 33687.4946875802, 45819.77090114528, 46403.30395044145, 46441.0, 46529.302060469796, 46725.53274467212, 29932.25169370696, 31198.532022019233, 31626.209344766565, 32414.513782293758, 32515.18712032218, 31236.37527249488, 31643.52534711935, 31761.364772703953, 31949.840250798596, 32300.676993230707, 35204.0, 35504.0, 35737.0, 35773.821130894175, 35844.0, 32229.51655725119, 32348.0, 32358.35283294368, 33009.33981320408, 33911.32177356489, 23357.2992810216, 24923.252302430956, 24978.37554061163, 25243.0, 25250.74749252484], "value": 17071.110546579675, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.3935958204512, 572.9570282228833, 573.6099452372385, 581.528961541152, 593.5370411079358, 21647.242346517876, 22563.435914102156, 22564.21025264116, 22584.43538911528, 22700.0, 23607.0, 24264.393390165256, 25695.357616059562, 25830.225093247187, 25855.48289034218, 6404.455621272185, 6568.737250509974, 6569.9014514782075, 6572.244191917919, 6573.57271777333, 6230.221222347207, 6408.935910640904, 6457.6771161441975, 6495.512836537278, 6502.512311576627, 6445.452136568398, 6447.54867159299, 6464.159659244292, 6508.54440189187, 6509.153810004716, 6405.48756099511, 6440.645764482952, 6484.221893372825, 6519.250286217075, 6524.021396790472, 5996.100584912255, 6009.038553831409, 6024.21685180928, 6034.426729460694, 6042.063480160582, 27799.58300625492, 28226.717732822613, 28232.71767282342, 28465.0, 28521.71478285232, 1827.7075667893207, 1875.9718604220948, 1878.4552479780848, 1882.4164509002253, 1885.754851869262, 18750.624987500174, 19044.143013564284, 20147.39557813268, 20980.685289720666, 21141.0, 2421.987890060556, 2427.9150229741877, 2503.0, 2509.3475696318906, 2512.786413154884, 131152.0, 136310.0, 136505.0, 136843.0, 136859.31570342183, 20900.790992090188, 22420.55158896813, 23501.529969400857, 23504.294871153892, 23656.40858978505, 44013.559864400944, 44360.0, 44443.77778111089, 44590.0, 44806.775966120615, 11450.083993280517, 11569.47131125015, 11721.304100056865, 11726.530938762355, 11962.282263064244, 9590.520473976274, 9717.368371055858, 9775.413475191512, 9792.853107203398, 9846.852297215548, 9204.769880753034, 11648.301101933912, 11963.820542691867, 11986.34075125859, 12172.57395991136, 4289.399484072233, 4386.517483076859, 4397.670174736843, 4414.624756895636, 4550.977245113753, 922.8569571716395, 938.2119020023214, 951.1249650321582, 956.7560272130562, 969.5588507229194, 19576.608467830563, 19812.405627831187, 20360.592788144153, 20372.49068773263, 20635.69046464304, 975.7804493988938, 1002.7242508310273, 1016.3038318751679, 1021.1116328793996, 1039.7920415916697, 10790.406527641055, 11264.943675281735, 11376.772464550662, 11464.31214127155, 11485.0811935045, 471547.0, 490278.0, 490758.0, 493281.0, 493612.0, 110408.44795776131, 111773.0, 114804.0, 116778.0, 116797.0, 1190.7320852808223, 1201.741625550511, 1218.585680868509, 1220.6887243752785, 1226.4235809169677, 16944.0, 17697.557561061076, 17804.376846810817, 18603.0, 18668.906655466635, 54025.0, 55698.443015569326, 56940.71529642325, 57261.71369143128, 57727.4227257722, 66991.99876309403, 70294.0, 70353.64823175852, 70420.0, 71209.64395177992, 12535.185212961129, 13008.869911300766, 14449.349779259748, 14685.118892866461, 15000.474983375529, 23337.76662233356, 23652.52694946057, 23792.762072379748, 24042.87978560096, 24084.0, 18432.723509147105, 18588.44234672962, 18676.0, 18794.436166915013, 18996.715049273997, 16154.192290385668, 16437.506874793777, 16640.583985400463, 16736.0, 17059.147042648066, 18621.44135675932, 19583.216671333557, 19646.901765491082, 19655.70516442283, 19671.60656786885, 14631.85368146305, 14835.777463338274, 14907.627309317353, 14917.552473425814, 14975.326110324844, 17961.461156165336, 18868.43394698161, 18911.148998295386, 18912.716309255648, 18940.715889261395], "value": 12599.180757798307, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.6051345109915, 1398.0497206397076, 1410.6755446247362, 1415.5894790510752, 1420.8508106648808, 13296.0, 13907.30463476826, 13929.0, 13938.651533711662, 13960.650983725413, 13813.447462101503, 14313.713725725505, 14363.71272574548, 14381.209033503153, 14392.136471811698, 2632.4866651003013, 2698.231004163814, 2698.473797609467, 2703.1620197738666, 2704.7700945419665, 2570.0747730816893, 2629.7633213010827, 2679.209633158223, 2681.142034548945, 2687.3281679580105, 2424.381782645432, 2453.386653336666, 2466.099873546161, 2618.5548456762394, 2647.2587675450904, 2571.1515199984146, 2582.935426614331, 2588.417606038645, 2601.193629974714, 2609.2041927212285, 2506.548821212181, 2532.9493410131695, 2548.2100548829735, 2559.7184309726103, 2565.551028569993, 13420.530281440102, 13615.795763063563, 13638.0, 13725.931370343083, 13738.862611373957, 7544.321011109027, 7789.415793815487, 7835.412344074217, 7847.843043139163, 7856.882146767803, 4950.331705219785, 5040.873978150539, 5115.846524604268, 5180.6373553851245, 5191.610629202787, 1733.0987886299054, 1780.5993651428325, 1781.6525777473398, 1788.3025620008207, 1791.2297711983842, 21998.780012199833, 22397.328080157622, 22465.775342246532, 22481.775182248133, 22517.099316027503, 6084.209052823105, 6404.199475065617, 6677.0, 7141.89287160693, 7153.749618763422, 15868.60328491797, 15972.0, 15999.12004839745, 16014.759778603331, 16023.839761602234, 7675.0, 7687.385009199251, 7688.654010569538, 7690.884636730453, 7743.419243556756, 6999.370056694922, 7010.894836577353, 7063.2583578724525, 7069.434445244368, 7183.173934997542, 4978.10394129053, 5008.824691135866, 5083.186690129635, 5114.3862736471865, 5114.974425127851, 1466.3401469338628, 1481.6666250093642, 1481.8666320031034, 1501.1068414293477, 1505.33012809301, 829.672279449614, 830.5805568188026, 831.9376046796515, 859.4113032572708, 879.7624641346929, 6566.704498297588, 6622.304658010936, 6749.291324410866, 6884.759033433906, 6894.931050689429, 664.1465716554204, 688.9311068893171, 703.7431337561856, 709.6841905352069, 711.4735096028901, 4547.909041819145, 4559.065391594715, 4655.092257009918, 4706.035262771192, 4716.316134160527, 17569.297228110732, 17851.642967140586, 18425.53936151607, 18442.63114737698, 18472.445826625222, 17760.733588996176, 19192.520186995156, 19351.612967740846, 19353.4193974181, 19451.80548194528, 10581.31221470602, 10711.036006759428, 10965.396903170402, 10979.945100274606, 11058.447077646086, 6844.965775171092, 7248.782536523912, 7316.231795661592, 7461.664225109775, 7597.050368703912, 15558.688826223639, 16237.269322880735, 16436.75344869804, 16560.254788534785, 16657.50027499177, 14242.430302788187, 15033.323500442724, 15466.304016319067, 16200.67598648044, 16998.320067197175, 9819.165370943265, 9900.059494348025, 9991.950040249752, 10028.899711003089, 10143.949280253551, 12870.099093063396, 12934.611961641165, 12968.935155324163, 12986.285754283228, 13000.284984325954, 9557.092076252746, 10020.69937901835, 10156.644517441853, 10443.373397596168, 10454.215933804842, 9449.149576538144, 9796.706098817047, 10002.749931251778, 10012.899871001197, 10028.749281268027, 8063.637136328762, 8103.270705636521, 8150.633221505165, 8151.184881511801, 8159.102498725017, 6293.181886354744, 6300.432961033529, 6586.967065164644, 6592.472602191718, 6651.43462805667, 6369.808905732835, 6416.7754128605275, 6455.354464553507, 6504.479641628753, 6583.473322134122], "value": 6086.330326630791, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.7394433061815, 493.55953198943206, 511.51150651128177, 512.5643203277215, 513.143051104655, 6079.5136389088875, 6080.442940879585, 6089.238845144357, 6108.328083910772, 6149.723262453189, 5809.854753631162, 5899.699117344239, 5922.644641321513, 5977.7608895644125, 6001.48987336077, 4820.879478013043, 4852.2479015752615, 4855.916493026918, 4859.489753575876, 4883.584895283905, 4820.903581928359, 4841.973766396002, 4857.344258525107, 4901.411830580335, 4904.950950490485, 4704.576588107069, 4789.832355867546, 4799.856004319859, 4841.443234028096, 4853.757312134379, 4762.452203034028, 4773.737444440571, 4830.71015739055, 4877.439094504142, 4882.292067650206, 4296.162248361571, 4306.418633484471, 4307.246231909435, 4367.737935723867, 4402.625776808975, 5808.215890854723, 5885.293764748215, 5937.732802023919, 5973.701314934236, 5987.0, 5548.6948217848, 5567.3040869891265, 5580.246666699984, 5584.134459158796, 5637.80267690633, 6359.42765151134, 6394.1687580614225, 6475.611463312216, 6477.83805404864, 6511.28375878653, 4763.64272679547, 4764.976175119137, 4767.189577771787, 4781.569658730731, 4815.446223684286, 6802.863942721118, 6841.2132604750095, 6863.828404289883, 6889.862202755967, 6905.792826215222, 4918.3360246367, 4931.260310953386, 4936.3089167515855, 4972.378452693413, 4985.202367621163, 4949.678270912379, 4962.330085438492, 5007.799688012512, 5014.52362025607, 5019.899602007939, 5582.86042848932, 5596.1605759136455, 5614.438556144353, 5640.802571909963, 5646.322441307069, 6397.904031439532, 6425.389587989133, 6436.069179246301, 6500.414962653289, 6666.433353164938, 1623.845734655206, 1661.775660285846, 1675.246139237348, 1685.3174464341962, 1697.8217287184914, 1177.3936422742295, 1193.3078814287692, 1205.4816428935642, 1223.3149436315691, 1229.7540491901655, 5661.66030038199, 5681.431856814285, 5692.430756924275, 5699.0, 5714.514266287329, 6388.39310265524, 6458.773942912069, 6486.2216534016225, 6597.833040140759, 6644.4020038196795, 5651.00496736722, 5655.953648575027, 5677.37548869624, 5688.601797874192, 5775.16260142277, 3477.6348483409383, 3479.8782042628386, 3501.9474707879403, 3532.452469867175, 3554.680078792921, 6295.26880107974, 6338.207724034496, 6366.458850997625, 6411.5832470889245, 6419.04038991647, 6766.357196066366, 6785.59286442815, 6789.388954994074, 6831.726730930806, 6832.558836756149, 6260.186175797117, 6286.874262514815, 6344.111824344595, 6356.237251529754, 6497.447716944018, 6421.073677896519, 6527.608343499405, 6552.475801935929, 6558.1802274715665, 6593.637349945799, 6452.548321617442, 6454.1609590752905, 6494.253160886558, 6530.47756179495, 6552.232466331973, 6297.338779428277, 6333.90499142504, 6363.61818290904, 6380.266269378895, 6434.099226108255, 4832.598546421498, 4859.489753575965, 4941.209406494943, 4965.950340496549, 4974.711632648878, 6645.734170633121, 6678.3989440950545, 6683.164604424447, 6715.227748808754, 6715.891877840297, 6373.3945275198785, 6414.839629009312, 6423.839404014937, 6426.742930282923, 6474.920799896224, 6295.716692748746, 6308.022256550242, 6392.520560957853, 6410.743570257137, 6432.935670643234, 6131.877362452815, 6158.969205153946, 6215.689215539295, 6217.129601855834, 6444.258910225197, 6416.51876109303, 6425.775097871552, 6509.869802603826, 6539.934600653933, 6541.771038013647, 6151.262688103751, 6178.969105154625, 6220.782272620437, 6256.5620406572925, 6279.560430769802], "value": 4949.34010919874, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [902.3728508686457, 915.7023967210656, 919.6597259014166, 920.9769755756105, 924.5377311344328, 18483.0, 19297.4210773677, 19297.710534341997, 19343.70984435233, 19347.129379177935, 19968.301109461172, 21752.129914803427, 21756.34730958074, 21866.0, 21883.562328753414, 1033.7260625934114, 1041.5781608448553, 1041.7031146123356, 1041.7864337810768, 1044.0394836750208, 997.6109317366233, 1058.3015209961427, 1061.3472714280701, 1076.4617691154422, 1080.9297395669257, 1112.8887111288848, 1113.6436340371085, 1115.0522056252203, 1117.407773879845, 1119.9328040317566, 1102.8676558812954, 1108.2519299472904, 1116.8994790468855, 1117.0560876059717, 1117.3966058328492, 817.207308910356, 819.2012787532168, 820.885076089348, 823.7858156879195, 824.7773101262685, 19325.51686207842, 19718.704219436575, 19856.503587410287, 20030.89984550068, 20197.293094741613, 20531.794682053285, 20564.280250191172, 21148.47128821792, 21177.682334764835, 21220.045097970473, 16069.758953615705, 16505.83494165067, 16632.584185395343, 16657.66684666312, 16707.081110538915, 3498.2129020970333, 3508.14050557615, 3514.6133925268455, 3539.929201415983, 3583.964160358389, 112278.0, 115206.0, 119576.0, 120155.0, 125930.37034814767, 16806.495805125865, 17078.914605426893, 17084.658306833793, 17247.827521724874, 17286.740698889527, 29710.702892971225, 30633.08100756981, 31021.534676979863, 31036.53445198324, 31049.223769405493, 8756.0, 8948.284137269004, 8984.55077246135, 9004.099590041074, 9009.144131307516, 4244.936325955113, 4326.740395576276, 4328.761918094472, 4342.522322544518, 4351.891202719958, 4869.488703686133, 5114.28400023997, 5398.8920221595345, 5625.690587017753, 5725.3988331225455, 1086.6685660873352, 1107.291333546531, 1121.5401685309148, 1124.2186680257144, 1129.3844854554288, 653.2096163642046, 671.4930227678071, 686.0361192524512, 691.8996745471878, 706.6819931030954, 10864.819227752536, 11955.222910510789, 12194.146409751233, 12289.078319126102, 12476.937615312047, 651.7359876762695, 686.2691233835949, 693.5561240805888, 704.5913370245348, 710.1123595505618, 5192.091384007784, 5357.624966252325, 5508.283923089973, 5545.195946587723, 5550.306211723535, 99143.0, 104424.0, 104491.47754261333, 106181.0, 107253.4637326824, 83873.16126838776, 87131.0, 88765.55617221873, 91014.0, 91295.0, 80185.0, 82056.0, 84193.0, 84799.57600211959, 86618.13381866227, 10705.9464702676, 11999.40002999864, 12409.0, 12568.434420451285, 12598.811017834923, 33415.49876751899, 35767.821160894026, 36201.0, 36526.0, 38571.80714096524, 65995.34004659893, 66087.33912660812, 66148.0, 66882.33117668761, 70378.0, 19228.327008554632, 19243.711344329568, 19435.8056419434, 19455.902720486873, 19493.122809473323, 18794.718079229096, 18826.34107806275, 18976.05119744035, 18991.71512427342, 21577.0, 17418.0420076897, 17486.213120409357, 17565.209565569836, 18038.0, 18983.715244271072, 18717.344892928682, 18819.529511762317, 18846.905765471634, 19018.42944711661, 19335.129919153955, 17237.138143093045, 17300.0, 17525.0, 19288.324908628132, 19420.902895485433, 12434.129610927148, 12740.190053658445, 13241.3379331035, 13618.114822536503, 13741.862581374058, 13154.473821047051, 14036.368363423466, 14253.714925701635, 14426.639334016734, 14652.926735366254], "value": 9165.51236380065, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1563.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 114.0, 105.0, 108.0, 113.0, 110.0, 111.0, 101.0, 110.0, 109.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 125.0, 146.0, 177.0, 123.0, 143.0, 157.0, 124.0, 172.0, 124.0], "value": 143.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 164.0, 161.0, 162.0, 167.0, 169.0, 167.0, 161.0, 163.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 167.0, 77.0, 75.0, 75.0, 92.0, 100.0, 77.0], "value": 89.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 126.0, 79.0, 78.0, 86.0, 130.0, 80.0, 79.0, 126.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 114.0, 114.0, 114.0, 113.0, 118.0, 114.0, 116.0, 116.0], "value": 115.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 155.0, 156.0, 151.0, 150.0, 151.0, 150.0, 150.0, 150.0, 155.0], "value": 152.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 100.0, 94.0, 94.0, 97.0, 94.0, 95.0, 94.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 56.0, 55.0, 58.0, 61.0, 56.0, 62.0, 62.0, 56.0, 55.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 55.0, 54.0, 54.0, 56.0], "value": 54.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 82.0, 86.0, 81.0, 109.0, 81.0, 83.0, 81.0, 80.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 147.0, 130.0, 148.0, 127.0, 124.0, 148.0, 134.0, 129.0, 181.0], "value": 140.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 202.0, 193.0, 185.0, 193.0, 182.0, 194.0, 200.0, 185.0, 187.0], "value": 191.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 76.0, 77.0, 74.0, 70.0, 77.0, 75.0, 68.0, 72.0, 69.0], "value": 72.8, "unit": "score"}]}]} 03:22:27 INFO - Return code: 0 03:22:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:22:27 INFO - # TBPL SUCCESS # 03:22:27 INFO - Running post-action listener: _package_coverage_data 03:22:27 INFO - Running post-action listener: _resource_record_post_action 03:22:27 INFO - [mozharness: 2017-07-30 10:22:27.655270Z] Finished run-tests step (success) 03:22:27 INFO - Running post-run listener: _resource_record_post_run 03:22:27 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 10600448; Write bytes: 445050880; Read time: 4228; Write time: 404128 03:22:27 INFO - TinderboxPrint: CPU usage
13.2% 03:22:27 INFO - TinderboxPrint: I/O read bytes / time
10,600,448 / 4,228 03:22:27 INFO - TinderboxPrint: I/O write bytes / time
445,050,880 / 404,128 03:22:27 INFO - TinderboxPrint: CPU idle
8,290.5 (86.8%) 03:22:27 INFO - TinderboxPrint: CPU user
1,205.0 (12.6%) 03:22:27 INFO - TinderboxPrint: Swap in / out
0 / 0 03:22:27 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 156135424; Read time: 0; Write time: 98536 03:22:27 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:22:27 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 8450048; Write bytes: 218009600; Read time: 3872; Write time: 212968 03:22:28 INFO - Running post-run listener: _upload_blobber_files 03:22:28 INFO - Blob upload gear active. 03:22:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:22:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:22:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:22:28 INFO - (blobuploader) - INFO - Open directory for files ... 03:22:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:22:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:22:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:22:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:22:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:22:29 INFO - (blobuploader) - INFO - Done attempting. 03:22:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:22:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:22:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:22:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:22:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:22:33 INFO - (blobuploader) - INFO - Done attempting. 03:22:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:22:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:22:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:22:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:22:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:22:34 INFO - (blobuploader) - INFO - Done attempting. 03:22:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:22:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:22:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:22:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:22:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:22:35 INFO - (blobuploader) - INFO - Done attempting. 03:22:35 INFO - (blobuploader) - INFO - Iteration through files over. 03:22:35 INFO - Return code: 0 03:22:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:22:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:22:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fc4e042f026a351d2b50721f1d2c25e30e7a5db936562e54324a8c16495ad658aa0a6a765e249ada67bdb3f90fce06a826bf7f1bed027734fe79edb50269b56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2064dd9ddf765a0b53f9d95a907ee5ed245f2c3963e7717347f28375e1e2f3e2d72f1afe8919e525f195129cd46032a27e67c4b54adbdb582ed5fc873c07a268", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/792ad92ac08be417857c99eab4ad87cd2cc51f7b0f3868b17d6f0de32f11b04683c4c78e031136a9841212470e8fd5836156661430b65ffa2dde2893b414f67a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d58b19b032f500aa3932d4971408a84112bd7ddab3aba5655183b2b2eba2e47f3236dbfd121d07790678eff4106991b65070969e036621352dbbbe5f66ad794e"} 03:22:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:22:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:22:35 INFO - Contents: 03:22:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fc4e042f026a351d2b50721f1d2c25e30e7a5db936562e54324a8c16495ad658aa0a6a765e249ada67bdb3f90fce06a826bf7f1bed027734fe79edb50269b56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2064dd9ddf765a0b53f9d95a907ee5ed245f2c3963e7717347f28375e1e2f3e2d72f1afe8919e525f195129cd46032a27e67c4b54adbdb582ed5fc873c07a268", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/792ad92ac08be417857c99eab4ad87cd2cc51f7b0f3868b17d6f0de32f11b04683c4c78e031136a9841212470e8fd5836156661430b65ffa2dde2893b414f67a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d58b19b032f500aa3932d4971408a84112bd7ddab3aba5655183b2b2eba2e47f3236dbfd121d07790678eff4106991b65070969e036621352dbbbe5f66ad794e"} 03:22:35 INFO - Running post-run listener: copy_logs_to_upload_dir 03:22:35 INFO - Copying logs to upload dir... 03:22:35 INFO - mkdir: /builds/slave/test/build/upload/logs 03:22:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.139727 ========= master_lag: -0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-07-30 03:22:35.897869) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-30 03:22:35.901241) ========= 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=4300f881736b422476174874000001bc-1501408804.72125-1684044571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fc4e042f026a351d2b50721f1d2c25e30e7a5db936562e54324a8c16495ad658aa0a6a765e249ada67bdb3f90fce06a826bf7f1bed027734fe79edb50269b56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2064dd9ddf765a0b53f9d95a907ee5ed245f2c3963e7717347f28375e1e2f3e2d72f1afe8919e525f195129cd46032a27e67c4b54adbdb582ed5fc873c07a268", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/792ad92ac08be417857c99eab4ad87cd2cc51f7b0f3868b17d6f0de32f11b04683c4c78e031136a9841212470e8fd5836156661430b65ffa2dde2893b414f67a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d58b19b032f500aa3932d4971408a84112bd7ddab3aba5655183b2b2eba2e47f3236dbfd121d07790678eff4106991b65070969e036621352dbbbe5f66ad794e"} build_url:https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fc4e042f026a351d2b50721f1d2c25e30e7a5db936562e54324a8c16495ad658aa0a6a765e249ada67bdb3f90fce06a826bf7f1bed027734fe79edb50269b56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2064dd9ddf765a0b53f9d95a907ee5ed245f2c3963e7717347f28375e1e2f3e2d72f1afe8919e525f195129cd46032a27e67c4b54adbdb582ed5fc873c07a268", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/792ad92ac08be417857c99eab4ad87cd2cc51f7b0f3868b17d6f0de32f11b04683c4c78e031136a9841212470e8fd5836156661430b65ffa2dde2893b414f67a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d58b19b032f500aa3932d4971408a84112bd7ddab3aba5655183b2b2eba2e47f3236dbfd121d07790678eff4106991b65070969e036621352dbbbe5f66ad794e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-30 03:22:35.926216) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:22:35.926515) ========= 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=4300f881736b422476174874000001bc-1501408804.72125-1684044571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:22:36.009773) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-30 03:22:36.010097) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-30 03:22:36.010374) ========= ========= Total master_lag: 0.11 =========