builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-057 starttime: 1496014553.93 results: success (0) revision: 51d220b260d8d52a41b65aae2c5d74be99c2d59e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-28 16:35:53.928876) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-28 16:35:53.929534) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-28 16:35:53.933054) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-28 16:35:53.950935) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:35:53.951456) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-28 16:35:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.1M=0s 2017-05-28 16:35:56 (43.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.153015 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:35:54.125010) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:35:54.125334) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019014 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:35:54.174524) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:35:54.174865) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 51d220b260d8d52a41b65aae2c5d74be99c2d59e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 51d220b260d8d52a41b65aae2c5d74be99c2d59e --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-28 16:35:56,318 truncating revision to first 12 chars 2017-05-28 16:35:56,318 Setting DEBUG logging. 2017-05-28 16:35:56,318 attempt 1/10 2017-05-28 16:35:56,318 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/51d220b260d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-28 16:35:56,783 unpacking tar archive at: mozilla-central-51d220b260d8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.758673 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:35:54.948790) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-28 16:35:54.952184) ========= script_repo_revision: 51d220b260d8d52a41b65aae2c5d74be99c2d59e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-28 16:35:54.952543) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-28 16:35:54.952823) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-28 16:35:54.961253) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2017-05-28 16:35:54.961575) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:35:57 INFO - MultiFileLogger online at 20170528 16:35:57 in /builds/slave/test 16:35:57 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 16:35:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:35:57 INFO - {'append_to_log': False, 16:35:57 INFO - 'base_work_dir': '/builds/slave/test', 16:35:57 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:35:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:35:57 INFO - 'branch': 'Firefox-Non-PGO', 16:35:57 INFO - 'buildbot_json_path': 'buildprops.json', 16:35:57 INFO - 'config_files': ('talos/linux_config.py',), 16:35:57 INFO - 'default_actions': ('clobber', 16:35:57 INFO - 'read-buildbot-config', 16:35:57 INFO - 'download-and-extract', 16:35:57 INFO - 'populate-webroot', 16:35:57 INFO - 'create-virtualenv', 16:35:57 INFO - 'install', 16:35:57 INFO - 'setup-mitmproxy', 16:35:57 INFO - 'run-tests'), 16:35:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:35:57 INFO - 'download_minidump_stackwalk': True, 16:35:57 INFO - 'download_symbols': 'ondemand', 16:35:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:35:57 INFO - 'tooltool.py': '/tools/tooltool.py', 16:35:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:35:57 INFO - '/tools/misc-python/virtualenv.py')}, 16:35:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:35:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:35:57 INFO - 'gecko_profile': False, 16:35:57 INFO - 'gecko_profile_interval': 0, 16:35:57 INFO - 'installer_path': 'installer.exe', 16:35:57 INFO - 'log_level': 'info', 16:35:57 INFO - 'log_name': 'talos', 16:35:57 INFO - 'log_to_console': True, 16:35:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:35:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:35:57 INFO - 'opt_config_files': (), 16:35:57 INFO - 'pip_index': False, 16:35:57 INFO - 'suite': 'dromaeojs-e10s', 16:35:57 INFO - 'system_bits': '32', 16:35:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:35:57 INFO - 'title': 'talos-linux64-ix-057', 16:35:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:35:57 INFO - 'use_talos_json': True, 16:35:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:35:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:35:57 INFO - 'work_dir': 'build'} 16:35:57 INFO - [mozharness: 2017-05-28 23:35:57.208871Z] Running clobber step. 16:35:57 INFO - Running pre-action listener: _resource_record_pre_action 16:35:57 INFO - Running main action method: clobber 16:35:57 INFO - rmtree: /builds/slave/test/build 16:35:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:35:58 INFO - Running post-action listener: _resource_record_post_action 16:35:58 INFO - [mozharness: 2017-05-28 23:35:58.237865Z] Finished clobber step (success) 16:35:58 INFO - [mozharness: 2017-05-28 23:35:58.237967Z] Running read-buildbot-config step. 16:35:58 INFO - Running pre-action listener: _resource_record_pre_action 16:35:58 INFO - Running main action method: read_buildbot_config 16:35:58 INFO - Using buildbot properties: 16:35:58 INFO - { 16:35:58 INFO - "project": "", 16:35:58 INFO - "product": "firefox", 16:35:58 INFO - "who": "archaeopteryx@coole-files.de", 16:35:58 INFO - "installer_path": "public/build/target.tar.bz2", 16:35:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:35:58 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:35:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:35:58 INFO - "stage_platform": "linux64", 16:35:58 INFO - "basedir": "/builds/slave/test", 16:35:58 INFO - "buildnumber": 862, 16:35:58 INFO - "platform": "ubuntu64_hw", 16:35:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:35:58 INFO - "slavebuilddir": "test", 16:35:58 INFO - "taskId": "RcAzeujzRsaRQJva6i5GyQ", 16:35:58 INFO - "branch": "mozilla-central", 16:35:58 INFO - "script_repo_revision": "production", 16:35:58 INFO - "revision": "51d220b260d8d52a41b65aae2c5d74be99c2d59e", 16:35:58 INFO - "slavename": "talos-linux64-ix-057", 16:35:58 INFO - "repo_path": "mozilla-central" 16:35:58 INFO - } 16:35:58 INFO - Finding installer, test and symbols from parent task. 16:35:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RcAzeujzRsaRQJva6i5GyQ'}, attempt #1 16:35:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RcAzeujzRsaRQJva6i5GyQ'}, attempt #1 16:35:59 INFO - Task dependencies: WlffePMAS1SlVHnA2AgD_g 16:35:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WlffePMAS1SlVHnA2AgD_g'}, attempt #1 16:35:59 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/target.tar.bz2 16:35:59 INFO - Set test_url: https://queue.taskcluster.net/v1/task/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/test_packages.json 16:35:59 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/target.crashreporter-symbols.zip 16:35:59 INFO - Running post-action listener: _resource_record_post_action 16:35:59 INFO - [mozharness: 2017-05-28 23:35:59.593882Z] Finished read-buildbot-config step (success) 16:35:59 INFO - [mozharness: 2017-05-28 23:35:59.594102Z] Running download-and-extract step. 16:35:59 INFO - Running pre-action listener: _resource_record_pre_action 16:35:59 INFO - Running main action method: download_and_extract 16:35:59 INFO - mkdir: /builds/slave/test/build/tests 16:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:59 INFO - trying https://queue.taskcluster.net/v1/task/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/target.test_packages.json 16:35:59 INFO - Downloading https://queue.taskcluster.net/v1/task/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:35:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:36:00 INFO - Downloaded 986 bytes. 16:36:00 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:36:00 INFO - Using the following test package requirements: 16:36:00 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:36:00 INFO - u'common': [u'target.common.tests.zip'], 16:36:00 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:36:00 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:36:00 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:36:00 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:36:00 INFO - u'mozbase': [u'target.common.tests.zip'], 16:36:00 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:36:00 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:36:00 INFO - u'web-platform': [u'target.common.tests.zip', 16:36:00 INFO - u'target.web-platform.tests.zip'], 16:36:00 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:36:00 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:36:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/target.common.tests.zip 16:36:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:36:00 INFO - Fetch https://queue.taskcluster.net/v1/task/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/target.common.tests.zip into memory 16:36:01 INFO - Content-Length response header: 63527024 16:36:01 INFO - Bytes received: 63527024 16:36:12 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:36:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/target.common.tests.zip 16:36:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:36:12 INFO - Fetch https://queue.taskcluster.net/v1/task/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/target.common.tests.zip into memory 16:36:13 INFO - Content-Length response header: 63527024 16:36:13 INFO - Bytes received: 63527024 16:36:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/target.talos.tests.zip 16:36:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:36:25 INFO - Fetch https://queue.taskcluster.net/v1/task/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/target.talos.tests.zip into memory 16:36:25 INFO - Content-Length response header: 14447425 16:36:25 INFO - Bytes received: 14447425 16:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:26 INFO - trying https://queue.taskcluster.net/v1/task/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/target.tar.bz2 16:36:26 INFO - Downloading https://queue.taskcluster.net/v1/task/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:36:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:36:27 INFO - Downloaded 54103431 bytes. 16:36:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/target.tar.bz2 16:36:27 INFO - mkdir: /builds/slave/test/properties 16:36:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:36:27 INFO - Writing to file /builds/slave/test/properties/build_url 16:36:27 INFO - Contents: 16:36:27 INFO - build_url:https://queue.taskcluster.net/v1/task/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/target.tar.bz2 16:36:27 INFO - Running post-action listener: _resource_record_post_action 16:36:27 INFO - Running post-action listener: set_extra_try_arguments 16:36:27 INFO - [mozharness: 2017-05-28 23:36:27.191265Z] Finished download-and-extract step (success) 16:36:27 INFO - [mozharness: 2017-05-28 23:36:27.191361Z] Running populate-webroot step. 16:36:27 INFO - Running pre-action listener: _resource_record_pre_action 16:36:27 INFO - Running main action method: populate_webroot 16:36:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:36:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:36:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:36:27 INFO - '--tppagecycles', 16:36:27 INFO - '7'], 16:36:27 INFO - 'tests': ['tsvgm']}}, 16:36:27 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:36:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:36:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:36:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:36:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:36:27 INFO - 'talos_options': ['--disable-e10s'], 16:36:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:36:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:36:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:36:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:36:27 INFO - 'talos_options': ['--disable-e10s'], 16:36:27 INFO - 'tests': ['damp', 'tps']}, 16:36:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:36:27 INFO - 'tests': ['damp', 'tps']}, 16:36:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:36:27 INFO - 'tests': ['dromaeo_dom']}, 16:36:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:36:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:36:27 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:36:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:36:27 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:36:27 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:36:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:36:27 INFO - 'tests': ['a11yr', 16:36:27 INFO - 'ts_paint', 16:36:27 INFO - 'tpaint', 16:36:27 INFO - 'sessionrestore', 16:36:27 INFO - 'sessionrestore_no_auto_restore', 16:36:27 INFO - 'tabpaint']}, 16:36:27 INFO - 'other-e10s': {'tests': ['a11yr', 16:36:27 INFO - 'ts_paint', 16:36:27 INFO - 'tpaint', 16:36:27 INFO - 'sessionrestore', 16:36:27 INFO - 'sessionrestore_no_auto_restore', 16:36:27 INFO - 'tabpaint']}, 16:36:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:36:27 INFO - 'ts_paint', 16:36:27 INFO - 'tpaint', 16:36:27 INFO - 'sessionrestore', 16:36:27 INFO - 'sessionrestore_no_auto_restore', 16:36:27 INFO - 'tabpaint']}, 16:36:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:36:27 INFO - 'ts_paint', 16:36:27 INFO - 'tpaint', 16:36:27 INFO - 'sessionrestore', 16:36:27 INFO - 'sessionrestore_no_auto_restore', 16:36:27 INFO - 'tabpaint']}, 16:36:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:36:27 INFO - 'tests': ['a11yr', 16:36:27 INFO - 'ts_paint', 16:36:27 INFO - 'tpaint', 16:36:27 INFO - 'sessionrestore', 16:36:27 INFO - 'sessionrestore_no_auto_restore', 16:36:27 INFO - 'tabpaint']}, 16:36:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:36:27 INFO - 'tests': ['a11yr', 16:36:27 INFO - 'ts_paint', 16:36:27 INFO - 'tpaint', 16:36:27 INFO - 'sessionrestore', 16:36:27 INFO - 'sessionrestore_no_auto_restore', 16:36:27 INFO - 'tabpaint']}, 16:36:27 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:36:27 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:36:27 INFO - 'bloom_basic_ref']}, 16:36:27 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 16:36:27 INFO - 'talos_options': ['--mitmproxy', 16:36:27 INFO - 'mitmproxy-recording-1.mp', 16:36:27 INFO - '--firstNonBlankPaint'], 16:36:27 INFO - 'tests': ['Quantum_1']}, 16:36:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:36:27 INFO - 'tests': ['tsvgx', 16:36:27 INFO - 'tsvgr_opacity', 16:36:27 INFO - 'tart', 16:36:27 INFO - 'tscrollx', 16:36:27 INFO - 'cart', 16:36:27 INFO - 'tsvg_static']}, 16:36:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:36:27 INFO - 'tsvgr_opacity', 16:36:27 INFO - 'tart', 16:36:27 INFO - 'tscrollx', 16:36:27 INFO - 'cart', 16:36:27 INFO - 'tsvg_static']}, 16:36:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:36:27 INFO - 'talos_options': ['--disable-e10s'], 16:36:27 INFO - 'tests': ['tp5o']}, 16:36:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:36:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:36:27 INFO - 'talos_options': ['--disable-e10s', 16:36:27 INFO - '--xperf_path', 16:36:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:36:27 INFO - 'tests': ['tp5n']}, 16:36:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:36:27 INFO - 'talos_options': ['--xperf_path', 16:36:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:36:27 INFO - 'tests': ['tp5n']}}, 16:36:27 INFO - 'talos.zip': {'path': '', 16:36:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:36:27 INFO - Running post-action listener: _resource_record_post_action 16:36:27 INFO - [mozharness: 2017-05-28 23:36:27.205769Z] Finished populate-webroot step (success) 16:36:27 INFO - [mozharness: 2017-05-28 23:36:27.205864Z] Running create-virtualenv step. 16:36:27 INFO - Running pre-action listener: _resource_record_pre_action 16:36:27 INFO - Running main action method: create_virtualenv 16:36:27 INFO - Creating virtualenv /builds/slave/test/build/venv 16:36:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:36:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:36:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:36:27 INFO - Using real prefix '/usr' 16:36:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:36:27 INFO - Installing distribute.............................................................................................................................................................................................done. 16:36:29 INFO - Installing pip.................done. 16:36:29 INFO - Return code: 0 16:36:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:36:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:36:29 INFO - Reading from file tmpfile_stdout 16:36:29 INFO - Output received: 16:36:29 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:36:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:29 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 0x250b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2885e40>, '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 0x2886fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2887440>, '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': '934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:36:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:36:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:36:30 INFO - Using env: {'DISPLAY': ':0', 16:36:30 INFO - 'HOME': '/home/cltbld', 16:36:30 INFO - 'LANG': 'en_US.UTF-8', 16:36:30 INFO - 'LANGUAGE': 'en_US:en', 16:36:30 INFO - 'LOGNAME': 'cltbld', 16:36:30 INFO - 'MAIL': '/var/mail/cltbld', 16:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:30 INFO - 'MOZ_NO_REMOTE': '1', 16:36:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:30 INFO - 'NO_EM_RESTART': '1', 16:36:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:30 INFO - 'PWD': '/builds/slave/test', 16:36:30 INFO - 'SHELL': '/bin/bash', 16:36:30 INFO - 'SHLVL': '1', 16:36:30 INFO - 'TERM': 'linux', 16:36:30 INFO - 'TMOUT': '86400', 16:36:30 INFO - 'USER': 'cltbld', 16:36:30 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970', 16:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:30 INFO - '_': '/tools/buildbot/bin/python'} 16:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:36:30 INFO - Cleaning up... 16:36:30 INFO - Return code: 0 16:36:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:30 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 0x250b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2885e40>, '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 0x2886fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2887440>, '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': '934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:36:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:36:30 INFO - Using env: {'DISPLAY': ':0', 16:36:30 INFO - 'HOME': '/home/cltbld', 16:36:30 INFO - 'LANG': 'en_US.UTF-8', 16:36:30 INFO - 'LANGUAGE': 'en_US:en', 16:36:30 INFO - 'LOGNAME': 'cltbld', 16:36:30 INFO - 'MAIL': '/var/mail/cltbld', 16:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:30 INFO - 'MOZ_NO_REMOTE': '1', 16:36:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:30 INFO - 'NO_EM_RESTART': '1', 16:36:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:30 INFO - 'PWD': '/builds/slave/test', 16:36:30 INFO - 'SHELL': '/bin/bash', 16:36:30 INFO - 'SHLVL': '1', 16:36:30 INFO - 'TERM': 'linux', 16:36:30 INFO - 'TMOUT': '86400', 16:36:30 INFO - 'USER': 'cltbld', 16:36:30 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970', 16:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:30 INFO - '_': '/tools/buildbot/bin/python'} 16:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:30 INFO - Downloading/unpacking psutil>=3.1.1 16:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:36:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:36:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:36:31 INFO - Installing collected packages: psutil 16:36:31 INFO - Running setup.py install for psutil 16:36:31 INFO - building 'psutil._psutil_linux' extension 16:36:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:36:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:36:31 INFO - building 'psutil._psutil_posix' extension 16:36:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:36:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:36:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:36:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:36:32 INFO - Successfully installed psutil 16:36:32 INFO - Cleaning up... 16:36:32 INFO - Return code: 0 16:36:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:36:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:32 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 0x250b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2885e40>, '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 0x2886fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2887440>, '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': '934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:36:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:36:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:36:32 INFO - Using env: {'DISPLAY': ':0', 16:36:32 INFO - 'HOME': '/home/cltbld', 16:36:32 INFO - 'LANG': 'en_US.UTF-8', 16:36:32 INFO - 'LANGUAGE': 'en_US:en', 16:36:32 INFO - 'LOGNAME': 'cltbld', 16:36:32 INFO - 'MAIL': '/var/mail/cltbld', 16:36:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:32 INFO - 'MOZ_NO_REMOTE': '1', 16:36:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:32 INFO - 'NO_EM_RESTART': '1', 16:36:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:32 INFO - 'PWD': '/builds/slave/test', 16:36:32 INFO - 'SHELL': '/bin/bash', 16:36:32 INFO - 'SHLVL': '1', 16:36:32 INFO - 'TERM': 'linux', 16:36:32 INFO - 'TMOUT': '86400', 16:36:32 INFO - 'USER': 'cltbld', 16:36:32 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970', 16:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:32 INFO - '_': '/tools/buildbot/bin/python'} 16:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:36:33 INFO - Installing collected packages: mozsystemmonitor 16:36:33 INFO - Running setup.py install for mozsystemmonitor 16:36:33 INFO - Successfully installed mozsystemmonitor 16:36:33 INFO - Cleaning up... 16:36:33 INFO - Return code: 0 16:36:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:36:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:33 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 0x250b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2885e40>, '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 0x2886fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2887440>, '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': '934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:36:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:36:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:36:33 INFO - Using env: {'DISPLAY': ':0', 16:36:33 INFO - 'HOME': '/home/cltbld', 16:36:33 INFO - 'LANG': 'en_US.UTF-8', 16:36:33 INFO - 'LANGUAGE': 'en_US:en', 16:36:33 INFO - 'LOGNAME': 'cltbld', 16:36:33 INFO - 'MAIL': '/var/mail/cltbld', 16:36:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:33 INFO - 'MOZ_NO_REMOTE': '1', 16:36:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:33 INFO - 'NO_EM_RESTART': '1', 16:36:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:33 INFO - 'PWD': '/builds/slave/test', 16:36:33 INFO - 'SHELL': '/bin/bash', 16:36:33 INFO - 'SHLVL': '1', 16:36:33 INFO - 'TERM': 'linux', 16:36:33 INFO - 'TMOUT': '86400', 16:36:33 INFO - 'USER': 'cltbld', 16:36:33 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970', 16:36:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:33 INFO - '_': '/tools/buildbot/bin/python'} 16:36:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:33 INFO - Downloading/unpacking jsonschema==2.5.1 16:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:36:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:35 INFO - Downloading functools32-3.2.3-2.tar.gz 16:36:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:36:35 INFO - warning: no files found matching '*.txt' 16:36:35 INFO - no previously-included directories found matching 'build' 16:36:35 INFO - no previously-included directories found matching 'dist' 16:36:35 INFO - no previously-included directories found matching '.git*' 16:36:35 INFO - Installing collected packages: jsonschema, functools32 16:36:35 INFO - Running setup.py install for functools32 16:36:35 INFO - warning: no files found matching '*.txt' 16:36:35 INFO - no previously-included directories found matching 'build' 16:36:35 INFO - no previously-included directories found matching 'dist' 16:36:35 INFO - no previously-included directories found matching '.git*' 16:36:35 INFO - Successfully installed jsonschema functools32 16:36:35 INFO - Cleaning up... 16:36:35 INFO - Return code: 0 16:36:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:35 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 0x250b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2885e40>, '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 0x2886fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2887440>, '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': '934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:36:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:36:35 INFO - Using env: {'DISPLAY': ':0', 16:36:35 INFO - 'HOME': '/home/cltbld', 16:36:35 INFO - 'LANG': 'en_US.UTF-8', 16:36:35 INFO - 'LANGUAGE': 'en_US:en', 16:36:35 INFO - 'LOGNAME': 'cltbld', 16:36:35 INFO - 'MAIL': '/var/mail/cltbld', 16:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:35 INFO - 'MOZ_NO_REMOTE': '1', 16:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:35 INFO - 'NO_EM_RESTART': '1', 16:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:35 INFO - 'PWD': '/builds/slave/test', 16:36:35 INFO - 'SHELL': '/bin/bash', 16:36:35 INFO - 'SHLVL': '1', 16:36:35 INFO - 'TERM': 'linux', 16:36:35 INFO - 'TMOUT': '86400', 16:36:35 INFO - 'USER': 'cltbld', 16:36:35 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970', 16:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:35 INFO - '_': '/tools/buildbot/bin/python'} 16:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:36:35 INFO - Cleaning up... 16:36:35 INFO - Return code: 0 16:36:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:35 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 0x250b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2885e40>, '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 0x2886fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2887440>, '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': '934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:36:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:36:35 INFO - Using env: {'DISPLAY': ':0', 16:36:35 INFO - 'HOME': '/home/cltbld', 16:36:35 INFO - 'LANG': 'en_US.UTF-8', 16:36:35 INFO - 'LANGUAGE': 'en_US:en', 16:36:35 INFO - 'LOGNAME': 'cltbld', 16:36:35 INFO - 'MAIL': '/var/mail/cltbld', 16:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:35 INFO - 'MOZ_NO_REMOTE': '1', 16:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:35 INFO - 'NO_EM_RESTART': '1', 16:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:35 INFO - 'PWD': '/builds/slave/test', 16:36:35 INFO - 'SHELL': '/bin/bash', 16:36:35 INFO - 'SHLVL': '1', 16:36:35 INFO - 'TERM': 'linux', 16:36:35 INFO - 'TMOUT': '86400', 16:36:35 INFO - 'USER': 'cltbld', 16:36:35 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970', 16:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:35 INFO - '_': '/tools/buildbot/bin/python'} 16:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:35 INFO - Downloading/unpacking blobuploader==1.2.4 16:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:36 INFO - Downloading blobuploader-1.2.4.tar.gz 16:36:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:36:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:36:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:37 INFO - Downloading docopt-0.6.1.tar.gz 16:36:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:36:37 INFO - Installing collected packages: blobuploader, requests, docopt 16:36:37 INFO - Running setup.py install for blobuploader 16:36:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:36:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:36:37 INFO - Running setup.py install for requests 16:36:37 INFO - Running setup.py install for docopt 16:36:37 INFO - Successfully installed blobuploader requests docopt 16:36:37 INFO - Cleaning up... 16:36:38 INFO - Return code: 0 16:36:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:38 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 0x250b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2885e40>, '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 0x2886fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2887440>, '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': '934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:36:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:36:38 INFO - Using env: {'DISPLAY': ':0', 16:36:38 INFO - 'HOME': '/home/cltbld', 16:36:38 INFO - 'LANG': 'en_US.UTF-8', 16:36:38 INFO - 'LANGUAGE': 'en_US:en', 16:36:38 INFO - 'LOGNAME': 'cltbld', 16:36:38 INFO - 'MAIL': '/var/mail/cltbld', 16:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:38 INFO - 'MOZ_NO_REMOTE': '1', 16:36:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:38 INFO - 'NO_EM_RESTART': '1', 16:36:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:38 INFO - 'PWD': '/builds/slave/test', 16:36:38 INFO - 'SHELL': '/bin/bash', 16:36:38 INFO - 'SHLVL': '1', 16:36:38 INFO - 'TERM': 'linux', 16:36:38 INFO - 'TMOUT': '86400', 16:36:38 INFO - 'USER': 'cltbld', 16:36:38 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970', 16:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:38 INFO - '_': '/tools/buildbot/bin/python'} 16:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:36:38 INFO - Running setup.py (path:/tmp/pip-YWzXLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:36:38 INFO - Running setup.py (path:/tmp/pip-IV9bWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:36:38 INFO - Running setup.py (path:/tmp/pip-2uQ01I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:36:38 INFO - Running setup.py (path:/tmp/pip-ibGLlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:36:38 INFO - Running setup.py (path:/tmp/pip-ClBNM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:36:38 INFO - Running setup.py (path:/tmp/pip-oebLhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:36:38 INFO - Running setup.py (path:/tmp/pip-ZvtwrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:36:38 INFO - Running setup.py (path:/tmp/pip-upC3v6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:36:38 INFO - Running setup.py (path:/tmp/pip-cUTsuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:36:38 INFO - Running setup.py (path:/tmp/pip-Ay0CPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:36:38 INFO - Running setup.py (path:/tmp/pip-lyFDOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:36:39 INFO - Running setup.py (path:/tmp/pip-Xrkg_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:36:39 INFO - Running setup.py (path:/tmp/pip-yOUMIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:36:39 INFO - Running setup.py (path:/tmp/pip-YczfWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:39 INFO - Running setup.py (path:/tmp/pip-qsBw4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:36:39 INFO - Running setup.py (path:/tmp/pip-bwKcEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:36:39 INFO - Running setup.py (path:/tmp/pip-CgR3Qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:36:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:36:39 INFO - Running setup.py install for manifestparser 16:36:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:36:39 INFO - Running setup.py install for mozcrash 16:36:39 INFO - Running setup.py install for mozdebug 16:36:39 INFO - Running setup.py install for mozdevice 16:36:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:36:39 INFO - Running setup.py install for mozfile 16:36:39 INFO - Running setup.py install for mozhttpd 16:36:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:36:40 INFO - Running setup.py install for mozinfo 16:36:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:36:40 INFO - Running setup.py install for mozInstall 16:36:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:36:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:36:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:36:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:36:40 INFO - Running setup.py install for mozleak 16:36:40 INFO - Running setup.py install for mozlog 16:36:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:36:40 INFO - Running setup.py install for moznetwork 16:36:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:36:40 INFO - Running setup.py install for mozprocess 16:36:40 INFO - Running setup.py install for mozprofile 16:36:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:36:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:36:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:36:40 INFO - Running setup.py install for mozrunner 16:36:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:36:40 INFO - Running setup.py install for mozscreenshot 16:36:41 INFO - Running setup.py install for moztest 16:36:41 INFO - Running setup.py install for mozversion 16:36:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:36:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:36:41 INFO - Cleaning up... 16:36:41 INFO - Return code: 0 16:36:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:41 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 0x250b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2885e40>, '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 0x2886fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2887440>, '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': '934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:36:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:36:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:36:41 INFO - Using env: {'DISPLAY': ':0', 16:36:41 INFO - 'HOME': '/home/cltbld', 16:36:41 INFO - 'LANG': 'en_US.UTF-8', 16:36:41 INFO - 'LANGUAGE': 'en_US:en', 16:36:41 INFO - 'LOGNAME': 'cltbld', 16:36:41 INFO - 'MAIL': '/var/mail/cltbld', 16:36:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:41 INFO - 'MOZ_NO_REMOTE': '1', 16:36:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:41 INFO - 'NO_EM_RESTART': '1', 16:36:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:41 INFO - 'PWD': '/builds/slave/test', 16:36:41 INFO - 'SHELL': '/bin/bash', 16:36:41 INFO - 'SHLVL': '1', 16:36:41 INFO - 'TERM': 'linux', 16:36:41 INFO - 'TMOUT': '86400', 16:36:41 INFO - 'USER': 'cltbld', 16:36:41 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970', 16:36:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:41 INFO - '_': '/tools/buildbot/bin/python'} 16:36:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:36:41 INFO - Running setup.py (path:/tmp/pip-Y2kqBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:36:41 INFO - Running setup.py (path:/tmp/pip-CtqP_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:36:41 INFO - Running setup.py (path:/tmp/pip-PprZ0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:36:41 INFO - Running setup.py (path:/tmp/pip-1Ylrjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:36:41 INFO - Running setup.py (path:/tmp/pip-K0iO2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:36:41 INFO - Running setup.py (path:/tmp/pip-dzui1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:36:41 INFO - Running setup.py (path:/tmp/pip-O0P4K9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:36:41 INFO - Running setup.py (path:/tmp/pip-l1duYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:36:42 INFO - Running setup.py (path:/tmp/pip-B8Erql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:36:42 INFO - Running setup.py (path:/tmp/pip-sKx6N_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:36:42 INFO - Running setup.py (path:/tmp/pip-kHR659-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:36:42 INFO - Running setup.py (path:/tmp/pip-e1EYKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:36:42 INFO - Running setup.py (path:/tmp/pip-vjQkDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:36:42 INFO - Running setup.py (path:/tmp/pip-mi3J7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:42 INFO - Running setup.py (path:/tmp/pip-FHagB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:36:42 INFO - Running setup.py (path:/tmp/pip-WpxEKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:36:42 INFO - Running setup.py (path:/tmp/pip-IMak2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:36:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:43 INFO - Downloading blessings-1.6.tar.gz 16:36:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:36:43 INFO - Installing collected packages: blessings 16:36:43 INFO - Running setup.py install for blessings 16:36:43 INFO - Successfully installed blessings 16:36:44 INFO - Cleaning up... 16:36:44 INFO - Return code: 0 16:36:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:36:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:36:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:36:44 INFO - Reading from file tmpfile_stdout 16:36:44 INFO - Current package versions: 16:36:44 INFO - argparse == 1.2.1 16:36:44 INFO - blessings == 1.6 16:36:44 INFO - blobuploader == 1.2.4 16:36:44 INFO - docopt == 0.6.1 16:36:44 INFO - functools32 == 3.2.3-2 16:36:44 INFO - jsonschema == 2.5.1 16:36:44 INFO - manifestparser == 1.1 16:36:44 INFO - mozInstall == 1.12 16:36:44 INFO - mozcrash == 1.0 16:36:44 INFO - mozdebug == 0.1 16:36:44 INFO - mozdevice == 0.51 16:36:44 INFO - mozfile == 1.2 16:36:44 INFO - mozhttpd == 0.7 16:36:44 INFO - mozinfo == 0.9 16:36:44 INFO - mozleak == 0.1 16:36:44 INFO - mozlog == 3.4 16:36:44 INFO - moznetwork == 0.27 16:36:44 INFO - mozprocess == 0.25 16:36:44 INFO - mozprofile == 0.28 16:36:44 INFO - mozrunner == 6.13 16:36:44 INFO - mozscreenshot == 0.1 16:36:44 INFO - mozsystemmonitor == 0.3 16:36:44 INFO - moztest == 0.8 16:36:44 INFO - mozversion == 1.4 16:36:44 INFO - psutil == 3.1.1 16:36:44 INFO - requests == 1.2.3 16:36:44 INFO - wsgiref == 0.1.2 16:36:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:44 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 0x250b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2885e40>, '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 0x2886fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2887440>, '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': '934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:36:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:36:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:36:44 INFO - Using env: {'DISPLAY': ':0', 16:36:44 INFO - 'HOME': '/home/cltbld', 16:36:44 INFO - 'LANG': 'en_US.UTF-8', 16:36:44 INFO - 'LANGUAGE': 'en_US:en', 16:36:44 INFO - 'LOGNAME': 'cltbld', 16:36:44 INFO - 'MAIL': '/var/mail/cltbld', 16:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:44 INFO - 'MOZ_NO_REMOTE': '1', 16:36:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:44 INFO - 'NO_EM_RESTART': '1', 16:36:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:44 INFO - 'PWD': '/builds/slave/test', 16:36:44 INFO - 'SHELL': '/bin/bash', 16:36:44 INFO - 'SHLVL': '1', 16:36:44 INFO - 'TERM': 'linux', 16:36:44 INFO - 'TMOUT': '86400', 16:36:44 INFO - 'USER': 'cltbld', 16:36:44 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970', 16:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:44 INFO - '_': '/tools/buildbot/bin/python'} 16:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:36:44 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:45 INFO - Downloading marionette_driver-1.4.0.tar.gz 16:36:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 16:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:36:45 INFO - Installing collected packages: marionette-driver 16:36:45 INFO - Running setup.py install for marionette-driver 16:36:45 INFO - Successfully installed marionette-driver 16:36:45 INFO - Cleaning up... 16:36:45 INFO - Return code: 0 16:36:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:45 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 0x250b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2885e40>, '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 0x2886fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2887440>, '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': '934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:36:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:36:45 INFO - Using env: {'DISPLAY': ':0', 16:36:45 INFO - 'HOME': '/home/cltbld', 16:36:45 INFO - 'LANG': 'en_US.UTF-8', 16:36:45 INFO - 'LANGUAGE': 'en_US:en', 16:36:45 INFO - 'LOGNAME': 'cltbld', 16:36:45 INFO - 'MAIL': '/var/mail/cltbld', 16:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:45 INFO - 'MOZ_NO_REMOTE': '1', 16:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:45 INFO - 'NO_EM_RESTART': '1', 16:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:45 INFO - 'PWD': '/builds/slave/test', 16:36:45 INFO - 'SHELL': '/bin/bash', 16:36:45 INFO - 'SHLVL': '1', 16:36:45 INFO - 'TERM': 'linux', 16:36:45 INFO - 'TMOUT': '86400', 16:36:45 INFO - 'USER': 'cltbld', 16:36:45 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970', 16:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:45 INFO - '_': '/tools/buildbot/bin/python'} 16:36:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:36:46 INFO - Cleaning up... 16:36:46 INFO - Return code: 0 16:36:46 INFO - Running post-action listener: _resource_record_post_action 16:36:46 INFO - Running post-action listener: _start_resource_monitoring 16:36:46 INFO - Starting resource monitoring. 16:36:46 INFO - [mozharness: 2017-05-28 23:36:46.049518Z] Finished create-virtualenv step (success) 16:36:46 INFO - [mozharness: 2017-05-28 23:36:46.050040Z] Running install step. 16:36:46 INFO - Running pre-action listener: _resource_record_pre_action 16:36:46 INFO - Running main action method: install 16:36:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:36:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:36:46 INFO - Reading from file tmpfile_stdout 16:36:46 INFO - Detecting whether we're running mozinstall >=1.0... 16:36:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:36:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:36:46 INFO - Reading from file tmpfile_stdout 16:36:46 INFO - Output received: 16:36:46 INFO - Usage: mozinstall [options] installer 16:36:46 INFO - Options: 16:36:46 INFO - -h, --help show this help message and exit 16:36:46 INFO - -d DEST, --destination=DEST 16:36:46 INFO - Directory to install application into. [default: 16:36:46 INFO - "/builds/slave/test"] 16:36:46 INFO - --app=APP Application being installed. [default: firefox] 16:36:46 INFO - mkdir: /builds/slave/test/build/application 16:36:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:36:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:37:01 INFO - Reading from file tmpfile_stdout 16:37:01 INFO - Output received: 16:37:01 INFO - /builds/slave/test/build/application/firefox/firefox 16:37:01 INFO - Running post-action listener: _resource_record_post_action 16:37:01 INFO - [mozharness: 2017-05-28 23:37:01.903573Z] Finished install step (success) 16:37:01 INFO - [mozharness: 2017-05-28 23:37:01.903851Z] Running setup-mitmproxy step. 16:37:01 INFO - Running pre-action listener: _resource_record_pre_action 16:37:01 INFO - Running main action method: setup_mitmproxy 16:37:01 INFO - Skipping: mitmproxy is not required 16:37:01 INFO - Running post-action listener: _resource_record_post_action 16:37:01 INFO - [mozharness: 2017-05-28 23:37:01.904953Z] Finished setup-mitmproxy step (success) 16:37:01 INFO - [mozharness: 2017-05-28 23:37:01.905172Z] Running run-tests step. 16:37:01 INFO - Running pre-action listener: _resource_record_pre_action 16:37:01 INFO - Running main action method: run_tests 16:37:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:37:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:37:01 INFO - Python 2.7.3 16:37:01 INFO - Return code: 0 16:37:01 INFO - grabbing minidump binary from tooltool 16:37: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')]} 16:37:01 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 0x2885e40>, '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 0x2886fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2887440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:37:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:37:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:37:01 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:37:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:37:01 INFO - Return code: 0 16:37:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:37:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:37:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:37:01 INFO - ENV: RUST_BACKTRACE is now 1 16:37:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:37:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:37:01 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/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:37:01 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/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:37:01 INFO - Using env: {'DISPLAY': ':0', 16:37:01 INFO - 'HOME': '/home/cltbld', 16:37:01 INFO - 'LANG': 'en_US.UTF-8', 16:37:01 INFO - 'LANGUAGE': 'en_US:en', 16:37:01 INFO - 'LOGNAME': 'cltbld', 16:37:01 INFO - 'MAIL': '/var/mail/cltbld', 16:37:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:37:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:01 INFO - 'MOZ_NO_REMOTE': '1', 16:37:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:37:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:01 INFO - 'NO_EM_RESTART': '1', 16:37:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:01 INFO - 'PWD': '/builds/slave/test', 16:37:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:37:01 INFO - 'RUST_BACKTRACE': '1', 16:37:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:37:01 INFO - 'SHELL': '/bin/bash', 16:37:01 INFO - 'SHLVL': '1', 16:37:01 INFO - 'TERM': 'linux', 16:37:01 INFO - 'TMOUT': '86400', 16:37:01 INFO - 'USER': 'cltbld', 16:37:01 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970', 16:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:01 INFO - '_': '/tools/buildbot/bin/python'} 16:37:01 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/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:37:02 INFO - mozversion application_buildid: 20170528224948 16:37:02 INFO - mozversion application_changeset: 51d220b260d8d52a41b65aae2c5d74be99c2d59e 16:37:02 INFO - mozversion application_display_name: Nightly 16:37:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:37:02 INFO - mozversion application_name: Firefox 16:37:02 INFO - mozversion application_remotingname: firefox 16:37:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:37:02 INFO - mozversion application_vendor: Mozilla 16:37:02 INFO - mozversion application_version: 55.0a1 16:37:02 INFO - mozversion platform_buildid: 20170528224948 16:37:02 INFO - mozversion platform_changeset: 51d220b260d8d52a41b65aae2c5d74be99c2d59e 16:37:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:37:02 INFO - mozversion platform_version: 55.0a1 16:37:02 INFO - using testdate: 1496014622 16:37:02 INFO - actual date: 1496014622 16:37:02 INFO - starting webserver on 'localhost:54882' 16:37:02 INFO - SUITE-START | Running 2 tests 16:37:02 INFO - TEST-START | dromaeo_css 16:37:02 INFO - operating with platform_type : linux_ 16:37:02 INFO - Initialising browser for dromaeo_css test... 16:37:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54882/getInfo.html -profile /tmp/tmph_Nyl3/profile 16:37:02 INFO - TEST-INFO | started process 1399 (/builds/slave/test/build/application/firefox/firefox http://localhost:54882/getInfo.html) 16:37:37 INFO - TEST-INFO | 1399: killed by SIGTERM 16:37:37 INFO - Browser initialized. 16:37:37 INFO - Running cycle 1/1 for dromaeo_css test... 16:37:37 INFO - TEST-INFO | started process 1599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph_Nyl3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:37:49 INFO - PID 1599 | RSS: Main: 183455744 16:37:49 INFO - PID 1599 | 16:40:54 INFO - PID 1599 | Cycle 1(1): loaded http://localhost:54882/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54882/tests/dromaeo/cssquery-ext.html) 16:40:56 INFO - PID 1599 | RSS: Main: 178380800 16:40:56 INFO - PID 1599 | 16:43:58 INFO - PID 1599 | Cycle 1(1): loaded http://localhost:54882/tests/dromaeo/cssquery-ext.html (next: http://localhost:54882/tests/dromaeo/cssquery-jquery.html) 16:43:58 INFO - PID 1599 | RSS: Main: 183341056 16:43:58 INFO - PID 1599 | 16:47:00 INFO - PID 1599 | Cycle 1(1): loaded http://localhost:54882/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54882/tests/dromaeo/cssquery-mootools.html) 16:47:01 INFO - PID 1599 | RSS: Main: 181186560 16:47:01 INFO - PID 1599 | 16:50:02 INFO - PID 1599 | Cycle 1(1): loaded http://localhost:54882/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54882/tests/dromaeo/cssquery-prototype.html) 16:50:03 INFO - PID 1599 | RSS: Main: 185081856 16:50:03 INFO - PID 1599 | 16:53:06 INFO - PID 1599 | Cycle 1(1): loaded http://localhost:54882/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54882/tests/dromaeo/cssquery-yui.html) 16:53:07 INFO - PID 1599 | RSS: Main: 183173120 16:53:07 INFO - PID 1599 | 16:56:08 INFO - PID 1599 | Cycle 1(1): loaded http://localhost:54882/tests/dromaeo/cssquery-yui.html (next: http://localhost:54882/tests/dromaeo/cssquery-dojo.html) 16:56:09 INFO - PID 1599 | RSS: Main: 181895168 16:56:09 INFO - PID 1599 | 16:56:09 INFO - PID 1599 | __start_tp_report 16:56:09 INFO - PID 1599 | _x_x_mozilla_page_load 16:56:09 INFO - PID 1599 | _x_x_mozilla_page_load_details 16:56:09 INFO - PID 1599 | |i|pagename|runs| 16:56:09 INFO - PID 1599 | |0;dojo.html;2700.7569318761307;2715.6741191057076;2731.3444773254423;2752.477029364421;2758.931026724332;5104.387473503176;5220.37355517338;5237.921431178531;5245.7377131143385;5289.4181640019615;5144.948550514494;5186.8703282417955;5199.324087868572;5299.576033917287;5317;4661.673682842203;4677.508861569538;4688.273317635763;4703.200455922484;4739.763011849411;4643.396358473394;4671.182543054952;4742.952570474303;4749.786259618309;4763.404574428197;4589.105124500724;4650.139724151043;4702.670813043088;4709.175894218498;4749.311349854269;4597.747123908183;4619.19164146273;4641.7214967101745;4668.206404911173;4690.132325519789;4641.883952901171;4655.464621568529;4658.254679251304;4659.370984917061;4660.5106463821485;5193.039287731782;5234.319538459976;5251.579873610102;5252.212168174766;5256.92114618281;5570.777168913239;5648.237487939116;5655.830325090254;5711.514521265697;5725.312962444534;5786.189933409326;5786.392428794958;5792.478676919098;5800.332961709415;5819.912701309484;5304.655197412233;5314.946850531523;5316.76074576645;5318.9202161967605;5324.520793128637;5657.377688454267;5719.142128680648;5765.279340082489;5893.970530147408;5895.498882594941;5556.249906262684;5560.7219639017885;5575.135853942646;5584.497395234448;5610.5231055360755;5632.338460154264;5665.745041473144;5669.603127781016;5674.4892959633835;5675.772969081273;5550.250716153268;5560.582956278296;5640.435956404409;5640.717964101778;5656.2929633795775;5674.347450043216;5690.715464226855;5725.570582206351;5739.598228123991;5765.740541675635;4736.976315118402;4738.668293219511;4744.833930812405;4746.098241334135;4790.784414701347;3974.2448934702315;4040.5151381834366;4066.6949978751713;4067.1458993611673;4107.815148318333;4695.248760198352;4732.503087175865;4761.880952976134;4762.571368576845;4768.642351823627;5696.572757043155;5723.255976723;5730.369659337553;5737.540996720252;5746.396628354046;4782.0914026334885;4816.446108697544;4821.04161996567;4822.035592881438;4856.854294371175;4945.159322915113;4963.875903102451;5034.16936205522;5053.8736531587;5094.541491265803;5287.127623942007;5292.364916210079;5306.336707911511;5308.46915308466;5311.070562651597;5597.944020559905;5661.745221464962;5666.575006874418;5690.601657883908;5695.800646977336;5215.921761173509;5246;5270.156774915995;5302.2046692996355;5308.389535203347;5535.474129957647;5617.9719101404235;5662.292213473316;5669.773209071756;5681;5656.462636049569;5679.460451257124;5744.856378590569;5760.991826430274;5771.3651498335985;5531.944680553304;5535.7785688572;5543.223948647112;5553.389127195925;5559.916601250903;5517.282753242052;5521.585881058856;5533.612647114664;5542.196381524575;5543.52880005204;5234.659747116425;5263.6578622389425;5435.184722291688;5476.726163691879;5485.6434331768305;5565.026120428828;5594.720263986866;5599.552035837205;5617.831465056055;5643.943560564342;5415.187721841755;5427.918581221364;5435.320584926884;5435.701036443033;5440.7551660174595 16:56:09 INFO - PID 1599 | |1;ext.html;748.2031636307333;763.1109757132939;1089.8801131875493;1099.3184225780012;1239.1387985350186;33004.504932426;33670.8316458418;33701;33731.83134084326;33736.15659608511;31473.370532589335;31542.369152616935;31885;31918.84040579794;32012.839935800348;6396.360363963601;6485.643289619069;6596.142501474826;6707.631080290582;6713.798586042402;6623.23832759234;6655.134832471772;6742.393184613384;6745.224299205581;6754.628495432749;6701.463882889381;6727.159105111861;6752.2234942981695;6757.425618822382;6766.763163289286;6705.061291419156;6706.497012724041;6715.194176698803;6748.156480439945;6749;6556.213254409454;6646.767363142267;6662.766803161914;6663.36698013688;6693.6318502482345;30843;30869.228269293224;31090.378192436252;31171.53242701361;31226.37547249065;3049.1919641295076;3068.2176045108354;3072.4623190941497;3076.09255269696;3087.043016664841;24364.878175609185;24531;24641.876790616112;24649.876750616313;24685.382865428328;3050.5119180931165;3087.521434177706;3090.644575873781;3117.438861005018;3135.545345924851;141131;141505;141702.29148854292;141822;142004.28997855049;33203.83398082994;33916.83041584826;38458.42312365317;39538.60461395407;40378;40851.38722919158;40869;40956.59043409587;40959.79520102381;40962.79518602388;11417.771644567229;11665.35840528779;11679.240849344766;11689.532418703327;11731.706707332385;9308.069193080637;9329;9332.486713230837;9339.813203735886;9352.438853668666;12686.80969785454;12704.174228675107;12734.172278801849;12735.80896286538;12880.162789418659;5268.4994925482015;5409.43200963901;5420.701861397661;5446.101393270145;5448.945510544923;866.4931015355961;904.1817155474306;911.9316051296179;917.3074328881652;933.8785957825575;20741.481462963246;21520.78479215219;21596.568068638855;21617.78382216158;21794;976.9560369783377;983.6852207293597;1001.7145113642576;1009.2531526670211;1013.7262939006574;11037.724056898642;11086;11283.153763467773;11283.251096080121;11445.599404020986;171827;172869;173119;173132;173581;40116.398254026215;40324;40361.59638403579;40395;40501.594984050374;1159.3217967488945;1209.661294837447;1217.303672365732;1220.2251570252954;1224.369449733388;19899.303524377156;20415.69376459384;20544.17823287052;20832.27087051946;21359.359219223446;28662.283442914093;28875.855620721763;36336.45495317625;37452;37471.62528374681;161578;163494;163787;165086;165714;29407.558886617146;29674.109776706733;29921.251968700955;30756.84621576878;31288;35665;36249.456258155624;36299.45550816687;36314.63685363113;36964.81517592395;27439.45121097527;27499.31251718723;27779.44441111126;28231.71768282373;29355.266118347212;27673.861630691717;28201.858990704914;28276.293092672848;29470.263243419085;29698.55452168176;31346.68653313529;31398.058058258288;31443.842780785948;31584.36831263316;31790.205244869063;26113;26367.208983730518;27165.320866978484;27611.447771044066;28115.578266325614;19846.680997720363;22542.211022614785;22570.887145564167;22597.548049039255;22743.431414214778 16:56:09 INFO - PID 1599 | |2;jquery.html;411.364441937207;421.0668636796028;433.8806828122267;435.373062789583;439.46604875076787;11646.417679116053;13277.46890124394;16715.331386744532;17378;17392.56518587036;18180.090995450242;18355.174017169225;18442.170102345393;18616.534586635305;19059.90470047648;5251.081060814361;5442.564594832424;5444.292242008533;5453.318335208099;5464.480874316933;5170.353705786777;5386.48828361305;5406.243125962349;5409.810656627019;5419.918701219485;5318.175682769177;5370.7046112463795;5391.272178255925;5394.1908713692865;5400.135978243482;5183.922241166386;5259.31628888244;5267.104592219332;5279.313689220415;5374.140137577989;4766.666333356667;4775.379200703921;4789.2816077588295;4795.088933102699;4800.351952486404;21179.258725944674;21269.574608507744;21408.678869816966;21434;21558.89220553903;1634.9673006539801;1642.2117383655911;1670.0814551996475;1671;1673.205227516932;14354.784678229835;14398.496052638213;14526.636834079127;14789.482368117064;14922.403103875831;1946.5133716570858;2005.7893921138216;2037.500812300981;2045.4681782736595;2064.1743302678897;76389;88264;89083.99999999935;89154.55422722845;89946.20107597877;11121.940491720463;11222.382768947624;11246.325220486633;11272.605458809066;11439.481404845039;15708.607284817743;15864.682706345808;15869.285882135331;15887.28507217155;15907.125108119164;6738.427233685192;6888.517803753689;6954.018104840197;6990.266022067712;7007.404370628554;5977.760889564455;6017.669028203403;6175.876482470326;6207.937920620826;6222.315545290015;6936.514443988974;6953.374196322356;7022.192447868459;7072.9646351767915;7082.610456424843;2014.0936578539715;2019.7374341335533;2039.8470114741453;2058.4545095549693;2160.103557023849;826.9586520673943;843.8818565400849;845.8815765792793;879.612970293069;894.1014280648037;17054.403095891583;17128.828711712722;17699.823001770073;17799.822001779816;18032.819671803114;861.6036623153294;873.3188113271658;883.337496877342;884.0938038510578;899.9685011024714;9127.680531181377;9302.90697093034;9636.903630963741;9708.174805141502;9817.754556136153;355070;359765;362231;362984;363948;73778.63110684413;76042.61978690072;77341;79120.20879791128;81004.59497702592;1040.9739756506149;1042.8748550174028;1080.9405482698528;1088.0425225801403;1088.7876864011441;14294;14657.853421466076;14661.780073298696;14871.702565948837;15183.696326073637;37258.62741372552;38449.42325865058;38769.6123038766;39224.60775392209;39625;48716.512834871195;49204;50574;51166.74416627893;51689.48310516997;8466.026406963278;8618.913810861812;8668.176523230282;8752.868706969528;8787.253083487974;13262.403191856583;13273.601791946257;13288.734225315633;13372;13460.25968571738;10744.623938162127;11110.555577776799;11376.203665743318;11499.19505634631;11701.122415819018;10360.326578772356;10429.9478502607;10464.686059418229;10553.63062292816;10835.512401941774;10639.734006649896;10739;10971.122310215324;11001.449927503752;11237.775244495228;8150.836983260183;8191.13993030747;8192.262696357357;8358.331333493185;8480.957595211985;10169.593216271267;10297;10309.329893556895;10327.277090603586;10329.535170917477 16:56:09 INFO - PID 1599 | |3;mootools.html;1256.3655354046205;1309.1294289297618;1321.3459337627876;1331.9134256273348;1355.5052405871857;9913.504324783758;10220.846687299678;10351.689449316524;10398.064174224319;10754.73113172171;10476.790464190712;10675.679729608124;10720.195985301114;10732.141428685705;10744.355338679685;2141.710869032684;2184.4102092435032;2187.3765976696645;2187.814035806958;2191.5178660694623;1574.6063484128968;1620.4004518328236;1950.7464029676194;2001.879887206765;2111.957760844782;2000.9699854502194;2018.8082132197417;2023.271622216001;2026.7669218039966;2032.3191730770209;2125.819305359046;2143.742750869898;2152.5264441822774;2155.8059774620283;2171.6525355943054;1924.7305377247196;1929.1029671202957;1929.79737127601;1930.5849242412949;1931.1502938707065;10167.08496235335;10302.7424314392;10359.741006474824;10399.84400233997;10410.89589104107;5132.076226279269;5312.548433383167;5313.256144139824;5330.813421530228;5337.4662533746705;3110.5023196288485;3322.6178989416285;3327.5341452196712;3336.749743769227;3379.5268662387284;1114.0586204657052;1117.8267368557886;1140.3158105136934;1142.160512023662;1151.7408583068827;14627.926860365737;14909.627259318495;14952.47666331684;15022.624434389229;15040.473583424637;4465.343120843093;4665.5567721066445;4687.81248750053;4762.78567464458;4835;11114.277571957797;11117.833232501518;11134.554617815196;11135.888641113484;11140.888591114148;5119.846404607868;5280.234366016983;5283.233931079972;5284.339457567804;5295.894082118336;4766.4280286365165;4804.8318308859025;4849.175640141114;4849.739067842316;4856.028794241166;3830.6743926766535;3910.393888947218;3940.9605903941165;3964.5638979712207;3992;1047.5914393386586;1069.4545781651414;1132.9150313726504;1139.7720455908852;1170.9414529273502;679.7926632377073;720.7297263526177;738.6233021159247;745.0723848808268;755.8715018446877;5817.127430885316;5929.644221346733;5993.580449368503;6030.095485677183;6186.4741496973265;560.1262031231292;561.2479277767811;564.2439131563724;569.7891780041411;680.0479328939425;3736.626337366296;3844.0774214188395;3852.711046671455;3860.1121741999495;3963.603639636013;12935.288559129338;13310;13407.731845363232;13518;13617.182969021891;13158.473661053451;13448.932755336356;13454.125481843648;13468.39392227352;13506;7144.9285507145305;7163.391111755455;7166.140063192346;7175.677094530759;7270.600116993616;5857.648541087548;5861.1501332307425;5905.970470147622;5953.970230148821;6107.938920610737;11763.117766167743;12018.75962480728;12085.274883507018;12221.755564888475;12263;12372.876271237172;12590.937045314715;13014.609561713163;13191.868081319448;13376.799348009594;7651.120121186135;7731.574763387843;7741.961290193513;8410;8800.515971621622;9876;9962.452065136487;10026;10055.29612927088;10067.798644026932;8092.71675491355;8328.333733301442;8330.708425205088;8340.499570025819;8522.573871306286;7723.729669461542;7752.030996125484;7781.299683028555;7924;7973.601319933864;7044.682989265598;7118.181409138016;7137.429005679429;7152.320529549685;7184.928150718426;5030.748462576783;5063.265826455217;5093.363329583802;5102.36220472441;5118.334616499831;5090.847274581768;5246.08193566132;5274.314339135888;5300.920486192633;5342.1452567589 16:56:09 INFO - PID 1599 | |4;prototype.html;367.4213114344906;371.9014461167789;384.97305188636807;389.7544546935431;394.46746891696205;5397.352317721874;5511.58663100267;5514.36584792749;5516.558675305976;5539.252200952875;5389.676619402839;5391.191321301807;5395.973020134904;5398.811041613544;5403.51368376846;4190.97904510477;4238.300680387732;4253.447051883259;4258.765767882765;4262.488501379823;4242.406063151161;4244.0663054128045;4244.596763307496;4259.552746961555;4286;4222.0922501662135;4225.598568136023;4226.809793559281;4235.8093885775215;4246.363045543162;4174.186033723425;4243.811732714845;4256.851010214643;4261.403403523509;4280.957190428087;3954.387070004154;3960.089334339258;3965.3258945978964;3967.7222594418404;3982.3429134192825;5363.463653634644;5381.596380271495;5381.816000479927;5409.377921539034;5421.051316019681;4899.510048995107;5050.292958985745;5151.356080489939;5157.240876131252;5161.612879034087;5723.399043100498;5738.84793202549;5766.509846663039;5783.942160578383;5786.132080187964;4333.8699839004885;4403.735775853459;4410.955890441087;4415.271480205763;4431.446069241345;6036.577439579231;6055.636661800306;6106.084087386883;6122.96938515309;6125.969370153165;4562.384078149474;4565.269556870885;4567.36056952027;4577.610903073276;4584.885377865513;4634.582887540138;4656.185167595657;4657.278121891045;4658.86023419298;4668.719876807335;4952.777125029383;5061.342025536656;5120.103981803244;5126.2054381570915;5142.485751424828;5729.914051289234;5760.193572899798;5761.164631128463;5766.481016708516;5786.479216870502;1598.8481094296023;1610.1063909530324;1620.7730917671536;1622.4483675550134;1626.430749237781;1113.9832902506469;1181.480148734554;1191.5650787462514;1200.5557943560939;1202.4889421995617;4916.508349165127;4937.308776771255;4946.480619534969;4949.430815456197;4983.825566105169;5878.823635290948;5899.76400943966;5929.315840486054;5929.916443449382;5935.258092738408;4705.741184234831;4877.731724755173;4964.925526117111;4966.255061740768;4974.228994505857;3120.937581248362;3132.451820931328;3147.2918593316776;3149.0867648381713;3156.7948083374968;5356.4107948125675;5384.488473595002;5404.3784964728775;5454.836354909359;5481.177823326533;5868.119782032729;5965.522758179422;6015.699215039318;6017.879642407127;6059.909101363483;5478.287822583118;5496.80761173365;5509.173623956359;5512.7519261634125;5519.724013799294;5928.170056192051;5931.18268822306;5954.345022047484;5973.940260597338;5985.700714964148;5685.971570142123;5785.450382213683;5804.564657650778;5846.795362162304;5862.824115276549;5448.210009548672;5472.480114389126;5475.890482190254;5504.724763761876;5505.256790333254;4136.772477513766;4170.854020109282;4178.12259425524;4196.097838964637;4205.3833703016;5756.366799651951;5967.522598192048;6001.349628852101;6013.407530996215;6027.909581356195;5773.134029895549;5796.884062318814;5802.245708057925;5811.186433899342;5850.976079186211;5528.585356098229;5651.2935883014625;5712.171735098471;5789.33422656383;5809.883802323845;5610.551155907599;5668.2064510967675;5672.319321681424;5674.914876276776;5683.573731970201;5647.463490968352;5811.94188058114;5829.417058294137;5839.5036421904615;5843.532517398683;5594.216809646571;5626.2685850839125;5660.858478537904;5674.773009079756;5688.971555142198 16:56:09 INFO - PID 1599 | |5;yui.html;735.7020406735274;740.4890625468427;751.6918063593928;760.8934749135123;766.9041369828769;13698.726025479496;14759.926200368996;14786.852131478696;15348.462803801869;16011.439599614016;16062.59843503913;16130.032198068124;16209.756853647204;16223.351065957348;16257.51227463175;877.1973644115642;896.9596368163449;901.6708901251029;902.1114202510522;903.2954295649404;872.4721543466206;894.7718331825375;896.8206358728248;897.7486303834904;899.4558292233203;945.6406565505098;950.353759443578;950.4819873169105;952.8618350339196;954.9952250238739;940.9764755881089;941.6751220828803;942.8397172480729;944.4333399960003;949.8100379924008;690.0511796280115;693.237438817297;695.5652717051843;695.5965539986846;697.0485287582464;14454.927725361305;14455.49405770793;14714.190719510423;14723;14770.778438323434;16134;16308.673826523522;16337.83662163375;16383.344666213337;16395.672086558203;12564;12892.355382230851;13259.27074010929;13325.600231993056;13330;3026.0921723482866;3044.29981104345;3047.3752880659413;3049.923751906198;3058.434189674895;71803.64098179528;72203.27796722071;73345.8998115034;73496;74149.69727573163;12022.819657705142;12396.380180990915;12588.181768185039;12747.171433856769;12785.936070319589;23481.41296467602;23665;24083.759162408503;24106.276811695676;24323.148689795773;6171.413715697002;6181.567290289727;6208.192934918432;6212.875742485216;6238.313785483593;2995.326051638364;3040.209545518137;3094.4894092474938;3113.5952326197903;3114.5795317632283;3451.1027132945114;3555.466679998021;3562.87529936451;3568.2506673598314;3579.2304654499408;761.8933349330987;788.9132195458495;789.0846617923296;789.4434423731255;794.1938931984041;557.7573755416407;578.3943335274561;586.0513791642804;588.2558563417281;589.3252226201062;10520;10787.67636970892;10977;11058.612948546763;11155.386453744959;604.5496105401504;615.2340336281359;624.1480379282247;625.8216408323697;635.6948664640998;4544.318352247189;4795;4819.566239038503;4833.419989601271;4971.279164521125;84130.5793471041;84786.57606711927;85668.57165714132;86948;87438;72032.27967720361;72168.63915680388;74032.25967740362;76650;78557;53304.73347633237;59788.701056494436;61102.9731580865;61370.386296136465;63437.68281158657;9857.507124643882;10154.949225254122;10354.741131471774;10562.577496900038;10622.309549879234;27564.724352756217;28158.85920570384;28567.857160714062;29098.563521547618;29231.85384073066;49338.506614933394;50995.23507147322;51443.228351574006;53183;53583.732081339345;13601.455941762615;13621;14002.57992260234;14008.43966241339;14240.216788076756;15123.39506419731;15650.765238521659;15665.530034098996;15775.05349679023;15853.365865365256;14857.108573485626;15702.607434814221;15765.842341576437;16030.11834349122;16071.35714571404;13899.444022238997;14481.203533805741;14515.49195778185;14774.704505910036;14799.18604476721;13942.930285348508;14072.296385180496;14240.35918383696;14304.284785760463;14307;10556.208284378856;10929.453527323762;11044.613438529614;11093.389863557259;11462.713432164262;11050.33697978124;12703.301318427206;12767.106302559103;12815;12881.227126372072 16:56:09 INFO - PID 1599 | __end_tp_report 16:56:09 INFO - PID 1599 | __start_cc_report 16:56:09 INFO - PID 1599 | _x_x_mozilla_cycle_collect,384 16:56:09 INFO - PID 1599 | __end_cc_report 16:56:09 INFO - PID 1599 | __startTimestamp1496015769106__endTimestamp 16:56:09 INFO - PID 1599 | 16:56:09 INFO - PID 1599 | ------- Summary: start ------- 16:56:09 INFO - PID 1599 | Number of tests: 6 16:56:09 INFO - PID 1599 | 16:56:09 INFO - PID 1599 | [#0] dojo.html Cycles:165 Average:5185.68 Median:5314.95 stddev:619.54 (11.7%) stddev-sans-first:589.98 16:56:09 INFO - PID 1599 | Values: 2700.8 2715.7 2731.3 2752.5 2758.9 5104.4 5220.4 5237.9 5245.7 5289.4 5144.9 5186.9 5199.3 5299.6 5317.0 4661.7 4677.5 4688.3 4703.2 4739.8 4643.4 4671.2 4743.0 4749.8 4763.4 4589.1 4650.1 4702.7 4709.2 4749.3 4597.7 4619.2 4641.7 4668.2 4690.1 4641.9 4655.5 4658.3 4659.4 4660.5 5193.0 5234.3 5251.6 5252.2 5256.9 5570.8 5648.2 5655.8 5711.5 5725.3 5786.2 5786.4 5792.5 5800.3 5819.9 5304.7 5314.9 5316.8 5318.9 5324.5 5657.4 5719.1 5765.3 5894.0 5895.5 5556.2 5560.7 5575.1 5584.5 5610.5 5632.3 5665.7 5669.6 5674.5 5675.8 5550.3 5560.6 5640.4 5640.7 5656.3 5674.3 5690.7 5725.6 5739.6 5765.7 4737.0 4738.7 4744.8 4746.1 4790.8 3974.2 4040.5 4066.7 4067.1 4107.8 4695.2 4732.5 4761.9 4762.6 4768.6 5696.6 5723.3 5730.4 5737.5 5746.4 4782.1 4816.4 4821.0 4822.0 4856.9 4945.2 4963.9 5034.2 5053.9 5094.5 5287.1 5292.4 5306.3 5308.5 5311.1 5597.9 5661.7 5666.6 5690.6 5695.8 5215.9 5246.0 5270.2 5302.2 5308.4 5535.5 5618.0 5662.3 5669.8 5681.0 5656.5 5679.5 5744.9 5761.0 5771.4 5531.9 5535.8 5543.2 5553.4 5559.9 5517.3 5521.6 5533.6 5542.2 5543.5 5234.7 5263.7 5435.2 5476.7 5485.6 5565.0 5594.7 5599.6 5617.8 5643.9 5415.2 5427.9 5435.3 5435.7 5440.8 16:56:09 INFO - PID 1599 | 16:56:09 INFO - PID 1599 | [#1] ext.html Cycles:180 Average:30319.06 Median:3089.08 stddev:41283.21 (1336.4%) stddev-sans-first:41339.31 16:56:09 INFO - PID 1599 | Values: 748.2 763.1 1089.9 1099.3 1239.1 33004.5 33670.8 33701.0 33731.8 33736.2 31473.4 31542.4 31885.0 31918.8 32012.8 6396.4 6485.6 6596.1 6707.6 6713.8 6623.2 6655.1 6742.4 6745.2 6754.6 6701.5 6727.2 6752.2 6757.4 6766.8 6705.1 6706.5 6715.2 6748.2 6749.0 6556.2 6646.8 6662.8 6663.4 6693.6 30843.0 30869.2 31090.4 31171.5 31226.4 3049.2 3068.2 3072.5 3076.1 3087.0 24364.9 24531.0 24641.9 24649.9 24685.4 3050.5 3087.5 3090.6 3117.4 3135.5 141131.0 141505.0 141702.3 141822.0 142004.3 33203.8 33916.8 38458.4 39538.6 40378.0 40851.4 40869.0 40956.6 40959.8 40962.8 11417.8 11665.4 11679.2 11689.5 11731.7 9308.1 9329.0 9332.5 9339.8 9352.4 12686.8 12704.2 12734.2 12735.8 12880.2 5268.5 5409.4 5420.7 5446.1 5448.9 866.5 904.2 911.9 917.3 933.9 20741.5 21520.8 21596.6 21617.8 21794.0 977.0 983.7 1001.7 1009.3 1013.7 11037.7 11086.0 11283.2 11283.3 11445.6 171827.0 172869.0 173119.0 173132.0 173581.0 40116.4 40324.0 40361.6 40395.0 40501.6 1159.3 1209.7 1217.3 1220.2 1224.4 19899.3 20415.7 20544.2 20832.3 21359.4 28662.3 28875.9 36336.5 37452.0 37471.6 161578.0 163494.0 163787.0 165086.0 165714.0 29407.6 29674.1 29921.3 30756.8 31288.0 35665.0 36249.5 36299.5 36314.6 36964.8 27439.5 27499.3 27779.4 28231.7 29355.3 27673.9 28201.9 28276.3 29470.3 29698.6 31346.7 31398.1 31443.8 31584.4 31790.2 26113.0 26367.2 27165.3 27611.4 28115.6 19846.7 22542.2 22570.9 22597.5 22743.4 16:56:09 INFO - PID 1599 | 16:56:09 INFO - PID 1599 | [#2] jquery.html Cycles:180 Average:24470.92 Median:37854.03 stddev:60143.13 (158.9%) stddev-sans-first:60284.72 16:56:09 INFO - PID 1599 | Values: 411.4 421.1 433.9 435.4 439.5 11646.4 13277.5 16715.3 17378.0 17392.6 18180.1 18355.2 18442.2 18616.5 19059.9 5251.1 5442.6 5444.3 5453.3 5464.5 5170.4 5386.5 5406.2 5409.8 5419.9 5318.2 5370.7 5391.3 5394.2 5400.1 5183.9 5259.3 5267.1 5279.3 5374.1 4766.7 4775.4 4789.3 4795.1 4800.4 21179.3 21269.6 21408.7 21434.0 21558.9 1635.0 1642.2 1670.1 1671.0 1673.2 14354.8 14398.5 14526.6 14789.5 14922.4 1946.5 2005.8 2037.5 2045.5 2064.2 76389.0 88264.0 89084.0 89154.6 89946.2 11121.9 11222.4 11246.3 11272.6 11439.5 15708.6 15864.7 15869.3 15887.3 15907.1 6738.4 6888.5 6954.0 6990.3 7007.4 5977.8 6017.7 6175.9 6207.9 6222.3 6936.5 6953.4 7022.2 7073.0 7082.6 2014.1 2019.7 2039.8 2058.5 2160.1 827.0 843.9 845.9 879.6 894.1 17054.4 17128.8 17699.8 17799.8 18032.8 861.6 873.3 883.3 884.1 900.0 9127.7 9302.9 9636.9 9708.2 9817.8 355070.0 359765.0 362231.0 362984.0 363948.0 73778.6 76042.6 77341.0 79120.2 81004.6 1041.0 1042.9 1080.9 1088.0 1088.8 14294.0 14657.9 14661.8 14871.7 15183.7 37258.6 38449.4 38769.6 39224.6 39625.0 48716.5 49204.0 50574.0 51166.7 51689.5 8466.0 8618.9 8668.2 8752.9 8787.3 13262.4 13273.6 13288.7 13372.0 13460.3 10744.6 11110.6 11376.2 11499.2 11701.1 10360.3 10429.9 10464.7 10553.6 10835.5 10639.7 10739.0 10971.1 11001.4 11237.8 8150.8 8191.1 8192.3 8358.3 8481.0 10169.6 10297.0 10309.3 10327.3 10329.5 16:56:09 INFO - PID 1599 | 16:56:09 INFO - PID 1599 | [#3] mootools.html Cycles:180 Average:6278.53 Median:3358.14 stddev:4146.94 (123.5%) stddev-sans-first:4141.41 16:56:09 INFO - PID 1599 | Values: 1256.4 1309.1 1321.3 1331.9 1355.5 9913.5 10220.8 10351.7 10398.1 10754.7 10476.8 10675.7 10720.2 10732.1 10744.4 2141.7 2184.4 2187.4 2187.8 2191.5 1574.6 1620.4 1950.7 2001.9 2112.0 2001.0 2018.8 2023.3 2026.8 2032.3 2125.8 2143.7 2152.5 2155.8 2171.7 1924.7 1929.1 1929.8 1930.6 1931.2 10167.1 10302.7 10359.7 10399.8 10410.9 5132.1 5312.5 5313.3 5330.8 5337.5 3110.5 3322.6 3327.5 3336.7 3379.5 1114.1 1117.8 1140.3 1142.2 1151.7 14627.9 14909.6 14952.5 15022.6 15040.5 4465.3 4665.6 4687.8 4762.8 4835.0 11114.3 11117.8 11134.6 11135.9 11140.9 5119.8 5280.2 5283.2 5284.3 5295.9 4766.4 4804.8 4849.2 4849.7 4856.0 3830.7 3910.4 3941.0 3964.6 3992.0 1047.6 1069.5 1132.9 1139.8 1170.9 679.8 720.7 738.6 745.1 755.9 5817.1 5929.6 5993.6 6030.1 6186.5 560.1 561.2 564.2 569.8 680.0 3736.6 3844.1 3852.7 3860.1 3963.6 12935.3 13310.0 13407.7 13518.0 13617.2 13158.5 13448.9 13454.1 13468.4 13506.0 7144.9 7163.4 7166.1 7175.7 7270.6 5857.6 5861.2 5906.0 5954.0 6107.9 11763.1 12018.8 12085.3 12221.8 12263.0 12372.9 12590.9 13014.6 13191.9 13376.8 7651.1 7731.6 7742.0 8410.0 8800.5 9876.0 9962.5 10026.0 10055.3 10067.8 8092.7 8328.3 8330.7 8340.5 8522.6 7723.7 7752.0 7781.3 7924.0 7973.6 7044.7 7118.2 7137.4 7152.3 7184.9 5030.7 5063.3 5093.4 5102.4 5118.3 5090.8 5246.1 5274.3 5300.9 5342.1 16:56:09 INFO - PID 1599 | 16:56:09 INFO - PID 1599 | [#4] prototype.html Cycles:180 Average:4821.54 Median:5390.43 stddev:1346.99 (25.0%) stddev-sans-first:1308.63 16:56:09 INFO - PID 1599 | Values: 367.4 371.9 385.0 389.8 394.5 5397.4 5511.6 5514.4 5516.6 5539.3 5389.7 5391.2 5396.0 5398.8 5403.5 4191.0 4238.3 4253.4 4258.8 4262.5 4242.4 4244.1 4244.6 4259.6 4286.0 4222.1 4225.6 4226.8 4235.8 4246.4 4174.2 4243.8 4256.9 4261.4 4281.0 3954.4 3960.1 3965.3 3967.7 3982.3 5363.5 5381.6 5381.8 5409.4 5421.1 4899.5 5050.3 5151.4 5157.2 5161.6 5723.4 5738.8 5766.5 5783.9 5786.1 4333.9 4403.7 4411.0 4415.3 4431.4 6036.6 6055.6 6106.1 6123.0 6126.0 4562.4 4565.3 4567.4 4577.6 4584.9 4634.6 4656.2 4657.3 4658.9 4668.7 4952.8 5061.3 5120.1 5126.2 5142.5 5729.9 5760.2 5761.2 5766.5 5786.5 1598.8 1610.1 1620.8 1622.4 1626.4 1114.0 1181.5 1191.6 1200.6 1202.5 4916.5 4937.3 4946.5 4949.4 4983.8 5878.8 5899.8 5929.3 5929.9 5935.3 4705.7 4877.7 4964.9 4966.3 4974.2 3120.9 3132.5 3147.3 3149.1 3156.8 5356.4 5384.5 5404.4 5454.8 5481.2 5868.1 5965.5 6015.7 6017.9 6059.9 5478.3 5496.8 5509.2 5512.8 5519.7 5928.2 5931.2 5954.3 5973.9 5985.7 5686.0 5785.5 5804.6 5846.8 5862.8 5448.2 5472.5 5475.9 5504.7 5505.3 4136.8 4170.9 4178.1 4196.1 4205.4 5756.4 5967.5 6001.3 6013.4 6027.9 5773.1 5796.9 5802.2 5811.2 5851.0 5528.6 5651.3 5712.2 5789.3 5809.9 5610.6 5668.2 5672.3 5674.9 5683.6 5647.5 5811.9 5829.4 5839.5 5843.5 5594.2 5626.3 5660.9 5674.8 5689.0 16:56:09 INFO - PID 1599 | 16:56:09 INFO - PID 1599 | [#5] yui.html Cycles:180 Average:17537.93 Median:3076.46 stddev:22324.59 (725.7%) stddev-sans-first:22351.56 16:56:09 INFO - PID 1599 | Values: 735.7 740.5 751.7 760.9 766.9 13698.7 14759.9 14786.9 15348.5 16011.4 16062.6 16130.0 16209.8 16223.4 16257.5 877.2 897.0 901.7 902.1 903.3 872.5 894.8 896.8 897.7 899.5 945.6 950.4 950.5 952.9 955.0 941.0 941.7 942.8 944.4 949.8 690.1 693.2 695.6 695.6 697.0 14454.9 14455.5 14714.2 14723.0 14770.8 16134.0 16308.7 16337.8 16383.3 16395.7 12564.0 12892.4 13259.3 13325.6 13330.0 3026.1 3044.3 3047.4 3049.9 3058.4 71803.6 72203.3 73345.9 73496.0 74149.7 12022.8 12396.4 12588.2 12747.2 12785.9 23481.4 23665.0 24083.8 24106.3 24323.1 6171.4 6181.6 6208.2 6212.9 6238.3 2995.3 3040.2 3094.5 3113.6 3114.6 3451.1 3555.5 3562.9 3568.3 3579.2 761.9 788.9 789.1 789.4 794.2 557.8 578.4 586.1 588.3 589.3 10520.0 10787.7 10977.0 11058.6 11155.4 604.5 615.2 624.1 625.8 635.7 4544.3 4795.0 4819.6 4833.4 4971.3 84130.6 84786.6 85668.6 86948.0 87438.0 72032.3 72168.6 74032.3 76650.0 78557.0 53304.7 59788.7 61103.0 61370.4 63437.7 9857.5 10154.9 10354.7 10562.6 10622.3 27564.7 28158.9 28567.9 29098.6 29231.9 49338.5 50995.2 51443.2 53183.0 53583.7 13601.5 13621.0 14002.6 14008.4 14240.2 15123.4 15650.8 15665.5 15775.1 15853.4 14857.1 15702.6 15765.8 16030.1 16071.4 13899.4 14481.2 14515.5 14774.7 14799.2 13942.9 14072.3 14240.4 14304.3 14307.0 10556.2 10929.5 11044.6 11093.4 11462.7 11050.3 12703.3 12767.1 12815.0 12881.2 16:56:09 INFO - PID 1599 | -------- Summary: end -------- 16:56:09 INFO - PID 1599 | 16:56:09 INFO - TEST-INFO | 1599: exit 0 16:56:09 INFO - TEST-OK | dromaeo_css | took 1147776ms 16:56:09 INFO - TEST-START | kraken 16:56:09 INFO - operating with platform_type : linux_ 16:56:09 INFO - Initialising browser for kraken test... 16:56:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54882/getInfo.html -profile /tmp/tmp6gE2FK/profile 16:56:10 INFO - TEST-INFO | started process 2003 (/builds/slave/test/build/application/firefox/firefox http://localhost:54882/getInfo.html) 16:56:44 INFO - TEST-INFO | 2003: killed by SIGTERM 16:56:45 INFO - Browser initialized. 16:56:45 INFO - Running cycle 1/1 for kraken test... 16:56:45 INFO - TEST-INFO | started process 2206 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6gE2FK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:56:57 INFO - PID 2206 | RSS: Main: 184303616 16:56:57 INFO - PID 2206 | 16:56:59 INFO - PID 2206 | Cycle 1(1): loaded http://localhost:54882/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54882/tests/kraken/driver.html?testName=audio-beat-detection) 16:57:00 INFO - PID 2206 | RSS: Main: 186978304 16:57:00 INFO - PID 2206 | 16:57:03 INFO - PID 2206 | Cycle 1(1): loaded http://localhost:54882/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54882/tests/kraken/driver.html?testName=audio-dft) 16:57:04 INFO - PID 2206 | RSS: Main: 186073088 16:57:04 INFO - PID 2206 | 16:57:07 INFO - PID 2206 | Cycle 1(1): loaded http://localhost:54882/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54882/tests/kraken/driver.html?testName=audio-fft) 16:57:07 INFO - PID 2206 | RSS: Main: 182333440 16:57:07 INFO - PID 2206 | 16:57:09 INFO - PID 2206 | Cycle 1(1): loaded http://localhost:54882/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54882/tests/kraken/driver.html?testName=audio-oscillator) 16:57:10 INFO - PID 2206 | RSS: Main: 182394880 16:57:10 INFO - PID 2206 | 16:57:12 INFO - PID 2206 | Cycle 1(1): loaded http://localhost:54882/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54882/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:57:13 INFO - PID 2206 | RSS: Main: 182734848 16:57:13 INFO - PID 2206 | 16:57:16 INFO - PID 2206 | Cycle 1(1): loaded http://localhost:54882/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54882/tests/kraken/driver.html?testName=imaging-darkroom) 16:57:16 INFO - PID 2206 | RSS: Main: 183586816 16:57:16 INFO - PID 2206 | 16:57:20 INFO - PID 2206 | Cycle 1(1): loaded http://localhost:54882/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54882/tests/kraken/driver.html?testName=imaging-desaturate) 16:57:21 INFO - PID 2206 | RSS: Main: 183246848 16:57:21 INFO - PID 2206 | 16:57:24 INFO - PID 2206 | Cycle 1(1): loaded http://localhost:54882/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54882/tests/kraken/driver.html?testName=json-parse-financial) 16:57:24 INFO - PID 2206 | RSS: Main: 183795712 16:57:24 INFO - PID 2206 | 16:57:26 INFO - PID 2206 | Cycle 1(1): loaded http://localhost:54882/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54882/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:57:26 INFO - PID 2206 | RSS: Main: 183988224 16:57:26 INFO - PID 2206 | 16:57:28 INFO - PID 2206 | Cycle 1(1): loaded http://localhost:54882/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54882/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:57:29 INFO - PID 2206 | RSS: Main: 183484416 16:57:29 INFO - PID 2206 | 16:57:31 INFO - PID 2206 | Cycle 1(1): loaded http://localhost:54882/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54882/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:57:32 INFO - PID 2206 | RSS: Main: 183255040 16:57:32 INFO - PID 2206 | 16:57:35 INFO - PID 2206 | Cycle 1(1): loaded http://localhost:54882/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54882/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:57:35 INFO - PID 2206 | RSS: Main: 183353344 16:57:35 INFO - PID 2206 | 16:57:38 INFO - PID 2206 | Cycle 1(1): loaded http://localhost:54882/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54882/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:57:39 INFO - PID 2206 | RSS: Main: 183439360 16:57:39 INFO - PID 2206 | 16:57:41 INFO - PID 2206 | Cycle 1(1): loaded http://localhost:54882/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54882/tests/kraken/driver.html?testName=ai-astar) 16:57:41 INFO - PID 2206 | RSS: Main: 184864768 16:57:41 INFO - PID 2206 | 16:57:41 INFO - PID 2206 | __start_tp_report 16:57:41 INFO - PID 2206 | _x_x_mozilla_page_load 16:57:41 INFO - PID 2206 | _x_x_mozilla_page_load_details 16:57:41 INFO - PID 2206 | |i|pagename|runs| 16:57:41 INFO - PID 2206 | |0;ai-astar;105;111;113;110;110;112;111;111;111;113 16:57:41 INFO - PID 2206 | |1;audio-beat-detection;159;128;124;170;131;125;125;122;154;130 16:57:41 INFO - PID 2206 | |2;audio-dft;164;166;166;168;165;170;162;164;163;165 16:57:41 INFO - PID 2206 | |3;audio-fft;74;76;74;115;75;75;75;74;94;74 16:57:41 INFO - PID 2206 | |4;audio-oscillator;85;85;104;84;83;83;97;83;84;106 16:57:41 INFO - PID 2206 | |5;imaging-gaussian-blur;114;115;114;114;114;114;115;114;114;114 16:57:41 INFO - PID 2206 | |6;imaging-darkroom;151;151;150;152;151;151;152;150;152;149 16:57:41 INFO - PID 2206 | |7;imaging-desaturate;95;95;94;94;95;95;94;95;95;95 16:57:41 INFO - PID 2206 | |8;json-parse-financial;55;55;57;55;58;57;56;58;58;59 16:57:41 INFO - PID 2206 | |9;json-stringify-tinderbox;57;56;56;57;57;57;57;58;58;57 16:57:41 INFO - PID 2206 | |10;stanford-crypto-aes;91;95;86;88;95;89;88;91;115;96 16:57:41 INFO - PID 2206 | |11;stanford-crypto-ccm;139;142;141;143;146;138;134;133;145;134 16:57:41 INFO - PID 2206 | |12;stanford-crypto-pbkdf2;189;197;206;194;193;205;202;194;196;194 16:57:41 INFO - PID 2206 | |13;stanford-crypto-sha256-iterative;77;73;77;73;74;75;78;72;72;77 16:57:41 INFO - PID 2206 | __end_tp_report 16:57:41 INFO - PID 2206 | __start_cc_report 16:57:41 INFO - PID 2206 | _x_x_mozilla_cycle_collect,1051 16:57:41 INFO - PID 2206 | __end_cc_report 16:57:41 INFO - PID 2206 | __startTimestamp1496015861705__endTimestamp 16:57:41 INFO - PID 2206 | 16:57:41 INFO - PID 2206 | ------- Summary: start ------- 16:57:41 INFO - PID 2206 | Number of tests: 14 16:57:41 INFO - PID 2206 | 16:57:41 INFO - PID 2206 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:2.26 (2.0%) stddev-sans-first:1.12 16:57:41 INFO - PID 2206 | Values: 105.0 111.0 113.0 110.0 110.0 112.0 111.0 111.0 111.0 113.0 16:57:41 INFO - PID 2206 | 16:57:41 INFO - PID 2206 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:130.50 stddev:17.35 (13.3%) stddev-sans-first:16.44 16:57:41 INFO - PID 2206 | Values: 159.0 128.0 124.0 170.0 131.0 125.0 125.0 122.0 154.0 130.0 16:57:41 INFO - PID 2206 | 16:57:41 INFO - PID 2206 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.50 stddev:2.36 (1.4%) stddev-sans-first:2.46 16:57:41 INFO - PID 2206 | Values: 164.0 166.0 166.0 168.0 165.0 170.0 162.0 164.0 163.0 165.0 16:57:41 INFO - PID 2206 | 16:57:41 INFO - PID 2206 | [#3] audio-fft Cycles:10 Average:80.60 Median:75.00 stddev:13.55 (18.1%) stddev-sans-first:14.16 16:57:41 INFO - PID 2206 | Values: 74.0 76.0 74.0 115.0 75.0 75.0 75.0 74.0 94.0 74.0 16:57:41 INFO - PID 2206 | 16:57:41 INFO - PID 2206 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:84.00 stddev:9.23 (11.0%) stddev-sans-first:9.65 16:57:41 INFO - PID 2206 | Values: 85.0 85.0 104.0 84.0 83.0 83.0 97.0 83.0 84.0 106.0 16:57:41 INFO - PID 2206 | 16:57:41 INFO - PID 2206 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:57:41 INFO - PID 2206 | Values: 114.0 115.0 114.0 114.0 114.0 114.0 115.0 114.0 114.0 114.0 16:57:41 INFO - PID 2206 | 16:57:41 INFO - PID 2206 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 16:57:41 INFO - PID 2206 | Values: 151.0 151.0 150.0 152.0 151.0 151.0 152.0 150.0 152.0 149.0 16:57:41 INFO - PID 2206 | 16:57:41 INFO - PID 2206 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 16:57:41 INFO - PID 2206 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 16:57:41 INFO - PID 2206 | 16:57:41 INFO - PID 2206 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.50 stddev:1.48 (2.6%) stddev-sans-first:1.41 16:57:41 INFO - PID 2206 | Values: 55.0 55.0 57.0 55.0 58.0 57.0 56.0 58.0 58.0 59.0 16:57:41 INFO - PID 2206 | 16:57:41 INFO - PID 2206 | [#9] json-stringify-tinderbox Cycles:10 Average:57.00 Median:57.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 16:57:41 INFO - PID 2206 | Values: 57.0 56.0 56.0 57.0 57.0 57.0 57.0 58.0 58.0 57.0 16:57:41 INFO - PID 2206 | 16:57:41 INFO - PID 2206 | [#10] stanford-crypto-aes Cycles:10 Average:93.40 Median:91.00 stddev:8.32 (9.1%) stddev-sans-first:8.77 16:57:41 INFO - PID 2206 | Values: 91.0 95.0 86.0 88.0 95.0 89.0 88.0 91.0 115.0 96.0 16:57:41 INFO - PID 2206 | 16:57:41 INFO - PID 2206 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:141.50 stddev:4.70 (3.3%) stddev-sans-first:4.98 16:57:41 INFO - PID 2206 | Values: 139.0 142.0 141.0 143.0 146.0 138.0 134.0 133.0 145.0 134.0 16:57:41 INFO - PID 2206 | 16:57:41 INFO - PID 2206 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.00 Median:196.50 stddev:5.56 (2.8%) stddev-sans-first:5.09 16:57:41 INFO - PID 2206 | Values: 189.0 197.0 206.0 194.0 193.0 205.0 202.0 194.0 196.0 194.0 16:57:41 INFO - PID 2206 | 16:57:41 INFO - PID 2206 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.80 Median:76.00 stddev:2.30 (3.0%) stddev-sans-first:2.30 16:57:41 INFO - PID 2206 | Values: 77.0 73.0 77.0 73.0 74.0 75.0 78.0 72.0 72.0 77.0 16:57:41 INFO - PID 2206 | -------- Summary: end -------- 16:57:41 INFO - PID 2206 | 16:57:42 INFO - TEST-INFO | 2206: exit 0 16:57:42 INFO - TEST-OK | kraken | took 92866ms 16:57:42 INFO - SUITE-END | took 1240s 16:57:43 INFO - Completed test suite (00:20:41) 16:57:43 INFO - javascript benchmark 16:57:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6770.997311480255, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2700.7569318761307, 2715.6741191057076, 2731.3444773254423, 2752.477029364421, 2758.931026724332, 5104.387473503176, 5220.37355517338, 5237.921431178531, 5245.7377131143385, 5289.4181640019615, 5144.948550514494, 5186.8703282417955, 5199.324087868572, 5299.576033917287, 5317.0, 4661.673682842203, 4677.508861569538, 4688.273317635763, 4703.200455922484, 4739.763011849411, 4643.396358473394, 4671.182543054952, 4742.952570474303, 4749.786259618309, 4763.404574428197, 4589.105124500724, 4650.139724151043, 4702.670813043088, 4709.175894218498, 4749.311349854269, 4597.747123908183, 4619.19164146273, 4641.7214967101745, 4668.206404911173, 4690.132325519789, 4641.883952901171, 4655.464621568529, 4658.254679251304, 4659.370984917061, 4660.5106463821485, 5193.039287731782, 5234.319538459976, 5251.579873610102, 5252.212168174766, 5256.92114618281, 5570.777168913239, 5648.237487939116, 5655.830325090254, 5711.514521265697, 5725.312962444534, 5786.189933409326, 5786.392428794958, 5792.478676919098, 5800.332961709415, 5819.912701309484, 5304.655197412233, 5314.946850531523, 5316.76074576645, 5318.9202161967605, 5324.520793128637, 5657.377688454267, 5719.142128680648, 5765.279340082489, 5893.970530147408, 5895.498882594941, 5556.249906262684, 5560.7219639017885, 5575.135853942646, 5584.497395234448, 5610.5231055360755, 5632.338460154264, 5665.745041473144, 5669.603127781016, 5674.4892959633835, 5675.772969081273, 5550.250716153268, 5560.582956278296, 5640.435956404409, 5640.717964101778, 5656.2929633795775, 5674.347450043216, 5690.715464226855, 5725.570582206351, 5739.598228123991, 5765.740541675635, 4736.976315118402, 4738.668293219511, 4744.833930812405, 4746.098241334135, 4790.784414701347, 3974.2448934702315, 4040.5151381834366, 4066.6949978751713, 4067.1458993611673, 4107.815148318333, 4695.248760198352, 4732.503087175865, 4761.880952976134, 4762.571368576845, 4768.642351823627, 5696.572757043155, 5723.255976723, 5730.369659337553, 5737.540996720252, 5746.396628354046, 4782.0914026334885, 4816.446108697544, 4821.04161996567, 4822.035592881438, 4856.854294371175, 4945.159322915113, 4963.875903102451, 5034.16936205522, 5053.8736531587, 5094.541491265803, 5287.127623942007, 5292.364916210079, 5306.336707911511, 5308.46915308466, 5311.070562651597, 5597.944020559905, 5661.745221464962, 5666.575006874418, 5690.601657883908, 5695.800646977336, 5215.921761173509, 5246.0, 5270.156774915995, 5302.2046692996355, 5308.389535203347, 5535.474129957647, 5617.9719101404235, 5662.292213473316, 5669.773209071756, 5681.0, 5656.462636049569, 5679.460451257124, 5744.856378590569, 5760.991826430274, 5771.3651498335985, 5531.944680553304, 5535.7785688572, 5543.223948647112, 5553.389127195925, 5559.916601250903, 5517.282753242052, 5521.585881058856, 5533.612647114664, 5542.196381524575, 5543.52880005204, 5234.659747116425, 5263.6578622389425, 5435.184722291688, 5476.726163691879, 5485.6434331768305, 5565.026120428828, 5594.720263986866, 5599.552035837205, 5617.831465056055, 5643.943560564342, 5415.187721841755, 5427.918581221364, 5435.320584926884, 5435.701036443033, 5440.7551660174595], "value": 5140.084414684153, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.2031636307333, 763.1109757132939, 1089.8801131875493, 1099.3184225780012, 1239.1387985350186, 33004.504932426, 33670.8316458418, 33701.0, 33731.83134084326, 33736.15659608511, 31473.370532589335, 31542.369152616935, 31885.0, 31918.84040579794, 32012.839935800348, 6396.360363963601, 6485.643289619069, 6596.142501474826, 6707.631080290582, 6713.798586042402, 6623.23832759234, 6655.134832471772, 6742.393184613384, 6745.224299205581, 6754.628495432749, 6701.463882889381, 6727.159105111861, 6752.2234942981695, 6757.425618822382, 6766.763163289286, 6705.061291419156, 6706.497012724041, 6715.194176698803, 6748.156480439945, 6749.0, 6556.213254409454, 6646.767363142267, 6662.766803161914, 6663.36698013688, 6693.6318502482345, 30843.0, 30869.228269293224, 31090.378192436252, 31171.53242701361, 31226.37547249065, 3049.1919641295076, 3068.2176045108354, 3072.4623190941497, 3076.09255269696, 3087.043016664841, 24364.878175609185, 24531.0, 24641.876790616112, 24649.876750616313, 24685.382865428328, 3050.5119180931165, 3087.521434177706, 3090.644575873781, 3117.438861005018, 3135.545345924851, 141131.0, 141505.0, 141702.29148854292, 141822.0, 142004.28997855049, 33203.83398082994, 33916.83041584826, 38458.42312365317, 39538.60461395407, 40378.0, 40851.38722919158, 40869.0, 40956.59043409587, 40959.79520102381, 40962.79518602388, 11417.771644567229, 11665.35840528779, 11679.240849344766, 11689.532418703327, 11731.706707332385, 9308.069193080637, 9329.0, 9332.486713230837, 9339.813203735886, 9352.438853668666, 12686.80969785454, 12704.174228675107, 12734.172278801849, 12735.80896286538, 12880.162789418659, 5268.4994925482015, 5409.43200963901, 5420.701861397661, 5446.101393270145, 5448.945510544923, 866.4931015355961, 904.1817155474306, 911.9316051296179, 917.3074328881652, 933.8785957825575, 20741.481462963246, 21520.78479215219, 21596.568068638855, 21617.78382216158, 21794.0, 976.9560369783377, 983.6852207293597, 1001.7145113642576, 1009.2531526670211, 1013.7262939006574, 11037.724056898642, 11086.0, 11283.153763467773, 11283.251096080121, 11445.599404020986, 171827.0, 172869.0, 173119.0, 173132.0, 173581.0, 40116.398254026215, 40324.0, 40361.59638403579, 40395.0, 40501.594984050374, 1159.3217967488945, 1209.661294837447, 1217.303672365732, 1220.2251570252954, 1224.369449733388, 19899.303524377156, 20415.69376459384, 20544.17823287052, 20832.27087051946, 21359.359219223446, 28662.283442914093, 28875.855620721763, 36336.45495317625, 37452.0, 37471.62528374681, 161578.0, 163494.0, 163787.0, 165086.0, 165714.0, 29407.558886617146, 29674.109776706733, 29921.251968700955, 30756.84621576878, 31288.0, 35665.0, 36249.456258155624, 36299.45550816687, 36314.63685363113, 36964.81517592395, 27439.45121097527, 27499.31251718723, 27779.44441111126, 28231.71768282373, 29355.266118347212, 27673.861630691717, 28201.858990704914, 28276.293092672848, 29470.263243419085, 29698.55452168176, 31346.68653313529, 31398.058058258288, 31443.842780785948, 31584.36831263316, 31790.205244869063, 26113.0, 26367.208983730518, 27165.320866978484, 27611.447771044066, 28115.578266325614, 19846.680997720363, 22542.211022614785, 22570.887145564167, 22597.548049039255, 22743.431414214778], "value": 14449.340565409551, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.364441937207, 421.0668636796028, 433.8806828122267, 435.373062789583, 439.46604875076787, 11646.417679116053, 13277.46890124394, 16715.331386744532, 17378.0, 17392.56518587036, 18180.090995450242, 18355.174017169225, 18442.170102345393, 18616.534586635305, 19059.90470047648, 5251.081060814361, 5442.564594832424, 5444.292242008533, 5453.318335208099, 5464.480874316933, 5170.353705786777, 5386.48828361305, 5406.243125962349, 5409.810656627019, 5419.918701219485, 5318.175682769177, 5370.7046112463795, 5391.272178255925, 5394.1908713692865, 5400.135978243482, 5183.922241166386, 5259.31628888244, 5267.104592219332, 5279.313689220415, 5374.140137577989, 4766.666333356667, 4775.379200703921, 4789.2816077588295, 4795.088933102699, 4800.351952486404, 21179.258725944674, 21269.574608507744, 21408.678869816966, 21434.0, 21558.89220553903, 1634.9673006539801, 1642.2117383655911, 1670.0814551996475, 1671.0, 1673.205227516932, 14354.784678229835, 14398.496052638213, 14526.636834079127, 14789.482368117064, 14922.403103875831, 1946.5133716570858, 2005.7893921138216, 2037.500812300981, 2045.4681782736595, 2064.1743302678897, 76389.0, 88264.0, 89083.99999999935, 89154.55422722845, 89946.20107597877, 11121.940491720463, 11222.382768947624, 11246.325220486633, 11272.605458809066, 11439.481404845039, 15708.607284817743, 15864.682706345808, 15869.285882135331, 15887.28507217155, 15907.125108119164, 6738.427233685192, 6888.517803753689, 6954.018104840197, 6990.266022067712, 7007.404370628554, 5977.760889564455, 6017.669028203403, 6175.876482470326, 6207.937920620826, 6222.315545290015, 6936.514443988974, 6953.374196322356, 7022.192447868459, 7072.9646351767915, 7082.610456424843, 2014.0936578539715, 2019.7374341335533, 2039.8470114741453, 2058.4545095549693, 2160.103557023849, 826.9586520673943, 843.8818565400849, 845.8815765792793, 879.612970293069, 894.1014280648037, 17054.403095891583, 17128.828711712722, 17699.823001770073, 17799.822001779816, 18032.819671803114, 861.6036623153294, 873.3188113271658, 883.337496877342, 884.0938038510578, 899.9685011024714, 9127.680531181377, 9302.90697093034, 9636.903630963741, 9708.174805141502, 9817.754556136153, 355070.0, 359765.0, 362231.0, 362984.0, 363948.0, 73778.63110684413, 76042.61978690072, 77341.0, 79120.20879791128, 81004.59497702592, 1040.9739756506149, 1042.8748550174028, 1080.9405482698528, 1088.0425225801403, 1088.7876864011441, 14294.0, 14657.853421466076, 14661.780073298696, 14871.702565948837, 15183.696326073637, 37258.62741372552, 38449.42325865058, 38769.6123038766, 39224.60775392209, 39625.0, 48716.512834871195, 49204.0, 50574.0, 51166.74416627893, 51689.48310516997, 8466.026406963278, 8618.913810861812, 8668.176523230282, 8752.868706969528, 8787.253083487974, 13262.403191856583, 13273.601791946257, 13288.734225315633, 13372.0, 13460.25968571738, 10744.623938162127, 11110.555577776799, 11376.203665743318, 11499.19505634631, 11701.122415819018, 10360.326578772356, 10429.9478502607, 10464.686059418229, 10553.63062292816, 10835.512401941774, 10639.734006649896, 10739.0, 10971.122310215324, 11001.449927503752, 11237.775244495228, 8150.836983260183, 8191.13993030747, 8192.262696357357, 8358.331333493185, 8480.957595211985, 10169.593216271267, 10297.0, 10309.329893556895, 10327.277090603586, 10329.535170917477], "value": 8694.7794312938, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1256.3655354046205, 1309.1294289297618, 1321.3459337627876, 1331.9134256273348, 1355.5052405871857, 9913.504324783758, 10220.846687299678, 10351.689449316524, 10398.064174224319, 10754.73113172171, 10476.790464190712, 10675.679729608124, 10720.195985301114, 10732.141428685705, 10744.355338679685, 2141.710869032684, 2184.4102092435032, 2187.3765976696645, 2187.814035806958, 2191.5178660694623, 1574.6063484128968, 1620.4004518328236, 1950.7464029676194, 2001.879887206765, 2111.957760844782, 2000.9699854502194, 2018.8082132197417, 2023.271622216001, 2026.7669218039966, 2032.3191730770209, 2125.819305359046, 2143.742750869898, 2152.5264441822774, 2155.8059774620283, 2171.6525355943054, 1924.7305377247196, 1929.1029671202957, 1929.79737127601, 1930.5849242412949, 1931.1502938707065, 10167.08496235335, 10302.7424314392, 10359.741006474824, 10399.84400233997, 10410.89589104107, 5132.076226279269, 5312.548433383167, 5313.256144139824, 5330.813421530228, 5337.4662533746705, 3110.5023196288485, 3322.6178989416285, 3327.5341452196712, 3336.749743769227, 3379.5268662387284, 1114.0586204657052, 1117.8267368557886, 1140.3158105136934, 1142.160512023662, 1151.7408583068827, 14627.926860365737, 14909.627259318495, 14952.47666331684, 15022.624434389229, 15040.473583424637, 4465.343120843093, 4665.5567721066445, 4687.81248750053, 4762.78567464458, 4835.0, 11114.277571957797, 11117.833232501518, 11134.554617815196, 11135.888641113484, 11140.888591114148, 5119.846404607868, 5280.234366016983, 5283.233931079972, 5284.339457567804, 5295.894082118336, 4766.4280286365165, 4804.8318308859025, 4849.175640141114, 4849.739067842316, 4856.028794241166, 3830.6743926766535, 3910.393888947218, 3940.9605903941165, 3964.5638979712207, 3992.0, 1047.5914393386586, 1069.4545781651414, 1132.9150313726504, 1139.7720455908852, 1170.9414529273502, 679.7926632377073, 720.7297263526177, 738.6233021159247, 745.0723848808268, 755.8715018446877, 5817.127430885316, 5929.644221346733, 5993.580449368503, 6030.095485677183, 6186.4741496973265, 560.1262031231292, 561.2479277767811, 564.2439131563724, 569.7891780041411, 680.0479328939425, 3736.626337366296, 3844.0774214188395, 3852.711046671455, 3860.1121741999495, 3963.603639636013, 12935.288559129338, 13310.0, 13407.731845363232, 13518.0, 13617.182969021891, 13158.473661053451, 13448.932755336356, 13454.125481843648, 13468.39392227352, 13506.0, 7144.9285507145305, 7163.391111755455, 7166.140063192346, 7175.677094530759, 7270.600116993616, 5857.648541087548, 5861.1501332307425, 5905.970470147622, 5953.970230148821, 6107.938920610737, 11763.117766167743, 12018.75962480728, 12085.274883507018, 12221.755564888475, 12263.0, 12372.876271237172, 12590.937045314715, 13014.609561713163, 13191.868081319448, 13376.799348009594, 7651.120121186135, 7731.574763387843, 7741.961290193513, 8410.0, 8800.515971621622, 9876.0, 9962.452065136487, 10026.0, 10055.29612927088, 10067.798644026932, 8092.71675491355, 8328.333733301442, 8330.708425205088, 8340.499570025819, 8522.573871306286, 7723.729669461542, 7752.030996125484, 7781.299683028555, 7924.0, 7973.601319933864, 7044.682989265598, 7118.181409138016, 7137.429005679429, 7152.320529549685, 7184.928150718426, 5030.748462576783, 5063.265826455217, 5093.363329583802, 5102.36220472441, 5118.334616499831, 5090.847274581768, 5246.08193566132, 5274.314339135888, 5300.920486192633, 5342.1452567589], "value": 4643.18764082374, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.4213114344906, 371.9014461167789, 384.97305188636807, 389.7544546935431, 394.46746891696205, 5397.352317721874, 5511.58663100267, 5514.36584792749, 5516.558675305976, 5539.252200952875, 5389.676619402839, 5391.191321301807, 5395.973020134904, 5398.811041613544, 5403.51368376846, 4190.97904510477, 4238.300680387732, 4253.447051883259, 4258.765767882765, 4262.488501379823, 4242.406063151161, 4244.0663054128045, 4244.596763307496, 4259.552746961555, 4286.0, 4222.0922501662135, 4225.598568136023, 4226.809793559281, 4235.8093885775215, 4246.363045543162, 4174.186033723425, 4243.811732714845, 4256.851010214643, 4261.403403523509, 4280.957190428087, 3954.387070004154, 3960.089334339258, 3965.3258945978964, 3967.7222594418404, 3982.3429134192825, 5363.463653634644, 5381.596380271495, 5381.816000479927, 5409.377921539034, 5421.051316019681, 4899.510048995107, 5050.292958985745, 5151.356080489939, 5157.240876131252, 5161.612879034087, 5723.399043100498, 5738.84793202549, 5766.509846663039, 5783.942160578383, 5786.132080187964, 4333.8699839004885, 4403.735775853459, 4410.955890441087, 4415.271480205763, 4431.446069241345, 6036.577439579231, 6055.636661800306, 6106.084087386883, 6122.96938515309, 6125.969370153165, 4562.384078149474, 4565.269556870885, 4567.36056952027, 4577.610903073276, 4584.885377865513, 4634.582887540138, 4656.185167595657, 4657.278121891045, 4658.86023419298, 4668.719876807335, 4952.777125029383, 5061.342025536656, 5120.103981803244, 5126.2054381570915, 5142.485751424828, 5729.914051289234, 5760.193572899798, 5761.164631128463, 5766.481016708516, 5786.479216870502, 1598.8481094296023, 1610.1063909530324, 1620.7730917671536, 1622.4483675550134, 1626.430749237781, 1113.9832902506469, 1181.480148734554, 1191.5650787462514, 1200.5557943560939, 1202.4889421995617, 4916.508349165127, 4937.308776771255, 4946.480619534969, 4949.430815456197, 4983.825566105169, 5878.823635290948, 5899.76400943966, 5929.315840486054, 5929.916443449382, 5935.258092738408, 4705.741184234831, 4877.731724755173, 4964.925526117111, 4966.255061740768, 4974.228994505857, 3120.937581248362, 3132.451820931328, 3147.2918593316776, 3149.0867648381713, 3156.7948083374968, 5356.4107948125675, 5384.488473595002, 5404.3784964728775, 5454.836354909359, 5481.177823326533, 5868.119782032729, 5965.522758179422, 6015.699215039318, 6017.879642407127, 6059.909101363483, 5478.287822583118, 5496.80761173365, 5509.173623956359, 5512.7519261634125, 5519.724013799294, 5928.170056192051, 5931.18268822306, 5954.345022047484, 5973.940260597338, 5985.700714964148, 5685.971570142123, 5785.450382213683, 5804.564657650778, 5846.795362162304, 5862.824115276549, 5448.210009548672, 5472.480114389126, 5475.890482190254, 5504.724763761876, 5505.256790333254, 4136.772477513766, 4170.854020109282, 4178.12259425524, 4196.097838964637, 4205.3833703016, 5756.366799651951, 5967.522598192048, 6001.349628852101, 6013.407530996215, 6027.909581356195, 5773.134029895549, 5796.884062318814, 5802.245708057925, 5811.186433899342, 5850.976079186211, 5528.585356098229, 5651.2935883014625, 5712.171735098471, 5789.33422656383, 5809.883802323845, 5610.551155907599, 5668.2064510967675, 5672.319321681424, 5674.914876276776, 5683.573731970201, 5647.463490968352, 5811.94188058114, 5829.417058294137, 5839.5036421904615, 5843.532517398683, 5594.216809646571, 5626.2685850839125, 5660.858478537904, 5674.773009079756, 5688.971555142198], "value": 4418.249394725019, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.7020406735274, 740.4890625468427, 751.6918063593928, 760.8934749135123, 766.9041369828769, 13698.726025479496, 14759.926200368996, 14786.852131478696, 15348.462803801869, 16011.439599614016, 16062.59843503913, 16130.032198068124, 16209.756853647204, 16223.351065957348, 16257.51227463175, 877.1973644115642, 896.9596368163449, 901.6708901251029, 902.1114202510522, 903.2954295649404, 872.4721543466206, 894.7718331825375, 896.8206358728248, 897.7486303834904, 899.4558292233203, 945.6406565505098, 950.353759443578, 950.4819873169105, 952.8618350339196, 954.9952250238739, 940.9764755881089, 941.6751220828803, 942.8397172480729, 944.4333399960003, 949.8100379924008, 690.0511796280115, 693.237438817297, 695.5652717051843, 695.5965539986846, 697.0485287582464, 14454.927725361305, 14455.49405770793, 14714.190719510423, 14723.0, 14770.778438323434, 16134.0, 16308.673826523522, 16337.83662163375, 16383.344666213337, 16395.672086558203, 12564.0, 12892.355382230851, 13259.27074010929, 13325.600231993056, 13330.0, 3026.0921723482866, 3044.29981104345, 3047.3752880659413, 3049.923751906198, 3058.434189674895, 71803.64098179528, 72203.27796722071, 73345.8998115034, 73496.0, 74149.69727573163, 12022.819657705142, 12396.380180990915, 12588.181768185039, 12747.171433856769, 12785.936070319589, 23481.41296467602, 23665.0, 24083.759162408503, 24106.276811695676, 24323.148689795773, 6171.413715697002, 6181.567290289727, 6208.192934918432, 6212.875742485216, 6238.313785483593, 2995.326051638364, 3040.209545518137, 3094.4894092474938, 3113.5952326197903, 3114.5795317632283, 3451.1027132945114, 3555.466679998021, 3562.87529936451, 3568.2506673598314, 3579.2304654499408, 761.8933349330987, 788.9132195458495, 789.0846617923296, 789.4434423731255, 794.1938931984041, 557.7573755416407, 578.3943335274561, 586.0513791642804, 588.2558563417281, 589.3252226201062, 10520.0, 10787.67636970892, 10977.0, 11058.612948546763, 11155.386453744959, 604.5496105401504, 615.2340336281359, 624.1480379282247, 625.8216408323697, 635.6948664640998, 4544.318352247189, 4795.0, 4819.566239038503, 4833.419989601271, 4971.279164521125, 84130.5793471041, 84786.57606711927, 85668.57165714132, 86948.0, 87438.0, 72032.27967720361, 72168.63915680388, 74032.25967740362, 76650.0, 78557.0, 53304.73347633237, 59788.701056494436, 61102.9731580865, 61370.386296136465, 63437.68281158657, 9857.507124643882, 10154.949225254122, 10354.741131471774, 10562.577496900038, 10622.309549879234, 27564.724352756217, 28158.85920570384, 28567.857160714062, 29098.563521547618, 29231.85384073066, 49338.506614933394, 50995.23507147322, 51443.228351574006, 53183.0, 53583.732081339345, 13601.455941762615, 13621.0, 14002.57992260234, 14008.43966241339, 14240.216788076756, 15123.39506419731, 15650.765238521659, 15665.530034098996, 15775.05349679023, 15853.365865365256, 14857.108573485626, 15702.607434814221, 15765.842341576437, 16030.11834349122, 16071.35714571404, 13899.444022238997, 14481.203533805741, 14515.49195778185, 14774.704505910036, 14799.18604476721, 13942.930285348508, 14072.296385180496, 14240.35918383696, 14304.284785760463, 14307.0, 10556.208284378856, 10929.453527323762, 11044.613438529614, 11093.389863557259, 11462.713432164262, 11050.33697978124, 12703.301318427206, 12767.106302559103, 12815.0, 12881.227126372072], "value": 7273.465018199691, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1561.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 113.0, 110.0, 110.0, 112.0, 111.0, 111.0, 111.0, 113.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 128.0, 124.0, 170.0, 131.0, 125.0, 125.0, 122.0, 154.0, 130.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 166.0, 168.0, 165.0, 170.0, 162.0, 164.0, 163.0, 165.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 115.0, 75.0, 75.0, 75.0, 74.0, 94.0, 74.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 104.0, 84.0, 83.0, 83.0, 97.0, 83.0, 84.0, 106.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 150.0, 152.0, 151.0, 151.0, 152.0, 150.0, 152.0, 149.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 57.0, 55.0, 58.0, 57.0, 56.0, 58.0, 58.0, 59.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 57.0, 57.0, 57.0, 57.0, 58.0, 58.0, 57.0], "value": 57.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 95.0, 86.0, 88.0, 95.0, 89.0, 88.0, 91.0, 115.0, 96.0], "value": 93.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 142.0, 141.0, 143.0, 146.0, 138.0, 134.0, 133.0, 145.0, 134.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 197.0, 206.0, 194.0, 193.0, 205.0, 202.0, 194.0, 196.0, 194.0], "value": 197.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 77.0, 73.0, 74.0, 75.0, 78.0, 72.0, 72.0, 77.0], "value": 74.8, "unit": "score"}]}]} 16:57:43 INFO - Return code: 0 16:57:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:57:43 INFO - # TBPL SUCCESS # 16:57:43 INFO - Running post-action listener: _resource_record_post_action 16:57:43 INFO - [mozharness: 2017-05-28 23:57:43.519955Z] Finished run-tests step (success) 16:57:43 INFO - Running post-run listener: _resource_record_post_run 16:57:43 INFO - Total resource usage - Wall time: 1257s; CPU: 13.0%; Read bytes: 4096; Write bytes: 413839360; Read time: 32; Write time: 319124 16:57:43 INFO - TinderboxPrint: CPU usage
12.7% 16:57:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 32 16:57:43 INFO - TinderboxPrint: I/O write bytes / time
413,839,360 / 319,124 16:57:43 INFO - TinderboxPrint: CPU idle
8,761.2 (87.3%) 16:57:43 INFO - TinderboxPrint: CPU user
1,220.6 (12.2%) 16:57:43 INFO - TinderboxPrint: Swap in / out
0 / 0 16:57:43 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 95305728; Read time: 0; Write time: 85996 16:57:43 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:57:43 INFO - run-tests - Wall time: 1242s; CPU: 13.0%; Read bytes: 4096; Write bytes: 318533632; Read time: 32; Write time: 233128 16:57:44 INFO - Running post-run listener: _upload_blobber_files 16:57:44 INFO - Blob upload gear active. 16:57:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:57:44 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 16:57:44 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'] 16:57:44 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 16:57:44 INFO - (blobuploader) - INFO - Open directory for files ... 16:57:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:57:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:57:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:45 INFO - (blobuploader) - INFO - Done attempting. 16:57:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:57:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:57:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:49 INFO - (blobuploader) - INFO - Done attempting. 16:57:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:57:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:57:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:50 INFO - (blobuploader) - INFO - Done attempting. 16:57:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:57:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:57:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:50 INFO - (blobuploader) - INFO - Done attempting. 16:57:50 INFO - (blobuploader) - INFO - Iteration through files over. 16:57:50 INFO - Return code: 0 16:57:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:57:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:57:50 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0445c7c94da6605dcd8c31c9ae4e1c0a93c45e1f1423acff817f69d0682c7df2e18c1d39d42989a67a15205aba9e0dc687bbfd300247e8323687cfed7be8f3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/352d702900c124981fbf6af5216c035e53a4c9007c007064b6a5625f6af4a26e56ff56d090b93c369663e750efbd402f6b5ab539b2433108c1b20018e41c71fe", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5a8b606e27181d2bbafd9b1daccd297f7664f55e177b44919ac82dac4ff747e931a51e0263a72aa3fa2123dee9adf39b2eb13ab5ee70ed51c5ad825468e856f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a85da751752c7f2e731b17120d5602dd1f59fd7b68ab620a4beee011c3d2285e5f22e1fc06a87b41b4d7d4d089bb7df4e49b88c1d009b8cebd4dac6e2eb09b9"} 16:57:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:57:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:57:50 INFO - Contents: 16:57:50 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0445c7c94da6605dcd8c31c9ae4e1c0a93c45e1f1423acff817f69d0682c7df2e18c1d39d42989a67a15205aba9e0dc687bbfd300247e8323687cfed7be8f3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/352d702900c124981fbf6af5216c035e53a4c9007c007064b6a5625f6af4a26e56ff56d090b93c369663e750efbd402f6b5ab539b2433108c1b20018e41c71fe", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5a8b606e27181d2bbafd9b1daccd297f7664f55e177b44919ac82dac4ff747e931a51e0263a72aa3fa2123dee9adf39b2eb13ab5ee70ed51c5ad825468e856f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a85da751752c7f2e731b17120d5602dd1f59fd7b68ab620a4beee011c3d2285e5f22e1fc06a87b41b4d7d4d089bb7df4e49b88c1d009b8cebd4dac6e2eb09b9"} 16:57:50 INFO - Running post-run listener: copy_logs_to_upload_dir 16:57:50 INFO - Copying logs to upload dir... 16:57:50 INFO - mkdir: /builds/slave/test/build/upload/logs 16:57:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1313.920295 ========= master_lag: -0.22 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2017-05-28 16:57:48.663329) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-28 16:57:48.671271) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0445c7c94da6605dcd8c31c9ae4e1c0a93c45e1f1423acff817f69d0682c7df2e18c1d39d42989a67a15205aba9e0dc687bbfd300247e8323687cfed7be8f3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/352d702900c124981fbf6af5216c035e53a4c9007c007064b6a5625f6af4a26e56ff56d090b93c369663e750efbd402f6b5ab539b2433108c1b20018e41c71fe", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5a8b606e27181d2bbafd9b1daccd297f7664f55e177b44919ac82dac4ff747e931a51e0263a72aa3fa2123dee9adf39b2eb13ab5ee70ed51c5ad825468e856f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a85da751752c7f2e731b17120d5602dd1f59fd7b68ab620a4beee011c3d2285e5f22e1fc06a87b41b4d7d4d089bb7df4e49b88c1d009b8cebd4dac6e2eb09b9"} build_url:https://queue.taskcluster.net/v1/task/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/WlffePMAS1SlVHnA2AgD_g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0445c7c94da6605dcd8c31c9ae4e1c0a93c45e1f1423acff817f69d0682c7df2e18c1d39d42989a67a15205aba9e0dc687bbfd300247e8323687cfed7be8f3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/352d702900c124981fbf6af5216c035e53a4c9007c007064b6a5625f6af4a26e56ff56d090b93c369663e750efbd402f6b5ab539b2433108c1b20018e41c71fe", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5a8b606e27181d2bbafd9b1daccd297f7664f55e177b44919ac82dac4ff747e931a51e0263a72aa3fa2123dee9adf39b2eb13ab5ee70ed51c5ad825468e856f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a85da751752c7f2e731b17120d5602dd1f59fd7b68ab620a4beee011c3d2285e5f22e1fc06a87b41b4d7d4d089bb7df4e49b88c1d009b8cebd4dac6e2eb09b9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-28 16:57:48.698423) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:57:48.698822) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1496014555.441800-2040639970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:57:48.779762) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-28 16:57:48.783111) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-28 16:57:48.783428) ========= ========= Total master_lag: -0.06 =========