builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-078 starttime: 1498010171.19 results: success (0) revision: c55e582aee5f4dd7c28cd9820156ecd0335e4e79 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-20 18:56:11.193588) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-20 18:56:11.194018) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-20 18:56:11.194304) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-20 18:56:11.242697) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-20 18:56:11.242977) ========= 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=dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-20 18:56:11-- 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% 50.2M=0s 2017-06-20 18:56:11 (50.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.176747 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-20 18:56:11.463069) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-20 18:56:11.463367) ========= 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=dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018355 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-20 18:56:11.512488) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-20 18:56:11.512798) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c55e582aee5f4dd7c28cd9820156ecd0335e4e79 --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 c55e582aee5f4dd7c28cd9820156ecd0335e4e79 --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=dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-20 18:56:11,678 truncating revision to first 12 chars 2017-06-20 18:56:11,678 Setting DEBUG logging. 2017-06-20 18:56:11,678 attempt 1/10 2017-06-20 18:56:11,678 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c55e582aee5f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-20 18:56:12,111 unpacking tar archive at: mozilla-central-c55e582aee5f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.811787 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-20 18:56:12.338652) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-20 18:56:12.341979) ========= script_repo_revision: c55e582aee5f4dd7c28cd9820156ecd0335e4e79 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-20 18:56:12.342352) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-20 18:56:12.342654) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-20 18:56:12.352227) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-06-20 18:56:12.352492) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:56:12 INFO - MultiFileLogger online at 20170620 18:56:12 in /builds/slave/test 18:56:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:56:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:56:12 INFO - {'append_to_log': False, 18:56:12 INFO - 'base_work_dir': '/builds/slave/test', 18:56:12 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:56:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:56:12 INFO - 'branch': 'Firefox-Non-PGO', 18:56:12 INFO - 'buildbot_json_path': 'buildprops.json', 18:56:12 INFO - 'config_files': ('talos/linux_config.py',), 18:56:12 INFO - 'default_actions': ('clobber', 18:56:12 INFO - 'read-buildbot-config', 18:56:12 INFO - 'download-and-extract', 18:56:12 INFO - 'populate-webroot', 18:56:12 INFO - 'create-virtualenv', 18:56:12 INFO - 'install', 18:56:12 INFO - 'setup-mitmproxy', 18:56:12 INFO - 'run-tests'), 18:56:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:56:12 INFO - 'download_minidump_stackwalk': True, 18:56:12 INFO - 'download_symbols': 'ondemand', 18:56:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:56:12 INFO - 'tooltool.py': '/tools/tooltool.py', 18:56:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:56:12 INFO - '/tools/misc-python/virtualenv.py')}, 18:56:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:56:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:56:12 INFO - 'gecko_profile': False, 18:56:12 INFO - 'gecko_profile_interval': 0, 18:56:12 INFO - 'installer_path': 'installer.exe', 18:56:12 INFO - 'log_level': 'info', 18:56:12 INFO - 'log_name': 'talos', 18:56:12 INFO - 'log_to_console': True, 18:56:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:56:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:56:12 INFO - 'opt_config_files': (), 18:56:12 INFO - 'pip_index': False, 18:56:12 INFO - 'suite': 'dromaeojs-e10s', 18:56:12 INFO - 'system_bits': '32', 18:56:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:56:12 INFO - 'title': 'talos-linux64-ix-078', 18:56:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:56:12 INFO - 'use_talos_json': True, 18:56:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:56:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:56:12 INFO - 'work_dir': 'build'} 18:56:12 INFO - [mozharness: 2017-06-21 01:56:12.735937Z] Running clobber step. 18:56:12 INFO - Running pre-action listener: _resource_record_pre_action 18:56:12 INFO - Running main action method: clobber 18:56:12 INFO - rmtree: /builds/slave/test/build 18:56:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:56:13 INFO - Running post-action listener: _resource_record_post_action 18:56:13 INFO - [mozharness: 2017-06-21 01:56:13.708023Z] Finished clobber step (success) 18:56:13 INFO - [mozharness: 2017-06-21 01:56:13.708122Z] Running read-buildbot-config step. 18:56:13 INFO - Running pre-action listener: _resource_record_pre_action 18:56:13 INFO - Running main action method: read_buildbot_config 18:56:13 INFO - Using buildbot properties: 18:56:13 INFO - { 18:56:13 INFO - "project": "", 18:56:13 INFO - "product": "firefox", 18:56:13 INFO - "who": "kwierso@gmail.com", 18:56:13 INFO - "installer_path": "public/build/target.tar.bz2", 18:56:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:56:13 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:56:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 18:56:13 INFO - "stage_platform": "linux64", 18:56:13 INFO - "basedir": "/builds/slave/test", 18:56:13 INFO - "buildnumber": 924, 18:56:13 INFO - "platform": "ubuntu64_hw", 18:56:13 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:56:13 INFO - "slavebuilddir": "test", 18:56:13 INFO - "taskId": "XMcSLiqRSRmVyYLTw4Voyg", 18:56:13 INFO - "branch": "mozilla-central", 18:56:13 INFO - "script_repo_revision": "production", 18:56:13 INFO - "revision": "c55e582aee5f4dd7c28cd9820156ecd0335e4e79", 18:56:13 INFO - "slavename": "talos-linux64-ix-078", 18:56:13 INFO - "repo_path": "mozilla-central" 18:56:13 INFO - } 18:56:13 INFO - Finding installer, test and symbols from parent task. 18:56:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XMcSLiqRSRmVyYLTw4Voyg'}, attempt #1 18:56:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XMcSLiqRSRmVyYLTw4Voyg'}, attempt #1 18:56:14 INFO - Task dependencies: GBreNVIdRyKCdB07FgIyDQ 18:56:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ'}, attempt #1 18:56:15 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/target.tar.bz2 18:56:15 INFO - Set test_url: https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/test_packages.json 18:56:15 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/target.crashreporter-symbols.zip 18:56:15 INFO - Running post-action listener: _resource_record_post_action 18:56:15 INFO - [mozharness: 2017-06-21 01:56:15.063542Z] Finished read-buildbot-config step (success) 18:56:15 INFO - [mozharness: 2017-06-21 01:56:15.063760Z] Running download-and-extract step. 18:56:15 INFO - Running pre-action listener: _resource_record_pre_action 18:56:15 INFO - Running main action method: download_and_extract 18:56:15 INFO - mkdir: /builds/slave/test/build/tests 18:56:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:15 INFO - trying https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/target.test_packages.json 18:56:15 INFO - Downloading https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:56:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:56:15 INFO - Downloaded 989 bytes. 18:56:15 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:56:15 INFO - Using the following test package requirements: 18:56:15 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:56:15 INFO - u'common': [u'target.common.tests.zip'], 18:56:15 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:56:15 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:56:15 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:56:15 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:56:15 INFO - u'mozbase': [u'target.common.tests.zip'], 18:56:15 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:56:15 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:56:15 INFO - u'web-platform': [u'target.common.tests.zip', 18:56:15 INFO - u'target.web-platform.tests.tar.gz'], 18:56:15 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:56:15 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:56:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/target.common.tests.zip 18:56:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:56:15 INFO - Fetch https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/target.common.tests.zip into memory 18:56:16 INFO - Content-Length response header: 67987494 18:56:16 INFO - Bytes received: 67987494 18:56:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:56:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/target.common.tests.zip 18:56:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:56:28 INFO - Fetch https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/target.common.tests.zip into memory 18:56:30 INFO - Content-Length response header: 67987494 18:56:30 INFO - Bytes received: 67987494 18:56:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/target.talos.tests.zip 18:56:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:56:43 INFO - Fetch https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/target.talos.tests.zip into memory 18:56:44 INFO - Content-Length response header: 14457064 18:56:44 INFO - Bytes received: 14457064 18:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:44 INFO - trying https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/target.tar.bz2 18:56:44 INFO - Downloading https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:56:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:56:45 INFO - Downloaded 59495364 bytes. 18:56:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/target.tar.bz2 18:56:45 INFO - mkdir: /builds/slave/test/properties 18:56:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:56:45 INFO - Writing to file /builds/slave/test/properties/build_url 18:56:45 INFO - Contents: 18:56:45 INFO - build_url:https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/target.tar.bz2 18:56:45 INFO - Running post-action listener: _resource_record_post_action 18:56:45 INFO - Running post-action listener: set_extra_try_arguments 18:56:45 INFO - [mozharness: 2017-06-21 01:56:45.932543Z] Finished download-and-extract step (success) 18:56:45 INFO - [mozharness: 2017-06-21 01:56:45.932639Z] Running populate-webroot step. 18:56:45 INFO - Running pre-action listener: _resource_record_pre_action 18:56:45 INFO - Running main action method: populate_webroot 18:56:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:56:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:56:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:56:45 INFO - '--tppagecycles', 18:56:45 INFO - '7'], 18:56:45 INFO - 'tests': ['tsvgm']}}, 18:56:45 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:56:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:56:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:56:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:56:45 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:56:45 INFO - 'talos_options': ['--disable-e10s'], 18:56:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:56:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:56:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:56:45 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:56:45 INFO - 'talos_options': ['--disable-e10s'], 18:56:45 INFO - 'tests': ['damp', 'tps']}, 18:56:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:56:45 INFO - 'tests': ['damp', 'tps']}, 18:56:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:56:45 INFO - 'tests': ['dromaeo_dom']}, 18:56:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:56:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:56:45 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:56:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:56:45 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:56:45 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:56:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:56:45 INFO - 'tests': ['a11yr', 18:56:45 INFO - 'ts_paint', 18:56:45 INFO - 'tpaint', 18:56:45 INFO - 'sessionrestore', 18:56:45 INFO - 'sessionrestore_no_auto_restore', 18:56:45 INFO - 'tabpaint']}, 18:56:45 INFO - 'other-e10s': {'tests': ['a11yr', 18:56:45 INFO - 'ts_paint', 18:56:45 INFO - 'tpaint', 18:56:45 INFO - 'sessionrestore', 18:56:45 INFO - 'sessionrestore_no_auto_restore', 18:56:45 INFO - 'tabpaint']}, 18:56:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:56:45 INFO - 'ts_paint', 18:56:45 INFO - 'tpaint', 18:56:45 INFO - 'sessionrestore', 18:56:45 INFO - 'sessionrestore_no_auto_restore', 18:56:45 INFO - 'tabpaint']}, 18:56:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:56:45 INFO - 'ts_paint', 18:56:45 INFO - 'tpaint', 18:56:45 INFO - 'sessionrestore', 18:56:45 INFO - 'sessionrestore_no_auto_restore', 18:56:45 INFO - 'tabpaint']}, 18:56:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:56:45 INFO - 'tests': ['a11yr', 18:56:45 INFO - 'ts_paint', 18:56:45 INFO - 'tpaint', 18:56:45 INFO - 'sessionrestore', 18:56:45 INFO - 'sessionrestore_no_auto_restore', 18:56:45 INFO - 'tabpaint']}, 18:56:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:56:45 INFO - 'tests': ['a11yr', 18:56:45 INFO - 'ts_paint', 18:56:45 INFO - 'tpaint', 18:56:45 INFO - 'sessionrestore', 18:56:45 INFO - 'sessionrestore_no_auto_restore', 18:56:45 INFO - 'tabpaint']}, 18:56:45 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 18:56:45 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 18:56:45 INFO - 'bloom_basic_ref']}, 18:56:45 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:56:45 INFO - 'talos_options': ['--mitmproxy', 18:56:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:56:45 INFO - '--firstNonBlankPaint'], 18:56:45 INFO - 'tests': ['quantum_pageload_google', 18:56:45 INFO - 'quantum_pageload_youtube', 18:56:45 INFO - 'quantum_pageload_amazon', 18:56:45 INFO - 'quantum_pageload_facebook']}, 18:56:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:56:45 INFO - 'tests': ['tsvgx', 18:56:45 INFO - 'tsvgr_opacity', 18:56:45 INFO - 'tart', 18:56:45 INFO - 'tscrollx', 18:56:45 INFO - 'cart', 18:56:45 INFO - 'tsvg_static']}, 18:56:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:56:45 INFO - 'tsvgr_opacity', 18:56:45 INFO - 'tart', 18:56:45 INFO - 'tscrollx', 18:56:45 INFO - 'cart', 18:56:45 INFO - 'tsvg_static']}, 18:56:45 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:56:45 INFO - 'talos_options': ['--disable-e10s'], 18:56:45 INFO - 'tests': ['tp5o']}, 18:56:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:56:45 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:56:45 INFO - 'talos_options': ['--disable-e10s', 18:56:45 INFO - '--xperf_path', 18:56:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:56:45 INFO - 'tests': ['tp5n']}, 18:56:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:56:45 INFO - 'talos_options': ['--xperf_path', 18:56:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:56:45 INFO - 'tests': ['tp5n']}}, 18:56:45 INFO - 'talos.zip': {'path': '', 18:56:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:56:45 INFO - Running post-action listener: _resource_record_post_action 18:56:45 INFO - [mozharness: 2017-06-21 01:56:45.947348Z] Finished populate-webroot step (success) 18:56:45 INFO - [mozharness: 2017-06-21 01:56:45.947436Z] Running create-virtualenv step. 18:56:45 INFO - Running pre-action listener: _resource_record_pre_action 18:56:45 INFO - Running main action method: create_virtualenv 18:56:45 INFO - Creating virtualenv /builds/slave/test/build/venv 18:56:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:56:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:56:45 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:56:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:56:46 INFO - Using real prefix '/usr' 18:56:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:56:46 INFO - Installing distribute.............................................................................................................................................................................................done. 18:56:48 INFO - Installing pip.................done. 18:56:48 INFO - Return code: 0 18:56:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:56:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:56:48 INFO - Reading from file tmpfile_stdout 18:56:48 INFO - Output received: 18:56:48 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:56:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b140>, '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 0x181ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181bed0>, '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': 'dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:56:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:56:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:56:48 INFO - Using env: {'DISPLAY': ':0', 18:56:48 INFO - 'HOME': '/home/cltbld', 18:56:48 INFO - 'LANG': 'en_US.UTF-8', 18:56:48 INFO - 'LANGUAGE': 'en_US:en', 18:56:48 INFO - 'LOGNAME': 'cltbld', 18:56:48 INFO - 'MAIL': '/var/mail/cltbld', 18:56:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:48 INFO - 'MOZ_NO_REMOTE': '1', 18:56:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:48 INFO - 'NO_EM_RESTART': '1', 18:56:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:48 INFO - 'PWD': '/builds/slave/test', 18:56:48 INFO - 'SHELL': '/bin/bash', 18:56:48 INFO - 'SHLVL': '1', 18:56:48 INFO - 'TERM': 'linux', 18:56:48 INFO - 'TMOUT': '86400', 18:56:48 INFO - 'USER': 'cltbld', 18:56:48 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355', 18:56:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:48 INFO - '_': '/tools/buildbot/bin/python'} 18:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:56:49 INFO - Cleaning up... 18:56:49 INFO - Return code: 0 18:56:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x149f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b140>, '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 0x181ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181bed0>, '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': 'dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:56:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:56:49 INFO - Using env: {'DISPLAY': ':0', 18:56:49 INFO - 'HOME': '/home/cltbld', 18:56:49 INFO - 'LANG': 'en_US.UTF-8', 18:56:49 INFO - 'LANGUAGE': 'en_US:en', 18:56:49 INFO - 'LOGNAME': 'cltbld', 18:56:49 INFO - 'MAIL': '/var/mail/cltbld', 18:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:49 INFO - 'MOZ_NO_REMOTE': '1', 18:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:49 INFO - 'NO_EM_RESTART': '1', 18:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:49 INFO - 'PWD': '/builds/slave/test', 18:56:49 INFO - 'SHELL': '/bin/bash', 18:56:49 INFO - 'SHLVL': '1', 18:56:49 INFO - 'TERM': 'linux', 18:56:49 INFO - 'TMOUT': '86400', 18:56:49 INFO - 'USER': 'cltbld', 18:56:49 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355', 18:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:49 INFO - '_': '/tools/buildbot/bin/python'} 18:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:49 INFO - Downloading/unpacking psutil>=3.1.1 18:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:56:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:56:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:56:50 INFO - Installing collected packages: psutil 18:56:50 INFO - Running setup.py install for psutil 18:56:50 INFO - building 'psutil._psutil_linux' extension 18:56:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:56:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:56:51 INFO - building 'psutil._psutil_posix' extension 18:56:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:56:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:56:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:56:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:56:51 INFO - Successfully installed psutil 18:56:51 INFO - Cleaning up... 18:56:52 INFO - Return code: 0 18:56:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:52 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 0x149f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b140>, '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 0x181ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181bed0>, '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': 'dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:56:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:56:52 INFO - Using env: {'DISPLAY': ':0', 18:56:52 INFO - 'HOME': '/home/cltbld', 18:56:52 INFO - 'LANG': 'en_US.UTF-8', 18:56:52 INFO - 'LANGUAGE': 'en_US:en', 18:56:52 INFO - 'LOGNAME': 'cltbld', 18:56:52 INFO - 'MAIL': '/var/mail/cltbld', 18:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:52 INFO - 'MOZ_NO_REMOTE': '1', 18:56:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:52 INFO - 'NO_EM_RESTART': '1', 18:56:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:52 INFO - 'PWD': '/builds/slave/test', 18:56:52 INFO - 'SHELL': '/bin/bash', 18:56:52 INFO - 'SHLVL': '1', 18:56:52 INFO - 'TERM': 'linux', 18:56:52 INFO - 'TMOUT': '86400', 18:56:52 INFO - 'USER': 'cltbld', 18:56:52 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355', 18:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:52 INFO - '_': '/tools/buildbot/bin/python'} 18:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:56:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:56:53 INFO - Installing collected packages: mozsystemmonitor 18:56:53 INFO - Running setup.py install for mozsystemmonitor 18:56:53 INFO - Successfully installed mozsystemmonitor 18:56:53 INFO - Cleaning up... 18:56:53 INFO - Return code: 0 18:56:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x149f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b140>, '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 0x181ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181bed0>, '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': 'dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:56:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:56:53 INFO - Using env: {'DISPLAY': ':0', 18:56:53 INFO - 'HOME': '/home/cltbld', 18:56:53 INFO - 'LANG': 'en_US.UTF-8', 18:56:53 INFO - 'LANGUAGE': 'en_US:en', 18:56:53 INFO - 'LOGNAME': 'cltbld', 18:56:53 INFO - 'MAIL': '/var/mail/cltbld', 18:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:53 INFO - 'MOZ_NO_REMOTE': '1', 18:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:53 INFO - 'NO_EM_RESTART': '1', 18:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:53 INFO - 'PWD': '/builds/slave/test', 18:56:53 INFO - 'SHELL': '/bin/bash', 18:56:53 INFO - 'SHLVL': '1', 18:56:53 INFO - 'TERM': 'linux', 18:56:53 INFO - 'TMOUT': '86400', 18:56:53 INFO - 'USER': 'cltbld', 18:56:53 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355', 18:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:53 INFO - '_': '/tools/buildbot/bin/python'} 18:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:53 INFO - Downloading/unpacking jsonschema==2.5.1 18:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:56:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:54 INFO - Downloading functools32-3.2.3-2.tar.gz 18:56:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:56:54 INFO - warning: no files found matching '*.txt' 18:56:54 INFO - no previously-included directories found matching 'build' 18:56:54 INFO - no previously-included directories found matching 'dist' 18:56:54 INFO - no previously-included directories found matching '.git*' 18:56:54 INFO - Installing collected packages: jsonschema, functools32 18:56:55 INFO - Running setup.py install for functools32 18:56:55 INFO - warning: no files found matching '*.txt' 18:56:55 INFO - no previously-included directories found matching 'build' 18:56:55 INFO - no previously-included directories found matching 'dist' 18:56:55 INFO - no previously-included directories found matching '.git*' 18:56:55 INFO - Successfully installed jsonschema functools32 18:56:55 INFO - Cleaning up... 18:56:55 INFO - Return code: 0 18:56:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:55 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 0x149f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b140>, '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 0x181ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181bed0>, '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': 'dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:56:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:56:55 INFO - Using env: {'DISPLAY': ':0', 18:56:55 INFO - 'HOME': '/home/cltbld', 18:56:55 INFO - 'LANG': 'en_US.UTF-8', 18:56:55 INFO - 'LANGUAGE': 'en_US:en', 18:56:55 INFO - 'LOGNAME': 'cltbld', 18:56:55 INFO - 'MAIL': '/var/mail/cltbld', 18:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:55 INFO - 'MOZ_NO_REMOTE': '1', 18:56:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:55 INFO - 'NO_EM_RESTART': '1', 18:56:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:55 INFO - 'PWD': '/builds/slave/test', 18:56:55 INFO - 'SHELL': '/bin/bash', 18:56:55 INFO - 'SHLVL': '1', 18:56:55 INFO - 'TERM': 'linux', 18:56:55 INFO - 'TMOUT': '86400', 18:56:55 INFO - 'USER': 'cltbld', 18:56:55 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355', 18:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:55 INFO - '_': '/tools/buildbot/bin/python'} 18:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:56:55 INFO - Cleaning up... 18:56:55 INFO - Return code: 0 18:56:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:55 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 0x149f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b140>, '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 0x181ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181bed0>, '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': 'dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:56:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:56:55 INFO - Using env: {'DISPLAY': ':0', 18:56:55 INFO - 'HOME': '/home/cltbld', 18:56:55 INFO - 'LANG': 'en_US.UTF-8', 18:56:55 INFO - 'LANGUAGE': 'en_US:en', 18:56:55 INFO - 'LOGNAME': 'cltbld', 18:56:55 INFO - 'MAIL': '/var/mail/cltbld', 18:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:55 INFO - 'MOZ_NO_REMOTE': '1', 18:56:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:55 INFO - 'NO_EM_RESTART': '1', 18:56:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:55 INFO - 'PWD': '/builds/slave/test', 18:56:55 INFO - 'SHELL': '/bin/bash', 18:56:55 INFO - 'SHLVL': '1', 18:56:55 INFO - 'TERM': 'linux', 18:56:55 INFO - 'TMOUT': '86400', 18:56:55 INFO - 'USER': 'cltbld', 18:56:55 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355', 18:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:55 INFO - '_': '/tools/buildbot/bin/python'} 18:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:55 INFO - Downloading/unpacking blobuploader==1.2.4 18:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:56 INFO - Downloading blobuploader-1.2.4.tar.gz 18:56:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:56:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:56:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:57 INFO - Downloading docopt-0.6.1.tar.gz 18:56:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:56:57 INFO - Installing collected packages: blobuploader, requests, docopt 18:56:57 INFO - Running setup.py install for blobuploader 18:56:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:56:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:56:57 INFO - Running setup.py install for requests 18:56:57 INFO - Running setup.py install for docopt 18:56:57 INFO - Successfully installed blobuploader requests docopt 18:56:57 INFO - Cleaning up... 18:56:57 INFO - Return code: 0 18:56:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:57 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 0x149f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b140>, '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 0x181ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181bed0>, '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': 'dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:56:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:56:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:56:57 INFO - Using env: {'DISPLAY': ':0', 18:56:57 INFO - 'HOME': '/home/cltbld', 18:56:57 INFO - 'LANG': 'en_US.UTF-8', 18:56:57 INFO - 'LANGUAGE': 'en_US:en', 18:56:57 INFO - 'LOGNAME': 'cltbld', 18:56:57 INFO - 'MAIL': '/var/mail/cltbld', 18:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:57 INFO - 'MOZ_NO_REMOTE': '1', 18:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:57 INFO - 'NO_EM_RESTART': '1', 18:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:57 INFO - 'PWD': '/builds/slave/test', 18:56:57 INFO - 'SHELL': '/bin/bash', 18:56:57 INFO - 'SHLVL': '1', 18:56:57 INFO - 'TERM': 'linux', 18:56:57 INFO - 'TMOUT': '86400', 18:56:57 INFO - 'USER': 'cltbld', 18:56:57 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355', 18:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:57 INFO - '_': '/tools/buildbot/bin/python'} 18:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:56:58 INFO - Running setup.py (path:/tmp/pip-LpA6DI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:56:58 INFO - Running setup.py (path:/tmp/pip-QK3pLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:56:58 INFO - Running setup.py (path:/tmp/pip-k0XDrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:56:58 INFO - Running setup.py (path:/tmp/pip-ot8bib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:56:58 INFO - Running setup.py (path:/tmp/pip-fqzmA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:56:58 INFO - Running setup.py (path:/tmp/pip-vRfeOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:56:58 INFO - Running setup.py (path:/tmp/pip-m80jcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:56:58 INFO - Running setup.py (path:/tmp/pip-pkndwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:56:58 INFO - Running setup.py (path:/tmp/pip-TGBXf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:56:58 INFO - Running setup.py (path:/tmp/pip-KL4ySq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:56:58 INFO - Running setup.py (path:/tmp/pip-DiP0W0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:56:58 INFO - Running setup.py (path:/tmp/pip-UNrPMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:56:59 INFO - Running setup.py (path:/tmp/pip-j3gDvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:56:59 INFO - Running setup.py (path:/tmp/pip-UMDjIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:56:59 INFO - Running setup.py (path:/tmp/pip-ev3_lL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:56:59 INFO - Running setup.py (path:/tmp/pip-53onDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:56:59 INFO - Running setup.py (path:/tmp/pip-mYZkZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:56:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:56:59 INFO - Running setup.py install for manifestparser 18:56:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:56:59 INFO - Running setup.py install for mozcrash 18:56:59 INFO - Running setup.py install for mozdebug 18:56:59 INFO - Running setup.py install for mozdevice 18:56:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:56:59 INFO - Running setup.py install for mozfile 18:56:59 INFO - Running setup.py install for mozhttpd 18:56:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:56:59 INFO - Running setup.py install for mozinfo 18:57:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:57:00 INFO - Running setup.py install for mozInstall 18:57:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:57:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:57:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:57:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:57:00 INFO - Running setup.py install for mozleak 18:57:00 INFO - Running setup.py install for mozlog 18:57:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:57:00 INFO - Running setup.py install for moznetwork 18:57:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:57:00 INFO - Running setup.py install for mozprocess 18:57:00 INFO - Running setup.py install for mozprofile 18:57:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:57:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:57:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:57:00 INFO - Running setup.py install for mozrunner 18:57:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:57:00 INFO - Running setup.py install for mozscreenshot 18:57:00 INFO - Running setup.py install for moztest 18:57:01 INFO - Running setup.py install for mozversion 18:57:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:57:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:57:01 INFO - Cleaning up... 18:57:01 INFO - Return code: 0 18:57:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:01 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 0x149f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b140>, '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 0x181ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181bed0>, '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': 'dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:57:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:57:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:57:01 INFO - Using env: {'DISPLAY': ':0', 18:57:01 INFO - 'HOME': '/home/cltbld', 18:57:01 INFO - 'LANG': 'en_US.UTF-8', 18:57:01 INFO - 'LANGUAGE': 'en_US:en', 18:57:01 INFO - 'LOGNAME': 'cltbld', 18:57:01 INFO - 'MAIL': '/var/mail/cltbld', 18:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:01 INFO - 'MOZ_NO_REMOTE': '1', 18:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:01 INFO - 'NO_EM_RESTART': '1', 18:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:01 INFO - 'PWD': '/builds/slave/test', 18:57:01 INFO - 'SHELL': '/bin/bash', 18:57:01 INFO - 'SHLVL': '1', 18:57:01 INFO - 'TERM': 'linux', 18:57:01 INFO - 'TMOUT': '86400', 18:57:01 INFO - 'USER': 'cltbld', 18:57:01 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355', 18:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:01 INFO - '_': '/tools/buildbot/bin/python'} 18:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:57:01 INFO - Running setup.py (path:/tmp/pip-avN1pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:57:01 INFO - Running setup.py (path:/tmp/pip-d5BNhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:57:01 INFO - Running setup.py (path:/tmp/pip-3aai3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:57:01 INFO - Running setup.py (path:/tmp/pip-WRn017-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:57:01 INFO - Running setup.py (path:/tmp/pip-9OO__v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:57:01 INFO - Running setup.py (path:/tmp/pip-6zJqyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:57:01 INFO - Running setup.py (path:/tmp/pip-kFOIrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:57:01 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)) 18:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:57:01 INFO - Running setup.py (path:/tmp/pip-XXMyct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:57:01 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)) 18:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:57:01 INFO - Running setup.py (path:/tmp/pip-EPsaYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:57:01 INFO - Running setup.py (path:/tmp/pip-Qvh0tO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:57:02 INFO - Running setup.py (path:/tmp/pip-YsJJpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:57:02 INFO - Running setup.py (path:/tmp/pip-mg9kR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:57:02 INFO - Running setup.py (path:/tmp/pip-vrFtE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:57:02 INFO - Running setup.py (path:/tmp/pip-OADQ8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:02 INFO - Running setup.py (path:/tmp/pip-QY3Wkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:57:02 INFO - Running setup.py (path:/tmp/pip-9a9OET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:57:02 INFO - Running setup.py (path:/tmp/pip-EKDw5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:57:02 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)) 18:57:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:03 INFO - Downloading blessings-1.6.tar.gz 18:57:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:57:03 INFO - Installing collected packages: blessings 18:57:03 INFO - Running setup.py install for blessings 18:57:03 INFO - Successfully installed blessings 18:57:03 INFO - Cleaning up... 18:57:03 INFO - Return code: 0 18:57:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:57:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:57:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:57:04 INFO - Reading from file tmpfile_stdout 18:57:04 INFO - Current package versions: 18:57:04 INFO - argparse == 1.2.1 18:57:04 INFO - blessings == 1.6 18:57:04 INFO - blobuploader == 1.2.4 18:57:04 INFO - docopt == 0.6.1 18:57:04 INFO - functools32 == 3.2.3-2 18:57:04 INFO - jsonschema == 2.5.1 18:57:04 INFO - manifestparser == 1.1 18:57:04 INFO - mozInstall == 1.13 18:57:04 INFO - mozcrash == 1.0 18:57:04 INFO - mozdebug == 0.1 18:57:04 INFO - mozdevice == 0.51 18:57:04 INFO - mozfile == 1.2 18:57:04 INFO - mozhttpd == 0.7 18:57:04 INFO - mozinfo == 0.10 18:57:04 INFO - mozleak == 0.1 18:57:04 INFO - mozlog == 3.4 18:57:04 INFO - moznetwork == 0.27 18:57:04 INFO - mozprocess == 0.25 18:57:04 INFO - mozprofile == 0.28 18:57:04 INFO - mozrunner == 6.13 18:57:04 INFO - mozscreenshot == 0.1 18:57:04 INFO - mozsystemmonitor == 0.3 18:57:04 INFO - moztest == 0.8 18:57:04 INFO - mozversion == 1.4 18:57:04 INFO - psutil == 3.1.1 18:57:04 INFO - requests == 1.2.3 18:57:04 INFO - wsgiref == 0.1.2 18:57:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:04 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 0x149f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b140>, '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 0x181ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181bed0>, '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': 'dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:57:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:57:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:57:04 INFO - Using env: {'DISPLAY': ':0', 18:57:04 INFO - 'HOME': '/home/cltbld', 18:57:04 INFO - 'LANG': 'en_US.UTF-8', 18:57:04 INFO - 'LANGUAGE': 'en_US:en', 18:57:04 INFO - 'LOGNAME': 'cltbld', 18:57:04 INFO - 'MAIL': '/var/mail/cltbld', 18:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:04 INFO - 'MOZ_NO_REMOTE': '1', 18:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:04 INFO - 'NO_EM_RESTART': '1', 18:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:04 INFO - 'PWD': '/builds/slave/test', 18:57:04 INFO - 'SHELL': '/bin/bash', 18:57:04 INFO - 'SHLVL': '1', 18:57:04 INFO - 'TERM': 'linux', 18:57:04 INFO - 'TMOUT': '86400', 18:57:04 INFO - 'USER': 'cltbld', 18:57:04 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355', 18:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:04 INFO - '_': '/tools/buildbot/bin/python'} 18:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:57:04 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:05 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:57:05 INFO - Installing collected packages: marionette-driver 18:57:05 INFO - Running setup.py install for marionette-driver 18:57:05 INFO - Successfully installed marionette-driver 18:57:05 INFO - Cleaning up... 18:57:05 INFO - Return code: 0 18:57:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:05 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 0x149f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b140>, '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 0x181ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181bed0>, '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': 'dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:57:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:57:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:57:05 INFO - Using env: {'DISPLAY': ':0', 18:57:05 INFO - 'HOME': '/home/cltbld', 18:57:05 INFO - 'LANG': 'en_US.UTF-8', 18:57:05 INFO - 'LANGUAGE': 'en_US:en', 18:57:05 INFO - 'LOGNAME': 'cltbld', 18:57:05 INFO - 'MAIL': '/var/mail/cltbld', 18:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:05 INFO - 'MOZ_NO_REMOTE': '1', 18:57:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:05 INFO - 'NO_EM_RESTART': '1', 18:57:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:05 INFO - 'PWD': '/builds/slave/test', 18:57:05 INFO - 'SHELL': '/bin/bash', 18:57:05 INFO - 'SHLVL': '1', 18:57:05 INFO - 'TERM': 'linux', 18:57:05 INFO - 'TMOUT': '86400', 18:57:05 INFO - 'USER': 'cltbld', 18:57:05 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355', 18:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:05 INFO - '_': '/tools/buildbot/bin/python'} 18:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:57:05 INFO - Cleaning up... 18:57:05 INFO - Return code: 0 18:57:05 INFO - Running post-action listener: _resource_record_post_action 18:57:05 INFO - Running post-action listener: _start_resource_monitoring 18:57:05 INFO - Starting resource monitoring. 18:57:05 INFO - [mozharness: 2017-06-21 01:57:05.921331Z] Finished create-virtualenv step (success) 18:57:05 INFO - [mozharness: 2017-06-21 01:57:05.922377Z] Running install step. 18:57:05 INFO - Running pre-action listener: _resource_record_pre_action 18:57:05 INFO - Running main action method: install 18:57:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:57:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:57:06 INFO - Reading from file tmpfile_stdout 18:57:06 INFO - Detecting whether we're running mozinstall >=1.0... 18:57:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:57:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:57:06 INFO - Reading from file tmpfile_stdout 18:57:06 INFO - Output received: 18:57:06 INFO - Usage: mozinstall [options] installer 18:57:06 INFO - Options: 18:57:06 INFO - -h, --help show this help message and exit 18:57:06 INFO - -d DEST, --destination=DEST 18:57:06 INFO - Directory to install application into. [default: 18:57:06 INFO - "/builds/slave/test"] 18:57:06 INFO - --app=APP Application being installed. [default: firefox] 18:57:06 INFO - mkdir: /builds/slave/test/build/application 18:57:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:57:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:57:23 INFO - Reading from file tmpfile_stdout 18:57:23 INFO - Output received: 18:57:23 INFO - /builds/slave/test/build/application/firefox/firefox 18:57:23 INFO - Running post-action listener: _resource_record_post_action 18:57:23 INFO - [mozharness: 2017-06-21 01:57:23.501816Z] Finished install step (success) 18:57:23 INFO - [mozharness: 2017-06-21 01:57:23.502159Z] Running setup-mitmproxy step. 18:57:23 INFO - Running pre-action listener: _resource_record_pre_action 18:57:23 INFO - Running main action method: setup_mitmproxy 18:57:23 INFO - Skipping: mitmproxy is not required 18:57:23 INFO - Running post-action listener: _resource_record_post_action 18:57:23 INFO - [mozharness: 2017-06-21 01:57:23.503766Z] Finished setup-mitmproxy step (success) 18:57:23 INFO - [mozharness: 2017-06-21 01:57:23.504082Z] Running run-tests step. 18:57:23 INFO - Running pre-action listener: _resource_record_pre_action 18:57:23 INFO - Running main action method: run_tests 18:57:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:57:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:57:23 INFO - Python 2.7.3 18:57:23 INFO - Return code: 0 18:57:23 INFO - grabbing minidump binary from tooltool 18:57:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:23 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 0x181b140>, '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 0x181ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181bed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:57:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:57:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:57:23 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:57:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:57:23 INFO - Return code: 0 18:57:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:57:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:57:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:57:23 INFO - ENV: RUST_BACKTRACE is now 1 18:57:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:57:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:57:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-078', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:57:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-078 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:57:23 INFO - Using env: {'DISPLAY': ':0', 18:57:23 INFO - 'HOME': '/home/cltbld', 18:57:23 INFO - 'LANG': 'en_US.UTF-8', 18:57:23 INFO - 'LANGUAGE': 'en_US:en', 18:57:23 INFO - 'LOGNAME': 'cltbld', 18:57:23 INFO - 'MAIL': '/var/mail/cltbld', 18:57:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:57:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:23 INFO - 'MOZ_NO_REMOTE': '1', 18:57:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:57:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:23 INFO - 'NO_EM_RESTART': '1', 18:57:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:23 INFO - 'PWD': '/builds/slave/test', 18:57:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:57:23 INFO - 'RUST_BACKTRACE': '1', 18:57:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:57:23 INFO - 'SHELL': '/bin/bash', 18:57:23 INFO - 'SHLVL': '1', 18:57:23 INFO - 'TERM': 'linux', 18:57:23 INFO - 'TMOUT': '86400', 18:57:23 INFO - 'USER': 'cltbld', 18:57:23 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355', 18:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:23 INFO - '_': '/tools/buildbot/bin/python'} 18:57:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-078', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:57:24 INFO - mozversion application_buildid: 20170621012444 18:57:24 INFO - mozversion application_changeset: c55e582aee5f4dd7c28cd9820156ecd0335e4e79 18:57:24 INFO - mozversion application_display_name: Nightly 18:57:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:57:24 INFO - mozversion application_name: Firefox 18:57:24 INFO - mozversion application_remotingname: firefox 18:57:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:57:24 INFO - mozversion application_vendor: Mozilla 18:57:24 INFO - mozversion application_version: 56.0a1 18:57:24 INFO - mozversion platform_buildid: 20170621012444 18:57:24 INFO - mozversion platform_changeset: c55e582aee5f4dd7c28cd9820156ecd0335e4e79 18:57:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:57:24 INFO - mozversion platform_version: 56.0a1 18:57:24 INFO - using testdate: 1498010244 18:57:24 INFO - actual date: 1498010244 18:57:24 INFO - starting webserver on 'localhost:39234' 18:57:24 INFO - SUITE-START | Running 2 tests 18:57:24 INFO - TEST-START | dromaeo_css 18:57:24 INFO - operating with platform_type : linux_ 18:57:24 INFO - Initialising browser for dromaeo_css test... 18:57:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39234/getInfo.html -profile /tmp/tmpvdawnN/profile 18:57:24 INFO - TEST-INFO | started process 3323 (/builds/slave/test/build/application/firefox/firefox http://localhost:39234/getInfo.html) 18:57:32 INFO - TEST-INFO | 3323: exit 0 18:57:32 INFO - Browser initialized. 18:57:32 INFO - Running cycle 1/1 for dromaeo_css test... 18:57:32 INFO - TEST-INFO | started process 3536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvdawnN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:57:44 INFO - PID 3536 | RSS: Main: 175079424 18:57:44 INFO - PID 3536 | 19:00:49 INFO - PID 3536 | Cycle 1(1): loaded http://localhost:39234/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39234/tests/dromaeo/cssquery-ext.html) 19:00:50 INFO - PID 3536 | RSS: Main: 178012160 19:00:50 INFO - PID 3536 | 19:03:52 INFO - PID 3536 | Cycle 1(1): loaded http://localhost:39234/tests/dromaeo/cssquery-ext.html (next: http://localhost:39234/tests/dromaeo/cssquery-jquery.html) 19:03:52 INFO - PID 3536 | RSS: Main: 177569792 19:03:52 INFO - PID 3536 | 19:06:54 INFO - PID 3536 | Cycle 1(1): loaded http://localhost:39234/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39234/tests/dromaeo/cssquery-mootools.html) 19:06:55 INFO - PID 3536 | RSS: Main: 180334592 19:06:55 INFO - PID 3536 | 19:09:56 INFO - PID 3536 | Cycle 1(1): loaded http://localhost:39234/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39234/tests/dromaeo/cssquery-prototype.html) 19:09:57 INFO - PID 3536 | RSS: Main: 177954816 19:09:57 INFO - PID 3536 | 19:12:59 INFO - PID 3536 | Cycle 1(1): loaded http://localhost:39234/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39234/tests/dromaeo/cssquery-yui.html) 19:13:00 INFO - PID 3536 | RSS: Main: 180293632 19:13:00 INFO - PID 3536 | 19:16:02 INFO - PID 3536 | Cycle 1(1): loaded http://localhost:39234/tests/dromaeo/cssquery-yui.html (next: http://localhost:39234/tests/dromaeo/cssquery-dojo.html) 19:16:02 INFO - PID 3536 | RSS: Main: 179421184 19:16:02 INFO - PID 3536 | 19:16:02 INFO - PID 3536 | __start_tp_report 19:16:02 INFO - PID 3536 | _x_x_mozilla_page_load 19:16:02 INFO - PID 3536 | _x_x_mozilla_page_load_details 19:16:02 INFO - PID 3536 | |i|pagename|runs| 19:16:02 INFO - PID 3536 | |0;dojo.html;3133.6552979172293;3133.9373212535734;3138.388014337204;3150.306932474855;3174.4603417419034;5890.88218235635;5899.321578018524;5922.496587790032;5962.0460726283745;5964.194833697449;6046.395360463963;6073.726682299296;6090.543209259312;6123.877522449548;6142.570020098595;5551.8889622207535;5609.971950140243;5637.069883469223;5658.632188907708;5687.345955215162;5598.104303311471;5716.456936591017;5735.967525845346;5749.482546570808;5768.048272035109;5687.2606561146995;5689.231953686241;5693.3452652945025;5716.714164291769;5719.370869204384;5602.803901863456;5699.430056994267;5701.77192912283;5708.486236238738;5712.800051998181;5423.647462914937;5528.917066244009;5534.833954981357;5545.223668686387;5545.694986775726;5952.970235148797;5953.821385358447;6000.819975400745;6007.519398448114;6011.909821352683;6503.187101612299;6554.672266386709;6578.144841170665;6582.901256481156;6603.537752357337;6576.210854697467;6647.667616619198;6648.5678430901835;6659.63372014539;6680.198376194888;6189.50483961282;6198.752049918043;6212.254529456494;6215.12988181655;6223.502119830403;6600.273969863311;6768.932310676929;6781.355771201728;6791;6834.1457317835275;6199.3490683477585;6270.843228919313;6296;6368.490520758328;6404.199475065617;6415.935840641534;6416.32628573993;6462.612243265419;6527.151470308924;6537.411632953057;6367.681615919186;6369.363063693686;6388.1376014237485;6388.361163883575;6395.680215989182;6354.17395738551;6417.679116044179;6448.613083215022;6456.0961465394885;6464.903026454607;5369.114096174166;5373.865653358697;5375.220593013991;5399.271098401666;5422.6475279106735;4601.861944141681;4633.4208223972;4653.325267836212;4653.418322709661;4691.155591993405;5558.833235002957;5740.253767010346;5743.798967036134;5747.195392645033;5756.65460072397;6376.426121649074;6471.7734879279;6477.190351206099;6490.350964903566;6526.543141980111;5662.66024038559;5718.313802343745;5752.511036561856;5753.424657534213;5777.191193232867;5858.326292476335;5874.118882167709;5875.882482350329;5876.853078673067;5881.794137205177;6441.323661015525;6451.1290975717675;6456.418922297016;6460.25707043696;6460.870782584416;6457.773977910751;6544.607323560602;6576.80269591913;6601.735930562723;6628.602283862983;6414.03789431589;6422.229332480132;6423.454006409507;6444.709988050643;6446.258680251831;6405.487560995016;6526.24948130971;6539.6403197824575;6548.1814773153355;6564.6389448580785;6693.029510720821;6707.5304728668525;6715.26132125456;6716.764913228014;6730.226024007302;6400.45596124316;6403;6416.807495775134;6424.775132870327;6493.610383377012;6232.283287422005;6295.464885484785;6320.051992201206;6343;6357.650329231937;6283.465905398092;6315.242170939517;6366.522510811615;6381.553291269566;6390.93609063922;6490.8052758417325;6520.510961677988;6541.2477565078725;6551.934480655133;6556;6278.497720182283;6285;6286.339934306832;6298.433141017331;6302.1492098566105 19:16:02 INFO - PID 3536 | |1;ext.html;728.2244409703666;760.2131793593632;773.5552057566899;794.5034353529046;805.7945223967887;40230.597694023054;40280.59719402805;40894.795526022404;40954.59045409545;41022.99999999996;35898.8205058975;36132.2773544529;36147;36192.276154476895;36195;6698.095757072793;6772.966135169318;6809.387155156035;6833.043373927654;6860.108185935846;6740.5618634788825;6860.794176174722;6868.038474613558;6877.277885821966;6879.415249703781;6807.863842723167;6839.281875403086;6850.554713943603;6860;6876.346747059021;6786.049953006583;6797.932020679779;6818.113645226138;6818.863622727543;6864.210615779174;6056.697165141725;6100.847478813021;6189.16446279751;6194.225721784777;6202.441780239755;31934.520982185284;32124.83937580297;32142;32321.83839080813;32352.676473235202;3227.289996200832;3285.3100848821778;3297.159224397787;3455;3504.5969713483023;30162.396752064837;30424;30456.69543304583;30456.8477157615;30463.847680761453;3456.9827150864085;3518.7185025197923;3539.3983022886173;3547.5565554305713;3548.290341931624;188438;191353;192453.9999999986;194766;196567;48283.75858120757;48514.75742621335;48771.512284877404;48926.75536622294;49255;50657.24014139791;50720;51092.74453627708;51234.23148652773;51244.487555123975;15111.924440377728;15206.46777362787;15355.846441535665;15377.615559610875;15378.154201519024;12599.622011339674;12637.494500220073;12666.49334026647;12677;12691.93654031724;14139.575812725634;14196.432142714175;14231;14265.286735663176;14371.425142994372;5735.283089613798;5748.827535173951;5762.855928601818;5945.702714864239;6009.278886533557;989.6684610655511;1005.2360206243162;1008.9293749437616;1032.7779527401644;1041.8280983637767;21824.89087554552;22692.432689182904;22721.886390568274;23224.4193895154;23551.175708850107;1090.2368342160519;1091.1194446660822;1118.7986162490668;1120.8318752187238;1131.2025022359217;11537.88462115385;11642.079056955508;12076.577319793765;12266.81599776004;12348.753024939451;233052;233083;234326;235438;235895;49878.25182622264;50077.24884126741;50213.24680129801;50247.24629130566;50325.74837125791;1432.0906224547487;1438.7266419380494;1474.5134105745078;1484.9034812737139;1486.7175236705207;21723;22017.53346759898;22091.116355345606;22753.544929101656;22965.196218132285;35592.644073558935;35631.10922226965;35684.821575891954;35689.286214276086;35766.105847354025;192032;192290;192384;192543;193287;33130;34665.82667086648;36469.08827279339;36709.63290367062;36709.81645091758;41824.79087604542;42965.35551966786;44764;44771.32843007292;44843.77578112089;30272.54591181178;30545;31315.373692525565;32088.358232834744;33491.33017339591;30880.69119308868;30961.845190773904;31766.364672705953;32589.511157333134;32843.50734738933;35097.473537897466;35464;35676.46485302774;37025.814870925475;37336.43995340018;30047.248818779706;31853.522197166596;32016;32264.516032259064;32704.50943235901;22970.770292297533;24173;25387.61918571186;25409.745902540737;25481.87259063693 19:16:02 INFO - PID 3536 | |2;jquery.html;549.4834855236076;554.1272495819081;566.501478698745;571.2373980735717;591.0985746736227;20301.39095827126;21682.24112156075;21857.781422185773;21881.452963675914;21904.99999999998;23515.176968806096;24368.634470482957;25419.872900635517;25500;25535.61696574553;6319.431251187392;6415.582987105847;6466.805995820133;6466.967665161667;6470.158879345702;6400.39196276353;6435.646039467827;6461.935380646204;6474.352564743535;6488.383603557654;5665.66006039639;5974.193483879686;6149.13912052313;6420.7752728654505;6442;6174.876502469971;6246.344133865924;6266.811995640115;6280.874382512324;6289.40250676185;5848.093545500455;5851.473367396912;5853.414658534155;5860.589758716891;5868.41315868414;27663.723362766315;28367.716322836714;28843.855780721173;28957;29075.418491630047;1917.1947781931483;1977.6440240756658;1982.8017198280202;1988.204718112752;1988.2146552111835;16821.747673784903;17313.480595582154;17324.56688582783;17328.826711732974;17352.47942561725;2290.988545057264;2329.7670232976734;2336.5794157051723;2346.636271377939;2353.8587684738973;129734;132564;132792.67207327898;133074.3346283272;133542;13849.376778045013;14476.34856431463;14604.152190322997;14646.194459304628;14917.776233356508;23562.29313120609;23575.528489430115;23576.882115589313;23705.40736481602;23779.643305350433;9513.952430237943;9730.708078757649;9902.752431189278;9915.55380007887;9916.405015699082;8774.912250877409;8947;9007.63969441215;9078.31912606544;9086.909130908738;8814.294856411472;8919.643214271357;8921.509316987498;8932.553372331358;8962.193402593797;2572.6655534780357;2634.6048092785854;2723.155821695281;2821.3651928315967;2862.7137286271204;931.2410385535767;952.2382094324513;966.1449617088787;970.6263088710897;981.8183636027358;18475.630487390445;19096.331628393218;19413.93223372728;19494;19516.70724939127;988.649029594498;997.9950100249453;1033.2973577967055;1035.5598870480017;1042.9165666746642;10287;10590.788184236271;10730.912361069004;10765.461726913623;11046.558137674403;486633;487152;499489;512146;513967;103463;105779.47110264553;106302;106404.46797765962;108274.45862770636;1121.4168632311153;1126.2116518437126;1159.1538177130742;1163.4822503985815;1166.7783121206944;15840.524784256491;16122.435714750396;16784.9089809162;16931.407400740914;17028.233729481955;46479.535204647524;48080.759596201795;48332.27501587409;48577.27134093062;49939.250911235635;62978.68510657417;63676;64424.677876610316;64621;64645.67677161584;12342.197757145757;12744.808827867404;12802.295873727035;12956.481740730642;13046.804297935349;17299.82700172982;17388.217530210917;17537.386191483238;17563;18838.52903677419;12737;15436.073835569901;15637.218139092773;15674.294656740247;15779.605509862346;13724.45102195901;13826.239556824472;14064;14174.29128543548;14297.070690405091;16061.357545698042;16133.112678802778;16162.838371616133;16301.51095467138;16399.42602008924;12849.164804287691;12892.871071289166;12930.094893357375;12939.288339141438;12942.158759680591;14421.855781442051;15336.923315383352;15379.461718839786;15484.458043968407;15740.134292614017 19:16:02 INFO - PID 3536 | |3;mootools.html;1362.3869258833524;1418.2766788937645;1423.8718515333624;1424.61535385446;1428.164523753604;11882.584109556166;12431.813522797154;12455.252684838893;12549.811752823704;12553.184043037196;12929;13358.66603334917;13405.93297033516;13409.597712068653;13503;2473.122041675206;2530.228280374485;2537.264193383926;2537.7716005559496;2538.4923015396994;2417.528581926525;2513.6983561972497;2519.5212909547217;2520.836145650536;2532.6580911576884;2456.4227406559444;2487;2507.4608959073794;2515.346010037394;2521.722610512842;2357.104300365867;2402.95194096118;2413.891374888134;2416.299273210767;2416.8791560422083;2410.6504556839336;2471.888765005579;2483.428811373376;2513.1204078572537;2515.3208633668805;12631.178973366701;12682.239065656091;12942.352882355939;12944.223346599234;12962.48150073996;6921.792346229621;7162.570245785269;7172.892406613905;7174.174969878426;7181.066461360042;4247.341662042389;4373.759443230621;4465.888352791174;4489.416375871148;4527.705699129546;1559.2983157579135;1608.203939050166;1619.7489389144584;1645.8025036995637;1680.3194706144031;17488.300467981266;18019.909900450544;20355.491112722302;20515.281965131297;20584.79415205844;5496.587755918322;5646.4353564644025;5870.7945221917025;5947.5539334550085;5990.850228744229;14696.706065878836;14707.264636768119;14720.779188312184;14743.189124598035;14758.778618320734;6947.201071876799;6962.930370696329;7005.719771209095;7017.438604911595;7053.400460960773;6257.968710156511;6521.217453905561;6538.705758240891;6565.967170164118;6592.571482853599;4549.545045495424;4717.787699553528;4730.385049943554;4754.144254034307;4804.25534042224;1351.3310911098872;1363.986360136406;1376.4631793600504;1385.5219949117538;1393.470481217131;894.865770134485;896.0859922878627;898.0480690468124;929.1080562659787;929.9209567186865;7038.507304488637;7051.612161331176;7292.854142917218;7451.701931922662;7538.773836784905;678.6911955060435;720.8450183210634;725.5791640848296;734.5299008634478;744.6611791634793;4518.81924723014;4583.702059366131;4617.699849509839;4760.738159401197;4943.752812359367;16797.244124014447;17649.38227162043;17804.37684681056;17822.198001089724;17867.285308587772;16609.08650024236;17087.487375378758;17200.827991720173;17243.913780431016;17360;9696.660616878375;9791.608335666637;10272.794544109076;10303.227257955683;10324.638637647797;7613.467057305936;7672.485575904616;7701.961490192513;7747.573883436465;7937.920620793718;14507;15437.84562154364;15533.689326213638;15573.454929077428;15579.688406231586;15798.526044218692;15827.287772050515;15914.602134946255;16106;16223.918880405523;9581.281403894596;9614.423134611945;9671.371360861522;9724.805503889742;9895.703128906145;12122.27266364021;12319.63041108768;12320.630381088224;12360.320182390054;12373.195742276723;9802;10013.549390277602;10111.7472063199;10318;10678.878717734526;9601.855972160563;9844.114029737359;9899.653512127328;9904.108630223314;9996.450195239331;8909.109089091038;9051.411658242194;9067.365284430027;9113.179813816789;9120.042395548371;6498.740050397932;6649.069130321662;6783.966080169567;6788;6849.794506164823;6780.491463140185;6903.0680858083515;6957.9304206959305;7054.4003759681;7116.359527642537 19:16:02 INFO - PID 3536 | |4;prototype.html;471.8820294926268;498.2600837755933;502.21403503516973;505.0908364943102;505.35062444758495;6247.281562620295;6266.122742816004;6310.873782524347;6353.332900045487;6365.872682546346;6051.636901785896;6191.876162476748;6223.1287619733275;6226.816904788098;6280.968595157018;4995.350604421438;5011.599072074244;5020.272060551218;5022.648414610979;5057.747112644372;5031.974840125813;5077.238414237857;5081.237814327862;5081.5172558607055;5082.110630639641;4835.274708793674;5029.446760856303;5040;5041.672291301072;5045.183733855809;4971.453140154598;4972.303877457159;5019.447860735316;5020.7740651670765;5027.698338099707;4445.155420470132;4447.666425018104;4493.078918821634;4499.347594598765;4499.842505512292;6076.969615151896;6082.354175933483;6092.786752463642;6110.816675499742;6112.6638034908065;5723.311623071162;5741.167530708024;5743.396943320975;5776.566757493205;5783.768649254025;6590.703418346186;6651.866962660768;6652.600843949379;6674.399304062609;6700.195976482853;4869.415670119608;4917.336159618441;4921.18800397934;4921.311016457699;4936;6958.721651133948;6970.4075153612;7036.226015138331;7044.189918159426;7065.491750428575;5049.6212784041345;5061.746912654353;5062.848114556569;5071.3153724247495;5077.923831142536;5130.974345128325;5141.485851414828;5141.53726164647;5147.198480531784;5153.4073581538605;5767.423257674283;5785.103308987113;5795;5799.797007104731;5809.477147056785;6716;6728.856094463953;6732.596044237362;6737.191537015589;6748.156480439945;1658.1792012953665;1769.195016267595;1776.786785585738;1779.2527138601818;1782.3138091834737;1154.1459320103231;1206.8314213571532;1211.3640338822013;1212.763511115324;1214.1197631716934;5604;5696.3511966935575;5714.314282286152;5716.628009277743;5752.683602401824;6629.403353698191;6716.429103526255;6808.71051237727;6849.417799487;6856.965715171492;5800.187973683687;5812.140115163192;5827.184194212814;5829.941700583025;5832.62087964281;3564.912701625977;3594.8022858742497;3609.7653652512504;3610.9277814443562;3619.4027985382118;6512.902306465407;6555.016747487915;6577.6711164441585;6590.901136482957;6637.734490620418;6955.513114081966;6976;6985;6997.755078572327;7009.754658586925;6604.438622717123;6630.767923122764;6637.369449902251;6647.169103862017;6650.800475985729;6737.0462565857315;6773.89839152423;6801.795946121624;6809.795706128824;6812.21659509143;6783.864322713617;6787.21946976104;6793.898091528532;6817.181938167451;6833.692483838338;6159.199304090619;6600.636964966973;6614.272430032596;6615.933840661532;6625.701843416961;4964.429090654621;4972.975135124301;5016.749162541785;5020.995800839773;5038.874028149326;6840.213375461885;6882.965585172243;6899.310068993262;6901.551399159039;6917.584944903322;6664.966675166593;6681.665916704243;6687.866242675022;6688.899666505104;6692.263850976486;6649.434798042221;6657.866842663217;6681.599104053772;6683.832904177434;6697.665116744241;6553.606783593;6573.934260657332;6574.27682954865;6591.868162636816;6603.636799976048;6671.8999215010845;6716.664166791738;6723.361280678328;6731.966340168267;6752.885773847456;6459.806205813833;6467.417932386108;6469.7412103515335;6486.351364863476;6496.415322620986 19:16:02 INFO - PID 3536 | |5;yui.html;862.6764963138819;882.4749274181862;886.6231851463126;893.9910600893993;894.0523045571695;16749;17183.742243866338;17243.74134387982;17253;17445.127743612815;16318.428854990078;16538.66922661546;16541.090240036792;17428.215730292137;19285.90357048216;1042.5360714482058;1068.743501559628;1074.656110044786;1074.7689246811933;1075.6665433715534;1035.140833108522;1046.3303485769113;1047.8637777089007;1055.3615062886959;1056.5034433816095;1130.0789856267115;1139.5954436175164;1141.2068612314445;1144.256233448257;1144.525022115825;1037.8028174646793;1099.7525556749747;1102.6747109602607;1116.8213085906257;1120.4453795371303;798.972035978738;807.4711064252865;808.3290868579065;810.222186700768;812.5327936436513;17867.017314047724;17880.46358609244;17953.461396158134;18010;18048.90975545127;18576.62846743071;19734.506637334038;19780.010999450114;19835.30576429818;20033;14605.70788584233;14983;15043.473478428312;15074.02018868781;15178.468753593681;3561.0385195996937;3620.583632882226;3621.3662609043577;3621.619729928346;3628.51015112959;89936;91016.08983910209;91663.54168229183;92423.53788231083;93767.53116234374;15445.150516721687;15511.689766204612;15886.76169857453;16112.919435402748;16149.354025838835;27154.45691086167;27973.580396294074;28038;28159.451230182538;28345.71654283472;8559.315254779603;8585.656573737106;8606.741797746077;8610.698625548075;8614.483131012159;3926.1755031443718;3936.3505021671103;3944.783036932939;3969.8213580388374;3974.6224108709625;4560.68075234737;4700.318453824177;4709.505501922317;4711.905761884812;4714.4106986626675;1015.4465816130079;1036.512838965685;1042.9634962776418;1050.1231471721198;1051.7738686182508;676.5399528320789;682.1745687717917;686.7321744519642;714.8856183010694;723.5260904107818;12076;12255.509779608716;13409.865901340861;14198.361073751706;14920.776188357184;672.8351553869236;689.4174422612884;718.5509056839476;723.8769409200448;725.3834240895197;5279.947200528022;5935.6735379553675;5972.671503067373;6323.936760632427;6517.110038088901;89885;91278.54360728154;93726.5313673441;94359.52820235855;96374;79310.6034469824;82700.99999999879;83605.58197208976;85115;86593;69638;72739;75193.62403187949;75892.62053689807;76014.61992690111;11302.265352752045;11634.301941883175;11667.004654337428;11692;13057.804132938203;32852.835735821165;34446.655533445344;34679.826600866836;34813.65186348104;34879.302413952086;62020.37979620326;62358.37641623526;64330.356696432435;64685.67657161684;66403.33596663972;17980.730289045412;18957.620847583246;19031.90484047571;19126.617467650292;19135.52161195981;19684.409467715417;19933.60132797365;20017.29939452112;20115.39653810388;20141.6978745316;17601.911990439967;18258.36095736696;18278.634427311114;18385;18708.25166993305;18180.81819181791;18197.81802182014;18285.085745712397;18417.723734143732;18539.907300463412;17351.392701255394;17841.197146128714;17850.821491784915;17886.821131788514;17919.641607167523;12686.619401417604;13214.141080829715;13447.596572102853;13882.861171388156;13976.532464091531;13174.670633234246;13338.399772010089;13694.726105478034;13820;13991.510297139552 19:16:02 INFO - PID 3536 | __end_tp_report 19:16:02 INFO - PID 3536 | __start_cc_report 19:16:02 INFO - PID 3536 | _x_x_mozilla_cycle_collect,360 19:16:02 INFO - PID 3536 | __end_cc_report 19:16:02 INFO - PID 3536 | __startTimestamp1498011362631__endTimestamp 19:16:02 INFO - PID 3536 | 19:16:02 INFO - PID 3536 | ------- Summary: start ------- 19:16:02 INFO - PID 3536 | Number of tests: 6 19:16:02 INFO - PID 3536 | 19:16:02 INFO - PID 3536 | [#0] dojo.html Cycles:165 Average:6047.28 Median:6295.46 stddev:690.11 (11.0%) stddev-sans-first:653.28 19:16:02 INFO - PID 3536 | Values: 3133.7 3133.9 3138.4 3150.3 3174.5 5890.9 5899.3 5922.5 5962.0 5964.2 6046.4 6073.7 6090.5 6123.9 6142.6 5551.9 5610.0 5637.1 5658.6 5687.3 5598.1 5716.5 5736.0 5749.5 5768.0 5687.3 5689.2 5693.3 5716.7 5719.4 5602.8 5699.4 5701.8 5708.5 5712.8 5423.6 5528.9 5534.8 5545.2 5545.7 5953.0 5953.8 6000.8 6007.5 6011.9 6503.2 6554.7 6578.1 6582.9 6603.5 6576.2 6647.7 6648.6 6659.6 6680.2 6189.5 6198.8 6212.3 6215.1 6223.5 6600.3 6768.9 6781.4 6791.0 6834.1 6199.3 6270.8 6296.0 6368.5 6404.2 6415.9 6416.3 6462.6 6527.2 6537.4 6367.7 6369.4 6388.1 6388.4 6395.7 6354.2 6417.7 6448.6 6456.1 6464.9 5369.1 5373.9 5375.2 5399.3 5422.6 4601.9 4633.4 4653.3 4653.4 4691.2 5558.8 5740.3 5743.8 5747.2 5756.7 6376.4 6471.8 6477.2 6490.4 6526.5 5662.7 5718.3 5752.5 5753.4 5777.2 5858.3 5874.1 5875.9 5876.9 5881.8 6441.3 6451.1 6456.4 6460.3 6460.9 6457.8 6544.6 6576.8 6601.7 6628.6 6414.0 6422.2 6423.5 6444.7 6446.3 6405.5 6526.2 6539.6 6548.2 6564.6 6693.0 6707.5 6715.3 6716.8 6730.2 6400.5 6403.0 6416.8 6424.8 6493.6 6232.3 6295.5 6320.1 6343.0 6357.7 6283.5 6315.2 6366.5 6381.6 6390.9 6490.8 6520.5 6541.2 6551.9 6556.0 6278.5 6285.0 6286.3 6298.4 6302.1 19:16:02 INFO - PID 3536 | 19:16:02 INFO - PID 3536 | [#1] ext.html Cycles:180 Average:36933.43 Median:18213.58 stddev:53865.98 (295.7%) stddev-sans-first:53948.49 19:16:02 INFO - PID 3536 | Values: 728.2 760.2 773.6 794.5 805.8 40230.6 40280.6 40894.8 40954.6 41023.0 35898.8 36132.3 36147.0 36192.3 36195.0 6698.1 6773.0 6809.4 6833.0 6860.1 6740.6 6860.8 6868.0 6877.3 6879.4 6807.9 6839.3 6850.6 6860.0 6876.3 6786.0 6797.9 6818.1 6818.9 6864.2 6056.7 6100.8 6189.2 6194.2 6202.4 31934.5 32124.8 32142.0 32321.8 32352.7 3227.3 3285.3 3297.2 3455.0 3504.6 30162.4 30424.0 30456.7 30456.8 30463.8 3457.0 3518.7 3539.4 3547.6 3548.3 188438.0 191353.0 192454.0 194766.0 196567.0 48283.8 48514.8 48771.5 48926.8 49255.0 50657.2 50720.0 51092.7 51234.2 51244.5 15111.9 15206.5 15355.8 15377.6 15378.2 12599.6 12637.5 12666.5 12677.0 12691.9 14139.6 14196.4 14231.0 14265.3 14371.4 5735.3 5748.8 5762.9 5945.7 6009.3 989.7 1005.2 1008.9 1032.8 1041.8 21824.9 22692.4 22721.9 23224.4 23551.2 1090.2 1091.1 1118.8 1120.8 1131.2 11537.9 11642.1 12076.6 12266.8 12348.8 233052.0 233083.0 234326.0 235438.0 235895.0 49878.3 50077.2 50213.2 50247.2 50325.7 1432.1 1438.7 1474.5 1484.9 1486.7 21723.0 22017.5 22091.1 22753.5 22965.2 35592.6 35631.1 35684.8 35689.3 35766.1 192032.0 192290.0 192384.0 192543.0 193287.0 33130.0 34665.8 36469.1 36709.6 36709.8 41824.8 42965.4 44764.0 44771.3 44843.8 30272.5 30545.0 31315.4 32088.4 33491.3 30880.7 30961.8 31766.4 32589.5 32843.5 35097.5 35464.0 35676.5 37025.8 37336.4 30047.2 31853.5 32016.0 32264.5 32704.5 22970.8 24173.0 25387.6 25409.7 25481.9 19:16:02 INFO - PID 3536 | 19:16:02 INFO - PID 3536 | [#2] jquery.html Cycles:180 Average:33357.58 Median:2341.61 stddev:83718.83 (3575.3%) stddev-sans-first:83917.44 19:16:02 INFO - PID 3536 | Values: 549.5 554.1 566.5 571.2 591.1 20301.4 21682.2 21857.8 21881.5 21905.0 23515.2 24368.6 25419.9 25500.0 25535.6 6319.4 6415.6 6466.8 6467.0 6470.2 6400.4 6435.6 6461.9 6474.4 6488.4 5665.7 5974.2 6149.1 6420.8 6442.0 6174.9 6246.3 6266.8 6280.9 6289.4 5848.1 5851.5 5853.4 5860.6 5868.4 27663.7 28367.7 28843.9 28957.0 29075.4 1917.2 1977.6 1982.8 1988.2 1988.2 16821.7 17313.5 17324.6 17328.8 17352.5 2291.0 2329.8 2336.6 2346.6 2353.9 129734.0 132564.0 132792.7 133074.3 133542.0 13849.4 14476.3 14604.2 14646.2 14917.8 23562.3 23575.5 23576.9 23705.4 23779.6 9514.0 9730.7 9902.8 9915.6 9916.4 8774.9 8947.0 9007.6 9078.3 9086.9 8814.3 8919.6 8921.5 8932.6 8962.2 2572.7 2634.6 2723.2 2821.4 2862.7 931.2 952.2 966.1 970.6 981.8 18475.6 19096.3 19413.9 19494.0 19516.7 988.6 998.0 1033.3 1035.6 1042.9 10287.0 10590.8 10730.9 10765.5 11046.6 486633.0 487152.0 499489.0 512146.0 513967.0 103463.0 105779.5 106302.0 106404.5 108274.5 1121.4 1126.2 1159.2 1163.5 1166.8 15840.5 16122.4 16784.9 16931.4 17028.2 46479.5 48080.8 48332.3 48577.3 49939.3 62978.7 63676.0 64424.7 64621.0 64645.7 12342.2 12744.8 12802.3 12956.5 13046.8 17299.8 17388.2 17537.4 17563.0 18838.5 12737.0 15436.1 15637.2 15674.3 15779.6 13724.5 13826.2 14064.0 14174.3 14297.1 16061.4 16133.1 16162.8 16301.5 16399.4 12849.2 12892.9 12930.1 12939.3 12942.2 14421.9 15336.9 15379.5 15484.5 15740.1 19:16:02 INFO - PID 3536 | 19:16:02 INFO - PID 3536 | [#3] mootools.html Cycles:180 Average:7976.25 Median:2521.28 stddev:5301.05 (210.3%) stddev-sans-first:5292.62 19:16:02 INFO - PID 3536 | Values: 1362.4 1418.3 1423.9 1424.6 1428.2 11882.6 12431.8 12455.3 12549.8 12553.2 12929.0 13358.7 13405.9 13409.6 13503.0 2473.1 2530.2 2537.3 2537.8 2538.5 2417.5 2513.7 2519.5 2520.8 2532.7 2456.4 2487.0 2507.5 2515.3 2521.7 2357.1 2403.0 2413.9 2416.3 2416.9 2410.7 2471.9 2483.4 2513.1 2515.3 12631.2 12682.2 12942.4 12944.2 12962.5 6921.8 7162.6 7172.9 7174.2 7181.1 4247.3 4373.8 4465.9 4489.4 4527.7 1559.3 1608.2 1619.7 1645.8 1680.3 17488.3 18019.9 20355.5 20515.3 20584.8 5496.6 5646.4 5870.8 5947.6 5990.9 14696.7 14707.3 14720.8 14743.2 14758.8 6947.2 6962.9 7005.7 7017.4 7053.4 6258.0 6521.2 6538.7 6566.0 6592.6 4549.5 4717.8 4730.4 4754.1 4804.3 1351.3 1364.0 1376.5 1385.5 1393.5 894.9 896.1 898.0 929.1 929.9 7038.5 7051.6 7292.9 7451.7 7538.8 678.7 720.8 725.6 734.5 744.7 4518.8 4583.7 4617.7 4760.7 4943.8 16797.2 17649.4 17804.4 17822.2 17867.3 16609.1 17087.5 17200.8 17243.9 17360.0 9696.7 9791.6 10272.8 10303.2 10324.6 7613.5 7672.5 7702.0 7747.6 7937.9 14507.0 15437.8 15533.7 15573.5 15579.7 15798.5 15827.3 15914.6 16106.0 16223.9 9581.3 9614.4 9671.4 9724.8 9895.7 12122.3 12319.6 12320.6 12360.3 12373.2 9802.0 10013.5 10111.7 10318.0 10678.9 9601.9 9844.1 9899.7 9904.1 9996.5 8909.1 9051.4 9067.4 9113.2 9120.0 6498.7 6649.1 6784.0 6788.0 6849.8 6780.5 6903.1 6957.9 7054.4 7116.4 19:16:02 INFO - PID 3536 | 19:16:02 INFO - PID 3536 | [#4] prototype.html Cycles:180 Average:5580.69 Median:6135.93 stddev:1583.67 (25.8%) stddev-sans-first:1540.99 19:16:02 INFO - PID 3536 | Values: 471.9 498.3 502.2 505.1 505.4 6247.3 6266.1 6310.9 6353.3 6365.9 6051.6 6191.9 6223.1 6226.8 6281.0 4995.4 5011.6 5020.3 5022.6 5057.7 5032.0 5077.2 5081.2 5081.5 5082.1 4835.3 5029.4 5040.0 5041.7 5045.2 4971.5 4972.3 5019.4 5020.8 5027.7 4445.2 4447.7 4493.1 4499.3 4499.8 6077.0 6082.4 6092.8 6110.8 6112.7 5723.3 5741.2 5743.4 5776.6 5783.8 6590.7 6651.9 6652.6 6674.4 6700.2 4869.4 4917.3 4921.2 4921.3 4936.0 6958.7 6970.4 7036.2 7044.2 7065.5 5049.6 5061.7 5062.8 5071.3 5077.9 5131.0 5141.5 5141.5 5147.2 5153.4 5767.4 5785.1 5795.0 5799.8 5809.5 6716.0 6728.9 6732.6 6737.2 6748.2 1658.2 1769.2 1776.8 1779.3 1782.3 1154.1 1206.8 1211.4 1212.8 1214.1 5604.0 5696.4 5714.3 5716.6 5752.7 6629.4 6716.4 6808.7 6849.4 6857.0 5800.2 5812.1 5827.2 5829.9 5832.6 3564.9 3594.8 3609.8 3610.9 3619.4 6512.9 6555.0 6577.7 6590.9 6637.7 6955.5 6976.0 6985.0 6997.8 7009.8 6604.4 6630.8 6637.4 6647.2 6650.8 6737.0 6773.9 6801.8 6809.8 6812.2 6783.9 6787.2 6793.9 6817.2 6833.7 6159.2 6600.6 6614.3 6615.9 6625.7 4964.4 4973.0 5016.7 5021.0 5038.9 6840.2 6883.0 6899.3 6901.6 6917.6 6665.0 6681.7 6687.9 6688.9 6692.3 6649.4 6657.9 6681.6 6683.8 6697.7 6553.6 6573.9 6574.3 6591.9 6603.6 6671.9 6716.7 6723.4 6732.0 6752.9 6459.8 6467.4 6469.7 6486.4 6496.4 19:16:02 INFO - PID 3536 | 19:16:02 INFO - PID 3536 | [#5] yui.html Cycles:180 Average:20888.73 Median:19485.16 stddev:26027.96 (133.6%) stddev-sans-first:26057.53 19:16:02 INFO - PID 3536 | Values: 862.7 882.5 886.6 894.0 894.1 16749.0 17183.7 17243.7 17253.0 17445.1 16318.4 16538.7 16541.1 17428.2 19285.9 1042.5 1068.7 1074.7 1074.8 1075.7 1035.1 1046.3 1047.9 1055.4 1056.5 1130.1 1139.6 1141.2 1144.3 1144.5 1037.8 1099.8 1102.7 1116.8 1120.4 799.0 807.5 808.3 810.2 812.5 17867.0 17880.5 17953.5 18010.0 18048.9 18576.6 19734.5 19780.0 19835.3 20033.0 14605.7 14983.0 15043.5 15074.0 15178.5 3561.0 3620.6 3621.4 3621.6 3628.5 89936.0 91016.1 91663.5 92423.5 93767.5 15445.2 15511.7 15886.8 16112.9 16149.4 27154.5 27973.6 28038.0 28159.5 28345.7 8559.3 8585.7 8606.7 8610.7 8614.5 3926.2 3936.4 3944.8 3969.8 3974.6 4560.7 4700.3 4709.5 4711.9 4714.4 1015.4 1036.5 1043.0 1050.1 1051.8 676.5 682.2 686.7 714.9 723.5 12076.0 12255.5 13409.9 14198.4 14920.8 672.8 689.4 718.6 723.9 725.4 5279.9 5935.7 5972.7 6323.9 6517.1 89885.0 91278.5 93726.5 94359.5 96374.0 79310.6 82701.0 83605.6 85115.0 86593.0 69638.0 72739.0 75193.6 75892.6 76014.6 11302.3 11634.3 11667.0 11692.0 13057.8 32852.8 34446.7 34679.8 34813.7 34879.3 62020.4 62358.4 64330.4 64685.7 66403.3 17980.7 18957.6 19031.9 19126.6 19135.5 19684.4 19933.6 20017.3 20115.4 20141.7 17601.9 18258.4 18278.6 18385.0 18708.3 18180.8 18197.8 18285.1 18417.7 18539.9 17351.4 17841.2 17850.8 17886.8 17919.6 12686.6 13214.1 13447.6 13882.9 13976.5 13174.7 13338.4 13694.7 13820.0 13991.5 19:16:02 INFO - PID 3536 | -------- Summary: end -------- 19:16:02 INFO - PID 3536 | 19:16:03 INFO - TEST-INFO | 3536: exit 0 19:16:03 INFO - TEST-OK | dromaeo_css | took 1119058ms 19:16:03 INFO - TEST-START | kraken 19:16:03 INFO - operating with platform_type : linux_ 19:16:03 INFO - Initialising browser for kraken test... 19:16:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39234/getInfo.html -profile /tmp/tmpV10faI/profile 19:16:03 INFO - TEST-INFO | started process 3939 (/builds/slave/test/build/application/firefox/firefox http://localhost:39234/getInfo.html) 19:16:09 INFO - TEST-INFO | 3939: exit 0 19:16:09 INFO - Browser initialized. 19:16:09 INFO - Running cycle 1/1 for kraken test... 19:16:09 INFO - TEST-INFO | started process 4152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV10faI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:16:21 INFO - PID 4152 | RSS: Main: 175165440 19:16:21 INFO - PID 4152 | 19:16:23 INFO - PID 4152 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39234/tests/kraken/driver.html?testName=audio-beat-detection) 19:16:24 INFO - PID 4152 | RSS: Main: 177594368 19:16:24 INFO - PID 4152 | 19:16:27 INFO - PID 4152 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39234/tests/kraken/driver.html?testName=audio-dft) 19:16:28 INFO - PID 4152 | RSS: Main: 179400704 19:16:28 INFO - PID 4152 | 19:16:30 INFO - PID 4152 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39234/tests/kraken/driver.html?testName=audio-fft) 19:16:31 INFO - PID 4152 | RSS: Main: 175423488 19:16:31 INFO - PID 4152 | 19:16:33 INFO - PID 4152 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39234/tests/kraken/driver.html?testName=audio-oscillator) 19:16:34 INFO - PID 4152 | RSS: Main: 176041984 19:16:34 INFO - PID 4152 | 19:16:36 INFO - PID 4152 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39234/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:16:37 INFO - PID 4152 | RSS: Main: 176324608 19:16:37 INFO - PID 4152 | 19:16:40 INFO - PID 4152 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39234/tests/kraken/driver.html?testName=imaging-darkroom) 19:16:40 INFO - PID 4152 | RSS: Main: 179761152 19:16:40 INFO - PID 4152 | 19:16:44 INFO - PID 4152 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39234/tests/kraken/driver.html?testName=imaging-desaturate) 19:16:44 INFO - PID 4152 | RSS: Main: 181211136 19:16:44 INFO - PID 4152 | 19:16:47 INFO - PID 4152 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39234/tests/kraken/driver.html?testName=json-parse-financial) 19:16:48 INFO - PID 4152 | RSS: Main: 180445184 19:16:48 INFO - PID 4152 | 19:16:49 INFO - PID 4152 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39234/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:16:50 INFO - PID 4152 | RSS: Main: 180707328 19:16:50 INFO - PID 4152 | 19:16:52 INFO - PID 4152 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39234/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:16:52 INFO - PID 4152 | RSS: Main: 180641792 19:16:52 INFO - PID 4152 | 19:16:54 INFO - PID 4152 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39234/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:16:55 INFO - PID 4152 | RSS: Main: 179908608 19:16:55 INFO - PID 4152 | 19:16:58 INFO - PID 4152 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:16:58 INFO - PID 4152 | RSS: Main: 180113408 19:16:58 INFO - PID 4152 | 19:17:01 INFO - PID 4152 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:17:02 INFO - PID 4152 | RSS: Main: 180731904 19:17:02 INFO - PID 4152 | 19:17:04 INFO - PID 4152 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39234/tests/kraken/driver.html?testName=ai-astar) 19:17:04 INFO - PID 4152 | RSS: Main: 181981184 19:17:04 INFO - PID 4152 | 19:17:04 INFO - PID 4152 | __start_tp_report 19:17:04 INFO - PID 4152 | _x_x_mozilla_page_load 19:17:04 INFO - PID 4152 | _x_x_mozilla_page_load_details 19:17:04 INFO - PID 4152 | |i|pagename|runs| 19:17:04 INFO - PID 4152 | |0;ai-astar;102;107;109;107;109;107;111;110;113;107 19:17:04 INFO - PID 4152 | |1;audio-beat-detection;155;120;152;173;122;154;149;121;176;122 19:17:04 INFO - PID 4152 | |2;audio-dft;165;161;164;163;165;163;167;171;174;163 19:17:04 INFO - PID 4152 | |3;audio-fft;74;75;74;187;75;75;75;74;156;75 19:17:04 INFO - PID 4152 | |4;audio-oscillator;82;83;136;82;82;82;144;82;82;133 19:17:04 INFO - PID 4152 | |5;imaging-gaussian-blur;114;114;114;114;115;114;114;114;115;114 19:17:04 INFO - PID 4152 | |6;imaging-darkroom;150;151;151;150;153;150;151;151;151;152 19:17:04 INFO - PID 4152 | |7;imaging-desaturate;95;96;94;95;96;94;94;94;95;94 19:17:04 INFO - PID 4152 | |8;json-parse-financial;53;53;55;58;53;53;53;54;53;54 19:17:04 INFO - PID 4152 | |9;json-stringify-tinderbox;55;61;61;58;58;54;55;55;54;54 19:17:04 INFO - PID 4152 | |10;stanford-crypto-aes;79;79;80;78;77;79;86;77;76;78 19:17:04 INFO - PID 4152 | |11;stanford-crypto-ccm;126;129;126;127;128;131;129;124;126;165 19:17:04 INFO - PID 4152 | |12;stanford-crypto-pbkdf2;196;179;183;184;196;189;183;177;185;179 19:17:04 INFO - PID 4152 | |13;stanford-crypto-sha256-iterative;69;68;70;67;67;68;67;68;71;68 19:17:04 INFO - PID 4152 | __end_tp_report 19:17:04 INFO - PID 4152 | __start_cc_report 19:17:04 INFO - PID 4152 | _x_x_mozilla_cycle_collect,976 19:17:04 INFO - PID 4152 | __end_cc_report 19:17:04 INFO - PID 4152 | __startTimestamp1498011424554__endTimestamp 19:17:04 INFO - PID 4152 | 19:17:04 INFO - PID 4152 | ------- Summary: start ------- 19:17:04 INFO - PID 4152 | Number of tests: 14 19:17:04 INFO - PID 4152 | 19:17:04 INFO - PID 4152 | [#0] ai-astar Cycles:10 Average:108.20 Median:109.00 stddev:2.97 (2.7%) stddev-sans-first:2.15 19:17:04 INFO - PID 4152 | Values: 102.0 107.0 109.0 107.0 109.0 107.0 111.0 110.0 113.0 107.0 19:17:04 INFO - PID 4152 | 19:17:04 INFO - PID 4152 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:153.00 stddev:21.72 (14.2%) stddev-sans-first:22.70 19:17:04 INFO - PID 4152 | Values: 155.0 120.0 152.0 173.0 122.0 154.0 149.0 121.0 176.0 122.0 19:17:04 INFO - PID 4152 | 19:17:04 INFO - PID 4152 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.00 stddev:4.03 (2.4%) stddev-sans-first:4.27 19:17:04 INFO - PID 4152 | Values: 165.0 161.0 164.0 163.0 165.0 163.0 167.0 171.0 174.0 163.0 19:17:04 INFO - PID 4152 | 19:17:04 INFO - PID 4152 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.00 stddev:41.50 (55.3%) stddev-sans-first:43.38 19:17:04 INFO - PID 4152 | Values: 74.0 75.0 74.0 187.0 75.0 75.0 75.0 74.0 156.0 75.0 19:17:04 INFO - PID 4152 | 19:17:04 INFO - PID 4152 | [#4] audio-oscillator Cycles:10 Average:98.80 Median:82.00 stddev:26.96 (32.9%) stddev-sans-first:27.90 19:17:04 INFO - PID 4152 | Values: 82.0 83.0 136.0 82.0 82.0 82.0 144.0 82.0 82.0 133.0 19:17:04 INFO - PID 4152 | 19:17:04 INFO - PID 4152 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:17:04 INFO - PID 4152 | Values: 114.0 114.0 114.0 114.0 115.0 114.0 114.0 114.0 115.0 114.0 19:17:04 INFO - PID 4152 | 19:17:04 INFO - PID 4152 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 19:17:04 INFO - PID 4152 | Values: 150.0 151.0 151.0 150.0 153.0 150.0 151.0 151.0 151.0 152.0 19:17:04 INFO - PID 4152 | 19:17:04 INFO - PID 4152 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 19:17:04 INFO - PID 4152 | Values: 95.0 96.0 94.0 95.0 96.0 94.0 94.0 94.0 95.0 94.0 19:17:04 INFO - PID 4152 | 19:17:04 INFO - PID 4152 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:53.50 stddev:1.60 (3.0%) stddev-sans-first:1.66 19:17:04 INFO - PID 4152 | Values: 53.0 53.0 55.0 58.0 53.0 53.0 53.0 54.0 53.0 54.0 19:17:04 INFO - PID 4152 | 19:17:04 INFO - PID 4152 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:56.50 stddev:2.80 (5.0%) stddev-sans-first:2.92 19:17:04 INFO - PID 4152 | Values: 55.0 61.0 61.0 58.0 58.0 54.0 55.0 55.0 54.0 54.0 19:17:04 INFO - PID 4152 | 19:17:04 INFO - PID 4152 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:79.00 stddev:2.77 (3.5%) stddev-sans-first:2.93 19:17:04 INFO - PID 4152 | Values: 79.0 79.0 80.0 78.0 77.0 79.0 86.0 77.0 76.0 78.0 19:17:04 INFO - PID 4152 | 19:17:04 INFO - PID 4152 | [#11] stanford-crypto-ccm Cycles:10 Average:131.10 Median:128.50 stddev:12.08 (9.4%) stddev-sans-first:12.67 19:17:04 INFO - PID 4152 | Values: 126.0 129.0 126.0 127.0 128.0 131.0 129.0 124.0 126.0 165.0 19:17:04 INFO - PID 4152 | 19:17:04 INFO - PID 4152 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.10 Median:184.50 stddev:6.69 (3.6%) stddev-sans-first:5.82 19:17:04 INFO - PID 4152 | Values: 196.0 179.0 183.0 184.0 196.0 189.0 183.0 177.0 185.0 179.0 19:17:04 INFO - PID 4152 | 19:17:04 INFO - PID 4152 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:1.34 (2.0%) stddev-sans-first:1.39 19:17:04 INFO - PID 4152 | Values: 69.0 68.0 70.0 67.0 67.0 68.0 67.0 68.0 71.0 68.0 19:17:04 INFO - PID 4152 | -------- Summary: end -------- 19:17:04 INFO - PID 4152 | 19:17:05 INFO - TEST-INFO | 4152: exit 0 19:17:05 INFO - TEST-OK | kraken | took 62169ms 19:17:05 INFO - SUITE-END | took 1181s 19:17:05 INFO - Completed test suite (00:19:41) 19:17:05 INFO - javascript benchmark 19:17:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8129.927642245853, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3133.6552979172293, 3133.9373212535734, 3138.388014337204, 3150.306932474855, 3174.4603417419034, 5890.88218235635, 5899.321578018524, 5922.496587790032, 5962.0460726283745, 5964.194833697449, 6046.395360463963, 6073.726682299296, 6090.543209259312, 6123.877522449548, 6142.570020098595, 5551.8889622207535, 5609.971950140243, 5637.069883469223, 5658.632188907708, 5687.345955215162, 5598.104303311471, 5716.456936591017, 5735.967525845346, 5749.482546570808, 5768.048272035109, 5687.2606561146995, 5689.231953686241, 5693.3452652945025, 5716.714164291769, 5719.370869204384, 5602.803901863456, 5699.430056994267, 5701.77192912283, 5708.486236238738, 5712.800051998181, 5423.647462914937, 5528.917066244009, 5534.833954981357, 5545.223668686387, 5545.694986775726, 5952.970235148797, 5953.821385358447, 6000.819975400745, 6007.519398448114, 6011.909821352683, 6503.187101612299, 6554.672266386709, 6578.144841170665, 6582.901256481156, 6603.537752357337, 6576.210854697467, 6647.667616619198, 6648.5678430901835, 6659.63372014539, 6680.198376194888, 6189.50483961282, 6198.752049918043, 6212.254529456494, 6215.12988181655, 6223.502119830403, 6600.273969863311, 6768.932310676929, 6781.355771201728, 6791.0, 6834.1457317835275, 6199.3490683477585, 6270.843228919313, 6296.0, 6368.490520758328, 6404.199475065617, 6415.935840641534, 6416.32628573993, 6462.612243265419, 6527.151470308924, 6537.411632953057, 6367.681615919186, 6369.363063693686, 6388.1376014237485, 6388.361163883575, 6395.680215989182, 6354.17395738551, 6417.679116044179, 6448.613083215022, 6456.0961465394885, 6464.903026454607, 5369.114096174166, 5373.865653358697, 5375.220593013991, 5399.271098401666, 5422.6475279106735, 4601.861944141681, 4633.4208223972, 4653.325267836212, 4653.418322709661, 4691.155591993405, 5558.833235002957, 5740.253767010346, 5743.798967036134, 5747.195392645033, 5756.65460072397, 6376.426121649074, 6471.7734879279, 6477.190351206099, 6490.350964903566, 6526.543141980111, 5662.66024038559, 5718.313802343745, 5752.511036561856, 5753.424657534213, 5777.191193232867, 5858.326292476335, 5874.118882167709, 5875.882482350329, 5876.853078673067, 5881.794137205177, 6441.323661015525, 6451.1290975717675, 6456.418922297016, 6460.25707043696, 6460.870782584416, 6457.773977910751, 6544.607323560602, 6576.80269591913, 6601.735930562723, 6628.602283862983, 6414.03789431589, 6422.229332480132, 6423.454006409507, 6444.709988050643, 6446.258680251831, 6405.487560995016, 6526.24948130971, 6539.6403197824575, 6548.1814773153355, 6564.6389448580785, 6693.029510720821, 6707.5304728668525, 6715.26132125456, 6716.764913228014, 6730.226024007302, 6400.45596124316, 6403.0, 6416.807495775134, 6424.775132870327, 6493.610383377012, 6232.283287422005, 6295.464885484785, 6320.051992201206, 6343.0, 6357.650329231937, 6283.465905398092, 6315.242170939517, 6366.522510811615, 6381.553291269566, 6390.93609063922, 6490.8052758417325, 6520.510961677988, 6541.2477565078725, 6551.934480655133, 6556.0, 6278.497720182283, 6285.0, 6286.339934306832, 6298.433141017331, 6302.1492098566105], "value": 5997.1096827853335, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.2244409703666, 760.2131793593632, 773.5552057566899, 794.5034353529046, 805.7945223967887, 40230.597694023054, 40280.59719402805, 40894.795526022404, 40954.59045409545, 41022.99999999996, 35898.8205058975, 36132.2773544529, 36147.0, 36192.276154476895, 36195.0, 6698.095757072793, 6772.966135169318, 6809.387155156035, 6833.043373927654, 6860.108185935846, 6740.5618634788825, 6860.794176174722, 6868.038474613558, 6877.277885821966, 6879.415249703781, 6807.863842723167, 6839.281875403086, 6850.554713943603, 6860.0, 6876.346747059021, 6786.049953006583, 6797.932020679779, 6818.113645226138, 6818.863622727543, 6864.210615779174, 6056.697165141725, 6100.847478813021, 6189.16446279751, 6194.225721784777, 6202.441780239755, 31934.520982185284, 32124.83937580297, 32142.0, 32321.83839080813, 32352.676473235202, 3227.289996200832, 3285.3100848821778, 3297.159224397787, 3455.0, 3504.5969713483023, 30162.396752064837, 30424.0, 30456.69543304583, 30456.8477157615, 30463.847680761453, 3456.9827150864085, 3518.7185025197923, 3539.3983022886173, 3547.5565554305713, 3548.290341931624, 188438.0, 191353.0, 192453.9999999986, 194766.0, 196567.0, 48283.75858120757, 48514.75742621335, 48771.512284877404, 48926.75536622294, 49255.0, 50657.24014139791, 50720.0, 51092.74453627708, 51234.23148652773, 51244.487555123975, 15111.924440377728, 15206.46777362787, 15355.846441535665, 15377.615559610875, 15378.154201519024, 12599.622011339674, 12637.494500220073, 12666.49334026647, 12677.0, 12691.93654031724, 14139.575812725634, 14196.432142714175, 14231.0, 14265.286735663176, 14371.425142994372, 5735.283089613798, 5748.827535173951, 5762.855928601818, 5945.702714864239, 6009.278886533557, 989.6684610655511, 1005.2360206243162, 1008.9293749437616, 1032.7779527401644, 1041.8280983637767, 21824.89087554552, 22692.432689182904, 22721.886390568274, 23224.4193895154, 23551.175708850107, 1090.2368342160519, 1091.1194446660822, 1118.7986162490668, 1120.8318752187238, 1131.2025022359217, 11537.88462115385, 11642.079056955508, 12076.577319793765, 12266.81599776004, 12348.753024939451, 233052.0, 233083.0, 234326.0, 235438.0, 235895.0, 49878.25182622264, 50077.24884126741, 50213.24680129801, 50247.24629130566, 50325.74837125791, 1432.0906224547487, 1438.7266419380494, 1474.5134105745078, 1484.9034812737139, 1486.7175236705207, 21723.0, 22017.53346759898, 22091.116355345606, 22753.544929101656, 22965.196218132285, 35592.644073558935, 35631.10922226965, 35684.821575891954, 35689.286214276086, 35766.105847354025, 192032.0, 192290.0, 192384.0, 192543.0, 193287.0, 33130.0, 34665.82667086648, 36469.08827279339, 36709.63290367062, 36709.81645091758, 41824.79087604542, 42965.35551966786, 44764.0, 44771.32843007292, 44843.77578112089, 30272.54591181178, 30545.0, 31315.373692525565, 32088.358232834744, 33491.33017339591, 30880.69119308868, 30961.845190773904, 31766.364672705953, 32589.511157333134, 32843.50734738933, 35097.473537897466, 35464.0, 35676.46485302774, 37025.814870925475, 37336.43995340018, 30047.248818779706, 31853.522197166596, 32016.0, 32264.516032259064, 32704.50943235901, 22970.770292297533, 24173.0, 25387.61918571186, 25409.745902540737, 25481.87259063693], "value": 16350.460279635736, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.4834855236076, 554.1272495819081, 566.501478698745, 571.2373980735717, 591.0985746736227, 20301.39095827126, 21682.24112156075, 21857.781422185773, 21881.452963675914, 21904.99999999998, 23515.176968806096, 24368.634470482957, 25419.872900635517, 25500.0, 25535.61696574553, 6319.431251187392, 6415.582987105847, 6466.805995820133, 6466.967665161667, 6470.158879345702, 6400.39196276353, 6435.646039467827, 6461.935380646204, 6474.352564743535, 6488.383603557654, 5665.66006039639, 5974.193483879686, 6149.13912052313, 6420.7752728654505, 6442.0, 6174.876502469971, 6246.344133865924, 6266.811995640115, 6280.874382512324, 6289.40250676185, 5848.093545500455, 5851.473367396912, 5853.414658534155, 5860.589758716891, 5868.41315868414, 27663.723362766315, 28367.716322836714, 28843.855780721173, 28957.0, 29075.418491630047, 1917.1947781931483, 1977.6440240756658, 1982.8017198280202, 1988.204718112752, 1988.2146552111835, 16821.747673784903, 17313.480595582154, 17324.56688582783, 17328.826711732974, 17352.47942561725, 2290.988545057264, 2329.7670232976734, 2336.5794157051723, 2346.636271377939, 2353.8587684738973, 129734.0, 132564.0, 132792.67207327898, 133074.3346283272, 133542.0, 13849.376778045013, 14476.34856431463, 14604.152190322997, 14646.194459304628, 14917.776233356508, 23562.29313120609, 23575.528489430115, 23576.882115589313, 23705.40736481602, 23779.643305350433, 9513.952430237943, 9730.708078757649, 9902.752431189278, 9915.55380007887, 9916.405015699082, 8774.912250877409, 8947.0, 9007.63969441215, 9078.31912606544, 9086.909130908738, 8814.294856411472, 8919.643214271357, 8921.509316987498, 8932.553372331358, 8962.193402593797, 2572.6655534780357, 2634.6048092785854, 2723.155821695281, 2821.3651928315967, 2862.7137286271204, 931.2410385535767, 952.2382094324513, 966.1449617088787, 970.6263088710897, 981.8183636027358, 18475.630487390445, 19096.331628393218, 19413.93223372728, 19494.0, 19516.70724939127, 988.649029594498, 997.9950100249453, 1033.2973577967055, 1035.5598870480017, 1042.9165666746642, 10287.0, 10590.788184236271, 10730.912361069004, 10765.461726913623, 11046.558137674403, 486633.0, 487152.0, 499489.0, 512146.0, 513967.0, 103463.0, 105779.47110264553, 106302.0, 106404.46797765962, 108274.45862770636, 1121.4168632311153, 1126.2116518437126, 1159.1538177130742, 1163.4822503985815, 1166.7783121206944, 15840.524784256491, 16122.435714750396, 16784.9089809162, 16931.407400740914, 17028.233729481955, 46479.535204647524, 48080.759596201795, 48332.27501587409, 48577.27134093062, 49939.250911235635, 62978.68510657417, 63676.0, 64424.677876610316, 64621.0, 64645.67677161584, 12342.197757145757, 12744.808827867404, 12802.295873727035, 12956.481740730642, 13046.804297935349, 17299.82700172982, 17388.217530210917, 17537.386191483238, 17563.0, 18838.52903677419, 12737.0, 15436.073835569901, 15637.218139092773, 15674.294656740247, 15779.605509862346, 13724.45102195901, 13826.239556824472, 14064.0, 14174.29128543548, 14297.070690405091, 16061.357545698042, 16133.112678802778, 16162.838371616133, 16301.51095467138, 16399.42602008924, 12849.164804287691, 12892.871071289166, 12930.094893357375, 12939.288339141438, 12942.158759680591, 14421.855781442051, 15336.923315383352, 15379.461718839786, 15484.458043968407, 15740.134292614017], "value": 11201.067425845764, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1362.3869258833524, 1418.2766788937645, 1423.8718515333624, 1424.61535385446, 1428.164523753604, 11882.584109556166, 12431.813522797154, 12455.252684838893, 12549.811752823704, 12553.184043037196, 12929.0, 13358.66603334917, 13405.93297033516, 13409.597712068653, 13503.0, 2473.122041675206, 2530.228280374485, 2537.264193383926, 2537.7716005559496, 2538.4923015396994, 2417.528581926525, 2513.6983561972497, 2519.5212909547217, 2520.836145650536, 2532.6580911576884, 2456.4227406559444, 2487.0, 2507.4608959073794, 2515.346010037394, 2521.722610512842, 2357.104300365867, 2402.95194096118, 2413.891374888134, 2416.299273210767, 2416.8791560422083, 2410.6504556839336, 2471.888765005579, 2483.428811373376, 2513.1204078572537, 2515.3208633668805, 12631.178973366701, 12682.239065656091, 12942.352882355939, 12944.223346599234, 12962.48150073996, 6921.792346229621, 7162.570245785269, 7172.892406613905, 7174.174969878426, 7181.066461360042, 4247.341662042389, 4373.759443230621, 4465.888352791174, 4489.416375871148, 4527.705699129546, 1559.2983157579135, 1608.203939050166, 1619.7489389144584, 1645.8025036995637, 1680.3194706144031, 17488.300467981266, 18019.909900450544, 20355.491112722302, 20515.281965131297, 20584.79415205844, 5496.587755918322, 5646.4353564644025, 5870.7945221917025, 5947.5539334550085, 5990.850228744229, 14696.706065878836, 14707.264636768119, 14720.779188312184, 14743.189124598035, 14758.778618320734, 6947.201071876799, 6962.930370696329, 7005.719771209095, 7017.438604911595, 7053.400460960773, 6257.968710156511, 6521.217453905561, 6538.705758240891, 6565.967170164118, 6592.571482853599, 4549.545045495424, 4717.787699553528, 4730.385049943554, 4754.144254034307, 4804.25534042224, 1351.3310911098872, 1363.986360136406, 1376.4631793600504, 1385.5219949117538, 1393.470481217131, 894.865770134485, 896.0859922878627, 898.0480690468124, 929.1080562659787, 929.9209567186865, 7038.507304488637, 7051.612161331176, 7292.854142917218, 7451.701931922662, 7538.773836784905, 678.6911955060435, 720.8450183210634, 725.5791640848296, 734.5299008634478, 744.6611791634793, 4518.81924723014, 4583.702059366131, 4617.699849509839, 4760.738159401197, 4943.752812359367, 16797.244124014447, 17649.38227162043, 17804.37684681056, 17822.198001089724, 17867.285308587772, 16609.08650024236, 17087.487375378758, 17200.827991720173, 17243.913780431016, 17360.0, 9696.660616878375, 9791.608335666637, 10272.794544109076, 10303.227257955683, 10324.638637647797, 7613.467057305936, 7672.485575904616, 7701.961490192513, 7747.573883436465, 7937.920620793718, 14507.0, 15437.84562154364, 15533.689326213638, 15573.454929077428, 15579.688406231586, 15798.526044218692, 15827.287772050515, 15914.602134946255, 16106.0, 16223.918880405523, 9581.281403894596, 9614.423134611945, 9671.371360861522, 9724.805503889742, 9895.703128906145, 12122.27266364021, 12319.63041108768, 12320.630381088224, 12360.320182390054, 12373.195742276723, 9802.0, 10013.549390277602, 10111.7472063199, 10318.0, 10678.878717734526, 9601.855972160563, 9844.114029737359, 9899.653512127328, 9904.108630223314, 9996.450195239331, 8909.109089091038, 9051.411658242194, 9067.365284430027, 9113.179813816789, 9120.042395548371, 6498.740050397932, 6649.069130321662, 6783.966080169567, 6788.0, 6849.794506164823, 6780.491463140185, 6903.0680858083515, 6957.9304206959305, 7054.4003759681, 7116.359527642537], "value": 5864.695039447829, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.8820294926268, 498.2600837755933, 502.21403503516973, 505.0908364943102, 505.35062444758495, 6247.281562620295, 6266.122742816004, 6310.873782524347, 6353.332900045487, 6365.872682546346, 6051.636901785896, 6191.876162476748, 6223.1287619733275, 6226.816904788098, 6280.968595157018, 4995.350604421438, 5011.599072074244, 5020.272060551218, 5022.648414610979, 5057.747112644372, 5031.974840125813, 5077.238414237857, 5081.237814327862, 5081.5172558607055, 5082.110630639641, 4835.274708793674, 5029.446760856303, 5040.0, 5041.672291301072, 5045.183733855809, 4971.453140154598, 4972.303877457159, 5019.447860735316, 5020.7740651670765, 5027.698338099707, 4445.155420470132, 4447.666425018104, 4493.078918821634, 4499.347594598765, 4499.842505512292, 6076.969615151896, 6082.354175933483, 6092.786752463642, 6110.816675499742, 6112.6638034908065, 5723.311623071162, 5741.167530708024, 5743.396943320975, 5776.566757493205, 5783.768649254025, 6590.703418346186, 6651.866962660768, 6652.600843949379, 6674.399304062609, 6700.195976482853, 4869.415670119608, 4917.336159618441, 4921.18800397934, 4921.311016457699, 4936.0, 6958.721651133948, 6970.4075153612, 7036.226015138331, 7044.189918159426, 7065.491750428575, 5049.6212784041345, 5061.746912654353, 5062.848114556569, 5071.3153724247495, 5077.923831142536, 5130.974345128325, 5141.485851414828, 5141.53726164647, 5147.198480531784, 5153.4073581538605, 5767.423257674283, 5785.103308987113, 5795.0, 5799.797007104731, 5809.477147056785, 6716.0, 6728.856094463953, 6732.596044237362, 6737.191537015589, 6748.156480439945, 1658.1792012953665, 1769.195016267595, 1776.786785585738, 1779.2527138601818, 1782.3138091834737, 1154.1459320103231, 1206.8314213571532, 1211.3640338822013, 1212.763511115324, 1214.1197631716934, 5604.0, 5696.3511966935575, 5714.314282286152, 5716.628009277743, 5752.683602401824, 6629.403353698191, 6716.429103526255, 6808.71051237727, 6849.417799487, 6856.965715171492, 5800.187973683687, 5812.140115163192, 5827.184194212814, 5829.941700583025, 5832.62087964281, 3564.912701625977, 3594.8022858742497, 3609.7653652512504, 3610.9277814443562, 3619.4027985382118, 6512.902306465407, 6555.016747487915, 6577.6711164441585, 6590.901136482957, 6637.734490620418, 6955.513114081966, 6976.0, 6985.0, 6997.755078572327, 7009.754658586925, 6604.438622717123, 6630.767923122764, 6637.369449902251, 6647.169103862017, 6650.800475985729, 6737.0462565857315, 6773.89839152423, 6801.795946121624, 6809.795706128824, 6812.21659509143, 6783.864322713617, 6787.21946976104, 6793.898091528532, 6817.181938167451, 6833.692483838338, 6159.199304090619, 6600.636964966973, 6614.272430032596, 6615.933840661532, 6625.701843416961, 4964.429090654621, 4972.975135124301, 5016.749162541785, 5020.995800839773, 5038.874028149326, 6840.213375461885, 6882.965585172243, 6899.310068993262, 6901.551399159039, 6917.584944903322, 6664.966675166593, 6681.665916704243, 6687.866242675022, 6688.899666505104, 6692.263850976486, 6649.434798042221, 6657.866842663217, 6681.599104053772, 6683.832904177434, 6697.665116744241, 6553.606783593, 6573.934260657332, 6574.27682954865, 6591.868162636816, 6603.636799976048, 6671.8999215010845, 6716.664166791738, 6723.361280678328, 6731.966340168267, 6752.885773847456, 6459.806205813833, 6467.417932386108, 6469.7412103515335, 6486.351364863476, 6496.415322620986], "value": 5106.541627969497, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [862.6764963138819, 882.4749274181862, 886.6231851463126, 893.9910600893993, 894.0523045571695, 16749.0, 17183.742243866338, 17243.74134387982, 17253.0, 17445.127743612815, 16318.428854990078, 16538.66922661546, 16541.090240036792, 17428.215730292137, 19285.90357048216, 1042.5360714482058, 1068.743501559628, 1074.656110044786, 1074.7689246811933, 1075.6665433715534, 1035.140833108522, 1046.3303485769113, 1047.8637777089007, 1055.3615062886959, 1056.5034433816095, 1130.0789856267115, 1139.5954436175164, 1141.2068612314445, 1144.256233448257, 1144.525022115825, 1037.8028174646793, 1099.7525556749747, 1102.6747109602607, 1116.8213085906257, 1120.4453795371303, 798.972035978738, 807.4711064252865, 808.3290868579065, 810.222186700768, 812.5327936436513, 17867.017314047724, 17880.46358609244, 17953.461396158134, 18010.0, 18048.90975545127, 18576.62846743071, 19734.506637334038, 19780.010999450114, 19835.30576429818, 20033.0, 14605.70788584233, 14983.0, 15043.473478428312, 15074.02018868781, 15178.468753593681, 3561.0385195996937, 3620.583632882226, 3621.3662609043577, 3621.619729928346, 3628.51015112959, 89936.0, 91016.08983910209, 91663.54168229183, 92423.53788231083, 93767.53116234374, 15445.150516721687, 15511.689766204612, 15886.76169857453, 16112.919435402748, 16149.354025838835, 27154.45691086167, 27973.580396294074, 28038.0, 28159.451230182538, 28345.71654283472, 8559.315254779603, 8585.656573737106, 8606.741797746077, 8610.698625548075, 8614.483131012159, 3926.1755031443718, 3936.3505021671103, 3944.783036932939, 3969.8213580388374, 3974.6224108709625, 4560.68075234737, 4700.318453824177, 4709.505501922317, 4711.905761884812, 4714.4106986626675, 1015.4465816130079, 1036.512838965685, 1042.9634962776418, 1050.1231471721198, 1051.7738686182508, 676.5399528320789, 682.1745687717917, 686.7321744519642, 714.8856183010694, 723.5260904107818, 12076.0, 12255.509779608716, 13409.865901340861, 14198.361073751706, 14920.776188357184, 672.8351553869236, 689.4174422612884, 718.5509056839476, 723.8769409200448, 725.3834240895197, 5279.947200528022, 5935.6735379553675, 5972.671503067373, 6323.936760632427, 6517.110038088901, 89885.0, 91278.54360728154, 93726.5313673441, 94359.52820235855, 96374.0, 79310.6034469824, 82700.99999999879, 83605.58197208976, 85115.0, 86593.0, 69638.0, 72739.0, 75193.62403187949, 75892.62053689807, 76014.61992690111, 11302.265352752045, 11634.301941883175, 11667.004654337428, 11692.0, 13057.804132938203, 32852.835735821165, 34446.655533445344, 34679.826600866836, 34813.65186348104, 34879.302413952086, 62020.37979620326, 62358.37641623526, 64330.356696432435, 64685.67657161684, 66403.33596663972, 17980.730289045412, 18957.620847583246, 19031.90484047571, 19126.617467650292, 19135.52161195981, 19684.409467715417, 19933.60132797365, 20017.29939452112, 20115.39653810388, 20141.6978745316, 17601.911990439967, 18258.36095736696, 18278.634427311114, 18385.0, 18708.25166993305, 18180.81819181791, 18197.81802182014, 18285.085745712397, 18417.723734143732, 18539.907300463412, 17351.392701255394, 17841.197146128714, 17850.821491784915, 17886.821131788514, 17919.641607167523, 12686.619401417604, 13214.141080829715, 13447.596572102853, 13882.861171388156, 13976.532464091531, 13174.670633234246, 13338.399772010089, 13694.726105478034, 13820.0, 13991.510297139552], "value": 8777.899016525567, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 107.0, 109.0, 107.0, 109.0, 107.0, 111.0, 110.0, 113.0, 107.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 120.0, 152.0, 173.0, 122.0, 154.0, 149.0, 121.0, 176.0, 122.0], "value": 144.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 161.0, 164.0, 163.0, 165.0, 163.0, 167.0, 171.0, 174.0, 163.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 187.0, 75.0, 75.0, 75.0, 74.0, 156.0, 75.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 136.0, 82.0, 82.0, 82.0, 144.0, 82.0, 82.0, 133.0], "value": 98.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 150.0, 153.0, 150.0, 151.0, 151.0, 151.0, 152.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 95.0, 96.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 55.0, 58.0, 53.0, 53.0, 53.0, 54.0, 53.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 61.0, 61.0, 58.0, 58.0, 54.0, 55.0, 55.0, 54.0, 54.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 78.0, 77.0, 79.0, 86.0, 77.0, 76.0, 78.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 129.0, 126.0, 127.0, 128.0, 131.0, 129.0, 124.0, 126.0, 165.0], "value": 131.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 179.0, 183.0, 184.0, 196.0, 189.0, 183.0, 177.0, 185.0, 179.0], "value": 185.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 70.0, 67.0, 67.0, 68.0, 67.0, 68.0, 71.0, 68.0], "value": 68.3, "unit": "score"}]}]} 19:17:05 INFO - Return code: 0 19:17:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:17:05 INFO - # TBPL SUCCESS # 19:17:05 INFO - Running post-action listener: _resource_record_post_action 19:17:05 INFO - [mozharness: 2017-06-21 02:17:05.920841Z] Finished run-tests step (success) 19:17:05 INFO - Running post-run listener: _resource_record_post_run 19:17:05 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8843264; Write bytes: 434790400; Read time: 3008; Write time: 335548 19:17:05 INFO - TinderboxPrint: CPU usage
13.3% 19:17:05 INFO - TinderboxPrint: I/O read bytes / time
8,843,264 / 3,008 19:17:05 INFO - TinderboxPrint: I/O write bytes / time
434,790,400 / 335,548 19:17:05 INFO - TinderboxPrint: CPU idle
8,291.8 (86.7%) 19:17:05 INFO - TinderboxPrint: CPU user
1,212.7 (12.7%) 19:17:05 INFO - TinderboxPrint: Swap in / out
0 / 0 19:17:05 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 111394816; Read time: 92; Write time: 103404 19:17:05 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:17:06 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 6807552; Write bytes: 300146688; Read time: 2788; Write time: 228340 19:17:06 INFO - Running post-run listener: _upload_blobber_files 19:17:06 INFO - Blob upload gear active. 19:17:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:17:06 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 19:17:06 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:17:06 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:17:06 INFO - (blobuploader) - INFO - Open directory for files ... 19:17:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:17:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:17:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:17:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:17:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:17:13 INFO - (blobuploader) - INFO - Done attempting. 19:17:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:17:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:17:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:17:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:17:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:17:14 INFO - (blobuploader) - INFO - Done attempting. 19:17:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:17:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:17:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:17:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:17:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:17:15 INFO - (blobuploader) - INFO - Done attempting. 19:17:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:17:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:17:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:17:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:17:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:17:15 INFO - (blobuploader) - INFO - Done attempting. 19:17:15 INFO - (blobuploader) - INFO - Iteration through files over. 19:17:15 INFO - Return code: 0 19:17:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:17:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:17:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c71942b4303633d470e48b93c7614d5cbda8c7b36abf165a4930194b9fb247f0919ebc1a0cd5381895d3251edf66497c633f556e33e39daf3732e242922c78be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78d470b0e512400f8b0118c12e248bd62a8b9c8a3ac162eca4e1a463329646a54fed78bb2957b0ad1b13e46baf148432f683140d1caa5da6a3541a99ed519042", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00c5cd75b2205fbfaecdf3469d3baea0de71c6a3c77737242d8fee3df37440a719c6a935a47a0ac0c29e96fc25d82413e675fd5f999fdd6f76bf9650d4833a9f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/319b0978c9ae88ed6f2f834dcb575d1a7d51f33240e1f9b5c206e9276cf04fb25f9e74ca8cc6f84a3af3e5e6e6c74d54cdb3c45d6280dd0ec80bef6ff918cdf1"} 19:17:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:17:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:17:15 INFO - Contents: 19:17:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c71942b4303633d470e48b93c7614d5cbda8c7b36abf165a4930194b9fb247f0919ebc1a0cd5381895d3251edf66497c633f556e33e39daf3732e242922c78be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78d470b0e512400f8b0118c12e248bd62a8b9c8a3ac162eca4e1a463329646a54fed78bb2957b0ad1b13e46baf148432f683140d1caa5da6a3541a99ed519042", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00c5cd75b2205fbfaecdf3469d3baea0de71c6a3c77737242d8fee3df37440a719c6a935a47a0ac0c29e96fc25d82413e675fd5f999fdd6f76bf9650d4833a9f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/319b0978c9ae88ed6f2f834dcb575d1a7d51f33240e1f9b5c206e9276cf04fb25f9e74ca8cc6f84a3af3e5e6e6c74d54cdb3c45d6280dd0ec80bef6ff918cdf1"} 19:17:15 INFO - Running post-run listener: copy_logs_to_upload_dir 19:17:15 INFO - Copying logs to upload dir... 19:17:15 INFO - mkdir: /builds/slave/test/build/upload/logs 19:17:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.538271 ========= master_lag: 0.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-06-20 19:17:16.056514) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-20 19:17:16.064099) ========= 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=dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c71942b4303633d470e48b93c7614d5cbda8c7b36abf165a4930194b9fb247f0919ebc1a0cd5381895d3251edf66497c633f556e33e39daf3732e242922c78be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78d470b0e512400f8b0118c12e248bd62a8b9c8a3ac162eca4e1a463329646a54fed78bb2957b0ad1b13e46baf148432f683140d1caa5da6a3541a99ed519042", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00c5cd75b2205fbfaecdf3469d3baea0de71c6a3c77737242d8fee3df37440a719c6a935a47a0ac0c29e96fc25d82413e675fd5f999fdd6f76bf9650d4833a9f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/319b0978c9ae88ed6f2f834dcb575d1a7d51f33240e1f9b5c206e9276cf04fb25f9e74ca8cc6f84a3af3e5e6e6c74d54cdb3c45d6280dd0ec80bef6ff918cdf1"} build_url:https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011337 build_url: 'https://queue.taskcluster.net/v1/task/GBreNVIdRyKCdB07FgIyDQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c71942b4303633d470e48b93c7614d5cbda8c7b36abf165a4930194b9fb247f0919ebc1a0cd5381895d3251edf66497c633f556e33e39daf3732e242922c78be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78d470b0e512400f8b0118c12e248bd62a8b9c8a3ac162eca4e1a463329646a54fed78bb2957b0ad1b13e46baf148432f683140d1caa5da6a3541a99ed519042", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00c5cd75b2205fbfaecdf3469d3baea0de71c6a3c77737242d8fee3df37440a719c6a935a47a0ac0c29e96fc25d82413e675fd5f999fdd6f76bf9650d4833a9f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/319b0978c9ae88ed6f2f834dcb575d1a7d51f33240e1f9b5c206e9276cf04fb25f9e74ca8cc6f84a3af3e5e6e6c74d54cdb3c45d6280dd0ec80bef6ff918cdf1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-20 19:17:16.090730) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-20 19:17:16.091020) ========= 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=dac658600622fd96716c9acf000001b3-1498007853.120831-1091747355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004369 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-20 19:17:16.170395) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-20 19:17:16.170689) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-20 19:17:16.173026) ========= ========= Total master_lag: 0.34 =========