builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1496298566.84 results: success (0) revision: bdb2387396b4a74dfefb7c983733eed3625e906a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-31 23:29:26.844677) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-31 23:29:26.845444) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-31 23:29:26.845753) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-31 23:29:26.894151) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 23:29:26.894486) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-31 23:29:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111K=0.1s 2017-05-31 23:29:28 (111 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.246798 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 23:29:27.155085) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 23:29:27.155429) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023089 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 23:29:27.206177) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 23:29:27.206571) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bdb2387396b4a74dfefb7c983733eed3625e906a --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 bdb2387396b4a74dfefb7c983733eed3625e906a --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=a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-31 23:29:28,454 truncating revision to first 12 chars 2017-05-31 23:29:28,454 Setting DEBUG logging. 2017-05-31 23:29:28,454 attempt 1/10 2017-05-31 23:29:28,454 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bdb2387396b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-31 23:29:29,003 unpacking tar archive at: mozilla-central-bdb2387396b4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.857264 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 23:29:28.076274) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-31 23:29:28.076621) ========= script_repo_revision: bdb2387396b4a74dfefb7c983733eed3625e906a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-31 23:29:28.077033) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-31 23:29:28.077378) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-31 23:29:28.089625) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-05-31 23:29:28.089944) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:29:29 INFO - MultiFileLogger online at 20170531 23:29:29 in /builds/slave/test 23:29:29 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 23:29:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:29:29 INFO - {'append_to_log': False, 23:29:29 INFO - 'base_work_dir': '/builds/slave/test', 23:29:29 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 23:29:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:29:29 INFO - 'branch': 'Firefox-Non-PGO', 23:29:29 INFO - 'buildbot_json_path': 'buildprops.json', 23:29:29 INFO - 'config_files': ('talos/linux_config.py',), 23:29:29 INFO - 'default_actions': ('clobber', 23:29:29 INFO - 'read-buildbot-config', 23:29:29 INFO - 'download-and-extract', 23:29:29 INFO - 'populate-webroot', 23:29:29 INFO - 'create-virtualenv', 23:29:29 INFO - 'install', 23:29:29 INFO - 'setup-mitmproxy', 23:29:29 INFO - 'run-tests'), 23:29:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:29:29 INFO - 'download_minidump_stackwalk': True, 23:29:29 INFO - 'download_symbols': 'ondemand', 23:29:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:29:29 INFO - 'tooltool.py': '/tools/tooltool.py', 23:29:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:29:29 INFO - '/tools/misc-python/virtualenv.py')}, 23:29:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:29:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:29:29 INFO - 'gecko_profile': False, 23:29:29 INFO - 'gecko_profile_interval': 0, 23:29:29 INFO - 'installer_path': 'installer.exe', 23:29:29 INFO - 'log_level': 'info', 23:29:29 INFO - 'log_name': 'talos', 23:29:29 INFO - 'log_to_console': True, 23:29:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:29:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:29:29 INFO - 'opt_config_files': (), 23:29:29 INFO - 'pip_index': False, 23:29:29 INFO - 'suite': 'dromaeojs-e10s', 23:29:29 INFO - 'system_bits': '32', 23:29:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:29:29 INFO - 'title': 'talos-linux64-ix-064', 23:29:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:29:29 INFO - 'use_talos_json': True, 23:29:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:29:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:29:29 INFO - 'work_dir': 'build'} 23:29:29 INFO - [mozharness: 2017-06-01 06:29:29.441789Z] Running clobber step. 23:29:29 INFO - Running pre-action listener: _resource_record_pre_action 23:29:29 INFO - Running main action method: clobber 23:29:29 INFO - rmtree: /builds/slave/test/build 23:29:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:29:30 INFO - Running post-action listener: _resource_record_post_action 23:29:30 INFO - [mozharness: 2017-06-01 06:29:30.979202Z] Finished clobber step (success) 23:29:30 INFO - [mozharness: 2017-06-01 06:29:30.979302Z] Running read-buildbot-config step. 23:29:30 INFO - Running pre-action listener: _resource_record_pre_action 23:29:30 INFO - Running main action method: read_buildbot_config 23:29:30 INFO - Using buildbot properties: 23:29:30 INFO - { 23:29:30 INFO - "project": "", 23:29:30 INFO - "product": "firefox", 23:29:30 INFO - "who": "philringnalda@gmail.com", 23:29:30 INFO - "installer_path": "public/build/target.tar.bz2", 23:29:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 23:29:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 23:29:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 23:29:30 INFO - "stage_platform": "linux64", 23:29:30 INFO - "basedir": "/builds/slave/test", 23:29:30 INFO - "buildnumber": 921, 23:29:30 INFO - "platform": "ubuntu64_hw", 23:29:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:29:30 INFO - "slavebuilddir": "test", 23:29:30 INFO - "taskId": "CCwEoG_1Qg-Ok6jXJyXHVQ", 23:29:30 INFO - "branch": "mozilla-central", 23:29:30 INFO - "script_repo_revision": "production", 23:29:30 INFO - "revision": "bdb2387396b4a74dfefb7c983733eed3625e906a", 23:29:30 INFO - "slavename": "talos-linux64-ix-064", 23:29:30 INFO - "repo_path": "mozilla-central" 23:29:30 INFO - } 23:29:30 INFO - Finding installer, test and symbols from parent task. 23:29:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CCwEoG_1Qg-Ok6jXJyXHVQ'}, attempt #1 23:29:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CCwEoG_1Qg-Ok6jXJyXHVQ'}, attempt #1 23:29:31 INFO - Task dependencies: RibvKKO0QmyIR4wWKbMfMw 23:29:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RibvKKO0QmyIR4wWKbMfMw'}, attempt #1 23:29:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/target.tar.bz2 23:29:32 INFO - Set test_url: https://queue.taskcluster.net/v1/task/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/test_packages.json 23:29:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/target.crashreporter-symbols.zip 23:29:32 INFO - Running post-action listener: _resource_record_post_action 23:29:32 INFO - [mozharness: 2017-06-01 06:29:32.281434Z] Finished read-buildbot-config step (success) 23:29:32 INFO - [mozharness: 2017-06-01 06:29:32.281653Z] Running download-and-extract step. 23:29:32 INFO - Running pre-action listener: _resource_record_pre_action 23:29:32 INFO - Running main action method: download_and_extract 23:29:32 INFO - mkdir: /builds/slave/test/build/tests 23:29: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')]} 23:29:32 INFO - trying https://queue.taskcluster.net/v1/task/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/target.test_packages.json 23:29:32 INFO - Downloading https://queue.taskcluster.net/v1/task/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 23:29:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 23:29:32 INFO - Downloaded 986 bytes. 23:29:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 23:29:32 INFO - Using the following test package requirements: 23:29:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 23:29:32 INFO - u'common': [u'target.common.tests.zip'], 23:29:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 23:29:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 23:29:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 23:29:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 23:29:32 INFO - u'mozbase': [u'target.common.tests.zip'], 23:29:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 23:29:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 23:29:32 INFO - u'web-platform': [u'target.common.tests.zip', 23:29:32 INFO - u'target.web-platform.tests.zip'], 23:29:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 23:29:32 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 23:29:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/target.common.tests.zip 23:29:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/target.common.tests.zip'}, attempt #1 23:29:32 INFO - Fetch https://queue.taskcluster.net/v1/task/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/target.common.tests.zip into memory 23:29:35 INFO - Content-Length response header: 63527439 23:29:35 INFO - Bytes received: 63527439 23:29:45 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 23:29:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/target.common.tests.zip 23:29:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/target.common.tests.zip'}, attempt #1 23:29:45 INFO - Fetch https://queue.taskcluster.net/v1/task/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/target.common.tests.zip into memory 23:29:47 INFO - Content-Length response header: 63527439 23:29:47 INFO - Bytes received: 63527439 23:29:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/target.talos.tests.zip 23:29:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 23:29:59 INFO - Fetch https://queue.taskcluster.net/v1/task/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/target.talos.tests.zip into memory 23:30:00 INFO - Content-Length response header: 14447425 23:30:00 INFO - Bytes received: 14447425 23:30:00 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')]} 23:30:00 INFO - trying https://queue.taskcluster.net/v1/task/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/target.tar.bz2 23:30:00 INFO - Downloading https://queue.taskcluster.net/v1/task/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 23:30:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 23:30:02 INFO - Downloaded 54222242 bytes. 23:30:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/target.tar.bz2 23:30:02 INFO - mkdir: /builds/slave/test/properties 23:30:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:30:02 INFO - Writing to file /builds/slave/test/properties/build_url 23:30:02 INFO - Contents: 23:30:02 INFO - build_url:https://queue.taskcluster.net/v1/task/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/target.tar.bz2 23:30:02 INFO - Running post-action listener: _resource_record_post_action 23:30:02 INFO - Running post-action listener: set_extra_try_arguments 23:30:02 INFO - [mozharness: 2017-06-01 06:30:02.681784Z] Finished download-and-extract step (success) 23:30:02 INFO - [mozharness: 2017-06-01 06:30:02.681880Z] Running populate-webroot step. 23:30:02 INFO - Running pre-action listener: _resource_record_pre_action 23:30:02 INFO - Running main action method: populate_webroot 23:30:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:30:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:30:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:30:02 INFO - '--tppagecycles', 23:30:02 INFO - '7'], 23:30:02 INFO - 'tests': ['tsvgm']}}, 23:30:02 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:30:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:30:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:30:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:30:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 23:30:02 INFO - 'talos_options': ['--disable-e10s'], 23:30:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:30:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 23:30:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:30:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 23:30:02 INFO - 'talos_options': ['--disable-e10s'], 23:30:02 INFO - 'tests': ['damp', 'tps']}, 23:30:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 23:30:02 INFO - 'tests': ['damp', 'tps']}, 23:30:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:30:02 INFO - 'tests': ['dromaeo_dom']}, 23:30:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:30:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:30:02 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 23:30:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 23:30:02 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 23:30:02 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 23:30:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:30:02 INFO - 'tests': ['a11yr', 23:30:02 INFO - 'ts_paint', 23:30:02 INFO - 'tpaint', 23:30:02 INFO - 'sessionrestore', 23:30:02 INFO - 'sessionrestore_no_auto_restore', 23:30:02 INFO - 'tabpaint']}, 23:30:02 INFO - 'other-e10s': {'tests': ['a11yr', 23:30:02 INFO - 'ts_paint', 23:30:02 INFO - 'tpaint', 23:30:02 INFO - 'sessionrestore', 23:30:02 INFO - 'sessionrestore_no_auto_restore', 23:30:02 INFO - 'tabpaint']}, 23:30:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:30:02 INFO - 'ts_paint', 23:30:02 INFO - 'tpaint', 23:30:02 INFO - 'sessionrestore', 23:30:02 INFO - 'sessionrestore_no_auto_restore', 23:30:02 INFO - 'tabpaint']}, 23:30:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:30:02 INFO - 'ts_paint', 23:30:02 INFO - 'tpaint', 23:30:02 INFO - 'sessionrestore', 23:30:02 INFO - 'sessionrestore_no_auto_restore', 23:30:02 INFO - 'tabpaint']}, 23:30:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:30:02 INFO - 'tests': ['a11yr', 23:30:02 INFO - 'ts_paint', 23:30:02 INFO - 'tpaint', 23:30:02 INFO - 'sessionrestore', 23:30:02 INFO - 'sessionrestore_no_auto_restore', 23:30:02 INFO - 'tabpaint']}, 23:30:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:30:02 INFO - 'tests': ['a11yr', 23:30:02 INFO - 'ts_paint', 23:30:02 INFO - 'tpaint', 23:30:02 INFO - 'sessionrestore', 23:30:02 INFO - 'sessionrestore_no_auto_restore', 23:30:02 INFO - 'tabpaint']}, 23:30:02 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 23:30:02 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 23:30:02 INFO - 'bloom_basic_ref']}, 23:30:02 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 23:30:02 INFO - 'talos_options': ['--mitmproxy', 23:30:02 INFO - 'mitmproxy-recording-1.mp', 23:30:02 INFO - '--firstNonBlankPaint'], 23:30:02 INFO - 'tests': ['Quantum_1']}, 23:30:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:30:02 INFO - 'tests': ['tsvgx', 23:30:02 INFO - 'tsvgr_opacity', 23:30:02 INFO - 'tart', 23:30:02 INFO - 'tscrollx', 23:30:02 INFO - 'cart', 23:30:02 INFO - 'tsvg_static']}, 23:30:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:30:02 INFO - 'tsvgr_opacity', 23:30:02 INFO - 'tart', 23:30:02 INFO - 'tscrollx', 23:30:02 INFO - 'cart', 23:30:02 INFO - 'tsvg_static']}, 23:30:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 23:30:02 INFO - 'talos_options': ['--disable-e10s'], 23:30:02 INFO - 'tests': ['tp5o']}, 23:30:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 23:30:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 23:30:02 INFO - 'talos_options': ['--disable-e10s', 23:30:02 INFO - '--xperf_path', 23:30:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:30:02 INFO - 'tests': ['tp5n']}, 23:30:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 23:30:02 INFO - 'talos_options': ['--xperf_path', 23:30:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:30:02 INFO - 'tests': ['tp5n']}}, 23:30:02 INFO - 'talos.zip': {'path': '', 23:30:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:30:02 INFO - Running post-action listener: _resource_record_post_action 23:30:02 INFO - [mozharness: 2017-06-01 06:30:02.696196Z] Finished populate-webroot step (success) 23:30:02 INFO - [mozharness: 2017-06-01 06:30:02.696291Z] Running create-virtualenv step. 23:30:02 INFO - Running pre-action listener: _resource_record_pre_action 23:30:02 INFO - Running main action method: create_virtualenv 23:30:02 INFO - Creating virtualenv /builds/slave/test/build/venv 23:30:02 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 23:30:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:30:02 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 23:30:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:30:02 INFO - Using real prefix '/usr' 23:30:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:30:03 INFO - Installing distribute.............................................................................................................................................................................................done. 23:30:05 INFO - Installing pip.................done. 23:30:05 INFO - Return code: 0 23:30:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:30:05 INFO - Reading from file tmpfile_stdout 23:30:05 INFO - Output received: 23:30:05 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) 23:30:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1588dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585840>, '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 0x1586740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586bd0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920', '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 23:30:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:30:05 INFO - Using env: {'DISPLAY': ':0', 23:30:05 INFO - 'HOME': '/home/cltbld', 23:30:05 INFO - 'LANG': 'en_US.UTF-8', 23:30:05 INFO - 'LANGUAGE': 'en_US:en', 23:30:05 INFO - 'LOGNAME': 'cltbld', 23:30:05 INFO - 'MAIL': '/var/mail/cltbld', 23:30:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:05 INFO - 'MOZ_NO_REMOTE': '1', 23:30:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:05 INFO - 'NO_EM_RESTART': '1', 23:30:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:05 INFO - 'PWD': '/builds/slave/test', 23:30:05 INFO - 'SHELL': '/bin/bash', 23:30:05 INFO - 'SHLVL': '1', 23:30:05 INFO - 'TERM': 'linux', 23:30:05 INFO - 'TMOUT': '86400', 23:30:05 INFO - 'USER': 'cltbld', 23:30:05 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920', 23:30:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:05 INFO - '_': '/tools/buildbot/bin/python'} 23:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:05 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 23:30:05 INFO - Cleaning up... 23:30:05 INFO - Return code: 0 23:30:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x120a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1588dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585840>, '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 0x1586740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586bd0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920', '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 23:30:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:30:05 INFO - Using env: {'DISPLAY': ':0', 23:30:05 INFO - 'HOME': '/home/cltbld', 23:30:05 INFO - 'LANG': 'en_US.UTF-8', 23:30:05 INFO - 'LANGUAGE': 'en_US:en', 23:30:05 INFO - 'LOGNAME': 'cltbld', 23:30:05 INFO - 'MAIL': '/var/mail/cltbld', 23:30:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:05 INFO - 'MOZ_NO_REMOTE': '1', 23:30:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:05 INFO - 'NO_EM_RESTART': '1', 23:30:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:05 INFO - 'PWD': '/builds/slave/test', 23:30:05 INFO - 'SHELL': '/bin/bash', 23:30:05 INFO - 'SHLVL': '1', 23:30:05 INFO - 'TERM': 'linux', 23:30:05 INFO - 'TMOUT': '86400', 23:30:05 INFO - 'USER': 'cltbld', 23:30:05 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920', 23:30:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:05 INFO - '_': '/tools/buildbot/bin/python'} 23:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:05 INFO - Downloading/unpacking psutil>=3.1.1 23:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:30:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:30:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:30:07 INFO - Installing collected packages: psutil 23:30:07 INFO - Running setup.py install for psutil 23:30:07 INFO - building 'psutil._psutil_linux' extension 23:30:07 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 23:30:07 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 23:30:07 INFO - building 'psutil._psutil_posix' extension 23:30:07 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 23:30:07 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 23:30:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:30:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:30:07 INFO - Successfully installed psutil 23:30:07 INFO - Cleaning up... 23:30:07 INFO - Return code: 0 23:30:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1588dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585840>, '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 0x1586740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586bd0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920', '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 23:30:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:30:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:30:07 INFO - Using env: {'DISPLAY': ':0', 23:30:07 INFO - 'HOME': '/home/cltbld', 23:30:07 INFO - 'LANG': 'en_US.UTF-8', 23:30:07 INFO - 'LANGUAGE': 'en_US:en', 23:30:07 INFO - 'LOGNAME': 'cltbld', 23:30:07 INFO - 'MAIL': '/var/mail/cltbld', 23:30:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:07 INFO - 'MOZ_NO_REMOTE': '1', 23:30:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:07 INFO - 'NO_EM_RESTART': '1', 23:30:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:07 INFO - 'PWD': '/builds/slave/test', 23:30:07 INFO - 'SHELL': '/bin/bash', 23:30:07 INFO - 'SHLVL': '1', 23:30:07 INFO - 'TERM': 'linux', 23:30:07 INFO - 'TMOUT': '86400', 23:30:07 INFO - 'USER': 'cltbld', 23:30:07 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920', 23:30:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:07 INFO - '_': '/tools/buildbot/bin/python'} 23:30:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:30:07 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 23:30:07 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 23:30:07 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 23:30:07 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 23:30:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:30:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:30:09 INFO - Installing collected packages: mozsystemmonitor 23:30:09 INFO - Running setup.py install for mozsystemmonitor 23:30:09 INFO - Successfully installed mozsystemmonitor 23:30:09 INFO - Cleaning up... 23:30:09 INFO - Return code: 0 23:30:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:30:09 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')]} 23:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:09 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')]} 23:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:09 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 0x120a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1588dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585840>, '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 0x1586740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586bd0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920', '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 23:30:09 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 23:30:09 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 23:30:09 INFO - Using env: {'DISPLAY': ':0', 23:30:09 INFO - 'HOME': '/home/cltbld', 23:30:09 INFO - 'LANG': 'en_US.UTF-8', 23:30:09 INFO - 'LANGUAGE': 'en_US:en', 23:30:09 INFO - 'LOGNAME': 'cltbld', 23:30:09 INFO - 'MAIL': '/var/mail/cltbld', 23:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:09 INFO - 'MOZ_NO_REMOTE': '1', 23:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:09 INFO - 'NO_EM_RESTART': '1', 23:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:09 INFO - 'PWD': '/builds/slave/test', 23:30:09 INFO - 'SHELL': '/bin/bash', 23:30:09 INFO - 'SHLVL': '1', 23:30:09 INFO - 'TERM': 'linux', 23:30:09 INFO - 'TMOUT': '86400', 23:30:09 INFO - 'USER': 'cltbld', 23:30:09 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920', 23:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:09 INFO - '_': '/tools/buildbot/bin/python'} 23:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:09 INFO - Downloading/unpacking jsonschema==2.5.1 23:30:09 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 23:30:09 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 23:30:09 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 23:30:09 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 23:30:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:30:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:30:10 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 23:30:10 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 23:30:10 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 23:30:10 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 23:30:10 INFO - Downloading functools32-3.2.3-2.tar.gz 23:30:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:30:10 INFO - warning: no files found matching '*.txt' 23:30:10 INFO - no previously-included directories found matching 'build' 23:30:10 INFO - no previously-included directories found matching 'dist' 23:30:10 INFO - no previously-included directories found matching '.git*' 23:30:10 INFO - Installing collected packages: jsonschema, functools32 23:30:10 INFO - Running setup.py install for functools32 23:30:10 INFO - warning: no files found matching '*.txt' 23:30:10 INFO - no previously-included directories found matching 'build' 23:30:10 INFO - no previously-included directories found matching 'dist' 23:30:10 INFO - no previously-included directories found matching '.git*' 23:30:10 INFO - Successfully installed jsonschema functools32 23:30:10 INFO - Cleaning up... 23:30:10 INFO - Return code: 0 23:30:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:30:10 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')]} 23:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:10 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')]} 23:30:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:10 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 0x120a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1588dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585840>, '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 0x1586740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586bd0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920', '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 23:30:10 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 23:30:10 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 23:30:10 INFO - Using env: {'DISPLAY': ':0', 23:30:10 INFO - 'HOME': '/home/cltbld', 23:30:10 INFO - 'LANG': 'en_US.UTF-8', 23:30:10 INFO - 'LANGUAGE': 'en_US:en', 23:30:10 INFO - 'LOGNAME': 'cltbld', 23:30:10 INFO - 'MAIL': '/var/mail/cltbld', 23:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:10 INFO - 'MOZ_NO_REMOTE': '1', 23:30:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:10 INFO - 'NO_EM_RESTART': '1', 23:30:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:10 INFO - 'PWD': '/builds/slave/test', 23:30:10 INFO - 'SHELL': '/bin/bash', 23:30:10 INFO - 'SHLVL': '1', 23:30:10 INFO - 'TERM': 'linux', 23:30:10 INFO - 'TMOUT': '86400', 23:30:10 INFO - 'USER': 'cltbld', 23:30:10 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920', 23:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:10 INFO - '_': '/tools/buildbot/bin/python'} 23:30:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:30:11 INFO - Cleaning up... 23:30:11 INFO - Return code: 0 23:30:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:30:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x120a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1588dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585840>, '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 0x1586740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586bd0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920', '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 23:30:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:30:11 INFO - Using env: {'DISPLAY': ':0', 23:30:11 INFO - 'HOME': '/home/cltbld', 23:30:11 INFO - 'LANG': 'en_US.UTF-8', 23:30:11 INFO - 'LANGUAGE': 'en_US:en', 23:30:11 INFO - 'LOGNAME': 'cltbld', 23:30:11 INFO - 'MAIL': '/var/mail/cltbld', 23:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:11 INFO - 'MOZ_NO_REMOTE': '1', 23:30:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:11 INFO - 'NO_EM_RESTART': '1', 23:30:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:11 INFO - 'PWD': '/builds/slave/test', 23:30:11 INFO - 'SHELL': '/bin/bash', 23:30:11 INFO - 'SHLVL': '1', 23:30:11 INFO - 'TERM': 'linux', 23:30:11 INFO - 'TMOUT': '86400', 23:30:11 INFO - 'USER': 'cltbld', 23:30:11 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920', 23:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:11 INFO - '_': '/tools/buildbot/bin/python'} 23:30:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:11 INFO - Downloading/unpacking blobuploader==1.2.4 23:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:12 INFO - Downloading blobuploader-1.2.4.tar.gz 23:30:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:30:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:30:12 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 23:30:12 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 23:30:12 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 23:30:12 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 23:30:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:30:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:30:12 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 23:30:12 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 23:30:12 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 23:30:12 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 23:30:12 INFO - Downloading docopt-0.6.1.tar.gz 23:30:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:30:12 INFO - Installing collected packages: blobuploader, requests, docopt 23:30:12 INFO - Running setup.py install for blobuploader 23:30:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:30:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:30:13 INFO - Running setup.py install for requests 23:30:13 INFO - Running setup.py install for docopt 23:30:13 INFO - Successfully installed blobuploader requests docopt 23:30:13 INFO - Cleaning up... 23:30:13 INFO - Return code: 0 23:30:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:30:13 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')]} 23:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:13 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')]} 23:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:13 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 0x120a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1588dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585840>, '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 0x1586740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586bd0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920', '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 23:30:13 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 23:30:13 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 23:30:13 INFO - Using env: {'DISPLAY': ':0', 23:30:13 INFO - 'HOME': '/home/cltbld', 23:30:13 INFO - 'LANG': 'en_US.UTF-8', 23:30:13 INFO - 'LANGUAGE': 'en_US:en', 23:30:13 INFO - 'LOGNAME': 'cltbld', 23:30:13 INFO - 'MAIL': '/var/mail/cltbld', 23:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:13 INFO - 'MOZ_NO_REMOTE': '1', 23:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:13 INFO - 'NO_EM_RESTART': '1', 23:30:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:13 INFO - 'PWD': '/builds/slave/test', 23:30:13 INFO - 'SHELL': '/bin/bash', 23:30:13 INFO - 'SHLVL': '1', 23:30:13 INFO - 'TERM': 'linux', 23:30:13 INFO - 'TMOUT': '86400', 23:30:13 INFO - 'USER': 'cltbld', 23:30:13 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920', 23:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:13 INFO - '_': '/tools/buildbot/bin/python'} 23:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:30:13 INFO - Running setup.py (path:/tmp/pip-JrFKbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:30:13 INFO - Running setup.py (path:/tmp/pip-jEYcVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:30:13 INFO - Running setup.py (path:/tmp/pip-NfCgJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:30:14 INFO - Running setup.py (path:/tmp/pip-MeorKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:30:14 INFO - Running setup.py (path:/tmp/pip-OLpW2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:30:14 INFO - Running setup.py (path:/tmp/pip-2uo0_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:30:14 INFO - Running setup.py (path:/tmp/pip-KQbUmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:30:14 INFO - Running setup.py (path:/tmp/pip-u3w9lE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:30:14 INFO - Running setup.py (path:/tmp/pip-XQKq_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:30:14 INFO - Running setup.py (path:/tmp/pip-zz7pBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:30:14 INFO - Running setup.py (path:/tmp/pip-tBQq1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:30:14 INFO - Running setup.py (path:/tmp/pip-WQ3CMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:30:14 INFO - Running setup.py (path:/tmp/pip-EjgxED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:30:14 INFO - Running setup.py (path:/tmp/pip-JIJCLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:30:14 INFO - Running setup.py (path:/tmp/pip-6OUcsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:30:14 INFO - Running setup.py (path:/tmp/pip-4Yw7WU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:30:14 INFO - Running setup.py (path:/tmp/pip-9QKmIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:30:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:30:15 INFO - Running setup.py install for manifestparser 23:30:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:30:15 INFO - Running setup.py install for mozcrash 23:30:15 INFO - Running setup.py install for mozdebug 23:30:15 INFO - Running setup.py install for mozdevice 23:30:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:30:15 INFO - Running setup.py install for mozfile 23:30:15 INFO - Running setup.py install for mozhttpd 23:30:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:30:15 INFO - Running setup.py install for mozinfo 23:30:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:30:15 INFO - Running setup.py install for mozInstall 23:30:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:30:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:30:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:30:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:30:15 INFO - Running setup.py install for mozleak 23:30:15 INFO - Running setup.py install for mozlog 23:30:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:30:16 INFO - Running setup.py install for moznetwork 23:30:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:30:16 INFO - Running setup.py install for mozprocess 23:30:16 INFO - Running setup.py install for mozprofile 23:30:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:30:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:30:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:30:16 INFO - Running setup.py install for mozrunner 23:30:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:30:16 INFO - Running setup.py install for mozscreenshot 23:30:16 INFO - Running setup.py install for moztest 23:30:16 INFO - Running setup.py install for mozversion 23:30:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:30:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:30:16 INFO - Cleaning up... 23:30:16 INFO - Return code: 0 23:30:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:16 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 0x120a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1588dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585840>, '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 0x1586740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586bd0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920', '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 23:30:16 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 23:30:16 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 23:30:16 INFO - Using env: {'DISPLAY': ':0', 23:30:16 INFO - 'HOME': '/home/cltbld', 23:30:16 INFO - 'LANG': 'en_US.UTF-8', 23:30:16 INFO - 'LANGUAGE': 'en_US:en', 23:30:16 INFO - 'LOGNAME': 'cltbld', 23:30:16 INFO - 'MAIL': '/var/mail/cltbld', 23:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:16 INFO - 'MOZ_NO_REMOTE': '1', 23:30:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:16 INFO - 'NO_EM_RESTART': '1', 23:30:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:16 INFO - 'PWD': '/builds/slave/test', 23:30:16 INFO - 'SHELL': '/bin/bash', 23:30:16 INFO - 'SHLVL': '1', 23:30:16 INFO - 'TERM': 'linux', 23:30:16 INFO - 'TMOUT': '86400', 23:30:16 INFO - 'USER': 'cltbld', 23:30:16 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920', 23:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:16 INFO - '_': '/tools/buildbot/bin/python'} 23:30:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:30:17 INFO - Running setup.py (path:/tmp/pip-Hp79lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:30:17 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)) 23:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:30:17 INFO - Running setup.py (path:/tmp/pip-gSGnn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:30:17 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)) 23:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:30:17 INFO - Running setup.py (path:/tmp/pip-uOWMKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:30:17 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)) 23:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:30:17 INFO - Running setup.py (path:/tmp/pip-Wbe90o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:30:17 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)) 23:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:30:17 INFO - Running setup.py (path:/tmp/pip-NQZZcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:30:17 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)) 23:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:30:17 INFO - Running setup.py (path:/tmp/pip-2xJzMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:30:17 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)) 23:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:30:17 INFO - Running setup.py (path:/tmp/pip-91Lu10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:30:17 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)) 23:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:30:17 INFO - Running setup.py (path:/tmp/pip-IHyl6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:30:17 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)) 23:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:30:17 INFO - Running setup.py (path:/tmp/pip-N1rl8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:30:17 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)) 23:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:30:17 INFO - Running setup.py (path:/tmp/pip-SnWNL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:30:17 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)) 23:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:30:17 INFO - Running setup.py (path:/tmp/pip-gULb3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:30:17 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)) 23:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:30:17 INFO - Running setup.py (path:/tmp/pip-oHP3Qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:30:17 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)) 23:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:30:17 INFO - Running setup.py (path:/tmp/pip-OWyDrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:30:17 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)) 23:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:30:17 INFO - Running setup.py (path:/tmp/pip-yaLwDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:30:18 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)) 23:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:30:18 INFO - Running setup.py (path:/tmp/pip-xeXSJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:30:18 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)) 23:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:30:18 INFO - Running setup.py (path:/tmp/pip-tQV7Nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:30:18 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)) 23:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:30:18 INFO - Running setup.py (path:/tmp/pip-AlbqT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:30:18 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)) 23:30:18 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)) 23:30:18 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)) 23:30:18 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)) 23:30:18 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)) 23:30:18 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)) 23:30:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:19 INFO - Downloading blessings-1.6.tar.gz 23:30:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:30:19 INFO - Installing collected packages: blessings 23:30:19 INFO - Running setup.py install for blessings 23:30:19 INFO - Successfully installed blessings 23:30:19 INFO - Cleaning up... 23:30:19 INFO - Return code: 0 23:30:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:30:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:30:19 INFO - Reading from file tmpfile_stdout 23:30:19 INFO - Current package versions: 23:30:19 INFO - argparse == 1.2.1 23:30:19 INFO - blessings == 1.6 23:30:19 INFO - blobuploader == 1.2.4 23:30:19 INFO - docopt == 0.6.1 23:30:19 INFO - functools32 == 3.2.3-2 23:30:19 INFO - jsonschema == 2.5.1 23:30:19 INFO - manifestparser == 1.1 23:30:19 INFO - mozInstall == 1.12 23:30:19 INFO - mozcrash == 1.0 23:30:19 INFO - mozdebug == 0.1 23:30:19 INFO - mozdevice == 0.51 23:30:19 INFO - mozfile == 1.2 23:30:19 INFO - mozhttpd == 0.7 23:30:19 INFO - mozinfo == 0.9 23:30:19 INFO - mozleak == 0.1 23:30:19 INFO - mozlog == 3.4 23:30:19 INFO - moznetwork == 0.27 23:30:19 INFO - mozprocess == 0.25 23:30:19 INFO - mozprofile == 0.28 23:30:19 INFO - mozrunner == 6.13 23:30:19 INFO - mozscreenshot == 0.1 23:30:19 INFO - mozsystemmonitor == 0.3 23:30:19 INFO - moztest == 0.8 23:30:19 INFO - mozversion == 1.4 23:30:19 INFO - psutil == 3.1.1 23:30:19 INFO - requests == 1.2.3 23:30:19 INFO - wsgiref == 0.1.2 23:30:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:19 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 0x120a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1588dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585840>, '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 0x1586740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586bd0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920', '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 23:30:19 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 23:30:19 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 23:30:19 INFO - Using env: {'DISPLAY': ':0', 23:30:19 INFO - 'HOME': '/home/cltbld', 23:30:19 INFO - 'LANG': 'en_US.UTF-8', 23:30:19 INFO - 'LANGUAGE': 'en_US:en', 23:30:19 INFO - 'LOGNAME': 'cltbld', 23:30:19 INFO - 'MAIL': '/var/mail/cltbld', 23:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:19 INFO - 'MOZ_NO_REMOTE': '1', 23:30:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:19 INFO - 'NO_EM_RESTART': '1', 23:30:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:19 INFO - 'PWD': '/builds/slave/test', 23:30:19 INFO - 'SHELL': '/bin/bash', 23:30:19 INFO - 'SHLVL': '1', 23:30:19 INFO - 'TERM': 'linux', 23:30:19 INFO - 'TMOUT': '86400', 23:30:19 INFO - 'USER': 'cltbld', 23:30:19 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920', 23:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:19 INFO - '_': '/tools/buildbot/bin/python'} 23:30:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:20 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)) 23:30:20 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)) 23:30:20 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)) 23:30:20 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)) 23:30:20 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)) 23:30:20 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)) 23:30:20 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)) 23:30:20 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)) 23:30:20 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)) 23:30:20 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 23:30:20 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 23:30:20 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 23:30:20 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 23:30:20 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 23:30:21 INFO - Downloading marionette_driver-1.4.0.tar.gz 23:30:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 23:30:21 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)) 23:30:21 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)) 23:30:21 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)) 23:30:21 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)) 23:30:21 INFO - Installing collected packages: marionette-driver 23:30:21 INFO - Running setup.py install for marionette-driver 23:30:21 INFO - Successfully installed marionette-driver 23:30:21 INFO - Cleaning up... 23:30:21 INFO - Return code: 0 23:30:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:30:21 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')]} 23:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:21 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')]} 23:30:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:21 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 0x120a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1588dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585840>, '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 0x1586740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586bd0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920', '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 23:30:21 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 23:30:21 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 23:30:21 INFO - Using env: {'DISPLAY': ':0', 23:30:21 INFO - 'HOME': '/home/cltbld', 23:30:21 INFO - 'LANG': 'en_US.UTF-8', 23:30:21 INFO - 'LANGUAGE': 'en_US:en', 23:30:21 INFO - 'LOGNAME': 'cltbld', 23:30:21 INFO - 'MAIL': '/var/mail/cltbld', 23:30:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:21 INFO - 'MOZ_NO_REMOTE': '1', 23:30:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:21 INFO - 'NO_EM_RESTART': '1', 23:30:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:21 INFO - 'PWD': '/builds/slave/test', 23:30:21 INFO - 'SHELL': '/bin/bash', 23:30:21 INFO - 'SHLVL': '1', 23:30:21 INFO - 'TERM': 'linux', 23:30:21 INFO - 'TMOUT': '86400', 23:30:21 INFO - 'USER': 'cltbld', 23:30:21 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920', 23:30:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:21 INFO - '_': '/tools/buildbot/bin/python'} 23:30:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:30:21 INFO - Cleaning up... 23:30:21 INFO - Return code: 0 23:30:21 INFO - Running post-action listener: _resource_record_post_action 23:30:21 INFO - Running post-action listener: _start_resource_monitoring 23:30:21 INFO - Starting resource monitoring. 23:30:21 INFO - [mozharness: 2017-06-01 06:30:21.594484Z] Finished create-virtualenv step (success) 23:30:21 INFO - [mozharness: 2017-06-01 06:30:21.595004Z] Running install step. 23:30:21 INFO - Running pre-action listener: _resource_record_pre_action 23:30:21 INFO - Running main action method: install 23:30:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:30:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:30:21 INFO - Reading from file tmpfile_stdout 23:30:21 INFO - Detecting whether we're running mozinstall >=1.0... 23:30:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:30:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:30:21 INFO - Reading from file tmpfile_stdout 23:30:21 INFO - Output received: 23:30:21 INFO - Usage: mozinstall [options] installer 23:30:21 INFO - Options: 23:30:21 INFO - -h, --help show this help message and exit 23:30:21 INFO - -d DEST, --destination=DEST 23:30:21 INFO - Directory to install application into. [default: 23:30:21 INFO - "/builds/slave/test"] 23:30:21 INFO - --app=APP Application being installed. [default: firefox] 23:30:21 INFO - mkdir: /builds/slave/test/build/application 23:30:21 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'] 23:30:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 23:30:37 INFO - Reading from file tmpfile_stdout 23:30:37 INFO - Output received: 23:30:37 INFO - /builds/slave/test/build/application/firefox/firefox 23:30:37 INFO - Running post-action listener: _resource_record_post_action 23:30:37 INFO - [mozharness: 2017-06-01 06:30:37.452236Z] Finished install step (success) 23:30:37 INFO - [mozharness: 2017-06-01 06:30:37.452514Z] Running setup-mitmproxy step. 23:30:37 INFO - Running pre-action listener: _resource_record_pre_action 23:30:37 INFO - Running main action method: setup_mitmproxy 23:30:37 INFO - Skipping: mitmproxy is not required 23:30:37 INFO - Running post-action listener: _resource_record_post_action 23:30:37 INFO - [mozharness: 2017-06-01 06:30:37.453701Z] Finished setup-mitmproxy step (success) 23:30:37 INFO - [mozharness: 2017-06-01 06:30:37.453922Z] Running run-tests step. 23:30:37 INFO - Running pre-action listener: _resource_record_pre_action 23:30:37 INFO - Running main action method: run_tests 23:30:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:30:37 INFO - Python 2.7.3 23:30:37 INFO - Return code: 0 23:30:37 INFO - grabbing minidump binary from tooltool 23:30:37 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')]} 23:30:37 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 0x1585840>, '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 0x1586740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:30:37 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 23:30:37 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 23:30:37 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 23:30:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:30:37 INFO - Return code: 0 23:30:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:30:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:30:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:30:37 INFO - ENV: RUST_BACKTRACE is now 1 23:30:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:30:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:30:37 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/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 23:30:37 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/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 23:30:37 INFO - Using env: {'DISPLAY': ':0', 23:30:37 INFO - 'HOME': '/home/cltbld', 23:30:37 INFO - 'LANG': 'en_US.UTF-8', 23:30:37 INFO - 'LANGUAGE': 'en_US:en', 23:30:37 INFO - 'LOGNAME': 'cltbld', 23:30:37 INFO - 'MAIL': '/var/mail/cltbld', 23:30:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:30:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:37 INFO - 'MOZ_NO_REMOTE': '1', 23:30:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:37 INFO - 'NO_EM_RESTART': '1', 23:30:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:37 INFO - 'PWD': '/builds/slave/test', 23:30:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:30:37 INFO - 'RUST_BACKTRACE': '1', 23:30:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 23:30:37 INFO - 'SHELL': '/bin/bash', 23:30:37 INFO - 'SHLVL': '1', 23:30:37 INFO - 'TERM': 'linux', 23:30:37 INFO - 'TMOUT': '86400', 23:30:37 INFO - 'USER': 'cltbld', 23:30:37 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920', 23:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:37 INFO - '_': '/tools/buildbot/bin/python'} 23:30:37 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/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 23:30:37 INFO - mozversion application_buildid: 20170601054739 23:30:37 INFO - mozversion application_changeset: bdb2387396b4a74dfefb7c983733eed3625e906a 23:30:37 INFO - mozversion application_display_name: Nightly 23:30:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:30:37 INFO - mozversion application_name: Firefox 23:30:37 INFO - mozversion application_remotingname: firefox 23:30:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 23:30:37 INFO - mozversion application_vendor: Mozilla 23:30:37 INFO - mozversion application_version: 55.0a1 23:30:37 INFO - mozversion platform_buildid: 20170601054739 23:30:37 INFO - mozversion platform_changeset: bdb2387396b4a74dfefb7c983733eed3625e906a 23:30:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 23:30:37 INFO - mozversion platform_version: 55.0a1 23:30:37 INFO - using testdate: 1496298637 23:30:37 INFO - actual date: 1496298637 23:30:37 INFO - starting webserver on 'localhost:36815' 23:30:37 INFO - SUITE-START | Running 2 tests 23:30:37 INFO - TEST-START | dromaeo_css 23:30:37 INFO - operating with platform_type : linux_ 23:30:37 INFO - Initialising browser for dromaeo_css test... 23:30:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36815/getInfo.html -profile /tmp/tmpzO88ae/profile 23:30:37 INFO - TEST-INFO | started process 15440 (/builds/slave/test/build/application/firefox/firefox http://localhost:36815/getInfo.html) 23:31:13 INFO - TEST-INFO | 15440: killed by SIGTERM 23:31:13 INFO - Browser initialized. 23:31:13 INFO - Running cycle 1/1 for dromaeo_css test... 23:31:13 INFO - TEST-INFO | started process 15646 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzO88ae/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:31:25 INFO - PID 15646 | RSS: Main: 183947264 23:31:25 INFO - PID 15646 | 23:34:29 INFO - PID 15646 | Cycle 1(1): loaded http://localhost:36815/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36815/tests/dromaeo/cssquery-ext.html) 23:34:31 INFO - PID 15646 | RSS: Main: 178991104 23:34:31 INFO - PID 15646 | 23:37:33 INFO - PID 15646 | Cycle 1(1): loaded http://localhost:36815/tests/dromaeo/cssquery-ext.html (next: http://localhost:36815/tests/dromaeo/cssquery-jquery.html) 23:37:33 INFO - PID 15646 | RSS: Main: 184553472 23:37:33 INFO - PID 15646 | 23:40:35 INFO - PID 15646 | Cycle 1(1): loaded http://localhost:36815/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36815/tests/dromaeo/cssquery-mootools.html) 23:40:36 INFO - PID 15646 | RSS: Main: 181530624 23:40:36 INFO - PID 15646 | 23:43:37 INFO - PID 15646 | Cycle 1(1): loaded http://localhost:36815/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36815/tests/dromaeo/cssquery-prototype.html) 23:43:38 INFO - PID 15646 | RSS: Main: 185933824 23:43:38 INFO - PID 15646 | 23:46:41 INFO - PID 15646 | Cycle 1(1): loaded http://localhost:36815/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36815/tests/dromaeo/cssquery-yui.html) 23:46:42 INFO - PID 15646 | RSS: Main: 183447552 23:46:42 INFO - PID 15646 | 23:49:43 INFO - PID 15646 | Cycle 1(1): loaded http://localhost:36815/tests/dromaeo/cssquery-yui.html (next: http://localhost:36815/tests/dromaeo/cssquery-dojo.html) 23:49:44 INFO - PID 15646 | RSS: Main: 181673984 23:49:44 INFO - PID 15646 | 23:49:44 INFO - PID 15646 | __start_tp_report 23:49:44 INFO - PID 15646 | _x_x_mozilla_page_load 23:49:44 INFO - PID 15646 | _x_x_mozilla_page_load_details 23:49:44 INFO - PID 15646 | |i|pagename|runs| 23:49:44 INFO - PID 15646 | |0;dojo.html;2743.4650243202577;2756.228256088296;2765.516034693929;2789.13536803591;2792.3577577157253;5193.221016847466;5301.602379821509;5303.602229832763;5310.283111779909;5338.172583249598;5185.948140518593;5247.47525247476;5270.130428479306;5285.26006359109;5345.278387417698;4479.1671715140055;4663.160631086403;4707.62339012879;4737.336772851803;4739.5497427744485;4757.429108506984;4768.809247630091;4794.280857871312;4802.087603355369;4822.686525375857;4630.18971679958;4640.303954406832;4710.1286262041285;4716.056788642285;4756.215224487955;4751.978324660215;4756.904861902743;4770.856874293777;4785.449673287581;4806.471288158335;4702.36518070063;4708.317293992386;4714.504976977437;4720.1031803957485;4729.456112547033;5046.041252162077;5131.640785145041;5135.050015747099;5146.433892271847;5278.498542638443;5660.660360378391;5698.173764804122;5744.798932037359;5747.626404283708;5758.48173664368;5780.942190578083;5799.913001304942;5803.129530570406;5804.361520232771;5815.912761308584;5318.973405132988;5365.1683988980985;5368.57051435892;5373.758180881791;5373.892522149535;5772.451617096369;5807.767689292466;5865.560082993792;5888.882222355529;5892.381299963442;5631.099024156116;5635.5773317001385;5641.069223578145;5651.660900345993;5693.28833895763;5562.249096371938;5704.543636509069;5711.971440142773;5727.684977326204;5736.913946290809;5507.834764957058;5541.362743284493;5603.635763675348;5687.829365118971;5720.11338242573;5690.573207009491;5690.77236910519;5695.60130790849;5731.570132240098;5747.913781293284;4751.786169622375;4753.096911586787;4769.284607308862;4774.40319960005;4806.591439727592;4011.0574015106426;4053.7973101344814;4056.1887622475624;4077.836886524565;4110.917781644351;4769.833055843029;4779.904401911942;4798.7840547175465;4833.32333473314;4837.274408838703;5670.5747068969995;5680.034394153004;5699.344575373802;5715.199872017921;5715.685637289989;4730.692504987233;4776.832810851603;4786.832460863922;4789.904201915942;4826.565609095198;5016.698998060128;5017.096922553902;5059.114654935372;5087.186050231945;5098.821541246039;5365.3293338332705;5370.838874833761;5378.569714422759;5382.031234377693;5421.05131601976;5548.55611551083;5599.748011339581;5623.662580245198;5683.687397193029;5767.3367562729145;5226.372835259793;5365.678059316453;5370.167624018283;5384.084705600136;5414.133738601805;5477.863053423696;5549.278593782782;5551.833444996657;5553.361363443256;5693;5685.60200785941;5711.600187986967;5714.742836572281;5743.511801496919;5763.394843541368;5578.219049333015;5582.49757521825;5585.273914391103;5591.692456914909;5597.692126933058;5546.861328466659;5590.7763689453595;5594.608377413542;5602.579806514609;5605.271314729059;5313.54834839043;5375.865603359947;5445.373782015119;5463.453654634504;5487.972560137174;5610.49505544503;5626.156076588544;5640.689762062962;5647.491725744539;5662;5354.411014788292;5436.6194366393975;5469.644473109235;5482.42434544383;5483.75323110453 23:49:44 INFO - PID 15646 | |1;ext.html;751.9962400187998;1094.4801219420776;1115.6262652011576;1205.939703014849;1224.1125184241432;34461.310773784506;34869;34904.650953490454;34910.12724681878;34924.825375873086;32297.354052918927;32662.346753064925;32673.346533069325;32687;32710.182245443877;6482.675866206694;6700.262971073178;6700.932990670104;6701.095352127473;6702.564333318319;6610.305917878602;6637.634930078843;6683.9974003899315;6697.631630260334;6727.159105111861;6665.800025999228;6667.366600172976;6712.731490740389;6718;6729.091572637681;6643.103181070542;6652.966735166342;6658;6671.532992690513;6696.631685257309;6534.967325163391;6557.901631475532;6595.439387652007;6617.867642647168;6622.106015687868;30965.22586935322;31200.37599248002;31233.8438307807;31275.687243127504;31287.37425251505;3003.459377312083;3016.577679124924;3019.8490075496356;3023.2593014711315;3036.3320069584656;23939.162129325563;24031.158909438087;24050.63924041141;24067.15764948236;24148.275551733477;2777.2362600284882;2777.916662500108;2783.7077106903685;2788.3168623687125;2789.27478855499;145710;146077.26961365124;146633;146942;147052.2647386767;32961.83519082437;33700.66299337024;38911.887049036006;39787.60212397897;39897;41320.79339603283;41520.792396037825;41657.79171104186;41730;44486.555134448885;13165.341732913315;13188.406521706545;13210.27343496117;13242.668933276746;13247;10413.16694664425;10462.529186186639;10498.73753156162;10503.474826258656;10513.474326283655;12456.190347627557;12546.623601291976;12622.936885315514;12677.429515671816;12879.806802897776;5164.173732202905;5313.388960269618;5330.600204984642;5366.973165134149;5406.729663516809;862.2067697717989;892.7143314139413;895.5880295064343;911.876896618948;927.0868194828089;20579.176832926816;21000.684989725167;21386.144554217968;21632.567348653254;21708.89145554262;977.5552123783662;980.9852852207223;985.3939827006483;986.8766404199475;1002.674130907458;10502.684919452277;11169.106471482262;11252.49363778632;11265.831012534818;11371.090312775124;188696;189563;189705;189852;190389;40786.59213407828;40950.1809963799;41077.1784564313;41140.794296028325;41203.381949270784;1229.2685851918095;1244.3964677131585;1247.5882958623633;1250.774860525096;1258.8552316483538;19547.413577592695;19700.113494892477;20320.695189571874;21288.893555532122;21362.465938351666;29685.109446716633;29790;29846.8507657469;29874.103776886728;29876.551851722677;151407.24296378446;151502.24248879126;151512;151515.2424237872;152021;29148.105373151524;29699;29967.4006519864;30370.240743981576;30732.385352293277;36882.44676329804;36899.63100368962;37065;37100.62899370972;37174.6282537182;25357.619635705847;27367.72632273652;27464.17607471779;28179.577306340012;28687.856560717064;26751.732482674925;27397.45205095927;28256.43487130287;28708.138755837357;29234.561481578217;30564;30574;30984.53523197199;31087.378252435275;31377.372452551277;27161.320966975985;27483;27535.86232068827;27667.723322766513;28435.857820710764;21757;22624.208152714575;22778;22915.312540623807;22981.425464362856 23:49:44 INFO - PID 15646 | |2;jquery.html;401.44199562608;405.355484779201;422.10303105899953;425.57867710966144;438.08003193294064;13406.932965335183;14011.439542418291;17540.210690518925;18130.3654372097;18154.092295385228;18364.632707345845;19166.904165479187;19169.32907348243;19215.231390744353;19220.423387298404;5597.972010139943;5665.943340566603;5699.629524080942;5702.572307076985;5714.771409143629;5566.387697353288;5610.495055445009;5620.325560932693;5656.660600363971;5666.405027472118;5579.581531385142;5591.077472217079;5629.437056294379;5636.070048442002;5645.3790083091035;5132.332796736438;5332.893342133155;5353.0899747043095;5358.892822143535;5381.650192737459;4828.251620998751;4861.343718597979;4869.537393947569;4875.34182885313;4886.267059941002;22678.77321226783;22780.772192278197;22810;22888.31335059951;23009.309720708407;1626.6746650669913;1639.8360163983625;1661.3935913391647;1669.1070277401652;1669.858062064726;15034.69930601382;15063;15272.923635381752;15724.37102515898;15869.52391428259;2032.4410787033537;2052.7639321477923;2060.8763474191446;2083.541620843412;2100.1809294375207;105319.47340263326;106578;107063;107274;108806;9845.261605379625;11117.610883619034;11124.165687573464;11170.720731981766;11182.66452006441;15687.607809804846;15775;15789.605259868365;15832.841671583366;15836.366545338058;8114.553699546582;8184.140665230065;8193.590320483952;8260.215279548433;8311.002679678477;7650.31147196755;7689.884651730228;7719.691212351556;7832.882506762403;7839.25527074927;7123.643817809192;7137.678804453812;7211.567305961659;7243.963780181065;7276.63616819157;2026.8378529717588;2073.7200477935285;2079.3034333498144;2080.583883223361;2089.7387826521685;827.5076329583887;860.2043110123111;876.8071024374627;889.5152142082451;898.4429653614801;17557.47327580149;17680.646387072185;17707.97928704221;18113.366032189075;18338.541536461697;861.4745005546612;873.9650413983496;875.6672464463591;879.9296056315479;888.2006194425069;9332.486713230837;9458.196053335407;9871.457069861082;9932.106110450095;10010.199184065403;360379;401946;403340;404140;410514;86541.56729216313;90162;90704.5464772672;90731;90999;1038.1798379280435;1075.8924107589335;1112.2325595339353;1122.0911062039775;1124.8537690100234;17330.740038899174;18121.36575219861;18122.27510899549;18356.72464913054;18508;45042.77478612717;47076.52923470722;47327.52672473231;47540.762296188295;48233.75883120562;56152;58362;58959.70520147372;59156.70421647864;59295.703521482115;9563.61745530171;9775.657851975147;9800.754981125243;9809.558569864515;9822.312438129547;15723;16421.947256592925;16468.258928348492;16498.505044848673;16549;12439.942604878324;12541.93729031349;12552.623421297376;12561.371931403575;12666.43001064936;12117.15179937396;12152.21010634306;12376.938115309365;12583;13057.934710326388;12982.675433114247;13215.471381144647;13231.801522977355;13249.602511924657;13658;9566.330356874952;9753.122219000325;9791.314607977372;9825.950870245602;9898.851517227391;13434.395452204479;13550.186988780704;13558.728825423634;13569.05016648825;13609.183448993092 23:49:44 INFO - PID 15646 | |3;mootools.html;1273.3378643105586;1311.200167897583;1322.8015797630355;1323.0474058677748;1329.6476433745056;9972;10357.741056473593;10417.635382761604;10428.687139385831;10632.946835265831;10288.691339259816;10399.272050956437;10454.738631534216;10472.895271047288;10485.633002844901;2196.8027425053383;2250.7636698146703;2251.7748225177515;2252.9436764080947;2259.152817693365;2149.5378493623866;2176.9346919592435;2183.6724491326268;2188.420068681801;2191.1345018717598;2130.7762684918093;2193.462601662595;2201.8678879267213;2203.8126759225484;2215.5458131083087;2012.87922724637;2019.1418647075009;2028.20899849059;2031.0251079481784;2031.4819720971132;1880.5674694820268;1950.6391317606287;2044.8057434543693;2103.905324260397;2122.384508492535;10380.429076400795;10463.529141188665;10468.633597824115;10469.424181670005;10485.21360897928;5525.143602741581;5743.971280143614;5748.338941021794;5749.8275051748515;5755.079187330049;3222.7582931280012;3356.9496457553155;3373.9831300843584;3375.3249350130072;3409.3181363727354;989.1542730964993;992.8560358748014;1016.8169729448696;1019.3781793106199;1024.4672770159475;14870.107793532314;15013.774793378108;15014.62463438412;15030.699386012328;15065.09609423438;4662.906741865144;4756.405449318835;4851.369321988119;4932.926006109911;4977.950220497821;11226.214165008534;11302.886971130349;11306.265092768943;11339.319640821577;11340.20618556693;5308.203769434538;5380.3274590676165;5388.676679399248;5408.810691625774;5424.05079111154;4844.709317440965;4985.975070124626;4987.376577927759;4994.500549945049;5018.247262910592;3794.1273507093524;3875.8643447479203;3902.375619900802;3928.548216955087;3930.3514920037874;1132.5243397772956;1143.7426579019655;1148.6324376199536;1163.4706208675032;1167.3229526874393;684.44901854008;710.8862581986857;713.9857202856018;724.8477819657826;727.7591706141017;5417.6478528895495;5519.172124181405;5548.195511650788;5570.442955704397;5615.9157612635845;526.8235141227732;544.1701405356783;544.6269305525727;546.3143754588046;549.1926867504761;3281.1469018055477;3284.8850290240207;3292.7859689120132;3347.2636020075543;3408.931821363559;13112.344382780822;13578;13687.931560342135;13701.45194192241;13732.794008089886;13382;13639.249841258628;13677.521286754916;13700.520481783089;13764.17414955086;7480.738174163987;7503.324700776847;7535.924640753632;7562.621868906533;7664.195259497784;5551.777928882961;5755.453231942959;5806.867660806102;5883.823485295448;6143.631382117087;12054.517819287481;12264.87735122673;12361.01111911027;12524.624261272176;12608.74782504363;12297.877021229673;12437.129400941847;12700.555480558136;12713.745725085631;12733.55432559856;7972.641231144728;8083.919160808552;8113.797155071171;8164.387670924586;8227.341812655093;9539.379940303857;9657.661981830603;9699.854502182332;9701.805963880824;9717.611295548098;7959.801004974922;8104.392170587347;8279.62741676638;8289.95855020721;8529.402941794264;7938.722144724907;8044.396670249637;8065.516069035877;8077.394195435483;8126.837463250584;6929.307069293232;7062.258462861531;7062.470314726519;7082.752103676346;7095.538789978635;4656.743879086547;5141.331626888481;5169.767360468863;5386.730663466889;5519.337679478488;5018.548330650113;5152.536271735562;5189.247559103985;5243.213517972335;5254.474552544715 23:49:44 INFO - PID 15646 | |4;prototype.html;357.2800806375153;360.23629904602245;379.53696490281845;381.3631235836154;391.94904662393884;5423.620346575742;5528.944710552898;5538.307711536058;5560.721963901804;5597.328320601534;5350.732463376826;5437.483439073291;5439.265699130616;5453.291072160613;5474.671519708821;4074.7351422157612;4190.937135942963;4201.978990105045;4208.326667733163;4229.217594744967;4202.243596152692;4206.906204386851;4214.894627634319;4218.4305118809025;4227.365895115727;4148.357004664282;4152.626263636272;4161.958380416202;4163.895902602444;4184.8535301264465;4158.708890377659;4169.145325208325;4170.186813571355;4185.916281674349;4187.769672668002;3667.423008106513;3677.42999835026;3686.5760437549757;3691.7664812788144;3694.649008344203;5416.945830541684;5424.267723857308;5427.62006659534;5431.669241035971;5436.592255580847;4932.284818701268;4943.085529177078;4946.3817022872145;4952.034353301107;4957.206846904478;5814.30228372598;5815.854603634901;5822.912656310159;5838.299404071496;5843.620164689281;4114.629683328515;4124.8556300529335;4125.401816736587;4130.421740956269;4135.7932103395015;5771.942280577225;6131.693415329216;6170.321264660884;6170.81487555374;6196.349383314777;4134.441850350225;4160.9375859362135;4167.499900011957;4167.8958026049595;4168.103857670555;4216.831326746896;4217.903345130227;4246.681498887596;4248.745075295492;4268.850590229327;4775.116603428308;4854.344663470386;4861.927071093936;4866.9513304867205;4903.730294833747;5795.913061304083;5811.88376232473;5817.854553636108;5836.88326233473;5863.824085277449;1485.094092603511;1491.1574960147482;1492.3881208704597;1497.288787825774;1499.1379956524825;979.9608015679293;1005.1506477026901;1005.969820905374;1021.1932573267185;1021.9080282774586;4959.454460009396;4971.502849715;5018.774155163026;5026.271190677331;5037.4458809530925;5992.224898314122;5993.490553303018;6005.669688167105;6024.759009639653;6035.8792824143275;4936.432310284292;4936.7284799336385;4950.603951683856;4969.130402179604;4973.676711013845;3149.3228955774616;3161.9683803162134;3172.191091271757;3177.8252196128974;3201.3437245364644;5534;5572.498475137257;5579.46995035471;5589.161625756088;5589.944100558942;6060.272767267956;6173.938260617426;6174.413430724074;6181.258249010058;6198.202521268781;5534.501894829485;5561.860953476195;5589.245451864028;5594.049011668027;5595.104783234826;5995.88008239824;6011.609245399035;6025.698715064317;6034.456898879122;6046.7278972445465;5890.970545147418;5933.970330148494;5946.821595352147;5970;5991.310999235144;5224.52979231871;5317.973410132925;5449.509544141047;5578.553715702815;5578.693171875423;4209.7474151551005;4235.470566179228;4246.150769846105;4247.808848601882;4253.91492170161;5993.460588547052;6025.879482410415;6026.034226116201;6034.09488576717;6042.066538707571;5584.329880414376;5769.394213607511;5789.1895134680335;5799.4780469757925;5818.7090645466715;5720.599558030898;5731.799387021434;5742.540596752333;5757.15021064559;5757.625754325955;5657.915131272952;5741.311042674905;5747.224124743107;5763.394843541368;5791.82624521265;5830.53355731532;5832.212651292021;5853.209816674695;5881.647101173943;5892.882142357043;5595.132754423071;5675.77296908119;5678.659280443187;5687.118496633028;5701.7434215461235 23:49:44 INFO - PID 15646 | |5;yui.html;730.5616630021991;750.7747675697291;755.8563872864152;770.0912922751155;773.0375682275568;13829.308534573269;14666.120032798026;14747.262636868154;16096.839031609681;17527.73708394375;16745.413910513136;17076.31694732209;17082.48752537423;17085.82914170858;17085.91457042716;868.9826203475926;894.3515950935584;899.1682693508511;900.513722589804;902.0168016861619;817.9222973817477;904.2585080234211;904.8235594059161;908;912.1015799437548;968.975775605612;973.8880028796708;974.3617930255658;978.1978777402533;980.2745967983712;974.288769198482;975.2734213011281;976.6825781620967;976.799756050008;979.0405402705353;712.3802292005936;713.3080911515822;714.9606771627558;715.8783006888789;718.8526352097807;15713.607159820982;15859;15998.76001859973;16021;16108.19459027044;16516.587085322844;17127.40054098113;17139;17149.314027438886;17156.65686686272;12550.18423802459;13189.07676462648;13265.867341326657;13282.667933301647;13285.601431957057;3038.255627371308;3053.7862349635534;3056.816591004547;3064.218624250824;3077.6306843178736;79694;81570.18429815744;81602.18397816006;81642;82535;11962.641120766391;11978.221415608132;12071.75856482883;12076.637700868989;12351.814722779165;22867.31398058061;23663.408414789425;23665.881670591538;23677.17129900445;23679.7632023681;6093.634381937098;6438;6509.121268628674;6713.1944166700305;6714.261431242559;3064.862081206351;3139.136737397234;3141.8900338488043;3144.4497212987635;3144.7798654093995;3585.6055833858254;3651.8904432867057;3666.395044817575;3672.210474747942;3673.1551743099235;705.0939542687622;733.6771820399007;743.0488974113143;745.3515441565764;745.6532712288704;596.5674885707914;610.5298919831794;614.6097228259997;627.4133685004444;634.2104080419907;9945.751356216153;10025.548850301753;10078.445685487368;10284.691459256233;10656.040956313815;591.6804925340355;599.4724642314823;603.5563860562484;603.9758409663652;621.5928566788671;4712.410948631421;4855.202250479996;4924;5047.192449208109;5071.492850714899;84504;85123.5743821277;86759.56620216859;87959.56020219858;88829;66027.33972660308;66956;69200.3079969204;73545.63227183936;74104;59630;61341.4792668653;61761;62228;62384.770741267006;10467.895321046692;10923.453827308444;11015.944920275668;11180.496877640364;11328.603498877499;25140.74859251384;26046;26174.345641358355;27030.459390812466;27216.183514494598;34065.82967085149;34413.65586344105;34543.13642158866;34623.82688086543;35170.64829351674;14252.501162459264;14797.408103675732;15188.544343669708;15285.388584456497;15411.306491208146;14793.852061479678;15674.9216253918;16574.668506629558;16665.91667041657;16674.833251667813;13595.388207530486;14511.05678130918;14560.344784484936;14751.041182323115;14760.33578488949;12964.481420743065;13346.265955372159;14333.928330358282;14470.421183152555;14582.708345833236;13735.931320343334;15009.849901500846;15317.617059573155;15362.539123826304;15421.306041228396;9525.571349289437;9537.14165725088;9671.564779585076;9999.800004000024;10072.899271007489;10910.454477276264;11260.98651121403;11331.376774277494;11373.772524549628;11406.087512998774 23:49:44 INFO - PID 15646 | __end_tp_report 23:49:44 INFO - PID 15646 | __start_cc_report 23:49:44 INFO - PID 15646 | _x_x_mozilla_cycle_collect,386 23:49:44 INFO - PID 15646 | __end_cc_report 23:49:44 INFO - PID 15646 | __startTimestamp1496299784081__endTimestamp 23:49:44 INFO - PID 15646 | 23:49:44 INFO - PID 15646 | ------- Summary: start ------- 23:49:44 INFO - PID 15646 | Number of tests: 6 23:49:44 INFO - PID 15646 | 23:49:44 INFO - PID 15646 | [#0] dojo.html Cycles:165 Average:5212.53 Median:5375.87 stddev:614.96 (11.4%) stddev-sans-first:585.55 23:49:44 INFO - PID 15646 | Values: 2743.5 2756.2 2765.5 2789.1 2792.4 5193.2 5301.6 5303.6 5310.3 5338.2 5185.9 5247.5 5270.1 5285.3 5345.3 4479.2 4663.2 4707.6 4737.3 4739.5 4757.4 4768.8 4794.3 4802.1 4822.7 4630.2 4640.3 4710.1 4716.1 4756.2 4752.0 4756.9 4770.9 4785.4 4806.5 4702.4 4708.3 4714.5 4720.1 4729.5 5046.0 5131.6 5135.1 5146.4 5278.5 5660.7 5698.2 5744.8 5747.6 5758.5 5780.9 5799.9 5803.1 5804.4 5815.9 5319.0 5365.2 5368.6 5373.8 5373.9 5772.5 5807.8 5865.6 5888.9 5892.4 5631.1 5635.6 5641.1 5651.7 5693.3 5562.2 5704.5 5712.0 5727.7 5736.9 5507.8 5541.4 5603.6 5687.8 5720.1 5690.6 5690.8 5695.6 5731.6 5747.9 4751.8 4753.1 4769.3 4774.4 4806.6 4011.1 4053.8 4056.2 4077.8 4110.9 4769.8 4779.9 4798.8 4833.3 4837.3 5670.6 5680.0 5699.3 5715.2 5715.7 4730.7 4776.8 4786.8 4789.9 4826.6 5016.7 5017.1 5059.1 5087.2 5098.8 5365.3 5370.8 5378.6 5382.0 5421.1 5548.6 5599.7 5623.7 5683.7 5767.3 5226.4 5365.7 5370.2 5384.1 5414.1 5477.9 5549.3 5551.8 5553.4 5693.0 5685.6 5711.6 5714.7 5743.5 5763.4 5578.2 5582.5 5585.3 5591.7 5597.7 5546.9 5590.8 5594.6 5602.6 5605.3 5313.5 5375.9 5445.4 5463.5 5488.0 5610.5 5626.2 5640.7 5647.5 5662.0 5354.4 5436.6 5469.6 5482.4 5483.8 23:49:44 INFO - PID 15646 | 23:49:44 INFO - PID 15646 | [#1] ext.html Cycles:180 Average:30606.68 Median:29875.33 stddev:42278.06 (141.5%) stddev-sans-first:42337.22 23:49:44 INFO - PID 15646 | Values: 752.0 1094.5 1115.6 1205.9 1224.1 34461.3 34869.0 34904.7 34910.1 34924.8 32297.4 32662.3 32673.3 32687.0 32710.2 6482.7 6700.3 6700.9 6701.1 6702.6 6610.3 6637.6 6684.0 6697.6 6727.2 6665.8 6667.4 6712.7 6718.0 6729.1 6643.1 6653.0 6658.0 6671.5 6696.6 6535.0 6557.9 6595.4 6617.9 6622.1 30965.2 31200.4 31233.8 31275.7 31287.4 3003.5 3016.6 3019.8 3023.3 3036.3 23939.2 24031.2 24050.6 24067.2 24148.3 2777.2 2777.9 2783.7 2788.3 2789.3 145710.0 146077.3 146633.0 146942.0 147052.3 32961.8 33700.7 38911.9 39787.6 39897.0 41320.8 41520.8 41657.8 41730.0 44486.6 13165.3 13188.4 13210.3 13242.7 13247.0 10413.2 10462.5 10498.7 10503.5 10513.5 12456.2 12546.6 12622.9 12677.4 12879.8 5164.2 5313.4 5330.6 5367.0 5406.7 862.2 892.7 895.6 911.9 927.1 20579.2 21000.7 21386.1 21632.6 21708.9 977.6 981.0 985.4 986.9 1002.7 10502.7 11169.1 11252.5 11265.8 11371.1 188696.0 189563.0 189705.0 189852.0 190389.0 40786.6 40950.2 41077.2 41140.8 41203.4 1229.3 1244.4 1247.6 1250.8 1258.9 19547.4 19700.1 20320.7 21288.9 21362.5 29685.1 29790.0 29846.9 29874.1 29876.6 151407.2 151502.2 151512.0 151515.2 152021.0 29148.1 29699.0 29967.4 30370.2 30732.4 36882.4 36899.6 37065.0 37100.6 37174.6 25357.6 27367.7 27464.2 28179.6 28687.9 26751.7 27397.5 28256.4 28708.1 29234.6 30564.0 30574.0 30984.5 31087.4 31377.4 27161.3 27483.0 27535.9 27667.7 28435.9 21757.0 22624.2 22778.0 22915.3 22981.4 23:49:44 INFO - PID 15646 | 23:49:44 INFO - PID 15646 | [#2] jquery.html Cycles:180 Average:27532.40 Median:180390.22 stddev:66647.95 (36.9%) stddev-sans-first:66803.79 23:49:44 INFO - PID 15646 | Values: 401.4 405.4 422.1 425.6 438.1 13406.9 14011.4 17540.2 18130.4 18154.1 18364.6 19166.9 19169.3 19215.2 19220.4 5598.0 5665.9 5699.6 5702.6 5714.8 5566.4 5610.5 5620.3 5656.7 5666.4 5579.6 5591.1 5629.4 5636.1 5645.4 5132.3 5332.9 5353.1 5358.9 5381.7 4828.3 4861.3 4869.5 4875.3 4886.3 22678.8 22780.8 22810.0 22888.3 23009.3 1626.7 1639.8 1661.4 1669.1 1669.9 15034.7 15063.0 15272.9 15724.4 15869.5 2032.4 2052.8 2060.9 2083.5 2100.2 105319.5 106578.0 107063.0 107274.0 108806.0 9845.3 11117.6 11124.2 11170.7 11182.7 15687.6 15775.0 15789.6 15832.8 15836.4 8114.6 8184.1 8193.6 8260.2 8311.0 7650.3 7689.9 7719.7 7832.9 7839.3 7123.6 7137.7 7211.6 7244.0 7276.6 2026.8 2073.7 2079.3 2080.6 2089.7 827.5 860.2 876.8 889.5 898.4 17557.5 17680.6 17708.0 18113.4 18338.5 861.5 874.0 875.7 879.9 888.2 9332.5 9458.2 9871.5 9932.1 10010.2 360379.0 401946.0 403340.0 404140.0 410514.0 86541.6 90162.0 90704.5 90731.0 90999.0 1038.2 1075.9 1112.2 1122.1 1124.9 17330.7 18121.4 18122.3 18356.7 18508.0 45042.8 47076.5 47327.5 47540.8 48233.8 56152.0 58362.0 58959.7 59156.7 59295.7 9563.6 9775.7 9800.8 9809.6 9822.3 15723.0 16421.9 16468.3 16498.5 16549.0 12439.9 12541.9 12552.6 12561.4 12666.4 12117.2 12152.2 12376.9 12583.0 13057.9 12982.7 13215.5 13231.8 13249.6 13658.0 9566.3 9753.1 9791.3 9826.0 9898.9 13434.4 13550.2 13558.7 13569.1 13609.2 23:49:44 INFO - PID 15646 | 23:49:44 INFO - PID 15646 | [#3] mootools.html Cycles:180 Average:6301.72 Median:3409.12 stddev:4163.66 (122.1%) stddev-sans-first:4158.20 23:49:44 INFO - PID 15646 | Values: 1273.3 1311.2 1322.8 1323.0 1329.6 9972.0 10357.7 10417.6 10428.7 10632.9 10288.7 10399.3 10454.7 10472.9 10485.6 2196.8 2250.8 2251.8 2252.9 2259.2 2149.5 2176.9 2183.7 2188.4 2191.1 2130.8 2193.5 2201.9 2203.8 2215.5 2012.9 2019.1 2028.2 2031.0 2031.5 1880.6 1950.6 2044.8 2103.9 2122.4 10380.4 10463.5 10468.6 10469.4 10485.2 5525.1 5744.0 5748.3 5749.8 5755.1 3222.8 3356.9 3374.0 3375.3 3409.3 989.2 992.9 1016.8 1019.4 1024.5 14870.1 15013.8 15014.6 15030.7 15065.1 4662.9 4756.4 4851.4 4932.9 4978.0 11226.2 11302.9 11306.3 11339.3 11340.2 5308.2 5380.3 5388.7 5408.8 5424.1 4844.7 4986.0 4987.4 4994.5 5018.2 3794.1 3875.9 3902.4 3928.5 3930.4 1132.5 1143.7 1148.6 1163.5 1167.3 684.4 710.9 714.0 724.8 727.8 5417.6 5519.2 5548.2 5570.4 5615.9 526.8 544.2 544.6 546.3 549.2 3281.1 3284.9 3292.8 3347.3 3408.9 13112.3 13578.0 13687.9 13701.5 13732.8 13382.0 13639.2 13677.5 13700.5 13764.2 7480.7 7503.3 7535.9 7562.6 7664.2 5551.8 5755.5 5806.9 5883.8 6143.6 12054.5 12264.9 12361.0 12524.6 12608.7 12297.9 12437.1 12700.6 12713.7 12733.6 7972.6 8083.9 8113.8 8164.4 8227.3 9539.4 9657.7 9699.9 9701.8 9717.6 7959.8 8104.4 8279.6 8290.0 8529.4 7938.7 8044.4 8065.5 8077.4 8126.8 6929.3 7062.3 7062.5 7082.8 7095.5 4656.7 5141.3 5169.8 5386.7 5519.3 5018.5 5152.5 5189.2 5243.2 5254.5 23:49:44 INFO - PID 15646 | 23:49:44 INFO - PID 15646 | [#4] prototype.html Cycles:180 Average:4794.71 Median:5429.64 stddev:1406.71 (25.9%) stddev-sans-first:1370.66 23:49:44 INFO - PID 15646 | Values: 357.3 360.2 379.5 381.4 391.9 5423.6 5528.9 5538.3 5560.7 5597.3 5350.7 5437.5 5439.3 5453.3 5474.7 4074.7 4190.9 4202.0 4208.3 4229.2 4202.2 4206.9 4214.9 4218.4 4227.4 4148.4 4152.6 4162.0 4163.9 4184.9 4158.7 4169.1 4170.2 4185.9 4187.8 3667.4 3677.4 3686.6 3691.8 3694.6 5416.9 5424.3 5427.6 5431.7 5436.6 4932.3 4943.1 4946.4 4952.0 4957.2 5814.3 5815.9 5822.9 5838.3 5843.6 4114.6 4124.9 4125.4 4130.4 4135.8 5771.9 6131.7 6170.3 6170.8 6196.3 4134.4 4160.9 4167.5 4167.9 4168.1 4216.8 4217.9 4246.7 4248.7 4268.9 4775.1 4854.3 4861.9 4867.0 4903.7 5795.9 5811.9 5817.9 5836.9 5863.8 1485.1 1491.2 1492.4 1497.3 1499.1 980.0 1005.2 1006.0 1021.2 1021.9 4959.5 4971.5 5018.8 5026.3 5037.4 5992.2 5993.5 6005.7 6024.8 6035.9 4936.4 4936.7 4950.6 4969.1 4973.7 3149.3 3162.0 3172.2 3177.8 3201.3 5534.0 5572.5 5579.5 5589.2 5589.9 6060.3 6173.9 6174.4 6181.3 6198.2 5534.5 5561.9 5589.2 5594.0 5595.1 5995.9 6011.6 6025.7 6034.5 6046.7 5891.0 5934.0 5946.8 5970.0 5991.3 5224.5 5318.0 5449.5 5578.6 5578.7 4209.7 4235.5 4246.2 4247.8 4253.9 5993.5 6025.9 6026.0 6034.1 6042.1 5584.3 5769.4 5789.2 5799.5 5818.7 5720.6 5731.8 5742.5 5757.2 5757.6 5657.9 5741.3 5747.2 5763.4 5791.8 5830.5 5832.2 5853.2 5881.6 5892.9 5595.1 5675.8 5678.7 5687.1 5701.7 23:49:44 INFO - PID 15646 | 23:49:44 INFO - PID 15646 | [#5] yui.html Cycles:180 Average:17206.77 Median:34239.74 stddev:22208.72 (64.9%) stddev-sans-first:22236.56 23:49:44 INFO - PID 15646 | Values: 730.6 750.8 755.9 770.1 773.0 13829.3 14666.1 14747.3 16096.8 17527.7 16745.4 17076.3 17082.5 17085.8 17085.9 869.0 894.4 899.2 900.5 902.0 817.9 904.3 904.8 908.0 912.1 969.0 973.9 974.4 978.2 980.3 974.3 975.3 976.7 976.8 979.0 712.4 713.3 715.0 715.9 718.9 15713.6 15859.0 15998.8 16021.0 16108.2 16516.6 17127.4 17139.0 17149.3 17156.7 12550.2 13189.1 13265.9 13282.7 13285.6 3038.3 3053.8 3056.8 3064.2 3077.6 79694.0 81570.2 81602.2 81642.0 82535.0 11962.6 11978.2 12071.8 12076.6 12351.8 22867.3 23663.4 23665.9 23677.2 23679.8 6093.6 6438.0 6509.1 6713.2 6714.3 3064.9 3139.1 3141.9 3144.4 3144.8 3585.6 3651.9 3666.4 3672.2 3673.2 705.1 733.7 743.0 745.4 745.7 596.6 610.5 614.6 627.4 634.2 9945.8 10025.5 10078.4 10284.7 10656.0 591.7 599.5 603.6 604.0 621.6 4712.4 4855.2 4924.0 5047.2 5071.5 84504.0 85123.6 86759.6 87959.6 88829.0 66027.3 66956.0 69200.3 73545.6 74104.0 59630.0 61341.5 61761.0 62228.0 62384.8 10467.9 10923.5 11015.9 11180.5 11328.6 25140.7 26046.0 26174.3 27030.5 27216.2 34065.8 34413.7 34543.1 34623.8 35170.6 14252.5 14797.4 15188.5 15285.4 15411.3 14793.9 15674.9 16574.7 16665.9 16674.8 13595.4 14511.1 14560.3 14751.0 14760.3 12964.5 13346.3 14333.9 14470.4 14582.7 13735.9 15009.8 15317.6 15362.5 15421.3 9525.6 9537.1 9671.6 9999.8 10072.9 10910.5 11261.0 11331.4 11373.8 11406.1 23:49:44 INFO - PID 15646 | -------- Summary: end -------- 23:49:44 INFO - PID 15646 | 23:49:44 INFO - TEST-INFO | 15646: exit 0 23:49:45 INFO - TEST-OK | dromaeo_css | took 1147243ms 23:49:45 INFO - TEST-START | kraken 23:49:45 INFO - operating with platform_type : linux_ 23:49:45 INFO - Initialising browser for kraken test... 23:49:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36815/getInfo.html -profile /tmp/tmpHKHc0i/profile 23:49:45 INFO - TEST-INFO | started process 16051 (/builds/slave/test/build/application/firefox/firefox http://localhost:36815/getInfo.html) 23:50:20 INFO - TEST-INFO | 16051: killed by SIGTERM 23:50:20 INFO - Browser initialized. 23:50:20 INFO - Running cycle 1/1 for kraken test... 23:50:20 INFO - TEST-INFO | started process 16258 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHKHc0i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:50:32 INFO - PID 16258 | RSS: Main: 184836096 23:50:32 INFO - PID 16258 | 23:50:34 INFO - PID 16258 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36815/tests/kraken/driver.html?testName=audio-beat-detection) 23:50:36 INFO - PID 16258 | RSS: Main: 188354560 23:50:36 INFO - PID 16258 | 23:50:38 INFO - PID 16258 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36815/tests/kraken/driver.html?testName=audio-dft) 23:50:39 INFO - PID 16258 | RSS: Main: 186425344 23:50:39 INFO - PID 16258 | 23:50:42 INFO - PID 16258 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36815/tests/kraken/driver.html?testName=audio-fft) 23:50:42 INFO - PID 16258 | RSS: Main: 181800960 23:50:42 INFO - PID 16258 | 23:50:44 INFO - PID 16258 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36815/tests/kraken/driver.html?testName=audio-oscillator) 23:50:45 INFO - PID 16258 | RSS: Main: 182296576 23:50:45 INFO - PID 16258 | 23:50:47 INFO - PID 16258 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36815/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:50:48 INFO - PID 16258 | RSS: Main: 182624256 23:50:48 INFO - PID 16258 | 23:50:51 INFO - PID 16258 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36815/tests/kraken/driver.html?testName=imaging-darkroom) 23:50:52 INFO - PID 16258 | RSS: Main: 183660544 23:50:52 INFO - PID 16258 | 23:50:55 INFO - PID 16258 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36815/tests/kraken/driver.html?testName=imaging-desaturate) 23:50:56 INFO - PID 16258 | RSS: Main: 183201792 23:50:56 INFO - PID 16258 | 23:50:59 INFO - PID 16258 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36815/tests/kraken/driver.html?testName=json-parse-financial) 23:50:59 INFO - PID 16258 | RSS: Main: 183914496 23:50:59 INFO - PID 16258 | 23:51:01 INFO - PID 16258 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36815/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:51:02 INFO - PID 16258 | RSS: Main: 183734272 23:51:02 INFO - PID 16258 | 23:51:03 INFO - PID 16258 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36815/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:51:04 INFO - PID 16258 | RSS: Main: 183492608 23:51:04 INFO - PID 16258 | 23:51:06 INFO - PID 16258 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36815/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:51:07 INFO - PID 16258 | RSS: Main: 184360960 23:51:07 INFO - PID 16258 | 23:51:10 INFO - PID 16258 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36815/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:51:10 INFO - PID 16258 | RSS: Main: 183795712 23:51:10 INFO - PID 16258 | 23:51:14 INFO - PID 16258 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36815/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:51:14 INFO - PID 16258 | RSS: Main: 183476224 23:51:14 INFO - PID 16258 | 23:51:16 INFO - PID 16258 | Cycle 1(1): loaded http://localhost:36815/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36815/tests/kraken/driver.html?testName=ai-astar) 23:51:16 INFO - PID 16258 | RSS: Main: 185102336 23:51:16 INFO - PID 16258 | 23:51:16 INFO - PID 16258 | __start_tp_report 23:51:16 INFO - PID 16258 | _x_x_mozilla_page_load 23:51:16 INFO - PID 16258 | _x_x_mozilla_page_load_details 23:51:16 INFO - PID 16258 | |i|pagename|runs| 23:51:16 INFO - PID 16258 | |0;ai-astar;109;112;110;110;109;110;109;113;110;110 23:51:16 INFO - PID 16258 | |1;audio-beat-detection;151;133;129;178;127;126;127;123;146;126 23:51:16 INFO - PID 16258 | |2;audio-dft;163;164;163;165;166;171;170;167;163;164 23:51:16 INFO - PID 16258 | |3;audio-fft;77;79;75;102;77;75;74;74;95;74 23:51:16 INFO - PID 16258 | |4;audio-oscillator;84;83;115;84;84;85;98;83;83;109 23:51:16 INFO - PID 16258 | |5;imaging-gaussian-blur;114;115;114;115;114;114;115;114;115;114 23:51:16 INFO - PID 16258 | |6;imaging-darkroom;150;150;150;151;150;154;151;150;150;150 23:51:16 INFO - PID 16258 | |7;imaging-desaturate;94;96;95;95;94;94;95;95;95;94 23:51:16 INFO - PID 16258 | |8;json-parse-financial;55;55;57;59;57;56;57;57;56;57 23:51:16 INFO - PID 16258 | |9;json-stringify-tinderbox;57;56;56;56;57;60;56;56;56;56 23:51:16 INFO - PID 16258 | |10;stanford-crypto-aes;88;97;86;87;88;87;88;88;114;99 23:51:16 INFO - PID 16258 | |11;stanford-crypto-ccm;139;134;139;148;139;131;137;129;130;134 23:51:16 INFO - PID 16258 | |12;stanford-crypto-pbkdf2;187;194;193;201;199;192;198;191;185;196 23:51:16 INFO - PID 16258 | |13;stanford-crypto-sha256-iterative;74;75;72;73;76;81;76;74;71;74 23:51:16 INFO - PID 16258 | __end_tp_report 23:51:16 INFO - PID 16258 | __start_cc_report 23:51:16 INFO - PID 16258 | _x_x_mozilla_cycle_collect,1012 23:51:16 INFO - PID 16258 | __end_cc_report 23:51:16 INFO - PID 16258 | __startTimestamp1496299876712__endTimestamp 23:51:16 INFO - PID 16258 | 23:51:16 INFO - PID 16258 | ------- Summary: start ------- 23:51:16 INFO - PID 16258 | Number of tests: 14 23:51:16 INFO - PID 16258 | 23:51:16 INFO - PID 16258 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.00 stddev:1.32 (1.2%) stddev-sans-first:1.32 23:51:16 INFO - PID 16258 | Values: 109.0 112.0 110.0 110.0 109.0 110.0 109.0 113.0 110.0 110.0 23:51:16 INFO - PID 16258 | 23:51:16 INFO - PID 16258 | [#1] audio-beat-detection Cycles:10 Average:136.60 Median:131.00 stddev:17.24 (13.2%) stddev-sans-first:17.48 23:51:16 INFO - PID 16258 | Values: 151.0 133.0 129.0 178.0 127.0 126.0 127.0 123.0 146.0 126.0 23:51:16 INFO - PID 16258 | 23:51:16 INFO - PID 16258 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.50 stddev:2.91 (1.8%) stddev-sans-first:2.93 23:51:16 INFO - PID 16258 | Values: 163.0 164.0 163.0 165.0 166.0 171.0 170.0 167.0 163.0 164.0 23:51:16 INFO - PID 16258 | 23:51:16 INFO - PID 16258 | [#3] audio-fft Cycles:10 Average:80.20 Median:76.00 stddev:9.92 (13.1%) stddev-sans-first:10.45 23:51:16 INFO - PID 16258 | Values: 77.0 79.0 75.0 102.0 77.0 75.0 74.0 74.0 95.0 74.0 23:51:16 INFO - PID 16258 | 23:51:16 INFO - PID 16258 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:84.00 stddev:12.13 (14.4%) stddev-sans-first:12.61 23:51:16 INFO - PID 16258 | Values: 84.0 83.0 115.0 84.0 84.0 85.0 98.0 83.0 83.0 109.0 23:51:16 INFO - PID 16258 | 23:51:16 INFO - PID 16258 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 23:51:16 INFO - PID 16258 | Values: 114.0 115.0 114.0 115.0 114.0 114.0 115.0 114.0 115.0 114.0 23:51:16 INFO - PID 16258 | 23:51:16 INFO - PID 16258 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:150.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 23:51:16 INFO - PID 16258 | Values: 150.0 150.0 150.0 151.0 150.0 154.0 151.0 150.0 150.0 150.0 23:51:16 INFO - PID 16258 | 23:51:16 INFO - PID 16258 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 23:51:16 INFO - PID 16258 | Values: 94.0 96.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 23:51:16 INFO - PID 16258 | 23:51:16 INFO - PID 16258 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:57.00 stddev:1.17 (2.1%) stddev-sans-first:1.09 23:51:16 INFO - PID 16258 | Values: 55.0 55.0 57.0 59.0 57.0 56.0 57.0 57.0 56.0 57.0 23:51:16 INFO - PID 16258 | 23:51:16 INFO - PID 16258 | [#9] json-stringify-tinderbox Cycles:10 Average:56.60 Median:56.00 stddev:1.26 (2.3%) stddev-sans-first:1.33 23:51:16 INFO - PID 16258 | Values: 57.0 56.0 56.0 56.0 57.0 60.0 56.0 56.0 56.0 56.0 23:51:16 INFO - PID 16258 | 23:51:16 INFO - PID 16258 | [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:88.00 stddev:8.87 (10.1%) stddev-sans-first:9.27 23:51:16 INFO - PID 16258 | Values: 88.0 97.0 86.0 87.0 88.0 87.0 88.0 88.0 114.0 99.0 23:51:16 INFO - PID 16258 | 23:51:16 INFO - PID 16258 | [#11] stanford-crypto-ccm Cycles:10 Average:136.00 Median:138.00 stddev:5.68 (4.1%) stddev-sans-first:5.92 23:51:16 INFO - PID 16258 | Values: 139.0 134.0 139.0 148.0 139.0 131.0 137.0 129.0 130.0 134.0 23:51:16 INFO - PID 16258 | 23:51:16 INFO - PID 16258 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.60 Median:195.00 stddev:5.13 (2.6%) stddev-sans-first:4.85 23:51:16 INFO - PID 16258 | Values: 187.0 194.0 193.0 201.0 199.0 192.0 198.0 191.0 185.0 196.0 23:51:16 INFO - PID 16258 | 23:51:16 INFO - PID 16258 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:74.50 stddev:2.76 (3.7%) stddev-sans-first:2.92 23:51:16 INFO - PID 16258 | Values: 74.0 75.0 72.0 73.0 76.0 81.0 76.0 74.0 71.0 74.0 23:51:16 INFO - PID 16258 | -------- Summary: end -------- 23:51:16 INFO - PID 16258 | 23:51:17 INFO - TEST-INFO | 16258: exit 0 23:51:17 INFO - TEST-OK | kraken | took 92971ms 23:51:17 INFO - SUITE-END | took 1240s 23:51:18 INFO - Completed test suite (00:20:40) 23:51:18 INFO - javascript benchmark 23:51:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6858.639529472328, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2743.4650243202577, 2756.228256088296, 2765.516034693929, 2789.13536803591, 2792.3577577157253, 5193.221016847466, 5301.602379821509, 5303.602229832763, 5310.283111779909, 5338.172583249598, 5185.948140518593, 5247.47525247476, 5270.130428479306, 5285.26006359109, 5345.278387417698, 4479.1671715140055, 4663.160631086403, 4707.62339012879, 4737.336772851803, 4739.5497427744485, 4757.429108506984, 4768.809247630091, 4794.280857871312, 4802.087603355369, 4822.686525375857, 4630.18971679958, 4640.303954406832, 4710.1286262041285, 4716.056788642285, 4756.215224487955, 4751.978324660215, 4756.904861902743, 4770.856874293777, 4785.449673287581, 4806.471288158335, 4702.36518070063, 4708.317293992386, 4714.504976977437, 4720.1031803957485, 4729.456112547033, 5046.041252162077, 5131.640785145041, 5135.050015747099, 5146.433892271847, 5278.498542638443, 5660.660360378391, 5698.173764804122, 5744.798932037359, 5747.626404283708, 5758.48173664368, 5780.942190578083, 5799.913001304942, 5803.129530570406, 5804.361520232771, 5815.912761308584, 5318.973405132988, 5365.1683988980985, 5368.57051435892, 5373.758180881791, 5373.892522149535, 5772.451617096369, 5807.767689292466, 5865.560082993792, 5888.882222355529, 5892.381299963442, 5631.099024156116, 5635.5773317001385, 5641.069223578145, 5651.660900345993, 5693.28833895763, 5562.249096371938, 5704.543636509069, 5711.971440142773, 5727.684977326204, 5736.913946290809, 5507.834764957058, 5541.362743284493, 5603.635763675348, 5687.829365118971, 5720.11338242573, 5690.573207009491, 5690.77236910519, 5695.60130790849, 5731.570132240098, 5747.913781293284, 4751.786169622375, 4753.096911586787, 4769.284607308862, 4774.40319960005, 4806.591439727592, 4011.0574015106426, 4053.7973101344814, 4056.1887622475624, 4077.836886524565, 4110.917781644351, 4769.833055843029, 4779.904401911942, 4798.7840547175465, 4833.32333473314, 4837.274408838703, 5670.5747068969995, 5680.034394153004, 5699.344575373802, 5715.199872017921, 5715.685637289989, 4730.692504987233, 4776.832810851603, 4786.832460863922, 4789.904201915942, 4826.565609095198, 5016.698998060128, 5017.096922553902, 5059.114654935372, 5087.186050231945, 5098.821541246039, 5365.3293338332705, 5370.838874833761, 5378.569714422759, 5382.031234377693, 5421.05131601976, 5548.55611551083, 5599.748011339581, 5623.662580245198, 5683.687397193029, 5767.3367562729145, 5226.372835259793, 5365.678059316453, 5370.167624018283, 5384.084705600136, 5414.133738601805, 5477.863053423696, 5549.278593782782, 5551.833444996657, 5553.361363443256, 5693.0, 5685.60200785941, 5711.600187986967, 5714.742836572281, 5743.511801496919, 5763.394843541368, 5578.219049333015, 5582.49757521825, 5585.273914391103, 5591.692456914909, 5597.692126933058, 5546.861328466659, 5590.7763689453595, 5594.608377413542, 5602.579806514609, 5605.271314729059, 5313.54834839043, 5375.865603359947, 5445.373782015119, 5463.453654634504, 5487.972560137174, 5610.49505544503, 5626.156076588544, 5640.689762062962, 5647.491725744539, 5662.0, 5354.411014788292, 5436.6194366393975, 5469.644473109235, 5482.42434544383, 5483.75323110453], "value": 5167.887687946694, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.9962400187998, 1094.4801219420776, 1115.6262652011576, 1205.939703014849, 1224.1125184241432, 34461.310773784506, 34869.0, 34904.650953490454, 34910.12724681878, 34924.825375873086, 32297.354052918927, 32662.346753064925, 32673.346533069325, 32687.0, 32710.182245443877, 6482.675866206694, 6700.262971073178, 6700.932990670104, 6701.095352127473, 6702.564333318319, 6610.305917878602, 6637.634930078843, 6683.9974003899315, 6697.631630260334, 6727.159105111861, 6665.800025999228, 6667.366600172976, 6712.731490740389, 6718.0, 6729.091572637681, 6643.103181070542, 6652.966735166342, 6658.0, 6671.532992690513, 6696.631685257309, 6534.967325163391, 6557.901631475532, 6595.439387652007, 6617.867642647168, 6622.106015687868, 30965.22586935322, 31200.37599248002, 31233.8438307807, 31275.687243127504, 31287.37425251505, 3003.459377312083, 3016.577679124924, 3019.8490075496356, 3023.2593014711315, 3036.3320069584656, 23939.162129325563, 24031.158909438087, 24050.63924041141, 24067.15764948236, 24148.275551733477, 2777.2362600284882, 2777.916662500108, 2783.7077106903685, 2788.3168623687125, 2789.27478855499, 145710.0, 146077.26961365124, 146633.0, 146942.0, 147052.2647386767, 32961.83519082437, 33700.66299337024, 38911.887049036006, 39787.60212397897, 39897.0, 41320.79339603283, 41520.792396037825, 41657.79171104186, 41730.0, 44486.555134448885, 13165.341732913315, 13188.406521706545, 13210.27343496117, 13242.668933276746, 13247.0, 10413.16694664425, 10462.529186186639, 10498.73753156162, 10503.474826258656, 10513.474326283655, 12456.190347627557, 12546.623601291976, 12622.936885315514, 12677.429515671816, 12879.806802897776, 5164.173732202905, 5313.388960269618, 5330.600204984642, 5366.973165134149, 5406.729663516809, 862.2067697717989, 892.7143314139413, 895.5880295064343, 911.876896618948, 927.0868194828089, 20579.176832926816, 21000.684989725167, 21386.144554217968, 21632.567348653254, 21708.89145554262, 977.5552123783662, 980.9852852207223, 985.3939827006483, 986.8766404199475, 1002.674130907458, 10502.684919452277, 11169.106471482262, 11252.49363778632, 11265.831012534818, 11371.090312775124, 188696.0, 189563.0, 189705.0, 189852.0, 190389.0, 40786.59213407828, 40950.1809963799, 41077.1784564313, 41140.794296028325, 41203.381949270784, 1229.2685851918095, 1244.3964677131585, 1247.5882958623633, 1250.774860525096, 1258.8552316483538, 19547.413577592695, 19700.113494892477, 20320.695189571874, 21288.893555532122, 21362.465938351666, 29685.109446716633, 29790.0, 29846.8507657469, 29874.103776886728, 29876.551851722677, 151407.24296378446, 151502.24248879126, 151512.0, 151515.2424237872, 152021.0, 29148.105373151524, 29699.0, 29967.4006519864, 30370.240743981576, 30732.385352293277, 36882.44676329804, 36899.63100368962, 37065.0, 37100.62899370972, 37174.6282537182, 25357.619635705847, 27367.72632273652, 27464.17607471779, 28179.577306340012, 28687.856560717064, 26751.732482674925, 27397.45205095927, 28256.43487130287, 28708.138755837357, 29234.561481578217, 30564.0, 30574.0, 30984.53523197199, 31087.378252435275, 31377.372452551277, 27161.320966975985, 27483.0, 27535.86232068827, 27667.723322766513, 28435.857820710764, 21757.0, 22624.208152714575, 22778.0, 22915.312540623807, 22981.425464362856], "value": 14513.550119553207, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.44199562608, 405.355484779201, 422.10303105899953, 425.57867710966144, 438.08003193294064, 13406.932965335183, 14011.439542418291, 17540.210690518925, 18130.3654372097, 18154.092295385228, 18364.632707345845, 19166.904165479187, 19169.32907348243, 19215.231390744353, 19220.423387298404, 5597.972010139943, 5665.943340566603, 5699.629524080942, 5702.572307076985, 5714.771409143629, 5566.387697353288, 5610.495055445009, 5620.325560932693, 5656.660600363971, 5666.405027472118, 5579.581531385142, 5591.077472217079, 5629.437056294379, 5636.070048442002, 5645.3790083091035, 5132.332796736438, 5332.893342133155, 5353.0899747043095, 5358.892822143535, 5381.650192737459, 4828.251620998751, 4861.343718597979, 4869.537393947569, 4875.34182885313, 4886.267059941002, 22678.77321226783, 22780.772192278197, 22810.0, 22888.31335059951, 23009.309720708407, 1626.6746650669913, 1639.8360163983625, 1661.3935913391647, 1669.1070277401652, 1669.858062064726, 15034.69930601382, 15063.0, 15272.923635381752, 15724.37102515898, 15869.52391428259, 2032.4410787033537, 2052.7639321477923, 2060.8763474191446, 2083.541620843412, 2100.1809294375207, 105319.47340263326, 106578.0, 107063.0, 107274.0, 108806.0, 9845.261605379625, 11117.610883619034, 11124.165687573464, 11170.720731981766, 11182.66452006441, 15687.607809804846, 15775.0, 15789.605259868365, 15832.841671583366, 15836.366545338058, 8114.553699546582, 8184.140665230065, 8193.590320483952, 8260.215279548433, 8311.002679678477, 7650.31147196755, 7689.884651730228, 7719.691212351556, 7832.882506762403, 7839.25527074927, 7123.643817809192, 7137.678804453812, 7211.567305961659, 7243.963780181065, 7276.63616819157, 2026.8378529717588, 2073.7200477935285, 2079.3034333498144, 2080.583883223361, 2089.7387826521685, 827.5076329583887, 860.2043110123111, 876.8071024374627, 889.5152142082451, 898.4429653614801, 17557.47327580149, 17680.646387072185, 17707.97928704221, 18113.366032189075, 18338.541536461697, 861.4745005546612, 873.9650413983496, 875.6672464463591, 879.9296056315479, 888.2006194425069, 9332.486713230837, 9458.196053335407, 9871.457069861082, 9932.106110450095, 10010.199184065403, 360379.0, 401946.0, 403340.0, 404140.0, 410514.0, 86541.56729216313, 90162.0, 90704.5464772672, 90731.0, 90999.0, 1038.1798379280435, 1075.8924107589335, 1112.2325595339353, 1122.0911062039775, 1124.8537690100234, 17330.740038899174, 18121.36575219861, 18122.27510899549, 18356.72464913054, 18508.0, 45042.77478612717, 47076.52923470722, 47327.52672473231, 47540.762296188295, 48233.75883120562, 56152.0, 58362.0, 58959.70520147372, 59156.70421647864, 59295.703521482115, 9563.61745530171, 9775.657851975147, 9800.754981125243, 9809.558569864515, 9822.312438129547, 15723.0, 16421.947256592925, 16468.258928348492, 16498.505044848673, 16549.0, 12439.942604878324, 12541.93729031349, 12552.623421297376, 12561.371931403575, 12666.43001064936, 12117.15179937396, 12152.21010634306, 12376.938115309365, 12583.0, 13057.934710326388, 12982.675433114247, 13215.471381144647, 13231.801522977355, 13249.602511924657, 13658.0, 9566.330356874952, 9753.122219000325, 9791.314607977372, 9825.950870245602, 9898.851517227391, 13434.395452204479, 13550.186988780704, 13558.728825423634, 13569.05016648825, 13609.183448993092], "value": 9471.2618830822, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1273.3378643105586, 1311.200167897583, 1322.8015797630355, 1323.0474058677748, 1329.6476433745056, 9972.0, 10357.741056473593, 10417.635382761604, 10428.687139385831, 10632.946835265831, 10288.691339259816, 10399.272050956437, 10454.738631534216, 10472.895271047288, 10485.633002844901, 2196.8027425053383, 2250.7636698146703, 2251.7748225177515, 2252.9436764080947, 2259.152817693365, 2149.5378493623866, 2176.9346919592435, 2183.6724491326268, 2188.420068681801, 2191.1345018717598, 2130.7762684918093, 2193.462601662595, 2201.8678879267213, 2203.8126759225484, 2215.5458131083087, 2012.87922724637, 2019.1418647075009, 2028.20899849059, 2031.0251079481784, 2031.4819720971132, 1880.5674694820268, 1950.6391317606287, 2044.8057434543693, 2103.905324260397, 2122.384508492535, 10380.429076400795, 10463.529141188665, 10468.633597824115, 10469.424181670005, 10485.21360897928, 5525.143602741581, 5743.971280143614, 5748.338941021794, 5749.8275051748515, 5755.079187330049, 3222.7582931280012, 3356.9496457553155, 3373.9831300843584, 3375.3249350130072, 3409.3181363727354, 989.1542730964993, 992.8560358748014, 1016.8169729448696, 1019.3781793106199, 1024.4672770159475, 14870.107793532314, 15013.774793378108, 15014.62463438412, 15030.699386012328, 15065.09609423438, 4662.906741865144, 4756.405449318835, 4851.369321988119, 4932.926006109911, 4977.950220497821, 11226.214165008534, 11302.886971130349, 11306.265092768943, 11339.319640821577, 11340.20618556693, 5308.203769434538, 5380.3274590676165, 5388.676679399248, 5408.810691625774, 5424.05079111154, 4844.709317440965, 4985.975070124626, 4987.376577927759, 4994.500549945049, 5018.247262910592, 3794.1273507093524, 3875.8643447479203, 3902.375619900802, 3928.548216955087, 3930.3514920037874, 1132.5243397772956, 1143.7426579019655, 1148.6324376199536, 1163.4706208675032, 1167.3229526874393, 684.44901854008, 710.8862581986857, 713.9857202856018, 724.8477819657826, 727.7591706141017, 5417.6478528895495, 5519.172124181405, 5548.195511650788, 5570.442955704397, 5615.9157612635845, 526.8235141227732, 544.1701405356783, 544.6269305525727, 546.3143754588046, 549.1926867504761, 3281.1469018055477, 3284.8850290240207, 3292.7859689120132, 3347.2636020075543, 3408.931821363559, 13112.344382780822, 13578.0, 13687.931560342135, 13701.45194192241, 13732.794008089886, 13382.0, 13639.249841258628, 13677.521286754916, 13700.520481783089, 13764.17414955086, 7480.738174163987, 7503.324700776847, 7535.924640753632, 7562.621868906533, 7664.195259497784, 5551.777928882961, 5755.453231942959, 5806.867660806102, 5883.823485295448, 6143.631382117087, 12054.517819287481, 12264.87735122673, 12361.01111911027, 12524.624261272176, 12608.74782504363, 12297.877021229673, 12437.129400941847, 12700.555480558136, 12713.745725085631, 12733.55432559856, 7972.641231144728, 8083.919160808552, 8113.797155071171, 8164.387670924586, 8227.341812655093, 9539.379940303857, 9657.661981830603, 9699.854502182332, 9701.805963880824, 9717.611295548098, 7959.801004974922, 8104.392170587347, 8279.62741676638, 8289.95855020721, 8529.402941794264, 7938.722144724907, 8044.396670249637, 8065.516069035877, 8077.394195435483, 8126.837463250584, 6929.307069293232, 7062.258462861531, 7062.470314726519, 7082.752103676346, 7095.538789978635, 4656.743879086547, 5141.331626888481, 5169.767360468863, 5386.730663466889, 5519.337679478488, 5018.548330650113, 5152.536271735562, 5189.247559103985, 5243.213517972335, 5254.474552544715], "value": 4651.65774282002, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.2800806375153, 360.23629904602245, 379.53696490281845, 381.3631235836154, 391.94904662393884, 5423.620346575742, 5528.944710552898, 5538.307711536058, 5560.721963901804, 5597.328320601534, 5350.732463376826, 5437.483439073291, 5439.265699130616, 5453.291072160613, 5474.671519708821, 4074.7351422157612, 4190.937135942963, 4201.978990105045, 4208.326667733163, 4229.217594744967, 4202.243596152692, 4206.906204386851, 4214.894627634319, 4218.4305118809025, 4227.365895115727, 4148.357004664282, 4152.626263636272, 4161.958380416202, 4163.895902602444, 4184.8535301264465, 4158.708890377659, 4169.145325208325, 4170.186813571355, 4185.916281674349, 4187.769672668002, 3667.423008106513, 3677.42999835026, 3686.5760437549757, 3691.7664812788144, 3694.649008344203, 5416.945830541684, 5424.267723857308, 5427.62006659534, 5431.669241035971, 5436.592255580847, 4932.284818701268, 4943.085529177078, 4946.3817022872145, 4952.034353301107, 4957.206846904478, 5814.30228372598, 5815.854603634901, 5822.912656310159, 5838.299404071496, 5843.620164689281, 4114.629683328515, 4124.8556300529335, 4125.401816736587, 4130.421740956269, 4135.7932103395015, 5771.942280577225, 6131.693415329216, 6170.321264660884, 6170.81487555374, 6196.349383314777, 4134.441850350225, 4160.9375859362135, 4167.499900011957, 4167.8958026049595, 4168.103857670555, 4216.831326746896, 4217.903345130227, 4246.681498887596, 4248.745075295492, 4268.850590229327, 4775.116603428308, 4854.344663470386, 4861.927071093936, 4866.9513304867205, 4903.730294833747, 5795.913061304083, 5811.88376232473, 5817.854553636108, 5836.88326233473, 5863.824085277449, 1485.094092603511, 1491.1574960147482, 1492.3881208704597, 1497.288787825774, 1499.1379956524825, 979.9608015679293, 1005.1506477026901, 1005.969820905374, 1021.1932573267185, 1021.9080282774586, 4959.454460009396, 4971.502849715, 5018.774155163026, 5026.271190677331, 5037.4458809530925, 5992.224898314122, 5993.490553303018, 6005.669688167105, 6024.759009639653, 6035.8792824143275, 4936.432310284292, 4936.7284799336385, 4950.603951683856, 4969.130402179604, 4973.676711013845, 3149.3228955774616, 3161.9683803162134, 3172.191091271757, 3177.8252196128974, 3201.3437245364644, 5534.0, 5572.498475137257, 5579.46995035471, 5589.161625756088, 5589.944100558942, 6060.272767267956, 6173.938260617426, 6174.413430724074, 6181.258249010058, 6198.202521268781, 5534.501894829485, 5561.860953476195, 5589.245451864028, 5594.049011668027, 5595.104783234826, 5995.88008239824, 6011.609245399035, 6025.698715064317, 6034.456898879122, 6046.7278972445465, 5890.970545147418, 5933.970330148494, 5946.821595352147, 5970.0, 5991.310999235144, 5224.52979231871, 5317.973410132925, 5449.509544141047, 5578.553715702815, 5578.693171875423, 4209.7474151551005, 4235.470566179228, 4246.150769846105, 4247.808848601882, 4253.91492170161, 5993.460588547052, 6025.879482410415, 6026.034226116201, 6034.09488576717, 6042.066538707571, 5584.329880414376, 5769.394213607511, 5789.1895134680335, 5799.4780469757925, 5818.7090645466715, 5720.599558030898, 5731.799387021434, 5742.540596752333, 5757.15021064559, 5757.625754325955, 5657.915131272952, 5741.311042674905, 5747.224124743107, 5763.394843541368, 5791.82624521265, 5830.53355731532, 5832.212651292021, 5853.209816674695, 5881.647101173943, 5892.882142357043, 5595.132754423071, 5675.77296908119, 5678.659280443187, 5687.118496633028, 5701.7434215461235], "value": 4360.718942097294, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.5616630021991, 750.7747675697291, 755.8563872864152, 770.0912922751155, 773.0375682275568, 13829.308534573269, 14666.120032798026, 14747.262636868154, 16096.839031609681, 17527.73708394375, 16745.413910513136, 17076.31694732209, 17082.48752537423, 17085.82914170858, 17085.91457042716, 868.9826203475926, 894.3515950935584, 899.1682693508511, 900.513722589804, 902.0168016861619, 817.9222973817477, 904.2585080234211, 904.8235594059161, 908.0, 912.1015799437548, 968.975775605612, 973.8880028796708, 974.3617930255658, 978.1978777402533, 980.2745967983712, 974.288769198482, 975.2734213011281, 976.6825781620967, 976.799756050008, 979.0405402705353, 712.3802292005936, 713.3080911515822, 714.9606771627558, 715.8783006888789, 718.8526352097807, 15713.607159820982, 15859.0, 15998.76001859973, 16021.0, 16108.19459027044, 16516.587085322844, 17127.40054098113, 17139.0, 17149.314027438886, 17156.65686686272, 12550.18423802459, 13189.07676462648, 13265.867341326657, 13282.667933301647, 13285.601431957057, 3038.255627371308, 3053.7862349635534, 3056.816591004547, 3064.218624250824, 3077.6306843178736, 79694.0, 81570.18429815744, 81602.18397816006, 81642.0, 82535.0, 11962.641120766391, 11978.221415608132, 12071.75856482883, 12076.637700868989, 12351.814722779165, 22867.31398058061, 23663.408414789425, 23665.881670591538, 23677.17129900445, 23679.7632023681, 6093.634381937098, 6438.0, 6509.121268628674, 6713.1944166700305, 6714.261431242559, 3064.862081206351, 3139.136737397234, 3141.8900338488043, 3144.4497212987635, 3144.7798654093995, 3585.6055833858254, 3651.8904432867057, 3666.395044817575, 3672.210474747942, 3673.1551743099235, 705.0939542687622, 733.6771820399007, 743.0488974113143, 745.3515441565764, 745.6532712288704, 596.5674885707914, 610.5298919831794, 614.6097228259997, 627.4133685004444, 634.2104080419907, 9945.751356216153, 10025.548850301753, 10078.445685487368, 10284.691459256233, 10656.040956313815, 591.6804925340355, 599.4724642314823, 603.5563860562484, 603.9758409663652, 621.5928566788671, 4712.410948631421, 4855.202250479996, 4924.0, 5047.192449208109, 5071.492850714899, 84504.0, 85123.5743821277, 86759.56620216859, 87959.56020219858, 88829.0, 66027.33972660308, 66956.0, 69200.3079969204, 73545.63227183936, 74104.0, 59630.0, 61341.4792668653, 61761.0, 62228.0, 62384.770741267006, 10467.895321046692, 10923.453827308444, 11015.944920275668, 11180.496877640364, 11328.603498877499, 25140.74859251384, 26046.0, 26174.345641358355, 27030.459390812466, 27216.183514494598, 34065.82967085149, 34413.65586344105, 34543.13642158866, 34623.82688086543, 35170.64829351674, 14252.501162459264, 14797.408103675732, 15188.544343669708, 15285.388584456497, 15411.306491208146, 14793.852061479678, 15674.9216253918, 16574.668506629558, 16665.91667041657, 16674.833251667813, 13595.388207530486, 14511.05678130918, 14560.344784484936, 14751.041182323115, 14760.33578488949, 12964.481420743065, 13346.265955372159, 14333.928330358282, 14470.421183152555, 14582.708345833236, 13735.931320343334, 15009.849901500846, 15317.617059573155, 15362.539123826304, 15421.306041228396, 9525.571349289437, 9537.14165725088, 9671.564779585076, 9999.800004000024, 10072.899271007489, 10910.454477276264, 11260.98651121403, 11331.376774277494, 11373.772524549628, 11406.087512998774], "value": 7223.280676944112, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 110.0, 110.0, 109.0, 110.0, 109.0, 113.0, 110.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 133.0, 129.0, 178.0, 127.0, 126.0, 127.0, 123.0, 146.0, 126.0], "value": 136.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 165.0, 166.0, 171.0, 170.0, 167.0, 163.0, 164.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 75.0, 102.0, 77.0, 75.0, 74.0, 74.0, 95.0, 74.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 115.0, 84.0, 84.0, 85.0, 98.0, 83.0, 83.0, 109.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 115.0, 114.0, 114.0, 115.0, 114.0, 115.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 151.0, 150.0, 154.0, 151.0, 150.0, 150.0, 150.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 57.0, 59.0, 57.0, 56.0, 57.0, 57.0, 56.0, 57.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 56.0, 57.0, 60.0, 56.0, 56.0, 56.0, 56.0], "value": 56.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 97.0, 86.0, 87.0, 88.0, 87.0, 88.0, 88.0, 114.0, 99.0], "value": 92.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 134.0, 139.0, 148.0, 139.0, 131.0, 137.0, 129.0, 130.0, 134.0], "value": 136.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 194.0, 193.0, 201.0, 199.0, 192.0, 198.0, 191.0, 185.0, 196.0], "value": 193.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 72.0, 73.0, 76.0, 81.0, 76.0, 74.0, 71.0, 74.0], "value": 74.6, "unit": "score"}]}]} 23:51:18 INFO - Return code: 0 23:51:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:51:18 INFO - # TBPL SUCCESS # 23:51:18 INFO - Running post-action listener: _resource_record_post_action 23:51:18 INFO - [mozharness: 2017-06-01 06:51:18.515329Z] Finished run-tests step (success) 23:51:18 INFO - Running post-run listener: _resource_record_post_run 23:51:18 INFO - Total resource usage - Wall time: 1256s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401448960; Read time: 16; Write time: 350164 23:51:18 INFO - TinderboxPrint: CPU usage
12.6% 23:51:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 23:51:18 INFO - TinderboxPrint: I/O write bytes / time
401,448,960 / 350,164 23:51:18 INFO - TinderboxPrint: CPU idle
8,755.9 (87.3%) 23:51:18 INFO - TinderboxPrint: CPU user
1,215.8 (12.1%) 23:51:18 INFO - TinderboxPrint: Swap in / out
0 / 0 23:51:18 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 93913088; Read time: 0; Write time: 101372 23:51:18 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 23:51:18 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 4096; Write bytes: 307535872; Read time: 16; Write time: 248792 23:51:19 INFO - Running post-run listener: _upload_blobber_files 23:51:19 INFO - Blob upload gear active. 23:51:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:51:19 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 23:51:19 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'] 23:51:19 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 23:51:19 INFO - (blobuploader) - INFO - Open directory for files ... 23:51:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 23:51:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:51:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:51:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 23:51:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:51:20 INFO - (blobuploader) - INFO - Done attempting. 23:51:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:51:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:51:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:51:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:51:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:51:21 INFO - (blobuploader) - INFO - Done attempting. 23:51:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:51:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:51:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:51:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:51:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:51:24 INFO - (blobuploader) - INFO - Done attempting. 23:51:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:51:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:51:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:51:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:51:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:51:25 INFO - (blobuploader) - INFO - Done attempting. 23:51:25 INFO - (blobuploader) - INFO - Iteration through files over. 23:51:25 INFO - Return code: 0 23:51:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:51:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:51:25 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8dcc758c5469241f0b004da69aa945fb9ade06fc64907af2bc89459e497be444f5ee4c89c026023759e284b0ebadb44aaec7d6c89d258f3f4d3d9536e3da1c19", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc27fb06a4497f10d8d3644534e3dcdd017d102382e530cd75307de3527aa94b5799cbb518557bcfbd93e4bd3aef31763965d9d4ee4ab0e49b26a68a68c86716", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02b5f6798c9cf8b174b536b99ce9ad399da03ad59f4c04196ee60af891fdefa1ae3a118cfd18fe7d16c9f0003deb44f9536d14d083bd140b066ef332ae433379", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0dd05ec4504f297a3beaf18d2aa0f74a007a13b5f543b33a46c9914c67cef6e0ad5e9020fa83f7cb626f241de022a80595b66f70cc09507f842cd744666f355f"} 23:51:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:51:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:51:25 INFO - Contents: 23:51:25 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8dcc758c5469241f0b004da69aa945fb9ade06fc64907af2bc89459e497be444f5ee4c89c026023759e284b0ebadb44aaec7d6c89d258f3f4d3d9536e3da1c19", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc27fb06a4497f10d8d3644534e3dcdd017d102382e530cd75307de3527aa94b5799cbb518557bcfbd93e4bd3aef31763965d9d4ee4ab0e49b26a68a68c86716", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02b5f6798c9cf8b174b536b99ce9ad399da03ad59f4c04196ee60af891fdefa1ae3a118cfd18fe7d16c9f0003deb44f9536d14d083bd140b066ef332ae433379", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0dd05ec4504f297a3beaf18d2aa0f74a007a13b5f543b33a46c9914c67cef6e0ad5e9020fa83f7cb626f241de022a80595b66f70cc09507f842cd744666f355f"} 23:51:25 INFO - Running post-run listener: copy_logs_to_upload_dir 23:51:25 INFO - Copying logs to upload dir... 23:51:25 INFO - mkdir: /builds/slave/test/build/upload/logs 23:51:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1315.803804 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-05-31 23:51:23.890917) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-31 23:51:23.894980) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920 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/8dcc758c5469241f0b004da69aa945fb9ade06fc64907af2bc89459e497be444f5ee4c89c026023759e284b0ebadb44aaec7d6c89d258f3f4d3d9536e3da1c19", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc27fb06a4497f10d8d3644534e3dcdd017d102382e530cd75307de3527aa94b5799cbb518557bcfbd93e4bd3aef31763965d9d4ee4ab0e49b26a68a68c86716", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02b5f6798c9cf8b174b536b99ce9ad399da03ad59f4c04196ee60af891fdefa1ae3a118cfd18fe7d16c9f0003deb44f9536d14d083bd140b066ef332ae433379", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0dd05ec4504f297a3beaf18d2aa0f74a007a13b5f543b33a46c9914c67cef6e0ad5e9020fa83f7cb626f241de022a80595b66f70cc09507f842cd744666f355f"} build_url:https://queue.taskcluster.net/v1/task/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011279 build_url: 'https://queue.taskcluster.net/v1/task/RibvKKO0QmyIR4wWKbMfMw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8dcc758c5469241f0b004da69aa945fb9ade06fc64907af2bc89459e497be444f5ee4c89c026023759e284b0ebadb44aaec7d6c89d258f3f4d3d9536e3da1c19", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc27fb06a4497f10d8d3644534e3dcdd017d102382e530cd75307de3527aa94b5799cbb518557bcfbd93e4bd3aef31763965d9d4ee4ab0e49b26a68a68c86716", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02b5f6798c9cf8b174b536b99ce9ad399da03ad59f4c04196ee60af891fdefa1ae3a118cfd18fe7d16c9f0003deb44f9536d14d083bd140b066ef332ae433379", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0dd05ec4504f297a3beaf18d2aa0f74a007a13b5f543b33a46c9914c67cef6e0ad5e9020fa83f7cb626f241de022a80595b66f70cc09507f842cd744666f355f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-31 23:51:23.920139) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 23:51:23.920485) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1496280521.174358-913421920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 23:51:24.006550) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-31 23:51:24.006996) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-31 23:51:24.007395) ========= ========= Total master_lag: 0.15 =========