builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-025 starttime: 1497976295.65 results: success (0) revision: 464b2a3c25aa1065760d9ecbb0870bca4a66c62e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-20 09:31:35.649186) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-20 09:31:35.649576) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-20 09:31:35.649866) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-20 09:31:35.690107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-20 09:31:35.690477) ========= 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=232498196343f89f466a4a9a000001c8-1497955902.482075-185977431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-20 09:31:36-- 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% 36.1M=0s 2017-06-20 09:31:36 (36.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.107809 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-20 09:31:35.820108) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-20 09:31:35.820411) ========= 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=232498196343f89f466a4a9a000001c8-1497955902.482075-185977431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013538 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-20 09:31:35.869715) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-20 09:31:35.870046) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 464b2a3c25aa1065760d9ecbb0870bca4a66c62e --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 464b2a3c25aa1065760d9ecbb0870bca4a66c62e --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=232498196343f89f466a4a9a000001c8-1497955902.482075-185977431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-20 09:31:36,996 truncating revision to first 12 chars 2017-06-20 09:31:36,997 Setting DEBUG logging. 2017-06-20 09:31:36,997 attempt 1/10 2017-06-20 09:31:36,997 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/464b2a3c25aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-20 09:31:38,464 unpacking tar archive at: mozilla-central-464b2a3c25aa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.779217 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-20 09:31:37.666863) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-20 09:31:37.667172) ========= script_repo_revision: 464b2a3c25aa1065760d9ecbb0870bca4a66c62e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-20 09:31:37.667867) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-20 09:31:37.672170) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-20 09:31:37.682255) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-06-20 09:31:37.682537) ========= /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=232498196343f89f466a4a9a000001c8-1497955902.482075-185977431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:31:38 INFO - MultiFileLogger online at 20170620 09:31:38 in /builds/slave/test 09:31:38 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 09:31:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:31:38 INFO - {'append_to_log': False, 09:31:38 INFO - 'base_work_dir': '/builds/slave/test', 09:31:38 INFO - 'blob_upload_branch': 'Firefox', 09:31:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:31:38 INFO - 'branch': 'Firefox', 09:31:38 INFO - 'buildbot_json_path': 'buildprops.json', 09:31:38 INFO - 'config_files': ('talos/linux_config.py',), 09:31:38 INFO - 'default_actions': ('clobber', 09:31:38 INFO - 'read-buildbot-config', 09:31:38 INFO - 'download-and-extract', 09:31:38 INFO - 'populate-webroot', 09:31:38 INFO - 'create-virtualenv', 09:31:38 INFO - 'install', 09:31:38 INFO - 'setup-mitmproxy', 09:31:38 INFO - 'run-tests'), 09:31:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:31:38 INFO - 'download_minidump_stackwalk': True, 09:31:38 INFO - 'download_symbols': 'ondemand', 09:31:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:31:38 INFO - 'tooltool.py': '/tools/tooltool.py', 09:31:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:31:38 INFO - '/tools/misc-python/virtualenv.py')}, 09:31:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:31:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:31:38 INFO - 'gecko_profile': False, 09:31:38 INFO - 'gecko_profile_interval': 0, 09:31:38 INFO - 'installer_path': 'installer.exe', 09:31:38 INFO - 'log_level': 'info', 09:31:38 INFO - 'log_name': 'talos', 09:31:38 INFO - 'log_to_console': True, 09:31:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:31:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:31:38 INFO - 'opt_config_files': (), 09:31:38 INFO - 'pip_index': False, 09:31:38 INFO - 'suite': 'dromaeojs-e10s', 09:31:38 INFO - 'system_bits': '32', 09:31:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:31:38 INFO - 'title': 'talos-linux64-ix-025', 09:31:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:31:38 INFO - 'use_talos_json': True, 09:31:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:31:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:31:38 INFO - 'work_dir': 'build'} 09:31:38 INFO - [mozharness: 2017-06-20 16:31:38.907918Z] Running clobber step. 09:31:38 INFO - Running pre-action listener: _resource_record_pre_action 09:31:38 INFO - Running main action method: clobber 09:31:38 INFO - rmtree: /builds/slave/test/build 09:31:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:31:40 INFO - Running post-action listener: _resource_record_post_action 09:31:40 INFO - [mozharness: 2017-06-20 16:31:40.462838Z] Finished clobber step (success) 09:31:40 INFO - [mozharness: 2017-06-20 16:31:40.462937Z] Running read-buildbot-config step. 09:31:40 INFO - Running pre-action listener: _resource_record_pre_action 09:31:40 INFO - Running main action method: read_buildbot_config 09:31:40 INFO - Using buildbot properties: 09:31:40 INFO - { 09:31:40 INFO - "project": "", 09:31:40 INFO - "product": "firefox", 09:31:40 INFO - "who": "ffxbld@noreply.mozilla.org", 09:31:40 INFO - "installer_path": "public/build/target.tar.bz2", 09:31:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 09:31:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:31:40 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 09:31:40 INFO - "stage_platform": "linux64-stylo", 09:31:40 INFO - "basedir": "/builds/slave/test", 09:31:40 INFO - "buildnumber": 165, 09:31:40 INFO - "platform": "ubuntu64_hw_stylo", 09:31:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:31:40 INFO - "slavebuilddir": "test", 09:31:40 INFO - "taskId": "MJkJxPjmQOeNRgswvjN2CQ", 09:31:40 INFO - "branch": "mozilla-central", 09:31:40 INFO - "script_repo_revision": "production", 09:31:40 INFO - "revision": "464b2a3c25aa1065760d9ecbb0870bca4a66c62e", 09:31:40 INFO - "slavename": "talos-linux64-ix-025", 09:31:40 INFO - "repo_path": "mozilla-central" 09:31:40 INFO - } 09:31:40 INFO - Finding installer, test and symbols from parent task. 09:31:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MJkJxPjmQOeNRgswvjN2CQ'}, attempt #1 09:31:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MJkJxPjmQOeNRgswvjN2CQ'}, attempt #1 09:31:41 INFO - Task dependencies: Odpg4trQRASH_f5sLKD18w 09:31:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Odpg4trQRASH_f5sLKD18w'}, attempt #1 09:31:41 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/target.tar.bz2 09:31:41 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/test_packages.json 09:31:41 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/target.crashreporter-symbols.zip 09:31:41 INFO - Running post-action listener: _resource_record_post_action 09:31:41 INFO - [mozharness: 2017-06-20 16:31:41.817078Z] Finished read-buildbot-config step (success) 09:31:41 INFO - [mozharness: 2017-06-20 16:31:41.817386Z] Running download-and-extract step. 09:31:41 INFO - Running pre-action listener: _resource_record_pre_action 09:31:41 INFO - Running main action method: download_and_extract 09:31:41 INFO - mkdir: /builds/slave/test/build/tests 09:31:42 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')]} 09:31:42 INFO - trying https://queue.taskcluster.net/v1/task/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/target.test_packages.json 09:31:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:31:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:31:42 INFO - Downloaded 989 bytes. 09:31:42 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:31:42 INFO - Using the following test package requirements: 09:31:42 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:31:42 INFO - u'common': [u'target.common.tests.zip'], 09:31:42 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:31:42 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:31:42 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:31:42 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:31:42 INFO - u'mozbase': [u'target.common.tests.zip'], 09:31:42 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:31:42 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:31:42 INFO - u'web-platform': [u'target.common.tests.zip', 09:31:42 INFO - u'target.web-platform.tests.tar.gz'], 09:31:42 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:31:42 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:31:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/target.common.tests.zip 09:31:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:31:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/target.common.tests.zip into memory 09:31:43 INFO - Content-Length response header: 67987414 09:31:43 INFO - Bytes received: 67987414 09:31:54 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:31:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/target.common.tests.zip 09:31:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:31:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/target.common.tests.zip into memory 09:31:55 INFO - Content-Length response header: 67987414 09:31:55 INFO - Bytes received: 67987414 09:32:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/target.talos.tests.zip 09:32:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:32:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/target.talos.tests.zip into memory 09:32:08 INFO - Content-Length response header: 14457064 09:32:08 INFO - Bytes received: 14457064 09:32:08 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')]} 09:32:08 INFO - trying https://queue.taskcluster.net/v1/task/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/target.tar.bz2 09:32:08 INFO - Downloading https://queue.taskcluster.net/v1/task/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:32:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:32:09 INFO - Downloaded 61445420 bytes. 09:32:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/target.tar.bz2 09:32:09 INFO - mkdir: /builds/slave/test/properties 09:32:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:32:09 INFO - Writing to file /builds/slave/test/properties/build_url 09:32:09 INFO - Contents: 09:32:09 INFO - build_url:https://queue.taskcluster.net/v1/task/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/target.tar.bz2 09:32:09 INFO - Running post-action listener: _resource_record_post_action 09:32:09 INFO - Running post-action listener: set_extra_try_arguments 09:32:09 INFO - [mozharness: 2017-06-20 16:32:09.929988Z] Finished download-and-extract step (success) 09:32:09 INFO - [mozharness: 2017-06-20 16:32:09.930085Z] Running populate-webroot step. 09:32:09 INFO - Running pre-action listener: _resource_record_pre_action 09:32:09 INFO - Running main action method: populate_webroot 09:32:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:32:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:32:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:32:09 INFO - '--tppagecycles', 09:32:09 INFO - '7'], 09:32:09 INFO - 'tests': ['tsvgm']}}, 09:32:09 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:32:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:32:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:32:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:32:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:32:09 INFO - 'talos_options': ['--disable-e10s'], 09:32:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:32:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:32:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:32:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:32:09 INFO - 'talos_options': ['--disable-e10s'], 09:32:09 INFO - 'tests': ['damp', 'tps']}, 09:32:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:32:09 INFO - 'tests': ['damp', 'tps']}, 09:32:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:32:09 INFO - 'tests': ['dromaeo_dom']}, 09:32:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:32:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:32:09 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:32:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:32:09 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:32:09 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:32:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:32:09 INFO - 'tests': ['a11yr', 09:32:09 INFO - 'ts_paint', 09:32:09 INFO - 'tpaint', 09:32:09 INFO - 'sessionrestore', 09:32:09 INFO - 'sessionrestore_no_auto_restore', 09:32:09 INFO - 'tabpaint']}, 09:32:09 INFO - 'other-e10s': {'tests': ['a11yr', 09:32:09 INFO - 'ts_paint', 09:32:09 INFO - 'tpaint', 09:32:09 INFO - 'sessionrestore', 09:32:09 INFO - 'sessionrestore_no_auto_restore', 09:32:09 INFO - 'tabpaint']}, 09:32:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:32:09 INFO - 'ts_paint', 09:32:09 INFO - 'tpaint', 09:32:09 INFO - 'sessionrestore', 09:32:09 INFO - 'sessionrestore_no_auto_restore', 09:32:09 INFO - 'tabpaint']}, 09:32:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:32:09 INFO - 'ts_paint', 09:32:09 INFO - 'tpaint', 09:32:09 INFO - 'sessionrestore', 09:32:09 INFO - 'sessionrestore_no_auto_restore', 09:32:09 INFO - 'tabpaint']}, 09:32:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:32:09 INFO - 'tests': ['a11yr', 09:32:09 INFO - 'ts_paint', 09:32:09 INFO - 'tpaint', 09:32:09 INFO - 'sessionrestore', 09:32:09 INFO - 'sessionrestore_no_auto_restore', 09:32:09 INFO - 'tabpaint']}, 09:32:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:32:09 INFO - 'tests': ['a11yr', 09:32:09 INFO - 'ts_paint', 09:32:09 INFO - 'tpaint', 09:32:09 INFO - 'sessionrestore', 09:32:09 INFO - 'sessionrestore_no_auto_restore', 09:32:09 INFO - 'tabpaint']}, 09:32:09 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:32:09 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:32:09 INFO - 'bloom_basic_ref']}, 09:32:09 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:32:09 INFO - 'talos_options': ['--mitmproxy', 09:32:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:32:09 INFO - '--firstNonBlankPaint'], 09:32:09 INFO - 'tests': ['quantum_pageload_google', 09:32:09 INFO - 'quantum_pageload_youtube', 09:32:09 INFO - 'quantum_pageload_amazon', 09:32:09 INFO - 'quantum_pageload_facebook']}, 09:32:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:32:09 INFO - 'tests': ['tsvgx', 09:32:09 INFO - 'tsvgr_opacity', 09:32:09 INFO - 'tart', 09:32:09 INFO - 'tscrollx', 09:32:09 INFO - 'cart', 09:32:09 INFO - 'tsvg_static']}, 09:32:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:32:09 INFO - 'tsvgr_opacity', 09:32:09 INFO - 'tart', 09:32:09 INFO - 'tscrollx', 09:32:09 INFO - 'cart', 09:32:09 INFO - 'tsvg_static']}, 09:32:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:32:09 INFO - 'talos_options': ['--disable-e10s'], 09:32:09 INFO - 'tests': ['tp5o']}, 09:32:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:32:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:32:09 INFO - 'talos_options': ['--disable-e10s', 09:32:09 INFO - '--xperf_path', 09:32:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:32:09 INFO - 'tests': ['tp5n']}, 09:32:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:32:09 INFO - 'talos_options': ['--xperf_path', 09:32:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:32:09 INFO - 'tests': ['tp5n']}}, 09:32:09 INFO - 'talos.zip': {'path': '', 09:32:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:32:09 INFO - Running post-action listener: _resource_record_post_action 09:32:09 INFO - [mozharness: 2017-06-20 16:32:09.944700Z] Finished populate-webroot step (success) 09:32:09 INFO - [mozharness: 2017-06-20 16:32:09.944789Z] Running create-virtualenv step. 09:32:09 INFO - Running pre-action listener: _resource_record_pre_action 09:32:09 INFO - Running main action method: create_virtualenv 09:32:09 INFO - Creating virtualenv /builds/slave/test/build/venv 09:32:09 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 09:32:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:32:09 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:32:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:32:10 INFO - Using real prefix '/usr' 09:32:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:32:10 INFO - Installing distribute.............................................................................................................................................................................................done. 09:32:12 INFO - Installing pip.................done. 09:32:12 INFO - Return code: 0 09:32:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:32:12 INFO - Reading from file tmpfile_stdout 09:32:12 INFO - Output received: 09:32:12 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) 09:32:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:32:12 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')]} 09:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:12 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')]} 09:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:12 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 0x17ca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b489a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b46140>, '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 0x1b46a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b46ed0>, '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': '232498196343f89f466a4a9a000001c8-1497955902.482075-185977431', '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 09:32:12 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 09:32:12 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 09:32:12 INFO - Using env: {'DISPLAY': ':0', 09:32:12 INFO - 'HOME': '/home/cltbld', 09:32:12 INFO - 'LANG': 'en_US.UTF-8', 09:32:12 INFO - 'LANGUAGE': 'en_US:en', 09:32:12 INFO - 'LOGNAME': 'cltbld', 09:32:12 INFO - 'MAIL': '/var/mail/cltbld', 09:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:12 INFO - 'MOZ_NO_REMOTE': '1', 09:32:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:12 INFO - 'NO_EM_RESTART': '1', 09:32:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:12 INFO - 'PWD': '/builds/slave/test', 09:32:12 INFO - 'SHELL': '/bin/bash', 09:32:12 INFO - 'SHLVL': '1', 09:32:12 INFO - 'TERM': 'linux', 09:32:12 INFO - 'TMOUT': '86400', 09:32:12 INFO - 'USER': 'cltbld', 09:32:12 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1497955902.482075-185977431', 09:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:12 INFO - '_': '/tools/buildbot/bin/python'} 09:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:12 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 09:32:12 INFO - Cleaning up... 09:32:12 INFO - Return code: 0 09:32:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:32:12 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')]} 09:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:12 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')]} 09:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:12 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 0x17ca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b489a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b46140>, '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 0x1b46a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b46ed0>, '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': '232498196343f89f466a4a9a000001c8-1497955902.482075-185977431', '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 09:32:12 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 09:32:12 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 09:32:12 INFO - Using env: {'DISPLAY': ':0', 09:32:12 INFO - 'HOME': '/home/cltbld', 09:32:12 INFO - 'LANG': 'en_US.UTF-8', 09:32:12 INFO - 'LANGUAGE': 'en_US:en', 09:32:12 INFO - 'LOGNAME': 'cltbld', 09:32:12 INFO - 'MAIL': '/var/mail/cltbld', 09:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:12 INFO - 'MOZ_NO_REMOTE': '1', 09:32:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:12 INFO - 'NO_EM_RESTART': '1', 09:32:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:12 INFO - 'PWD': '/builds/slave/test', 09:32:12 INFO - 'SHELL': '/bin/bash', 09:32:12 INFO - 'SHLVL': '1', 09:32:12 INFO - 'TERM': 'linux', 09:32:12 INFO - 'TMOUT': '86400', 09:32:12 INFO - 'USER': 'cltbld', 09:32:12 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1497955902.482075-185977431', 09:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:12 INFO - '_': '/tools/buildbot/bin/python'} 09:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:13 INFO - Downloading/unpacking psutil>=3.1.1 09:32:13 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 09:32:13 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 09:32:13 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 09:32:13 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 09:32:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:32:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:32:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:32:14 INFO - Installing collected packages: psutil 09:32:14 INFO - Running setup.py install for psutil 09:32:14 INFO - building 'psutil._psutil_linux' extension 09:32:14 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 09:32: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:32:14 INFO - building 'psutil._psutil_posix' extension 09:32:14 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 09:32: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 09:32:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:32:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:32:14 INFO - Successfully installed psutil 09:32:14 INFO - Cleaning up... 09:32:14 INFO - Return code: 0 09:32:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:32: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')]} 09:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32: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')]} 09:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32: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 0x17ca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b489a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b46140>, '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 0x1b46a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b46ed0>, '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': '232498196343f89f466a4a9a000001c8-1497955902.482075-185977431', '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 09:32: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 09:32: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 09:32:14 INFO - Using env: {'DISPLAY': ':0', 09:32:14 INFO - 'HOME': '/home/cltbld', 09:32:14 INFO - 'LANG': 'en_US.UTF-8', 09:32:14 INFO - 'LANGUAGE': 'en_US:en', 09:32:14 INFO - 'LOGNAME': 'cltbld', 09:32:14 INFO - 'MAIL': '/var/mail/cltbld', 09:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:14 INFO - 'MOZ_NO_REMOTE': '1', 09:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:14 INFO - 'NO_EM_RESTART': '1', 09:32:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:14 INFO - 'PWD': '/builds/slave/test', 09:32:14 INFO - 'SHELL': '/bin/bash', 09:32:14 INFO - 'SHLVL': '1', 09:32:14 INFO - 'TERM': 'linux', 09:32:14 INFO - 'TMOUT': '86400', 09:32:14 INFO - 'USER': 'cltbld', 09:32:14 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1497955902.482075-185977431', 09:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:14 INFO - '_': '/tools/buildbot/bin/python'} 09:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:32: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 09:32: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 09:32: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 09:32: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 09:32:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:32:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:32:16 INFO - Installing collected packages: mozsystemmonitor 09:32:16 INFO - Running setup.py install for mozsystemmonitor 09:32:16 INFO - Successfully installed mozsystemmonitor 09:32:16 INFO - Cleaning up... 09:32:16 INFO - Return code: 0 09:32:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:16 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 0x17ca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b489a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b46140>, '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 0x1b46a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b46ed0>, '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': '232498196343f89f466a4a9a000001c8-1497955902.482075-185977431', '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 09:32:16 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 09:32:16 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 09:32:16 INFO - Using env: {'DISPLAY': ':0', 09:32:16 INFO - 'HOME': '/home/cltbld', 09:32:16 INFO - 'LANG': 'en_US.UTF-8', 09:32:16 INFO - 'LANGUAGE': 'en_US:en', 09:32:16 INFO - 'LOGNAME': 'cltbld', 09:32:16 INFO - 'MAIL': '/var/mail/cltbld', 09:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:16 INFO - 'MOZ_NO_REMOTE': '1', 09:32:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:16 INFO - 'NO_EM_RESTART': '1', 09:32:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:16 INFO - 'PWD': '/builds/slave/test', 09:32:16 INFO - 'SHELL': '/bin/bash', 09:32:16 INFO - 'SHLVL': '1', 09:32:16 INFO - 'TERM': 'linux', 09:32:16 INFO - 'TMOUT': '86400', 09:32:16 INFO - 'USER': 'cltbld', 09:32:16 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1497955902.482075-185977431', 09:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:16 INFO - '_': '/tools/buildbot/bin/python'} 09:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:16 INFO - Downloading/unpacking jsonschema==2.5.1 09:32: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 09:32: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 09:32: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 09:32: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 09:32:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:32:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:32: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 09:32: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 09:32: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 09:32: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 09:32:17 INFO - Downloading functools32-3.2.3-2.tar.gz 09:32:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:32:17 INFO - warning: no files found matching '*.txt' 09:32:17 INFO - no previously-included directories found matching 'build' 09:32:17 INFO - no previously-included directories found matching 'dist' 09:32:17 INFO - no previously-included directories found matching '.git*' 09:32:17 INFO - Installing collected packages: jsonschema, functools32 09:32:17 INFO - Running setup.py install for functools32 09:32:17 INFO - warning: no files found matching '*.txt' 09:32:17 INFO - no previously-included directories found matching 'build' 09:32:17 INFO - no previously-included directories found matching 'dist' 09:32:17 INFO - no previously-included directories found matching '.git*' 09:32:18 INFO - Successfully installed jsonschema functools32 09:32:18 INFO - Cleaning up... 09:32:18 INFO - Return code: 0 09:32:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:32:18 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')]} 09:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:18 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')]} 09:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:18 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 0x17ca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b489a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b46140>, '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 0x1b46a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b46ed0>, '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': '232498196343f89f466a4a9a000001c8-1497955902.482075-185977431', '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 09:32:18 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 09:32:18 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 09:32:18 INFO - Using env: {'DISPLAY': ':0', 09:32:18 INFO - 'HOME': '/home/cltbld', 09:32:18 INFO - 'LANG': 'en_US.UTF-8', 09:32:18 INFO - 'LANGUAGE': 'en_US:en', 09:32:18 INFO - 'LOGNAME': 'cltbld', 09:32:18 INFO - 'MAIL': '/var/mail/cltbld', 09:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:18 INFO - 'MOZ_NO_REMOTE': '1', 09:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:18 INFO - 'NO_EM_RESTART': '1', 09:32:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:18 INFO - 'PWD': '/builds/slave/test', 09:32:18 INFO - 'SHELL': '/bin/bash', 09:32:18 INFO - 'SHLVL': '1', 09:32:18 INFO - 'TERM': 'linux', 09:32:18 INFO - 'TMOUT': '86400', 09:32:18 INFO - 'USER': 'cltbld', 09:32:18 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1497955902.482075-185977431', 09:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:18 INFO - '_': '/tools/buildbot/bin/python'} 09:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:32:18 INFO - Cleaning up... 09:32:18 INFO - Return code: 0 09:32:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:32:18 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')]} 09:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:18 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')]} 09:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:18 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 0x17ca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b489a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b46140>, '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 0x1b46a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b46ed0>, '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': '232498196343f89f466a4a9a000001c8-1497955902.482075-185977431', '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 09:32:18 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 09:32:18 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 09:32:18 INFO - Using env: {'DISPLAY': ':0', 09:32:18 INFO - 'HOME': '/home/cltbld', 09:32:18 INFO - 'LANG': 'en_US.UTF-8', 09:32:18 INFO - 'LANGUAGE': 'en_US:en', 09:32:18 INFO - 'LOGNAME': 'cltbld', 09:32:18 INFO - 'MAIL': '/var/mail/cltbld', 09:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:18 INFO - 'MOZ_NO_REMOTE': '1', 09:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:18 INFO - 'NO_EM_RESTART': '1', 09:32:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:18 INFO - 'PWD': '/builds/slave/test', 09:32:18 INFO - 'SHELL': '/bin/bash', 09:32:18 INFO - 'SHLVL': '1', 09:32:18 INFO - 'TERM': 'linux', 09:32:18 INFO - 'TMOUT': '86400', 09:32:18 INFO - 'USER': 'cltbld', 09:32:18 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1497955902.482075-185977431', 09:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:18 INFO - '_': '/tools/buildbot/bin/python'} 09:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:18 INFO - Downloading/unpacking blobuploader==1.2.4 09:32: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 09:32: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 09:32: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 09:32: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 09:32:19 INFO - Downloading blobuploader-1.2.4.tar.gz 09:32:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:32:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:32: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 09:32: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 09:32: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 09:32: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 09:32:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:32:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:32: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 09:32: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 09:32: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 09:32: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 09:32:20 INFO - Downloading docopt-0.6.1.tar.gz 09:32:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:32:20 INFO - Installing collected packages: blobuploader, requests, docopt 09:32:20 INFO - Running setup.py install for blobuploader 09:32:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:32:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:32:20 INFO - Running setup.py install for requests 09:32:20 INFO - Running setup.py install for docopt 09:32:20 INFO - Successfully installed blobuploader requests docopt 09:32:20 INFO - Cleaning up... 09:32:20 INFO - Return code: 0 09:32:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:32:20 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')]} 09:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:20 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')]} 09:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32: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 0x17ca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b489a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b46140>, '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 0x1b46a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b46ed0>, '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': '232498196343f89f466a4a9a000001c8-1497955902.482075-185977431', '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 09:32: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 09:32: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 09:32:20 INFO - Using env: {'DISPLAY': ':0', 09:32:20 INFO - 'HOME': '/home/cltbld', 09:32:20 INFO - 'LANG': 'en_US.UTF-8', 09:32:20 INFO - 'LANGUAGE': 'en_US:en', 09:32:20 INFO - 'LOGNAME': 'cltbld', 09:32:20 INFO - 'MAIL': '/var/mail/cltbld', 09:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:20 INFO - 'MOZ_NO_REMOTE': '1', 09:32:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:20 INFO - 'NO_EM_RESTART': '1', 09:32:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:20 INFO - 'PWD': '/builds/slave/test', 09:32:20 INFO - 'SHELL': '/bin/bash', 09:32:20 INFO - 'SHLVL': '1', 09:32:20 INFO - 'TERM': 'linux', 09:32:20 INFO - 'TMOUT': '86400', 09:32:20 INFO - 'USER': 'cltbld', 09:32:20 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1497955902.482075-185977431', 09:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:20 INFO - '_': '/tools/buildbot/bin/python'} 09:32:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:32:20 INFO - Running setup.py (path:/tmp/pip-HkWeBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:32:21 INFO - Running setup.py (path:/tmp/pip-BYoDTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:32:21 INFO - Running setup.py (path:/tmp/pip-E7bVrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:32:21 INFO - Running setup.py (path:/tmp/pip-6AaNwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:32:21 INFO - Running setup.py (path:/tmp/pip-lCq8kT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:32:21 INFO - Running setup.py (path:/tmp/pip-LAv7iZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:32:21 INFO - Running setup.py (path:/tmp/pip-WgFWpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:32:21 INFO - Running setup.py (path:/tmp/pip-jHFocQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:32:21 INFO - Running setup.py (path:/tmp/pip-z7tZyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:32:21 INFO - Running setup.py (path:/tmp/pip-gRi5O1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:32:21 INFO - Running setup.py (path:/tmp/pip-673maK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:32:21 INFO - Running setup.py (path:/tmp/pip-QlUhdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:32:21 INFO - Running setup.py (path:/tmp/pip-aIeY9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:32:21 INFO - Running setup.py (path:/tmp/pip-cSI0C_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:21 INFO - Running setup.py (path:/tmp/pip-X9jXjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:32:22 INFO - Running setup.py (path:/tmp/pip-BisddC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:32:22 INFO - Running setup.py (path:/tmp/pip-ZIzoXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:32:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:32:22 INFO - Running setup.py install for manifestparser 09:32:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:32:22 INFO - Running setup.py install for mozcrash 09:32:22 INFO - Running setup.py install for mozdebug 09:32:22 INFO - Running setup.py install for mozdevice 09:32:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:32:22 INFO - Running setup.py install for mozfile 09:32:22 INFO - Running setup.py install for mozhttpd 09:32:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:32:22 INFO - Running setup.py install for mozinfo 09:32:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:32:22 INFO - Running setup.py install for mozInstall 09:32:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:32:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:32:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:32:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:32:22 INFO - Running setup.py install for mozleak 09:32:23 INFO - Running setup.py install for mozlog 09:32:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:32:23 INFO - Running setup.py install for moznetwork 09:32:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:32:23 INFO - Running setup.py install for mozprocess 09:32:23 INFO - Running setup.py install for mozprofile 09:32:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:32:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:32:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:32:23 INFO - Running setup.py install for mozrunner 09:32:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:32:23 INFO - Running setup.py install for mozscreenshot 09:32:23 INFO - Running setup.py install for moztest 09:32:23 INFO - Running setup.py install for mozversion 09:32:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:32:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:32:23 INFO - Cleaning up... 09:32:23 INFO - Return code: 0 09:32:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:32: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')]} 09:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32: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')]} 09:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32: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 0x17ca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b489a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b46140>, '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 0x1b46a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b46ed0>, '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': '232498196343f89f466a4a9a000001c8-1497955902.482075-185977431', '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 09:32: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 09:32: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 09:32:23 INFO - Using env: {'DISPLAY': ':0', 09:32:23 INFO - 'HOME': '/home/cltbld', 09:32:23 INFO - 'LANG': 'en_US.UTF-8', 09:32:23 INFO - 'LANGUAGE': 'en_US:en', 09:32:23 INFO - 'LOGNAME': 'cltbld', 09:32:23 INFO - 'MAIL': '/var/mail/cltbld', 09:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:23 INFO - 'MOZ_NO_REMOTE': '1', 09:32:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:23 INFO - 'NO_EM_RESTART': '1', 09:32:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:23 INFO - 'PWD': '/builds/slave/test', 09:32:23 INFO - 'SHELL': '/bin/bash', 09:32:23 INFO - 'SHLVL': '1', 09:32:23 INFO - 'TERM': 'linux', 09:32:23 INFO - 'TMOUT': '86400', 09:32:23 INFO - 'USER': 'cltbld', 09:32:23 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1497955902.482075-185977431', 09:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:23 INFO - '_': '/tools/buildbot/bin/python'} 09:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:32:24 INFO - Running setup.py (path:/tmp/pip-PnlkNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:32:24 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)) 09:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:32:24 INFO - Running setup.py (path:/tmp/pip-YprJbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:32:24 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)) 09:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:32:24 INFO - Running setup.py (path:/tmp/pip-lkUMvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:32:24 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)) 09:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:32:24 INFO - Running setup.py (path:/tmp/pip-uTcdhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:32:24 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)) 09:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:32:24 INFO - Running setup.py (path:/tmp/pip-kZWlKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:32:24 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)) 09:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:32:24 INFO - Running setup.py (path:/tmp/pip-3sczLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:32:24 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)) 09:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:32:24 INFO - Running setup.py (path:/tmp/pip-0W3FEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:32:24 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)) 09:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:32:24 INFO - Running setup.py (path:/tmp/pip-Asv73x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:32: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)) 09:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:32:24 INFO - Running setup.py (path:/tmp/pip-XR_OFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:32: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)) 09:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:32:24 INFO - Running setup.py (path:/tmp/pip-_2HlDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:32:24 INFO - Running setup.py (path:/tmp/pip-aMmnli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:32: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)) 09:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:32:24 INFO - Running setup.py (path:/tmp/pip-5y109B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:32:25 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)) 09:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:32:25 INFO - Running setup.py (path:/tmp/pip-ePtvRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:32:25 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)) 09:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:32:25 INFO - Running setup.py (path:/tmp/pip-Gi3CXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:32:25 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)) 09:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:25 INFO - Running setup.py (path:/tmp/pip-iTqdL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:25 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)) 09:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:32:25 INFO - Running setup.py (path:/tmp/pip-VBuXTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:32:25 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)) 09:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:32:25 INFO - Running setup.py (path:/tmp/pip-fXZnk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:32:25 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)) 09:32:25 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)) 09:32:25 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)) 09:32:25 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)) 09:32:25 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)) 09:32:25 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)) 09:32:25 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)) 09:32:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:32:25 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 09:32:25 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 09:32:25 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 09:32:25 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 09:32:26 INFO - Downloading blessings-1.6.tar.gz 09:32:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:32:26 INFO - Installing collected packages: blessings 09:32:26 INFO - Running setup.py install for blessings 09:32:26 INFO - Successfully installed blessings 09:32:26 INFO - Cleaning up... 09:32:26 INFO - Return code: 0 09:32:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:32:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:32:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:32:26 INFO - Reading from file tmpfile_stdout 09:32:26 INFO - Current package versions: 09:32:26 INFO - argparse == 1.2.1 09:32:26 INFO - blessings == 1.6 09:32:26 INFO - blobuploader == 1.2.4 09:32:26 INFO - docopt == 0.6.1 09:32:26 INFO - functools32 == 3.2.3-2 09:32:26 INFO - jsonschema == 2.5.1 09:32:26 INFO - manifestparser == 1.1 09:32:26 INFO - mozInstall == 1.13 09:32:26 INFO - mozcrash == 1.0 09:32:26 INFO - mozdebug == 0.1 09:32:26 INFO - mozdevice == 0.51 09:32:26 INFO - mozfile == 1.2 09:32:26 INFO - mozhttpd == 0.7 09:32:26 INFO - mozinfo == 0.10 09:32:26 INFO - mozleak == 0.1 09:32:26 INFO - mozlog == 3.4 09:32:26 INFO - moznetwork == 0.27 09:32:26 INFO - mozprocess == 0.25 09:32:26 INFO - mozprofile == 0.28 09:32:26 INFO - mozrunner == 6.13 09:32:26 INFO - mozscreenshot == 0.1 09:32:26 INFO - mozsystemmonitor == 0.3 09:32:26 INFO - moztest == 0.8 09:32:26 INFO - mozversion == 1.4 09:32:26 INFO - psutil == 3.1.1 09:32:26 INFO - requests == 1.2.3 09:32:26 INFO - wsgiref == 0.1.2 09:32:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:32: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')]} 09:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32: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')]} 09:32:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32: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 0x17ca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b489a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b46140>, '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 0x1b46a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b46ed0>, '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': '232498196343f89f466a4a9a000001c8-1497955902.482075-185977431', '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 09:32: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 09:32: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 09:32:26 INFO - Using env: {'DISPLAY': ':0', 09:32:26 INFO - 'HOME': '/home/cltbld', 09:32:26 INFO - 'LANG': 'en_US.UTF-8', 09:32:26 INFO - 'LANGUAGE': 'en_US:en', 09:32:26 INFO - 'LOGNAME': 'cltbld', 09:32:26 INFO - 'MAIL': '/var/mail/cltbld', 09:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:26 INFO - 'MOZ_NO_REMOTE': '1', 09:32:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:26 INFO - 'NO_EM_RESTART': '1', 09:32:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:26 INFO - 'PWD': '/builds/slave/test', 09:32:26 INFO - 'SHELL': '/bin/bash', 09:32:26 INFO - 'SHLVL': '1', 09:32:26 INFO - 'TERM': 'linux', 09:32:26 INFO - 'TMOUT': '86400', 09:32:26 INFO - 'USER': 'cltbld', 09:32:26 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1497955902.482075-185977431', 09:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:26 INFO - '_': '/tools/buildbot/bin/python'} 09:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:27 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)) 09:32:27 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)) 09:32:27 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)) 09:32:27 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)) 09:32:27 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)) 09:32:27 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)) 09:32:27 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)) 09:32:27 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)) 09:32:27 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)) 09:32:27 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:32: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 09:32: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 09:32: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 09:32: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 09:32:28 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:32:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:32:28 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)) 09:32:28 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)) 09:32:28 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)) 09:32:28 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)) 09:32:28 INFO - Installing collected packages: marionette-driver 09:32:28 INFO - Running setup.py install for marionette-driver 09:32:28 INFO - Successfully installed marionette-driver 09:32:28 INFO - Cleaning up... 09:32:28 INFO - Return code: 0 09:32:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:32: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')]} 09:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32: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')]} 09:32:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32: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 0x17ca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b489a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b46140>, '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 0x1b46a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b46ed0>, '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': '232498196343f89f466a4a9a000001c8-1497955902.482075-185977431', '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 09:32: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 09:32: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 09:32:28 INFO - Using env: {'DISPLAY': ':0', 09:32:28 INFO - 'HOME': '/home/cltbld', 09:32:28 INFO - 'LANG': 'en_US.UTF-8', 09:32:28 INFO - 'LANGUAGE': 'en_US:en', 09:32:28 INFO - 'LOGNAME': 'cltbld', 09:32:28 INFO - 'MAIL': '/var/mail/cltbld', 09:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:28 INFO - 'MOZ_NO_REMOTE': '1', 09:32:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:28 INFO - 'NO_EM_RESTART': '1', 09:32:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:28 INFO - 'PWD': '/builds/slave/test', 09:32:28 INFO - 'SHELL': '/bin/bash', 09:32:28 INFO - 'SHLVL': '1', 09:32:28 INFO - 'TERM': 'linux', 09:32:28 INFO - 'TMOUT': '86400', 09:32:28 INFO - 'USER': 'cltbld', 09:32:28 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1497955902.482075-185977431', 09:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:28 INFO - '_': '/tools/buildbot/bin/python'} 09:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:32:28 INFO - Cleaning up... 09:32:28 INFO - Return code: 0 09:32:28 INFO - Running post-action listener: _resource_record_post_action 09:32:28 INFO - Running post-action listener: _start_resource_monitoring 09:32:28 INFO - Starting resource monitoring. 09:32:28 INFO - [mozharness: 2017-06-20 16:32:28.756188Z] Finished create-virtualenv step (success) 09:32:28 INFO - [mozharness: 2017-06-20 16:32:28.756704Z] Running install step. 09:32:28 INFO - Running pre-action listener: _resource_record_pre_action 09:32:28 INFO - Running main action method: install 09:32:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:32:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:32:28 INFO - Reading from file tmpfile_stdout 09:32:28 INFO - Detecting whether we're running mozinstall >=1.0... 09:32:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:32:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:32:29 INFO - Reading from file tmpfile_stdout 09:32:29 INFO - Output received: 09:32:29 INFO - Usage: mozinstall [options] installer 09:32:29 INFO - Options: 09:32:29 INFO - -h, --help show this help message and exit 09:32:29 INFO - -d DEST, --destination=DEST 09:32:29 INFO - Directory to install application into. [default: 09:32:29 INFO - "/builds/slave/test"] 09:32:29 INFO - --app=APP Application being installed. [default: firefox] 09:32:29 INFO - mkdir: /builds/slave/test/build/application 09:32: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'] 09:32:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:32:46 INFO - Reading from file tmpfile_stdout 09:32:46 INFO - Output received: 09:32:46 INFO - /builds/slave/test/build/application/firefox/firefox 09:32:46 INFO - Running post-action listener: _resource_record_post_action 09:32:46 INFO - [mozharness: 2017-06-20 16:32:46.892447Z] Finished install step (success) 09:32:46 INFO - [mozharness: 2017-06-20 16:32:46.892727Z] Running setup-mitmproxy step. 09:32:46 INFO - Running pre-action listener: _resource_record_pre_action 09:32:46 INFO - Running main action method: setup_mitmproxy 09:32:46 INFO - Skipping: mitmproxy is not required 09:32:46 INFO - Running post-action listener: _resource_record_post_action 09:32:46 INFO - [mozharness: 2017-06-20 16:32:46.893852Z] Finished setup-mitmproxy step (success) 09:32:46 INFO - [mozharness: 2017-06-20 16:32:46.894071Z] Running run-tests step. 09:32:46 INFO - Running pre-action listener: _resource_record_pre_action 09:32:46 INFO - Running main action method: run_tests 09:32:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:32:46 INFO - Python 2.7.3 09:32:46 INFO - Return code: 0 09:32:46 INFO - grabbing minidump binary from tooltool 09:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:46 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 0x1b46140>, '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 0x1b46a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b46ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:32:46 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 09:32:46 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 09:32:46 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 09:32:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:32:47 INFO - Return code: 0 09:32:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:32:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:32:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:32:47 INFO - ENV: RUST_BACKTRACE is now 1 09:32:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:32:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:32: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/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 09:32: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/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 09:32:47 INFO - Using env: {'DISPLAY': ':0', 09:32:47 INFO - 'HOME': '/home/cltbld', 09:32:47 INFO - 'LANG': 'en_US.UTF-8', 09:32:47 INFO - 'LANGUAGE': 'en_US:en', 09:32:47 INFO - 'LOGNAME': 'cltbld', 09:32:47 INFO - 'MAIL': '/var/mail/cltbld', 09:32:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:32:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:47 INFO - 'MOZ_NO_REMOTE': '1', 09:32:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:32:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:47 INFO - 'NO_EM_RESTART': '1', 09:32:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:47 INFO - 'PWD': '/builds/slave/test', 09:32:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:32:47 INFO - 'RUST_BACKTRACE': '1', 09:32:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:32:47 INFO - 'SHELL': '/bin/bash', 09:32:47 INFO - 'SHLVL': '1', 09:32:47 INFO - 'TERM': 'linux', 09:32:47 INFO - 'TMOUT': '86400', 09:32:47 INFO - 'USER': 'cltbld', 09:32:47 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1497955902.482075-185977431', 09:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:47 INFO - '_': '/tools/buildbot/bin/python'} 09:32: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/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 09:32:47 INFO - mozversion application_buildid: 20170620154708 09:32:47 INFO - mozversion application_changeset: 464b2a3c25aa1065760d9ecbb0870bca4a66c62e 09:32:47 INFO - mozversion application_display_name: Nightly 09:32:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:32:47 INFO - mozversion application_name: Firefox 09:32:47 INFO - mozversion application_remotingname: firefox 09:32:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:32:47 INFO - mozversion application_vendor: Mozilla 09:32:47 INFO - mozversion application_version: 56.0a1 09:32:47 INFO - mozversion platform_buildid: 20170620154708 09:32:47 INFO - mozversion platform_changeset: 464b2a3c25aa1065760d9ecbb0870bca4a66c62e 09:32:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:32:47 INFO - mozversion platform_version: 56.0a1 09:32:47 INFO - using testdate: 1497976367 09:32:47 INFO - actual date: 1497976367 09:32:47 INFO - starting webserver on 'localhost:34993' 09:32:47 INFO - SUITE-START | Running 2 tests 09:32:47 INFO - TEST-START | dromaeo_css 09:32:47 INFO - operating with platform_type : linux_ 09:32:47 INFO - Initialising browser for dromaeo_css test... 09:32:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34993/getInfo.html -profile /tmp/tmpdPslWF/profile 09:32:47 INFO - TEST-INFO | started process 9856 (/builds/slave/test/build/application/firefox/firefox http://localhost:34993/getInfo.html) 09:32:54 INFO - TEST-INFO | 9856: exit 0 09:32:54 INFO - Browser initialized. 09:32:54 INFO - Running cycle 1/1 for dromaeo_css test... 09:32:54 INFO - TEST-INFO | started process 10094 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdPslWF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:33:06 INFO - PID 10094 | RSS: Main: 179253248 09:33:06 INFO - PID 10094 | 09:36:09 INFO - PID 10094 | Cycle 1(1): loaded http://localhost:34993/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34993/tests/dromaeo/cssquery-ext.html) 09:36:11 INFO - PID 10094 | RSS: Main: 184213504 09:36:11 INFO - PID 10094 | 09:39:13 INFO - PID 10094 | Cycle 1(1): loaded http://localhost:34993/tests/dromaeo/cssquery-ext.html (next: http://localhost:34993/tests/dromaeo/cssquery-jquery.html) 09:39:14 INFO - PID 10094 | RSS: Main: 182456320 09:39:14 INFO - PID 10094 | 09:42:15 INFO - PID 10094 | Cycle 1(1): loaded http://localhost:34993/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34993/tests/dromaeo/cssquery-mootools.html) 09:42:16 INFO - PID 10094 | RSS: Main: 184418304 09:42:16 INFO - PID 10094 | 09:45:18 INFO - PID 10094 | Cycle 1(1): loaded http://localhost:34993/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34993/tests/dromaeo/cssquery-prototype.html) 09:45:18 INFO - PID 10094 | RSS: Main: 184680448 09:45:18 INFO - PID 10094 | 09:48:21 INFO - PID 10094 | Cycle 1(1): loaded http://localhost:34993/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34993/tests/dromaeo/cssquery-yui.html) 09:48:22 INFO - PID 10094 | RSS: Main: 186908672 09:48:22 INFO - PID 10094 | 09:51:24 INFO - PID 10094 | Cycle 1(1): loaded http://localhost:34993/tests/dromaeo/cssquery-yui.html (next: http://localhost:34993/tests/dromaeo/cssquery-dojo.html) 09:51:24 INFO - PID 10094 | RSS: Main: 181923840 09:51:24 INFO - PID 10094 | 09:51:24 INFO - PID 10094 | __start_tp_report 09:51:24 INFO - PID 10094 | _x_x_mozilla_page_load 09:51:24 INFO - PID 10094 | _x_x_mozilla_page_load_details 09:51:24 INFO - PID 10094 | |i|pagename|runs| 09:51:24 INFO - PID 10094 | |0;dojo.html;3059.8164110153407;3103.2862441638417;3114.9688503114976;3122.3911337289223;3122.7501799856013;6044.546659000571;6069.666168360738;6095.66473843939;6110.266767987842;6168.506519478442;6112.144299798032;6132.814448934792;6185.103160041791;6200.472959798422;6201.596896201755;5680.857978550549;5696.914546281809;5726.484616384525;5744.080947048473;5824;5735.2257445245195;5739.626924249931;5762.56780741444;5792.189093526909;5798.985177593925;5576.776928922838;5601.579881508903;5675.9432405675825;5692.943070569283;5695.259616249902;5601.355844077902;5611.803586874481;5632.183333416672;5641.153826925953;5716.771329146871;5527.944720552783;5640.407757185478;5658.34928983164;5667.263255776764;5692.430756924316;6097.268327800648;6142.815715528542;6153.661548614825;6163.445289923929;6178.41305076017;6637.73449062037;6647.803395388828;6669.399754022113;6672;6675.065490831287;6439.227292724856;6509.251436084864;6513.316101809289;6590.406863382319;6759.898601520981;6147.907781383283;6182.041783523561;6201.565890387629;6210.782622608277;6235.438810506986;6911.447084233249;6912.688928998207;6945.861082778316;6946.6179360135675;6947.340002699735;6353.459955903708;6383.3616638336725;6415.550911436155;6419.807405777834;6424.839379015469;6497.707603157869;6598.274189839114;6634.104395906491;6659.334066593399;6666.666666666647;6657.3342665733035;6657.334266573401;6675.6662166891465;6679.56582822115;6684.064231007663;6513.576617519941;6584.934150658528;6587.83530411734;6700.865982680319;6748.223954245324;5333.759980800874;5385.057614917374;5396.757145928443;5422.8915421691345;5426.511613954684;4573.565511276423;4653.6509761768;4656.998745269783;4686.906261874743;4722.386089808303;5703.287089113861;5757.88484230313;5764.74058667361;5772.422757724278;5783.363829978699;6698.765543205965;6728.764493242713;6735.42748866342;6763.797086087426;6788.76239331621;5576;5664.037113690682;5698.629589076697;5728.885422291531;5763.481286684135;5867.266591676041;5905.084711869667;5935.465808077208;5940.257467816523;5977.910331345033;6366.267879193952;6441.935580644321;6478.190226221723;6491.675416229265;6502.544821862424;6697.598144111369;6703.8324041897395;6719.596824190564;6726.159230096238;6734.292899245705;6148.661823599566;6257.1552840367785;6268;6491.610503369813;6496.577722448026;6467.288598254094;6511.837204069936;6554.442872355903;6555.4427873629365;6574.704138313692;6625.370589793962;6691.665416729047;6720.428763555153;6729.899051514133;6768.120144381199;6511.2512061113575;6516.804495865132;6522.28254891952;6524.380183882524;6550.508711846726;6346.587471814318;6460.35396460369;6522.05430212607;6548.901766473602;6559.704813283318;6155.076738489262;6296.653684047421;6309.085182648582;6358.300586935526;6363.522735794926;6527.3472652734345;6571.704273307617;6583.572067815577;6603.438707709706;6609.933900660932;6359.936400636119;6372.872542549216;6397.616143031433;6401.487880969605;6405.071264666691 09:51:24 INFO - PID 10094 | |1;ext.html;805.7663277649482;836.6193382011186;860.8450478913796;878.9780255493616;883.4257732473891;39570.604293957054;40110.799446002726;40491.59508404915;40690;40706;36261;36536.81731591345;36565.08587285319;36597.268054638895;36757.08107297319;6753.628550429725;6803.897941530881;6817.5227734058635;6849.383555480006;6872.62200578968;6787.151606049244;6835.965820170917;6883.7246510139785;6886.896696549556;6912.481563882704;6812.829679258009;6861.073755043055;6881.1054562907;6881.552699074569;6882.03651488792;6766.932330676728;6773.0517727517945;6779.49153813461;6816.079829223066;6891.517593768438;6200.968995155041;6256.436920677115;6274.247090349188;6279.811605651837;6286.591371560834;32743.50884736731;32869;32948.17629559256;33002.83498582516;33121.50317745236;3466.9306613867834;3529.0471572675233;3613.1509095362567;3619.8914032579064;3627.365211088049;29711.70288297111;30029.24926876824;30036.24909377261;30082.398352033055;30098.84950575255;3704.073981504624;3706.3328600851837;3721.79530125843;3729.310077635646;3776.6978641708597;186549;188569;188647;190546;191316;46549.534504655196;47047.059058819315;47136;47256.52743472521;47461.288080678816;48742;48893.511064888895;48974;48988.51011489911;49097;15449.922750386177;15633.765493517607;15691.293891774669;15741;15762.684746305009;13017.153884997444;13021.47914083445;13025;13036.934815326053;13046.934765326112;13865.37605807741;13893.513727019506;13915.512957046454;13939.860601394059;14050.086744361584;5680.5171560417;5727.684977326204;5757.453041961007;5776.191333213354;5795.652260864362;984.6602921991902;986.2356673577891;995.8804943406693;1018.5721996761378;1040.7033995311451;21869.67195492069;22823.771762282497;22909.656355154686;22937.88531057334;23140;1064.350746044912;1086.4513420722485;1107.2360071550604;1113.5211858900589;1116.8883111688929;11643.88356116445;12013.219140755822;12133.939330303292;12161.452734626962;12161.817572736416;229395;230359;231587;231816;232182;50286.24570631443;50643.24035139476;50646.2403063947;50861.491385085676;51031;1410.168000879486;1459.0516164493165;1460.1166294391953;1468.860458256464;1484.6733718581895;21140.682889756357;21486.355409337746;22263.554728905656;22426.32721018372;23008.769912301334;34820.82589587036;35621.46567801537;35639.28721425609;35697.28605427825;35743.28513429769;179759;180978;181181.09409453397;181608;182184;29383.853080734458;29565.113046608636;29899.402011959202;31611.525827113073;32971.17572060622;40607;40651;41021;41225;42321.518746843714;27640.723592763814;30062.398752025274;30864;31321.37357252888;31674.208144795644;29662.961796337888;29864.552031719977;30429.39141217119;31477;31947.840260798548;32802.50796238011;34352;34507.929524228624;34529.48205776865;34662;28557.571636425055;29170.56244156382;29361;29948.95178668736;31071.067867963997;23489.76510234944;24412.51174976526;24532.386690332885;25774;26208.606870897333 09:51:24 INFO - PID 10094 | |2;jquery.html;548.3023524260637;557.9916301255482;563.2677519225009;586.6157666728293;592.8043745563963;20996.160153593857;21939.232126875522;21952.89023554884;21985.670214946767;21990.670139947913;23662.171823986166;24399;25129.371765705822;25432.872835635797;25579.488410231785;6388.073729309247;6528.183977002875;6532.412082912537;6533.509986750989;6536;6424.93575064248;6446.226452825667;6447.097406363113;6461.386168314026;6492.415682588566;5805.622634528742;6077.878442431149;6258.280297765747;6417.780621681889;6430.967845160768;6256.343083976162;6274.874502509947;6299.96850015747;6305.87388252237;6320.336364681688;5871.031279838864;5889.293284805808;5895.970520147414;5896.911546326808;5896.911546326808;27355.72644273552;28234.43531129366;28758;28799;28836.567451488034;1849.8890066595914;1895.924163033477;1900.4108726294892;1901.0684764465313;1909.23630547782;17793.822061779345;18280.90859545694;18296.63406731858;18305.7254141188;18322.541936451562;2266.331432227497;2355.316958082154;2367.337145599235;2413.6862207913036;2419.467717102252;120812;123596;123615;123720.38139809243;123884.38057809744;14014.649633759238;14365.64085897861;14533.128012319296;15100.924495377452;15112.395504179929;23170.1890433834;23204.65193022106;23241.883790581276;23317.533649326917;23334.883325583265;9631.518424078768;9715.222782177409;9798.167155791838;9834;9863.704088877344;8735.645974873905;8798.560071996375;8858.468491890508;8920.553972301359;8929.821403571892;8796.8680469793;8999.685011024583;9060.728178154666;9126.908730912739;9353.625854965861;2552.1067626330637;2650.1387049209084;2763.3023859439036;2858.6569611646737;2879.6544414670375;945.9716208513755;958.0121248409439;961.6730311694058;1011.7521207304111;1018.5365658625456;19948.50128746764;20191.697124543145;20914.268000619904;22985.885070574874;24677;1037.8806437259661;1063.4151216830867;1070.8875568065241;1074.8656417947757;1078.8867168947147;11432.199746017865;11603.88396116028;11665.066794656406;11704.648860534198;11794.410279485992;564113;578080;581597.2760408598;582232;585982;104848;109556;110524.4473777642;111019.44490277658;111142.44428777965;1200.975980480403;1216.2702378572963;1273.1597145883673;1275.5216793702361;1280.6798300424894;19494.805051949297;21008.63443876143;21349.679754804;21350.505464617327;21536.138554458274;49397.50602493929;50943;51033.97932041264;51127.74436127795;51216.23175652443;66818;67403.66298168477;67790.32209678038;68181.31818681948;68222.65888670525;12359.938200309301;12969.54606588765;12985.415656295301;13186.472541098248;13191.80212296797;18097.18562664657;18916.810831892057;18985;19397.709034364212;19674.50813729611;15600.765988509955;15704.764428533352;15801.604959876095;15839.208039598205;16107.275172617026;13265.156477616192;13935.66009709822;14305.141691498127;14503.492377766728;14682.55952321432;14133.858661413255;15148.31832567515;15260.542183734506;15291.61770955735;15404.691906162037;12380.071494637757;17502.73745893838;18117.90941045339;18203.908980455544;18577.16402761852;16388.75416868772;16451.83548164551;16533.66932661316;16554.503364899072;16661.833381666514 09:51:24 INFO - PID 10094 | |3;mootools.html;1341.6109328294795;1397.385150533765;1411.4848080450627;1419.6308959670482;1425.8735598876885;12925.935370323146;13525.526606568772;13559.728805423898;13568.253746043963;13581.660458488543;13013.674658133528;13288.402021909013;13324.866751332507;13348.199108053524;13367.532136375228;2572.7041390240083;2618.9345266368305;2623.9504198320633;2624.160268714012;2629.2243788082465;2535.3027917322793;2599.350162459385;2603.713591504933;2604.8046396520335;2608.3870290481723;2502.4244423782543;2553.706323772762;2561.5517284475236;2564.2563656539583;2574.163396896007;2431.756824317572;2464.7060293345958;2481.8262721609494;2485.8135639827087;2490.203134996802;2420.9273721788372;2427.0413186791293;2434.3062227265145;2469.6665950096867;2497.5254701606636;12878.549250776177;13011.544595939191;13017.349132543335;13033.608991730169;13052.738945221043;7089.361957423805;7354.48518603698;7369.189389167187;7370.5577665339715;7396.223396543393;4085.142120154771;4198.412222288882;4276.695607839608;4278.465191851019;4300.892477688051;1447.2763618190904;1499.8650121489009;1508.0800711565937;1536.3009830527083;1536.8770498360104;18949.33677321301;19402.320918767775;20272.391828245178;20451;20465.5906881863;5368.409474957752;5559.694216818114;6146.446819786241;6335.303116657164;6372.044193370939;14761.55715328542;14802.777958330633;14811.037282576597;14821.77767333491;14838;7196.496245262886;7301.853962920712;7326.3040011198855;7331.560106393634;7342.596157211297;6651.966740166365;6824.454043676494;6836;6872.587644741331;6922.8615427692175;4787.521247875185;4838.854834354975;4865.7323847188745;4970.260408856871;4997.0505603935135;1407.7395681798696;1410.4710733474947;1424.9028248248997;1425.942962281497;1442.596073099534;887.8712586674895;893.9061398553058;897.5243121145803;919.56780313254;932.9131561730644;6767.72929082841;6836.248012718597;7064.894026589605;7212.567245965259;7248.130224373109;719.3130560314887;726.1467775363926;732.2933369298653;737.5286303823799;740.7074205688723;4386.495553011381;5109.054824857413;5615.354234263031;6026.156338112668;6046.606970546988;17392;17479.300827966737;17755.73366399505;18028.729569056475;18288.81711182871;16908.40820571274;17103.23035463407;17416.564585885455;17666.646667066845;17983.64032719338;9826.508674566243;9928.50357482123;9979.301448898652;10060.295779295378;10095.798084038424;7717.729879454192;8187.4678145920325;8314.085450600309;8440.324774017941;8528.403011789364;15466.922665387052;15519.224038797789;15575.454859080332;15829.683406331578;15979.920100399424;14314.713705725619;14902.552923412315;15385.538433847003;15907.522774316789;16067.758983615022;9767;11206.663800086011;11222;11223.887761122285;11228.270162439416;12411.937940310241;12531.122821402414;12537.749245015231;12591.307478088793;12615.49538018469;9879.703608891745;10279.588816447258;10312.48437578103;10552;10559.841602375816;10087.899121008695;10132.240081993732;10199.215670914662;10401.94799026;10472.738181545523;8997.145271199226;9172.724818255463;9202.309826762885;9212.401193922373;9273.53632318395;5967.7016149191495;6001.099835024781;6125.84685382869;6347.746090156342;6471.676416179266;6726.7981960541265;6782.457403407814;6800.897986530305;6956.930430695628;7000.229974702676 09:51:24 INFO - PID 10094 | |4;prototype.html;492.1583093362525;494.91100284597934;509.3429475975991;513.4788189987166;514.9304843846082;6200.844978875531;6263.498920086394;6367.7771278005275;6390.648514331716;6390.744370225191;6147.139400483936;6166.722497487613;6167.163104971718;6241.469475094623;6264.592801467913;5022.974885125569;5038.395392552899;5042.319286896259;5054.41874184468;5075.086484432801;5035.546800787928;5050.46970068143;5061.089003979282;5072.72100034498;5092.9236061459105;4863.635227357945;5018.322526458936;5038.042771873351;5066.18940969445;5079.873003174913;4994.475580064077;4998.4751601081725;5003.524665156804;5004.84985450437;5033.345665063555;4462.107578484283;4469.41897553316;4472.239719247736;4538.228501154812;4541.3869127668;6015.518758499309;6073.817785466443;6087.969560152215;6092.72582733778;6097.146399504073;5702.54379649627;5731.656100633975;5733.627314224604;5745.798897038625;5767.423257674241;6616.338366163393;6618.900716489256;6624.73501059957;6655.735410272081;6656.201255849329;4865.878353041202;4909.263610458424;4932.630052746058;4959.404871415417;4965.478624744386;6979.162500499921;6995.160580730294;6996.370326670573;7041.718331266795;7047.8590428191665;5057.8735531612;5083.694978301313;5085.567726743194;5087.567556757643;5116.795328186831;5121.820736274212;5139.486051394831;5145.511176438233;5156.329677141947;5184.326037615086;5768.105943578752;5770.942290577041;5781.277340332458;5789.131630255495;5791.942080579224;6620.569662971891;6688.632125233159;6702.710265430129;6710.758509675726;6712.597244165366;1684.8399402056784;1686.9831301687072;1788.2131861980688;1789.9642007159784;1797.3260027489691;1209.7096696792707;1223.1254652923203;1233.444949772606;1234.4631781688715;1255.554278231233;5569.192467092249;5652.812909289013;5688.9715551422805;5704.743286552115;5747.540196784247;6758.5331354055415;6775.085363475966;6799.660016999131;6826;6838.418734407631;5764.193012978187;5787.681677507693;5800.274965629296;5806.854828629233;5816.738246778905;3611.9705883822985;3634.7092232621326;3645.3256147612246;3653.7990410527677;3656;6551.312112228243;6559.8360040998405;6567.6059436433015;6583.967080164569;6601.73593056282;6928.896066559006;6934.791956241321;6937.895931561031;6949.131358580177;6972.79081627552;6490.318516555788;6494.253160886558;6494.870102598016;6511.902321465182;6548.738050478118;6779.694913728796;6824.897626535507;6834.658267086526;6837.6581170942245;6852.862942741018;6753.932460675331;6772.11962444879;6789.762358317435;6795.286494917962;6805.638872225476;6444.428909550381;6501.837454063686;6584.637844918384;6598.802035938929;6646.83382915431;4939;4991.326170967018;5013.097642424399;5047.4952504749235;5053.191489361684;6779.830504237433;6832.795016149524;6850.8972365413565;6854.588724676535;6871.381575658214;6581.736730530725;6595.142631457879;6595.307492713196;6605;6651.470161862702;6583.407493325623;6587.901181482186;6604.8348791280605;6611.438027767501;6623.661501716383;6521.054447105238;6525.249596296487;6525.673716314261;6525.9021114684265;6534.313897040743;6660.467162626881;6664.50016248793;6671.8999215010845;6674.399304062657;6705.798826035227;6379.489640828815;6397.296297407189;6439.8068057958335;6457;6472.741090356333 09:51:24 INFO - PID 10094 | |5;yui.html;850.0819115355416;866.9436486628368;871.1723862330783;873.7029410000603;877.2061284537493;17449.825501744996;17698;17913.91043044786;17995;18054.729179062324;19029.52426189346;20281;20347.593048139028;20733.585328293462;20736.688949665768;1004.9095581397654;1025.1696126137815;1028.9948550257238;1031.293563908725;1031.9484025798718;1042.9895701043006;1043.191526566913;1043.2384359417592;1046.822040253155;1048.103871190129;1016.7102375822892;1099.1371773158073;1099.5052226498067;1101.3997371432588;1109.938953357565;1048.4600430778155;1076.0692001418756;1079.4117206122603;1083.8374243863404;1085.8208395614713;782.3076577229193;785.7171418289412;786.1156199275815;787.9369650427952;790.8260182759784;18483.353082642177;18698.158582863805;19131.61736765257;19297;19307.4207773767;19437.708434373497;19831.206751729915;19935.102920368474;19993.200271989102;20000.799992000186;15024.248787560688;15043.924780376137;15089.54731358061;15124.092554446768;15133.924330378388;3402.744794140425;3498.160441494023;3543.982280088583;3549.804760738158;3553.093961039944;100276.49861750644;102293;103643.48178259136;103831.96168038298;104184.47907760413;15285.159316237714;15598.142102184489;15735.606609834846;15739.763903541456;15811.130387828549;27161;27624.171274861787;27725.86137069302;27805.443891122064;27827;8066.919330806734;8085.474444161111;8125.228103330174;8136;8190.631421586043;4062.268791617478;4135.31767258399;4141.068259641616;4143.3784932260405;4150.27370210212;4970.15507363749;5021.447640759514;5037.773300201499;5063.3417655704525;5073.949260507421;879.4767113567417;904.2133343990639;940.9623615055458;943.9858402123974;949.781550243434;600.4535872356134;668.5754545863412;699.5697645947705;699.6361891816227;716.8243780273762;10477.52851121686;11057.336559806437;11564.132690048113;11758.3532905691;11868.228565143238;683.217715715503;697.2260790522516;707.2432497228019;721.5201890742702;733.4499125655758;4829.613630909519;4908;5468.863278418072;5634.267545219095;5742.971285143631;89874;92034.53982730178;94214.52892735493;97316.51341743246;97801.51099244459;78135;79987.20012799914;81575;81576.59211703904;83519;68747.31252687509;72457.27542724505;73662.6316868423;74792.62603686946;76453.23546764461;10771.407572583583;10949.945250273699;11391.00110912403;11500.712482187677;11644.2431241969;31147.221319467193;31816.522752158275;32422.67577324291;32427.35145297128;33338.66661333355;40966.79516602398;43414.56585434105;43639.12721745611;44156.558434415245;44811.55188448204;17073.74389384185;17112.058836764096;17841.553961151076;18121.27514899442;18287.542811429288;20084.799152008294;20121.99390030522;20342.288019919233;20377.592448151252;20702.171913123308;14043.719125617636;14686.41254349814;15224.391024359345;15838;15925.20373981273;16181.59546011359;16375.754363684793;16474;16495.83504164943;16852.57868553296;14944.178070205808;16186.190690465664;16204.432844850373;16296.755548666542;16670.083145427117;12510.311932843417;12758;13018.80471792905;13089.476420943056;13424.597262082154;12356.196847204903;12416.255024698547;12578.433970471533;12716.173448725804;13228.338583071001 09:51:24 INFO - PID 10094 | __end_tp_report 09:51:24 INFO - PID 10094 | __start_cc_report 09:51:24 INFO - PID 10094 | _x_x_mozilla_cycle_collect,365 09:51:24 INFO - PID 10094 | __end_cc_report 09:51:24 INFO - PID 10094 | __startTimestamp1497977484326__endTimestamp 09:51:24 INFO - PID 10094 | 09:51:24 INFO - PID 10094 | ------- Summary: start ------- 09:51:24 INFO - PID 10094 | Number of tests: 6 09:51:24 INFO - PID 10094 | 09:51:24 INFO - PID 10094 | [#0] dojo.html Cycles:165 Average:6114.70 Median:6353.46 stddev:724.78 (11.4%) stddev-sans-first:686.24 09:51:24 INFO - PID 10094 | Values: 3059.8 3103.3 3115.0 3122.4 3122.8 6044.5 6069.7 6095.7 6110.3 6168.5 6112.1 6132.8 6185.1 6200.5 6201.6 5680.9 5696.9 5726.5 5744.1 5824.0 5735.2 5739.6 5762.6 5792.2 5799.0 5576.8 5601.6 5675.9 5692.9 5695.3 5601.4 5611.8 5632.2 5641.2 5716.8 5527.9 5640.4 5658.3 5667.3 5692.4 6097.3 6142.8 6153.7 6163.4 6178.4 6637.7 6647.8 6669.4 6672.0 6675.1 6439.2 6509.3 6513.3 6590.4 6759.9 6147.9 6182.0 6201.6 6210.8 6235.4 6911.4 6912.7 6945.9 6946.6 6947.3 6353.5 6383.4 6415.6 6419.8 6424.8 6497.7 6598.3 6634.1 6659.3 6666.7 6657.3 6657.3 6675.7 6679.6 6684.1 6513.6 6584.9 6587.8 6700.9 6748.2 5333.8 5385.1 5396.8 5422.9 5426.5 4573.6 4653.7 4657.0 4686.9 4722.4 5703.3 5757.9 5764.7 5772.4 5783.4 6698.8 6728.8 6735.4 6763.8 6788.8 5576.0 5664.0 5698.6 5728.9 5763.5 5867.3 5905.1 5935.5 5940.3 5977.9 6366.3 6441.9 6478.2 6491.7 6502.5 6697.6 6703.8 6719.6 6726.2 6734.3 6148.7 6257.2 6268.0 6491.6 6496.6 6467.3 6511.8 6554.4 6555.4 6574.7 6625.4 6691.7 6720.4 6729.9 6768.1 6511.3 6516.8 6522.3 6524.4 6550.5 6346.6 6460.4 6522.1 6548.9 6559.7 6155.1 6296.7 6309.1 6358.3 6363.5 6527.3 6571.7 6583.6 6603.4 6609.9 6359.9 6372.9 6397.6 6401.5 6405.1 09:51:24 INFO - PID 10094 | 09:51:24 INFO - PID 10094 | [#1] ext.html Cycles:180 Average:35982.65 Median:32987.01 stddev:52312.94 (158.6%) stddev-sans-first:52393.01 09:51:24 INFO - PID 10094 | Values: 805.8 836.6 860.8 879.0 883.4 39570.6 40110.8 40491.6 40690.0 40706.0 36261.0 36536.8 36565.1 36597.3 36757.1 6753.6 6803.9 6817.5 6849.4 6872.6 6787.2 6836.0 6883.7 6886.9 6912.5 6812.8 6861.1 6881.1 6881.6 6882.0 6766.9 6773.1 6779.5 6816.1 6891.5 6201.0 6256.4 6274.2 6279.8 6286.6 32743.5 32869.0 32948.2 33002.8 33121.5 3466.9 3529.0 3613.2 3619.9 3627.4 29711.7 30029.2 30036.2 30082.4 30098.8 3704.1 3706.3 3721.8 3729.3 3776.7 186549.0 188569.0 188647.0 190546.0 191316.0 46549.5 47047.1 47136.0 47256.5 47461.3 48742.0 48893.5 48974.0 48988.5 49097.0 15449.9 15633.8 15691.3 15741.0 15762.7 13017.2 13021.5 13025.0 13036.9 13046.9 13865.4 13893.5 13915.5 13939.9 14050.1 5680.5 5727.7 5757.5 5776.2 5795.7 984.7 986.2 995.9 1018.6 1040.7 21869.7 22823.8 22909.7 22937.9 23140.0 1064.4 1086.5 1107.2 1113.5 1116.9 11643.9 12013.2 12133.9 12161.5 12161.8 229395.0 230359.0 231587.0 231816.0 232182.0 50286.2 50643.2 50646.2 50861.5 51031.0 1410.2 1459.1 1460.1 1468.9 1484.7 21140.7 21486.4 22263.6 22426.3 23008.8 34820.8 35621.5 35639.3 35697.3 35743.3 179759.0 180978.0 181181.1 181608.0 182184.0 29383.9 29565.1 29899.4 31611.5 32971.2 40607.0 40651.0 41021.0 41225.0 42321.5 27640.7 30062.4 30864.0 31321.4 31674.2 29663.0 29864.6 30429.4 31477.0 31947.8 32802.5 34352.0 34507.9 34529.5 34662.0 28557.6 29170.6 29361.0 29949.0 31071.1 23489.8 24412.5 24532.4 25774.0 26208.6 09:51:24 INFO - PID 10094 | 09:51:24 INFO - PID 10094 | [#2] jquery.html Cycles:180 Average:35974.97 Median:12626.11 stddev:95804.48 (758.8%) stddev-sans-first:96036.31 09:51:24 INFO - PID 10094 | Values: 548.3 558.0 563.3 586.6 592.8 20996.2 21939.2 21952.9 21985.7 21990.7 23662.2 24399.0 25129.4 25432.9 25579.5 6388.1 6528.2 6532.4 6533.5 6536.0 6424.9 6446.2 6447.1 6461.4 6492.4 5805.6 6077.9 6258.3 6417.8 6431.0 6256.3 6274.9 6300.0 6305.9 6320.3 5871.0 5889.3 5896.0 5896.9 5896.9 27355.7 28234.4 28758.0 28799.0 28836.6 1849.9 1895.9 1900.4 1901.1 1909.2 17793.8 18280.9 18296.6 18305.7 18322.5 2266.3 2355.3 2367.3 2413.7 2419.5 120812.0 123596.0 123615.0 123720.4 123884.4 14014.6 14365.6 14533.1 15100.9 15112.4 23170.2 23204.7 23241.9 23317.5 23334.9 9631.5 9715.2 9798.2 9834.0 9863.7 8735.6 8798.6 8858.5 8920.6 8929.8 8796.9 8999.7 9060.7 9126.9 9353.6 2552.1 2650.1 2763.3 2858.7 2879.7 946.0 958.0 961.7 1011.8 1018.5 19948.5 20191.7 20914.3 22985.9 24677.0 1037.9 1063.4 1070.9 1074.9 1078.9 11432.2 11603.9 11665.1 11704.6 11794.4 564113.0 578080.0 581597.3 582232.0 585982.0 104848.0 109556.0 110524.4 111019.4 111142.4 1201.0 1216.3 1273.2 1275.5 1280.7 19494.8 21008.6 21349.7 21350.5 21536.1 49397.5 50943.0 51034.0 51127.7 51216.2 66818.0 67403.7 67790.3 68181.3 68222.7 12359.9 12969.5 12985.4 13186.5 13191.8 18097.2 18916.8 18985.0 19397.7 19674.5 15600.8 15704.8 15801.6 15839.2 16107.3 13265.2 13935.7 14305.1 14503.5 14682.6 14133.9 15148.3 15260.5 15291.6 15404.7 12380.1 17502.7 18117.9 18203.9 18577.2 16388.8 16451.8 16533.7 16554.5 16661.8 09:51:24 INFO - PID 10094 | 09:51:24 INFO - PID 10094 | [#3] mootools.html Cycles:180 Average:8130.34 Median:2518.86 stddev:5384.95 (213.8%) stddev-sans-first:5375.89 09:51:24 INFO - PID 10094 | Values: 1341.6 1397.4 1411.5 1419.6 1425.9 12925.9 13525.5 13559.7 13568.3 13581.7 13013.7 13288.4 13324.9 13348.2 13367.5 2572.7 2618.9 2624.0 2624.2 2629.2 2535.3 2599.4 2603.7 2604.8 2608.4 2502.4 2553.7 2561.6 2564.3 2574.2 2431.8 2464.7 2481.8 2485.8 2490.2 2420.9 2427.0 2434.3 2469.7 2497.5 12878.5 13011.5 13017.3 13033.6 13052.7 7089.4 7354.5 7369.2 7370.6 7396.2 4085.1 4198.4 4276.7 4278.5 4300.9 1447.3 1499.9 1508.1 1536.3 1536.9 18949.3 19402.3 20272.4 20451.0 20465.6 5368.4 5559.7 6146.4 6335.3 6372.0 14761.6 14802.8 14811.0 14821.8 14838.0 7196.5 7301.9 7326.3 7331.6 7342.6 6652.0 6824.5 6836.0 6872.6 6922.9 4787.5 4838.9 4865.7 4970.3 4997.1 1407.7 1410.5 1424.9 1425.9 1442.6 887.9 893.9 897.5 919.6 932.9 6767.7 6836.2 7064.9 7212.6 7248.1 719.3 726.1 732.3 737.5 740.7 4386.5 5109.1 5615.4 6026.2 6046.6 17392.0 17479.3 17755.7 18028.7 18288.8 16908.4 17103.2 17416.6 17666.6 17983.6 9826.5 9928.5 9979.3 10060.3 10095.8 7717.7 8187.5 8314.1 8440.3 8528.4 15466.9 15519.2 15575.5 15829.7 15979.9 14314.7 14902.6 15385.5 15907.5 16067.8 9767.0 11206.7 11222.0 11223.9 11228.3 12411.9 12531.1 12537.7 12591.3 12615.5 9879.7 10279.6 10312.5 10552.0 10559.8 10087.9 10132.2 10199.2 10401.9 10472.7 8997.1 9172.7 9202.3 9212.4 9273.5 5967.7 6001.1 6125.8 6347.7 6471.7 6726.8 6782.5 6800.9 6956.9 7000.2 09:51:24 INFO - PID 10094 | 09:51:24 INFO - PID 10094 | [#4] prototype.html Cycles:180 Average:5569.48 Median:6156.93 stddev:1568.08 (25.5%) stddev-sans-first:1525.47 09:51:24 INFO - PID 10094 | Values: 492.2 494.9 509.3 513.5 514.9 6200.8 6263.5 6367.8 6390.6 6390.7 6147.1 6166.7 6167.2 6241.5 6264.6 5023.0 5038.4 5042.3 5054.4 5075.1 5035.5 5050.5 5061.1 5072.7 5092.9 4863.6 5018.3 5038.0 5066.2 5079.9 4994.5 4998.5 5003.5 5004.8 5033.3 4462.1 4469.4 4472.2 4538.2 4541.4 6015.5 6073.8 6088.0 6092.7 6097.1 5702.5 5731.7 5733.6 5745.8 5767.4 6616.3 6618.9 6624.7 6655.7 6656.2 4865.9 4909.3 4932.6 4959.4 4965.5 6979.2 6995.2 6996.4 7041.7 7047.9 5057.9 5083.7 5085.6 5087.6 5116.8 5121.8 5139.5 5145.5 5156.3 5184.3 5768.1 5770.9 5781.3 5789.1 5791.9 6620.6 6688.6 6702.7 6710.8 6712.6 1684.8 1687.0 1788.2 1790.0 1797.3 1209.7 1223.1 1233.4 1234.5 1255.6 5569.2 5652.8 5689.0 5704.7 5747.5 6758.5 6775.1 6799.7 6826.0 6838.4 5764.2 5787.7 5800.3 5806.9 5816.7 3612.0 3634.7 3645.3 3653.8 3656.0 6551.3 6559.8 6567.6 6584.0 6601.7 6928.9 6934.8 6937.9 6949.1 6972.8 6490.3 6494.3 6494.9 6511.9 6548.7 6779.7 6824.9 6834.7 6837.7 6852.9 6753.9 6772.1 6789.8 6795.3 6805.6 6444.4 6501.8 6584.6 6598.8 6646.8 4939.0 4991.3 5013.1 5047.5 5053.2 6779.8 6832.8 6850.9 6854.6 6871.4 6581.7 6595.1 6595.3 6605.0 6651.5 6583.4 6587.9 6604.8 6611.4 6623.7 6521.1 6525.2 6525.7 6525.9 6534.3 6660.5 6664.5 6671.9 6674.4 6705.8 6379.5 6397.3 6439.8 6457.0 6472.7 09:51:24 INFO - PID 10094 | 09:51:24 INFO - PID 10094 | [#5] yui.html Cycles:180 Average:20286.92 Median:20042.80 stddev:26132.85 (130.4%) stddev-sans-first:26165.40 09:51:24 INFO - PID 10094 | Values: 850.1 866.9 871.2 873.7 877.2 17449.8 17698.0 17913.9 17995.0 18054.7 19029.5 20281.0 20347.6 20733.6 20736.7 1004.9 1025.2 1029.0 1031.3 1031.9 1043.0 1043.2 1043.2 1046.8 1048.1 1016.7 1099.1 1099.5 1101.4 1109.9 1048.5 1076.1 1079.4 1083.8 1085.8 782.3 785.7 786.1 787.9 790.8 18483.4 18698.2 19131.6 19297.0 19307.4 19437.7 19831.2 19935.1 19993.2 20000.8 15024.2 15043.9 15089.5 15124.1 15133.9 3402.7 3498.2 3544.0 3549.8 3553.1 100276.5 102293.0 103643.5 103832.0 104184.5 15285.2 15598.1 15735.6 15739.8 15811.1 27161.0 27624.2 27725.9 27805.4 27827.0 8066.9 8085.5 8125.2 8136.0 8190.6 4062.3 4135.3 4141.1 4143.4 4150.3 4970.2 5021.4 5037.8 5063.3 5073.9 879.5 904.2 941.0 944.0 949.8 600.5 668.6 699.6 699.6 716.8 10477.5 11057.3 11564.1 11758.4 11868.2 683.2 697.2 707.2 721.5 733.4 4829.6 4908.0 5468.9 5634.3 5743.0 89874.0 92034.5 94214.5 97316.5 97801.5 78135.0 79987.2 81575.0 81576.6 83519.0 68747.3 72457.3 73662.6 74792.6 76453.2 10771.4 10949.9 11391.0 11500.7 11644.2 31147.2 31816.5 32422.7 32427.4 33338.7 40966.8 43414.6 43639.1 44156.6 44811.6 17073.7 17112.1 17841.6 18121.3 18287.5 20084.8 20122.0 20342.3 20377.6 20702.2 14043.7 14686.4 15224.4 15838.0 15925.2 16181.6 16375.8 16474.0 16495.8 16852.6 14944.2 16186.2 16204.4 16296.8 16670.1 12510.3 12758.0 13018.8 13089.5 13424.6 12356.2 12416.3 12578.4 12716.2 13228.3 09:51:24 INFO - PID 10094 | -------- Summary: end -------- 09:51:24 INFO - PID 10094 | 09:51:25 INFO - TEST-INFO | 10094: exit 0 09:51:25 INFO - TEST-OK | dromaeo_css | took 1117775ms 09:51:25 INFO - TEST-START | kraken 09:51:25 INFO - operating with platform_type : linux_ 09:51:25 INFO - Initialising browser for kraken test... 09:51:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34993/getInfo.html -profile /tmp/tmpKgqNZh/profile 09:51:25 INFO - TEST-INFO | started process 10517 (/builds/slave/test/build/application/firefox/firefox http://localhost:34993/getInfo.html) 09:51:31 INFO - TEST-INFO | 10517: exit 0 09:51:31 INFO - Browser initialized. 09:51:31 INFO - Running cycle 1/1 for kraken test... 09:51:31 INFO - TEST-INFO | started process 10754 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKgqNZh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:51:42 INFO - PID 10754 | RSS: Main: 179712000 09:51:42 INFO - PID 10754 | 09:51:45 INFO - PID 10754 | Cycle 1(1): loaded http://localhost:34993/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34993/tests/kraken/driver.html?testName=audio-beat-detection) 09:51:46 INFO - PID 10754 | RSS: Main: 183128064 09:51:46 INFO - PID 10754 | 09:51:49 INFO - PID 10754 | Cycle 1(1): loaded http://localhost:34993/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34993/tests/kraken/driver.html?testName=audio-dft) 09:51:49 INFO - PID 10754 | RSS: Main: 183738368 09:51:49 INFO - PID 10754 | 09:51:52 INFO - PID 10754 | Cycle 1(1): loaded http://localhost:34993/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34993/tests/kraken/driver.html?testName=audio-fft) 09:51:53 INFO - PID 10754 | RSS: Main: 179347456 09:51:53 INFO - PID 10754 | 09:51:55 INFO - PID 10754 | Cycle 1(1): loaded http://localhost:34993/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34993/tests/kraken/driver.html?testName=audio-oscillator) 09:51:56 INFO - PID 10754 | RSS: Main: 179736576 09:51:56 INFO - PID 10754 | 09:51:58 INFO - PID 10754 | Cycle 1(1): loaded http://localhost:34993/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34993/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:51:58 INFO - PID 10754 | RSS: Main: 179920896 09:51:58 INFO - PID 10754 | 09:52:01 INFO - PID 10754 | Cycle 1(1): loaded http://localhost:34993/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34993/tests/kraken/driver.html?testName=imaging-darkroom) 09:52:02 INFO - PID 10754 | RSS: Main: 183623680 09:52:02 INFO - PID 10754 | 09:52:06 INFO - PID 10754 | Cycle 1(1): loaded http://localhost:34993/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34993/tests/kraken/driver.html?testName=imaging-desaturate) 09:52:06 INFO - PID 10754 | RSS: Main: 185049088 09:52:06 INFO - PID 10754 | 09:52:09 INFO - PID 10754 | Cycle 1(1): loaded http://localhost:34993/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34993/tests/kraken/driver.html?testName=json-parse-financial) 09:52:10 INFO - PID 10754 | RSS: Main: 184262656 09:52:10 INFO - PID 10754 | 09:52:11 INFO - PID 10754 | Cycle 1(1): loaded http://localhost:34993/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34993/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:52:12 INFO - PID 10754 | RSS: Main: 184111104 09:52:12 INFO - PID 10754 | 09:52:14 INFO - PID 10754 | Cycle 1(1): loaded http://localhost:34993/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34993/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:52:14 INFO - PID 10754 | RSS: Main: 184692736 09:52:14 INFO - PID 10754 | 09:52:16 INFO - PID 10754 | Cycle 1(1): loaded http://localhost:34993/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34993/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:52:17 INFO - PID 10754 | RSS: Main: 184254464 09:52:17 INFO - PID 10754 | 09:52:20 INFO - PID 10754 | Cycle 1(1): loaded http://localhost:34993/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34993/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:52:20 INFO - PID 10754 | RSS: Main: 184172544 09:52:20 INFO - PID 10754 | 09:52:23 INFO - PID 10754 | Cycle 1(1): loaded http://localhost:34993/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34993/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:52:24 INFO - PID 10754 | RSS: Main: 184029184 09:52:24 INFO - PID 10754 | 09:52:26 INFO - PID 10754 | Cycle 1(1): loaded http://localhost:34993/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34993/tests/kraken/driver.html?testName=ai-astar) 09:52:26 INFO - PID 10754 | RSS: Main: 185708544 09:52:26 INFO - PID 10754 | 09:52:26 INFO - PID 10754 | __start_tp_report 09:52:26 INFO - PID 10754 | _x_x_mozilla_page_load 09:52:26 INFO - PID 10754 | _x_x_mozilla_page_load_details 09:52:26 INFO - PID 10754 | |i|pagename|runs| 09:52:26 INFO - PID 10754 | |0;ai-astar;101;108;110;107;121;109;108;107;110;110 09:52:26 INFO - PID 10754 | |1;audio-beat-detection;156;121;151;179;127;157;153;121;168;121 09:52:26 INFO - PID 10754 | |2;audio-dft;165;164;164;162;163;173;168;172;174;165 09:52:26 INFO - PID 10754 | |3;audio-fft;75;76;78;171;76;76;76;75;110;75 09:52:26 INFO - PID 10754 | |4;audio-oscillator;82;82;140;82;84;82;129;82;83;135 09:52:26 INFO - PID 10754 | |5;imaging-gaussian-blur;115;114;114;114;118;114;115;115;113;117 09:52:26 INFO - PID 10754 | |6;imaging-darkroom;150;150;153;150;151;156;150;152;151;151 09:52:26 INFO - PID 10754 | |7;imaging-desaturate;94;95;94;95;97;102;95;94;95;95 09:52:26 INFO - PID 10754 | |8;json-parse-financial;58;58;55;56;57;53;59;53;54;53 09:52:26 INFO - PID 10754 | |9;json-stringify-tinderbox;55;54;55;62;54;53;54;54;54;60 09:52:26 INFO - PID 10754 | |10;stanford-crypto-aes;77;80;78;78;78;79;80;77;78;77 09:52:26 INFO - PID 10754 | |11;stanford-crypto-ccm;128;133;124;126;128;133;128;137;139;161 09:52:26 INFO - PID 10754 | |12;stanford-crypto-pbkdf2;192;181;189;192;196;188;184;198;184;189 09:52:26 INFO - PID 10754 | |13;stanford-crypto-sha256-iterative;75;70;70;72;71;73;68;67;68;68 09:52:26 INFO - PID 10754 | __end_tp_report 09:52:26 INFO - PID 10754 | __start_cc_report 09:52:26 INFO - PID 10754 | _x_x_mozilla_cycle_collect,989 09:52:26 INFO - PID 10754 | __end_cc_report 09:52:26 INFO - PID 10754 | __startTimestamp1497977546607__endTimestamp 09:52:26 INFO - PID 10754 | 09:52:26 INFO - PID 10754 | ------- Summary: start ------- 09:52:26 INFO - PID 10754 | Number of tests: 14 09:52:26 INFO - PID 10754 | 09:52:26 INFO - PID 10754 | [#0] ai-astar Cycles:10 Average:109.10 Median:109.50 stddev:4.95 (4.5%) stddev-sans-first:4.30 09:52:26 INFO - PID 10754 | Values: 101.0 108.0 110.0 107.0 121.0 109.0 108.0 107.0 110.0 110.0 09:52:26 INFO - PID 10754 | 09:52:26 INFO - PID 10754 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:154.50 stddev:21.34 (13.8%) stddev-sans-first:22.29 09:52:26 INFO - PID 10754 | Values: 156.0 121.0 151.0 179.0 127.0 157.0 153.0 121.0 168.0 121.0 09:52:26 INFO - PID 10754 | 09:52:26 INFO - PID 10754 | [#2] audio-dft Cycles:10 Average:167.00 Median:166.50 stddev:4.45 (2.7%) stddev-sans-first:4.66 09:52:26 INFO - PID 10754 | Values: 165.0 164.0 164.0 162.0 163.0 173.0 168.0 172.0 174.0 165.0 09:52:26 INFO - PID 10754 | 09:52:26 INFO - PID 10754 | [#3] audio-fft Cycles:10 Average:88.80 Median:76.00 stddev:30.82 (40.6%) stddev-sans-first:32.28 09:52:26 INFO - PID 10754 | Values: 75.0 76.0 78.0 171.0 76.0 76.0 76.0 75.0 110.0 75.0 09:52:26 INFO - PID 10754 | 09:52:26 INFO - PID 10754 | [#4] audio-oscillator Cycles:10 Average:98.10 Median:82.00 stddev:25.37 (30.9%) stddev-sans-first:26.24 09:52:26 INFO - PID 10754 | Values: 82.0 82.0 140.0 82.0 84.0 82.0 129.0 82.0 83.0 135.0 09:52:26 INFO - PID 10754 | 09:52:26 INFO - PID 10754 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:115.00 stddev:1.52 (1.3%) stddev-sans-first:1.62 09:52:26 INFO - PID 10754 | Values: 115.0 114.0 114.0 114.0 118.0 114.0 115.0 115.0 113.0 117.0 09:52:26 INFO - PID 10754 | 09:52:26 INFO - PID 10754 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:151.00 stddev:1.90 (1.3%) stddev-sans-first:1.94 09:52:26 INFO - PID 10754 | Values: 150.0 150.0 153.0 150.0 151.0 156.0 150.0 152.0 151.0 151.0 09:52:26 INFO - PID 10754 | 09:52:26 INFO - PID 10754 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.00 stddev:2.41 (2.5%) stddev-sans-first:2.49 09:52:26 INFO - PID 10754 | Values: 94.0 95.0 94.0 95.0 97.0 102.0 95.0 94.0 95.0 95.0 09:52:26 INFO - PID 10754 | 09:52:26 INFO - PID 10754 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.50 stddev:2.32 (4.1%) stddev-sans-first:2.29 09:52:26 INFO - PID 10754 | Values: 58.0 58.0 55.0 56.0 57.0 53.0 59.0 53.0 54.0 53.0 09:52:26 INFO - PID 10754 | 09:52:26 INFO - PID 10754 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:54.50 stddev:2.99 (5.5%) stddev-sans-first:3.17 09:52:26 INFO - PID 10754 | Values: 55.0 54.0 55.0 62.0 54.0 53.0 54.0 54.0 54.0 60.0 09:52:26 INFO - PID 10754 | 09:52:26 INFO - PID 10754 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.00 stddev:1.14 (1.5%) stddev-sans-first:1.12 09:52:26 INFO - PID 10754 | Values: 77.0 80.0 78.0 78.0 78.0 79.0 80.0 77.0 78.0 77.0 09:52:26 INFO - PID 10754 | 09:52:26 INFO - PID 10754 | [#11] stanford-crypto-ccm Cycles:10 Average:133.70 Median:133.00 stddev:10.73 (8.1%) stddev-sans-first:11.18 09:52:26 INFO - PID 10754 | Values: 128.0 133.0 124.0 126.0 128.0 133.0 128.0 137.0 139.0 161.0 09:52:26 INFO - PID 10754 | 09:52:26 INFO - PID 10754 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.30 Median:190.50 stddev:5.40 (2.8%) stddev-sans-first:5.63 09:52:26 INFO - PID 10754 | Values: 192.0 181.0 189.0 192.0 196.0 188.0 184.0 198.0 184.0 189.0 09:52:26 INFO - PID 10754 | 09:52:26 INFO - PID 10754 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.50 stddev:2.57 (3.7%) stddev-sans-first:2.06 09:52:26 INFO - PID 10754 | Values: 75.0 70.0 70.0 72.0 71.0 73.0 68.0 67.0 68.0 68.0 09:52:26 INFO - PID 10754 | -------- Summary: end -------- 09:52:26 INFO - PID 10754 | 09:52:27 INFO - TEST-INFO | 10754: exit 0 09:52:27 INFO - TEST-OK | kraken | took 62519ms 09:52:27 INFO - SUITE-END | took 1180s 09:52:27 INFO - Completed test suite (00:19:40) 09:52:27 INFO - javascript benchmark 09:52:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8154.92136575282, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3059.8164110153407, 3103.2862441638417, 3114.9688503114976, 3122.3911337289223, 3122.7501799856013, 6044.546659000571, 6069.666168360738, 6095.66473843939, 6110.266767987842, 6168.506519478442, 6112.144299798032, 6132.814448934792, 6185.103160041791, 6200.472959798422, 6201.596896201755, 5680.857978550549, 5696.914546281809, 5726.484616384525, 5744.080947048473, 5824.0, 5735.2257445245195, 5739.626924249931, 5762.56780741444, 5792.189093526909, 5798.985177593925, 5576.776928922838, 5601.579881508903, 5675.9432405675825, 5692.943070569283, 5695.259616249902, 5601.355844077902, 5611.803586874481, 5632.183333416672, 5641.153826925953, 5716.771329146871, 5527.944720552783, 5640.407757185478, 5658.34928983164, 5667.263255776764, 5692.430756924316, 6097.268327800648, 6142.815715528542, 6153.661548614825, 6163.445289923929, 6178.41305076017, 6637.73449062037, 6647.803395388828, 6669.399754022113, 6672.0, 6675.065490831287, 6439.227292724856, 6509.251436084864, 6513.316101809289, 6590.406863382319, 6759.898601520981, 6147.907781383283, 6182.041783523561, 6201.565890387629, 6210.782622608277, 6235.438810506986, 6911.447084233249, 6912.688928998207, 6945.861082778316, 6946.6179360135675, 6947.340002699735, 6353.459955903708, 6383.3616638336725, 6415.550911436155, 6419.807405777834, 6424.839379015469, 6497.707603157869, 6598.274189839114, 6634.104395906491, 6659.334066593399, 6666.666666666647, 6657.3342665733035, 6657.334266573401, 6675.6662166891465, 6679.56582822115, 6684.064231007663, 6513.576617519941, 6584.934150658528, 6587.83530411734, 6700.865982680319, 6748.223954245324, 5333.759980800874, 5385.057614917374, 5396.757145928443, 5422.8915421691345, 5426.511613954684, 4573.565511276423, 4653.6509761768, 4656.998745269783, 4686.906261874743, 4722.386089808303, 5703.287089113861, 5757.88484230313, 5764.74058667361, 5772.422757724278, 5783.363829978699, 6698.765543205965, 6728.764493242713, 6735.42748866342, 6763.797086087426, 6788.76239331621, 5576.0, 5664.037113690682, 5698.629589076697, 5728.885422291531, 5763.481286684135, 5867.266591676041, 5905.084711869667, 5935.465808077208, 5940.257467816523, 5977.910331345033, 6366.267879193952, 6441.935580644321, 6478.190226221723, 6491.675416229265, 6502.544821862424, 6697.598144111369, 6703.8324041897395, 6719.596824190564, 6726.159230096238, 6734.292899245705, 6148.661823599566, 6257.1552840367785, 6268.0, 6491.610503369813, 6496.577722448026, 6467.288598254094, 6511.837204069936, 6554.442872355903, 6555.4427873629365, 6574.704138313692, 6625.370589793962, 6691.665416729047, 6720.428763555153, 6729.899051514133, 6768.120144381199, 6511.2512061113575, 6516.804495865132, 6522.28254891952, 6524.380183882524, 6550.508711846726, 6346.587471814318, 6460.35396460369, 6522.05430212607, 6548.901766473602, 6559.704813283318, 6155.076738489262, 6296.653684047421, 6309.085182648582, 6358.300586935526, 6363.522735794926, 6527.3472652734345, 6571.704273307617, 6583.572067815577, 6603.438707709706, 6609.933900660932, 6359.936400636119, 6372.872542549216, 6397.616143031433, 6401.487880969605, 6405.071264666691], "value": 6059.854793650862, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [805.7663277649482, 836.6193382011186, 860.8450478913796, 878.9780255493616, 883.4257732473891, 39570.604293957054, 40110.799446002726, 40491.59508404915, 40690.0, 40706.0, 36261.0, 36536.81731591345, 36565.08587285319, 36597.268054638895, 36757.08107297319, 6753.628550429725, 6803.897941530881, 6817.5227734058635, 6849.383555480006, 6872.62200578968, 6787.151606049244, 6835.965820170917, 6883.7246510139785, 6886.896696549556, 6912.481563882704, 6812.829679258009, 6861.073755043055, 6881.1054562907, 6881.552699074569, 6882.03651488792, 6766.932330676728, 6773.0517727517945, 6779.49153813461, 6816.079829223066, 6891.517593768438, 6200.968995155041, 6256.436920677115, 6274.247090349188, 6279.811605651837, 6286.591371560834, 32743.50884736731, 32869.0, 32948.17629559256, 33002.83498582516, 33121.50317745236, 3466.9306613867834, 3529.0471572675233, 3613.1509095362567, 3619.8914032579064, 3627.365211088049, 29711.70288297111, 30029.24926876824, 30036.24909377261, 30082.398352033055, 30098.84950575255, 3704.073981504624, 3706.3328600851837, 3721.79530125843, 3729.310077635646, 3776.6978641708597, 186549.0, 188569.0, 188647.0, 190546.0, 191316.0, 46549.534504655196, 47047.059058819315, 47136.0, 47256.52743472521, 47461.288080678816, 48742.0, 48893.511064888895, 48974.0, 48988.51011489911, 49097.0, 15449.922750386177, 15633.765493517607, 15691.293891774669, 15741.0, 15762.684746305009, 13017.153884997444, 13021.47914083445, 13025.0, 13036.934815326053, 13046.934765326112, 13865.37605807741, 13893.513727019506, 13915.512957046454, 13939.860601394059, 14050.086744361584, 5680.5171560417, 5727.684977326204, 5757.453041961007, 5776.191333213354, 5795.652260864362, 984.6602921991902, 986.2356673577891, 995.8804943406693, 1018.5721996761378, 1040.7033995311451, 21869.67195492069, 22823.771762282497, 22909.656355154686, 22937.88531057334, 23140.0, 1064.350746044912, 1086.4513420722485, 1107.2360071550604, 1113.5211858900589, 1116.8883111688929, 11643.88356116445, 12013.219140755822, 12133.939330303292, 12161.452734626962, 12161.817572736416, 229395.0, 230359.0, 231587.0, 231816.0, 232182.0, 50286.24570631443, 50643.24035139476, 50646.2403063947, 50861.491385085676, 51031.0, 1410.168000879486, 1459.0516164493165, 1460.1166294391953, 1468.860458256464, 1484.6733718581895, 21140.682889756357, 21486.355409337746, 22263.554728905656, 22426.32721018372, 23008.769912301334, 34820.82589587036, 35621.46567801537, 35639.28721425609, 35697.28605427825, 35743.28513429769, 179759.0, 180978.0, 181181.09409453397, 181608.0, 182184.0, 29383.853080734458, 29565.113046608636, 29899.402011959202, 31611.525827113073, 32971.17572060622, 40607.0, 40651.0, 41021.0, 41225.0, 42321.518746843714, 27640.723592763814, 30062.398752025274, 30864.0, 31321.37357252888, 31674.208144795644, 29662.961796337888, 29864.552031719977, 30429.39141217119, 31477.0, 31947.840260798548, 32802.50796238011, 34352.0, 34507.929524228624, 34529.48205776865, 34662.0, 28557.571636425055, 29170.56244156382, 29361.0, 29948.95178668736, 31071.067867963997, 23489.76510234944, 24412.51174976526, 24532.386690332885, 25774.0, 26208.606870897333], "value": 16200.502311710992, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.3023524260637, 557.9916301255482, 563.2677519225009, 586.6157666728293, 592.8043745563963, 20996.160153593857, 21939.232126875522, 21952.89023554884, 21985.670214946767, 21990.670139947913, 23662.171823986166, 24399.0, 25129.371765705822, 25432.872835635797, 25579.488410231785, 6388.073729309247, 6528.183977002875, 6532.412082912537, 6533.509986750989, 6536.0, 6424.93575064248, 6446.226452825667, 6447.097406363113, 6461.386168314026, 6492.415682588566, 5805.622634528742, 6077.878442431149, 6258.280297765747, 6417.780621681889, 6430.967845160768, 6256.343083976162, 6274.874502509947, 6299.96850015747, 6305.87388252237, 6320.336364681688, 5871.031279838864, 5889.293284805808, 5895.970520147414, 5896.911546326808, 5896.911546326808, 27355.72644273552, 28234.43531129366, 28758.0, 28799.0, 28836.567451488034, 1849.8890066595914, 1895.924163033477, 1900.4108726294892, 1901.0684764465313, 1909.23630547782, 17793.822061779345, 18280.90859545694, 18296.63406731858, 18305.7254141188, 18322.541936451562, 2266.331432227497, 2355.316958082154, 2367.337145599235, 2413.6862207913036, 2419.467717102252, 120812.0, 123596.0, 123615.0, 123720.38139809243, 123884.38057809744, 14014.649633759238, 14365.64085897861, 14533.128012319296, 15100.924495377452, 15112.395504179929, 23170.1890433834, 23204.65193022106, 23241.883790581276, 23317.533649326917, 23334.883325583265, 9631.518424078768, 9715.222782177409, 9798.167155791838, 9834.0, 9863.704088877344, 8735.645974873905, 8798.560071996375, 8858.468491890508, 8920.553972301359, 8929.821403571892, 8796.8680469793, 8999.685011024583, 9060.728178154666, 9126.908730912739, 9353.625854965861, 2552.1067626330637, 2650.1387049209084, 2763.3023859439036, 2858.6569611646737, 2879.6544414670375, 945.9716208513755, 958.0121248409439, 961.6730311694058, 1011.7521207304111, 1018.5365658625456, 19948.50128746764, 20191.697124543145, 20914.268000619904, 22985.885070574874, 24677.0, 1037.8806437259661, 1063.4151216830867, 1070.8875568065241, 1074.8656417947757, 1078.8867168947147, 11432.199746017865, 11603.88396116028, 11665.066794656406, 11704.648860534198, 11794.410279485992, 564113.0, 578080.0, 581597.2760408598, 582232.0, 585982.0, 104848.0, 109556.0, 110524.4473777642, 111019.44490277658, 111142.44428777965, 1200.975980480403, 1216.2702378572963, 1273.1597145883673, 1275.5216793702361, 1280.6798300424894, 19494.805051949297, 21008.63443876143, 21349.679754804, 21350.505464617327, 21536.138554458274, 49397.50602493929, 50943.0, 51033.97932041264, 51127.74436127795, 51216.23175652443, 66818.0, 67403.66298168477, 67790.32209678038, 68181.31818681948, 68222.65888670525, 12359.938200309301, 12969.54606588765, 12985.415656295301, 13186.472541098248, 13191.80212296797, 18097.18562664657, 18916.810831892057, 18985.0, 19397.709034364212, 19674.50813729611, 15600.765988509955, 15704.764428533352, 15801.604959876095, 15839.208039598205, 16107.275172617026, 13265.156477616192, 13935.66009709822, 14305.141691498127, 14503.492377766728, 14682.55952321432, 14133.858661413255, 15148.31832567515, 15260.542183734506, 15291.61770955735, 15404.691906162037, 12380.071494637757, 17502.73745893838, 18117.90941045339, 18203.908980455544, 18577.16402761852, 16388.75416868772, 16451.83548164551, 16533.66932661316, 16554.503364899072, 16661.833381666514], "value": 11610.427392709957, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.6109328294795, 1397.385150533765, 1411.4848080450627, 1419.6308959670482, 1425.8735598876885, 12925.935370323146, 13525.526606568772, 13559.728805423898, 13568.253746043963, 13581.660458488543, 13013.674658133528, 13288.402021909013, 13324.866751332507, 13348.199108053524, 13367.532136375228, 2572.7041390240083, 2618.9345266368305, 2623.9504198320633, 2624.160268714012, 2629.2243788082465, 2535.3027917322793, 2599.350162459385, 2603.713591504933, 2604.8046396520335, 2608.3870290481723, 2502.4244423782543, 2553.706323772762, 2561.5517284475236, 2564.2563656539583, 2574.163396896007, 2431.756824317572, 2464.7060293345958, 2481.8262721609494, 2485.8135639827087, 2490.203134996802, 2420.9273721788372, 2427.0413186791293, 2434.3062227265145, 2469.6665950096867, 2497.5254701606636, 12878.549250776177, 13011.544595939191, 13017.349132543335, 13033.608991730169, 13052.738945221043, 7089.361957423805, 7354.48518603698, 7369.189389167187, 7370.5577665339715, 7396.223396543393, 4085.142120154771, 4198.412222288882, 4276.695607839608, 4278.465191851019, 4300.892477688051, 1447.2763618190904, 1499.8650121489009, 1508.0800711565937, 1536.3009830527083, 1536.8770498360104, 18949.33677321301, 19402.320918767775, 20272.391828245178, 20451.0, 20465.5906881863, 5368.409474957752, 5559.694216818114, 6146.446819786241, 6335.303116657164, 6372.044193370939, 14761.55715328542, 14802.777958330633, 14811.037282576597, 14821.77767333491, 14838.0, 7196.496245262886, 7301.853962920712, 7326.3040011198855, 7331.560106393634, 7342.596157211297, 6651.966740166365, 6824.454043676494, 6836.0, 6872.587644741331, 6922.8615427692175, 4787.521247875185, 4838.854834354975, 4865.7323847188745, 4970.260408856871, 4997.0505603935135, 1407.7395681798696, 1410.4710733474947, 1424.9028248248997, 1425.942962281497, 1442.596073099534, 887.8712586674895, 893.9061398553058, 897.5243121145803, 919.56780313254, 932.9131561730644, 6767.72929082841, 6836.248012718597, 7064.894026589605, 7212.567245965259, 7248.130224373109, 719.3130560314887, 726.1467775363926, 732.2933369298653, 737.5286303823799, 740.7074205688723, 4386.495553011381, 5109.054824857413, 5615.354234263031, 6026.156338112668, 6046.606970546988, 17392.0, 17479.300827966737, 17755.73366399505, 18028.729569056475, 18288.81711182871, 16908.40820571274, 17103.23035463407, 17416.564585885455, 17666.646667066845, 17983.64032719338, 9826.508674566243, 9928.50357482123, 9979.301448898652, 10060.295779295378, 10095.798084038424, 7717.729879454192, 8187.4678145920325, 8314.085450600309, 8440.324774017941, 8528.403011789364, 15466.922665387052, 15519.224038797789, 15575.454859080332, 15829.683406331578, 15979.920100399424, 14314.713705725619, 14902.552923412315, 15385.538433847003, 15907.522774316789, 16067.758983615022, 9767.0, 11206.663800086011, 11222.0, 11223.887761122285, 11228.270162439416, 12411.937940310241, 12531.122821402414, 12537.749245015231, 12591.307478088793, 12615.49538018469, 9879.703608891745, 10279.588816447258, 10312.48437578103, 10552.0, 10559.841602375816, 10087.899121008695, 10132.240081993732, 10199.215670914662, 10401.94799026, 10472.738181545523, 8997.145271199226, 9172.724818255463, 9202.309826762885, 9212.401193922373, 9273.53632318395, 5967.7016149191495, 6001.099835024781, 6125.84685382869, 6347.746090156342, 6471.676416179266, 6726.7981960541265, 6782.457403407814, 6800.897986530305, 6956.930430695628, 7000.229974702676], "value": 5965.971636940011, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.1583093362525, 494.91100284597934, 509.3429475975991, 513.4788189987166, 514.9304843846082, 6200.844978875531, 6263.498920086394, 6367.7771278005275, 6390.648514331716, 6390.744370225191, 6147.139400483936, 6166.722497487613, 6167.163104971718, 6241.469475094623, 6264.592801467913, 5022.974885125569, 5038.395392552899, 5042.319286896259, 5054.41874184468, 5075.086484432801, 5035.546800787928, 5050.46970068143, 5061.089003979282, 5072.72100034498, 5092.9236061459105, 4863.635227357945, 5018.322526458936, 5038.042771873351, 5066.18940969445, 5079.873003174913, 4994.475580064077, 4998.4751601081725, 5003.524665156804, 5004.84985450437, 5033.345665063555, 4462.107578484283, 4469.41897553316, 4472.239719247736, 4538.228501154812, 4541.3869127668, 6015.518758499309, 6073.817785466443, 6087.969560152215, 6092.72582733778, 6097.146399504073, 5702.54379649627, 5731.656100633975, 5733.627314224604, 5745.798897038625, 5767.423257674241, 6616.338366163393, 6618.900716489256, 6624.73501059957, 6655.735410272081, 6656.201255849329, 4865.878353041202, 4909.263610458424, 4932.630052746058, 4959.404871415417, 4965.478624744386, 6979.162500499921, 6995.160580730294, 6996.370326670573, 7041.718331266795, 7047.8590428191665, 5057.8735531612, 5083.694978301313, 5085.567726743194, 5087.567556757643, 5116.795328186831, 5121.820736274212, 5139.486051394831, 5145.511176438233, 5156.329677141947, 5184.326037615086, 5768.105943578752, 5770.942290577041, 5781.277340332458, 5789.131630255495, 5791.942080579224, 6620.569662971891, 6688.632125233159, 6702.710265430129, 6710.758509675726, 6712.597244165366, 1684.8399402056784, 1686.9831301687072, 1788.2131861980688, 1789.9642007159784, 1797.3260027489691, 1209.7096696792707, 1223.1254652923203, 1233.444949772606, 1234.4631781688715, 1255.554278231233, 5569.192467092249, 5652.812909289013, 5688.9715551422805, 5704.743286552115, 5747.540196784247, 6758.5331354055415, 6775.085363475966, 6799.660016999131, 6826.0, 6838.418734407631, 5764.193012978187, 5787.681677507693, 5800.274965629296, 5806.854828629233, 5816.738246778905, 3611.9705883822985, 3634.7092232621326, 3645.3256147612246, 3653.7990410527677, 3656.0, 6551.312112228243, 6559.8360040998405, 6567.6059436433015, 6583.967080164569, 6601.73593056282, 6928.896066559006, 6934.791956241321, 6937.895931561031, 6949.131358580177, 6972.79081627552, 6490.318516555788, 6494.253160886558, 6494.870102598016, 6511.902321465182, 6548.738050478118, 6779.694913728796, 6824.897626535507, 6834.658267086526, 6837.6581170942245, 6852.862942741018, 6753.932460675331, 6772.11962444879, 6789.762358317435, 6795.286494917962, 6805.638872225476, 6444.428909550381, 6501.837454063686, 6584.637844918384, 6598.802035938929, 6646.83382915431, 4939.0, 4991.326170967018, 5013.097642424399, 5047.4952504749235, 5053.191489361684, 6779.830504237433, 6832.795016149524, 6850.8972365413565, 6854.588724676535, 6871.381575658214, 6581.736730530725, 6595.142631457879, 6595.307492713196, 6605.0, 6651.470161862702, 6583.407493325623, 6587.901181482186, 6604.8348791280605, 6611.438027767501, 6623.661501716383, 6521.054447105238, 6525.249596296487, 6525.673716314261, 6525.9021114684265, 6534.313897040743, 6660.467162626881, 6664.50016248793, 6671.8999215010845, 6674.399304062657, 6705.798826035227, 6379.489640828815, 6397.296297407189, 6439.8068057958335, 6457.0, 6472.741090356333], "value": 5104.120365077507, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [850.0819115355416, 866.9436486628368, 871.1723862330783, 873.7029410000603, 877.2061284537493, 17449.825501744996, 17698.0, 17913.91043044786, 17995.0, 18054.729179062324, 19029.52426189346, 20281.0, 20347.593048139028, 20733.585328293462, 20736.688949665768, 1004.9095581397654, 1025.1696126137815, 1028.9948550257238, 1031.293563908725, 1031.9484025798718, 1042.9895701043006, 1043.191526566913, 1043.2384359417592, 1046.822040253155, 1048.103871190129, 1016.7102375822892, 1099.1371773158073, 1099.5052226498067, 1101.3997371432588, 1109.938953357565, 1048.4600430778155, 1076.0692001418756, 1079.4117206122603, 1083.8374243863404, 1085.8208395614713, 782.3076577229193, 785.7171418289412, 786.1156199275815, 787.9369650427952, 790.8260182759784, 18483.353082642177, 18698.158582863805, 19131.61736765257, 19297.0, 19307.4207773767, 19437.708434373497, 19831.206751729915, 19935.102920368474, 19993.200271989102, 20000.799992000186, 15024.248787560688, 15043.924780376137, 15089.54731358061, 15124.092554446768, 15133.924330378388, 3402.744794140425, 3498.160441494023, 3543.982280088583, 3549.804760738158, 3553.093961039944, 100276.49861750644, 102293.0, 103643.48178259136, 103831.96168038298, 104184.47907760413, 15285.159316237714, 15598.142102184489, 15735.606609834846, 15739.763903541456, 15811.130387828549, 27161.0, 27624.171274861787, 27725.86137069302, 27805.443891122064, 27827.0, 8066.919330806734, 8085.474444161111, 8125.228103330174, 8136.0, 8190.631421586043, 4062.268791617478, 4135.31767258399, 4141.068259641616, 4143.3784932260405, 4150.27370210212, 4970.15507363749, 5021.447640759514, 5037.773300201499, 5063.3417655704525, 5073.949260507421, 879.4767113567417, 904.2133343990639, 940.9623615055458, 943.9858402123974, 949.781550243434, 600.4535872356134, 668.5754545863412, 699.5697645947705, 699.6361891816227, 716.8243780273762, 10477.52851121686, 11057.336559806437, 11564.132690048113, 11758.3532905691, 11868.228565143238, 683.217715715503, 697.2260790522516, 707.2432497228019, 721.5201890742702, 733.4499125655758, 4829.613630909519, 4908.0, 5468.863278418072, 5634.267545219095, 5742.971285143631, 89874.0, 92034.53982730178, 94214.52892735493, 97316.51341743246, 97801.51099244459, 78135.0, 79987.20012799914, 81575.0, 81576.59211703904, 83519.0, 68747.31252687509, 72457.27542724505, 73662.6316868423, 74792.62603686946, 76453.23546764461, 10771.407572583583, 10949.945250273699, 11391.00110912403, 11500.712482187677, 11644.2431241969, 31147.221319467193, 31816.522752158275, 32422.67577324291, 32427.35145297128, 33338.66661333355, 40966.79516602398, 43414.56585434105, 43639.12721745611, 44156.558434415245, 44811.55188448204, 17073.74389384185, 17112.058836764096, 17841.553961151076, 18121.27514899442, 18287.542811429288, 20084.799152008294, 20121.99390030522, 20342.288019919233, 20377.592448151252, 20702.171913123308, 14043.719125617636, 14686.41254349814, 15224.391024359345, 15838.0, 15925.20373981273, 16181.59546011359, 16375.754363684793, 16474.0, 16495.83504164943, 16852.57868553296, 14944.178070205808, 16186.190690465664, 16204.432844850373, 16296.755548666542, 16670.083145427117, 12510.311932843417, 12758.0, 13018.80471792905, 13089.476420943056, 13424.597262082154, 12356.196847204903, 12416.255024698547, 12578.433970471533, 12716.173448725804, 13228.338583071001], "value": 8473.29235824688, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 108.0, 110.0, 107.0, 121.0, 109.0, 108.0, 107.0, 110.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 121.0, 151.0, 179.0, 127.0, 157.0, 153.0, 121.0, 168.0, 121.0], "value": 145.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 164.0, 162.0, 163.0, 173.0, 168.0, 172.0, 174.0, 165.0], "value": 167.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 78.0, 171.0, 76.0, 76.0, 76.0, 75.0, 110.0, 75.0], "value": 88.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 140.0, 82.0, 84.0, 82.0, 129.0, 82.0, 83.0, 135.0], "value": 98.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 114.0, 118.0, 114.0, 115.0, 115.0, 113.0, 117.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 153.0, 150.0, 151.0, 156.0, 150.0, 152.0, 151.0, 151.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 97.0, 102.0, 95.0, 94.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 55.0, 56.0, 57.0, 53.0, 59.0, 53.0, 54.0, 53.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 62.0, 54.0, 53.0, 54.0, 54.0, 54.0, 60.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 78.0, 78.0, 78.0, 79.0, 80.0, 77.0, 78.0, 77.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 133.0, 124.0, 126.0, 128.0, 133.0, 128.0, 137.0, 139.0, 161.0], "value": 133.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 181.0, 189.0, 192.0, 196.0, 188.0, 184.0, 198.0, 184.0, 189.0], "value": 189.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 70.0, 70.0, 72.0, 71.0, 73.0, 68.0, 67.0, 68.0, 68.0], "value": 70.2, "unit": "score"}]}]} 09:52:27 INFO - Return code: 0 09:52:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:52:27 INFO - # TBPL SUCCESS # 09:52:27 INFO - Running post-action listener: _resource_record_post_action 09:52:27 INFO - [mozharness: 2017-06-20 16:52:27.981381Z] Finished run-tests step (success) 09:52:27 INFO - Running post-run listener: _resource_record_post_run 09:52:28 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 435458048; Read time: 16; Write time: 372580 09:52:28 INFO - TinderboxPrint: CPU usage
13.3% 09:52:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:52:28 INFO - TinderboxPrint: I/O write bytes / time
435,458,048 / 372,580 09:52:28 INFO - TinderboxPrint: CPU idle
8,290.4 (86.7%) 09:52:28 INFO - TinderboxPrint: CPU user
1,214.5 (12.7%) 09:52:28 INFO - TinderboxPrint: Swap in / out
0 / 0 09:52:28 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 104984576; Read time: 0; Write time: 103512 09:52:28 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:52:28 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 329654272; Read time: 0; Write time: 269032 09:52:28 INFO - Running post-run listener: _upload_blobber_files 09:52:28 INFO - Blob upload gear active. 09:52:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:52: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 09:52: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'] 09:52: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 09:52:29 INFO - (blobuploader) - INFO - Open directory for files ... 09:52:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:52:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:52:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:52:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:52:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:52:35 INFO - (blobuploader) - INFO - Done attempting. 09:52:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:52:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:52:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:52:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:52:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:52:36 INFO - (blobuploader) - INFO - Done attempting. 09:52:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:52:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:52:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:52:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:52:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:52:37 INFO - (blobuploader) - INFO - Done attempting. 09:52:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:52:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:52:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:52:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:52:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:52:38 INFO - (blobuploader) - INFO - Done attempting. 09:52:38 INFO - (blobuploader) - INFO - Iteration through files over. 09:52:38 INFO - Return code: 0 09:52:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:52:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:52:38 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a262903aacaa3caa05d7eef36d3ac0845f71ba612bfb512fdbc6ef1358667c7c4f5584d33d2085f7f67ffc716de355bfb98669d5c199e1f806e68fd0f5fbc0c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4144d88fd802b5fdcd4bda9613200839ef62d95296335253e3716ac462f148ef3408d65502ed6075586b287c9aeda6c3299caec0d15d2bca52c62892c987400", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33e78986efb998bb8837896cef97e171cdad1cf557e7410928ec8739999c5393499c9f84e4ac7dec5debb7181c9372d54e2c851f06a69e4fba6166b5526dc4d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c711a25ddd2ae36c97c5c11e09d1bd3fd4b543a9604a35a087a2f738cab59d2d4fba9b24172bbc2a8db0003491df31f3958b6f69be22f483cfa76759bb664c54"} 09:52:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:52:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:52:38 INFO - Contents: 09:52:38 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a262903aacaa3caa05d7eef36d3ac0845f71ba612bfb512fdbc6ef1358667c7c4f5584d33d2085f7f67ffc716de355bfb98669d5c199e1f806e68fd0f5fbc0c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4144d88fd802b5fdcd4bda9613200839ef62d95296335253e3716ac462f148ef3408d65502ed6075586b287c9aeda6c3299caec0d15d2bca52c62892c987400", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33e78986efb998bb8837896cef97e171cdad1cf557e7410928ec8739999c5393499c9f84e4ac7dec5debb7181c9372d54e2c851f06a69e4fba6166b5526dc4d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c711a25ddd2ae36c97c5c11e09d1bd3fd4b543a9604a35a087a2f738cab59d2d4fba9b24172bbc2a8db0003491df31f3958b6f69be22f483cfa76759bb664c54"} 09:52:38 INFO - Running post-run listener: copy_logs_to_upload_dir 09:52:38 INFO - Copying logs to upload dir... 09:52:38 INFO - mkdir: /builds/slave/test/build/upload/logs 09:52:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.506163 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-06-20 09:52:37.210758) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-20 09:52:37.220468) ========= 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=232498196343f89f466a4a9a000001c8-1497955902.482075-185977431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a262903aacaa3caa05d7eef36d3ac0845f71ba612bfb512fdbc6ef1358667c7c4f5584d33d2085f7f67ffc716de355bfb98669d5c199e1f806e68fd0f5fbc0c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4144d88fd802b5fdcd4bda9613200839ef62d95296335253e3716ac462f148ef3408d65502ed6075586b287c9aeda6c3299caec0d15d2bca52c62892c987400", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33e78986efb998bb8837896cef97e171cdad1cf557e7410928ec8739999c5393499c9f84e4ac7dec5debb7181c9372d54e2c851f06a69e4fba6166b5526dc4d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c711a25ddd2ae36c97c5c11e09d1bd3fd4b543a9604a35a087a2f738cab59d2d4fba9b24172bbc2a8db0003491df31f3958b6f69be22f483cfa76759bb664c54"} build_url:https://queue.taskcluster.net/v1/task/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011038 build_url: 'https://queue.taskcluster.net/v1/task/Odpg4trQRASH_f5sLKD18w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a262903aacaa3caa05d7eef36d3ac0845f71ba612bfb512fdbc6ef1358667c7c4f5584d33d2085f7f67ffc716de355bfb98669d5c199e1f806e68fd0f5fbc0c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4144d88fd802b5fdcd4bda9613200839ef62d95296335253e3716ac462f148ef3408d65502ed6075586b287c9aeda6c3299caec0d15d2bca52c62892c987400", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33e78986efb998bb8837896cef97e171cdad1cf557e7410928ec8739999c5393499c9f84e4ac7dec5debb7181c9372d54e2c851f06a69e4fba6166b5526dc4d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c711a25ddd2ae36c97c5c11e09d1bd3fd4b543a9604a35a087a2f738cab59d2d4fba9b24172bbc2a8db0003491df31f3958b6f69be22f483cfa76759bb664c54"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-20 09:52:37.243771) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-20 09:52:37.248134) ========= 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=232498196343f89f466a4a9a000001c8-1497955902.482075-185977431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004391 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-20 09:52:37.328922) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-20 09:52:37.329242) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-20 09:52:37.329533) ========= ========= Total master_lag: 0.19 =========