builder: mozilla-beta_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-054 starttime: 1495562138.94 results: success (0) revision: a2d407b9da248932f50c95533d13cd8043ca2e21 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-23 10:55:38.938632) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-23 10:55:38.939057) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-23 10:55:38.939341) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-23 10:55:38.968104) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 10:55:38.968487) ========= 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=cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-23 10:55:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.4M=0s 2017-05-23 10:55:39 (45.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.169076 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 10:55:39.149851) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 10:55:39.150164) ========= 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=cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017315 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 10:55:39.203090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 10:55:39.206466) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a2d407b9da248932f50c95533d13cd8043ca2e21 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a2d407b9da248932f50c95533d13cd8043ca2e21 --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=cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-23 10:55:39,662 truncating revision to first 12 chars 2017-05-23 10:55:39,662 Setting DEBUG logging. 2017-05-23 10:55:39,662 attempt 1/10 2017-05-23 10:55:39,662 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a2d407b9da24?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-23 10:55:39,977 unpacking tar archive at: mozilla-beta-a2d407b9da24/testing/mozharness/ program finished with exit code 0 elapsedTime=0.849779 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 10:55:40.069618) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-23 10:55:40.069941) ========= script_repo_revision: a2d407b9da248932f50c95533d13cd8043ca2e21 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-23 10:55:40.070330) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-23 10:55:40.070608) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-23 10:55:40.084765) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-23 10:55:40.085124) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-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=cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:55:40 INFO - MultiFileLogger online at 20170523 10:55:40 in /builds/slave/test 10:55:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 10:55:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:55:40 INFO - {'append_to_log': False, 10:55:40 INFO - 'base_work_dir': '/builds/slave/test', 10:55:40 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 10:55:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:55:40 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 10:55:40 INFO - 'buildbot_json_path': 'buildprops.json', 10:55:40 INFO - 'config_files': ('talos/linux_config.py',), 10:55:40 INFO - 'default_actions': ('clobber', 10:55:40 INFO - 'read-buildbot-config', 10:55:40 INFO - 'download-and-extract', 10:55:40 INFO - 'populate-webroot', 10:55:40 INFO - 'create-virtualenv', 10:55:40 INFO - 'install', 10:55:40 INFO - 'run-tests'), 10:55:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:55:40 INFO - 'download_minidump_stackwalk': True, 10:55:40 INFO - 'download_symbols': 'ondemand', 10:55:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:55:40 INFO - 'tooltool.py': '/tools/tooltool.py', 10:55:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:55:40 INFO - '/tools/misc-python/virtualenv.py')}, 10:55:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:55:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:55:40 INFO - 'gecko_profile': False, 10:55:40 INFO - 'gecko_profile_interval': 0, 10:55:40 INFO - 'installer_path': 'installer.exe', 10:55:40 INFO - 'log_level': 'info', 10:55:40 INFO - 'log_name': 'talos', 10:55:40 INFO - 'log_to_console': True, 10:55:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:55:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:55:40 INFO - 'opt_config_files': (), 10:55:40 INFO - 'pip_index': False, 10:55:40 INFO - 'suite': 'dromaeojs', 10:55:40 INFO - 'system_bits': '32', 10:55:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:55:40 INFO - 'title': 'talos-linux64-ix-054', 10:55:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:55:40 INFO - 'use_talos_json': True, 10:55:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:55:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:55:40 INFO - 'work_dir': 'build'} 10:55:40 INFO - [mozharness: 2017-05-23 17:55:40.760970Z] Running clobber step. 10:55:40 INFO - Running pre-action listener: _resource_record_pre_action 10:55:40 INFO - Running main action method: clobber 10:55:40 INFO - rmtree: /builds/slave/test/build 10:55:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:55:41 INFO - Running post-action listener: _resource_record_post_action 10:55:41 INFO - [mozharness: 2017-05-23 17:55:41.826062Z] Finished clobber step (success) 10:55:41 INFO - [mozharness: 2017-05-23 17:55:41.826161Z] Running read-buildbot-config step. 10:55:41 INFO - Running pre-action listener: _resource_record_pre_action 10:55:41 INFO - Running main action method: read_buildbot_config 10:55:41 INFO - Using buildbot properties: 10:55:41 INFO - { 10:55:41 INFO - "project": "", 10:55:41 INFO - "product": "firefox", 10:55:41 INFO - "who": "ffxbld@noreply.mozilla.org", 10:55:41 INFO - "installer_path": "public/build/target.tar.bz2", 10:55:41 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 10:55:41 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta/", 10:55:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs", 10:55:41 INFO - "stage_platform": "linux64", 10:55:41 INFO - "basedir": "/builds/slave/test", 10:55:41 INFO - "buildnumber": 54, 10:55:41 INFO - "platform": "ubuntu64_hw", 10:55:41 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:55:41 INFO - "slavebuilddir": "test", 10:55:41 INFO - "taskId": "XAIlzgxQTvqbQS67FDZLrw", 10:55:41 INFO - "branch": "mozilla-beta", 10:55:41 INFO - "script_repo_revision": "production", 10:55:41 INFO - "revision": "a2d407b9da248932f50c95533d13cd8043ca2e21", 10:55:41 INFO - "slavename": "talos-linux64-ix-054", 10:55:41 INFO - "repo_path": "releases/mozilla-beta" 10:55:41 INFO - } 10:55:41 INFO - Finding installer, test and symbols from parent task. 10:55:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XAIlzgxQTvqbQS67FDZLrw'}, attempt #1 10:55:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XAIlzgxQTvqbQS67FDZLrw'}, attempt #1 10:55:42 INFO - Task dependencies: PT7dQbQpTOWk_qKq63Ul6A 10:55:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A'}, attempt #1 10:55:43 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/target.tar.bz2 10:55:43 INFO - Set test_url: https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/test_packages.json 10:55:43 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/target.crashreporter-symbols.zip 10:55:43 INFO - Running post-action listener: _resource_record_post_action 10:55:43 INFO - [mozharness: 2017-05-23 17:55:43.245789Z] Finished read-buildbot-config step (success) 10:55:43 INFO - [mozharness: 2017-05-23 17:55:43.246006Z] Running download-and-extract step. 10:55:43 INFO - Running pre-action listener: _resource_record_pre_action 10:55:43 INFO - Running main action method: download_and_extract 10:55:43 INFO - mkdir: /builds/slave/test/build/tests 10:55:43 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')]} 10:55:43 INFO - trying https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/target.test_packages.json 10:55:43 INFO - Downloading https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:55:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:55:43 INFO - Downloaded 986 bytes. 10:55:43 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:55:43 INFO - Using the following test package requirements: 10:55:43 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:55:43 INFO - u'common': [u'target.common.tests.zip'], 10:55:43 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:55:43 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:55:43 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:55:43 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:55:43 INFO - u'mozbase': [u'target.common.tests.zip'], 10:55:43 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:55:43 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:55:43 INFO - u'web-platform': [u'target.common.tests.zip', 10:55:43 INFO - u'target.web-platform.tests.zip'], 10:55:43 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:55:43 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:55:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/target.common.tests.zip 10:55:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:55:43 INFO - Fetch https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/target.common.tests.zip into memory 10:55:44 INFO - Expected file size: 59717380 10:55:44 INFO - Obtained file size: 59717380 10:55:55 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:55:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/target.common.tests.zip 10:55:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:55:55 INFO - Fetch https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/target.common.tests.zip into memory 10:56:03 INFO - Expected file size: 59717380 10:56:03 INFO - Obtained file size: 59717380 10:56:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/target.talos.tests.zip 10:56:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:56:14 INFO - Fetch https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/target.talos.tests.zip into memory 10:56:14 INFO - Expected file size: 14404449 10:56:14 INFO - Obtained file size: 14404449 10:56:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:15 INFO - trying https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/target.tar.bz2 10:56:15 INFO - Downloading https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:56:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:56:17 INFO - Downloaded 59652939 bytes. 10:56:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/target.tar.bz2 10:56:17 INFO - mkdir: /builds/slave/test/properties 10:56:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:56:17 INFO - Writing to file /builds/slave/test/properties/build_url 10:56:17 INFO - Contents: 10:56:17 INFO - build_url:https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/target.tar.bz2 10:56:17 INFO - Running post-action listener: _resource_record_post_action 10:56:17 INFO - Running post-action listener: set_extra_try_arguments 10:56:17 INFO - [mozharness: 2017-05-23 17:56:17.283375Z] Finished download-and-extract step (success) 10:56:17 INFO - [mozharness: 2017-05-23 17:56:17.283508Z] Running populate-webroot step. 10:56:17 INFO - Running pre-action listener: _resource_record_pre_action 10:56:17 INFO - Running main action method: populate_webroot 10:56:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:56:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:56:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:56:17 INFO - '--tppagecycles', 10:56:17 INFO - '7'], 10:56:17 INFO - 'tests': ['tsvgm']}}, 10:56:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:56:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:56:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:56:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:56:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:56:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:56:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:56:17 INFO - 'talos_options': ['--disable-e10s'], 10:56:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:56:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:56:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:56:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:56:17 INFO - 'talos_options': ['--disable-e10s'], 10:56:17 INFO - 'tests': ['damp', 'tps']}, 10:56:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:56:17 INFO - 'tests': ['damp', 'tps']}, 10:56:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:56:17 INFO - 'tests': ['dromaeo_dom']}, 10:56:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:56:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:56:17 INFO - 'tests': ['basic_compositor_video']}, 10:56:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:56:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:56:17 INFO - 'tests': ['a11yr', 10:56:17 INFO - 'ts_paint', 10:56:17 INFO - 'tpaint', 10:56:17 INFO - 'sessionrestore', 10:56:17 INFO - 'sessionrestore_no_auto_restore', 10:56:17 INFO - 'tabpaint']}, 10:56:17 INFO - 'other-e10s': {'tests': ['a11yr', 10:56:17 INFO - 'ts_paint', 10:56:17 INFO - 'tpaint', 10:56:17 INFO - 'sessionrestore', 10:56:17 INFO - 'sessionrestore_no_auto_restore', 10:56:17 INFO - 'tabpaint']}, 10:56:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:56:17 INFO - 'ts_paint', 10:56:17 INFO - 'tpaint', 10:56:17 INFO - 'sessionrestore', 10:56:17 INFO - 'sessionrestore_no_auto_restore', 10:56:17 INFO - 'tabpaint']}, 10:56:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:56:17 INFO - 'ts_paint', 10:56:17 INFO - 'tpaint', 10:56:17 INFO - 'sessionrestore', 10:56:17 INFO - 'sessionrestore_no_auto_restore', 10:56:17 INFO - 'tabpaint']}, 10:56:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:56:17 INFO - 'tests': ['a11yr', 10:56:17 INFO - 'ts_paint', 10:56:17 INFO - 'tpaint', 10:56:17 INFO - 'sessionrestore', 10:56:17 INFO - 'sessionrestore_no_auto_restore', 10:56:17 INFO - 'tabpaint']}, 10:56:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:56:17 INFO - 'tests': ['a11yr', 10:56:17 INFO - 'ts_paint', 10:56:17 INFO - 'tpaint', 10:56:17 INFO - 'sessionrestore', 10:56:17 INFO - 'sessionrestore_no_auto_restore', 10:56:17 INFO - 'tabpaint']}, 10:56:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:56:17 INFO - 'tests': ['tsvgx', 10:56:17 INFO - 'tsvgr_opacity', 10:56:17 INFO - 'tart', 10:56:17 INFO - 'tscrollx', 10:56:17 INFO - 'cart', 10:56:17 INFO - 'tsvg_static']}, 10:56:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:56:17 INFO - 'tsvgr_opacity', 10:56:17 INFO - 'tart', 10:56:17 INFO - 'tscrollx', 10:56:17 INFO - 'cart', 10:56:17 INFO - 'tsvg_static']}, 10:56:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:56:17 INFO - 'talos_options': ['--disable-e10s'], 10:56:17 INFO - 'tests': ['tp5o']}, 10:56:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:56:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:56:17 INFO - 'talos_options': ['--disable-e10s', 10:56:17 INFO - '--xperf_path', 10:56:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:56:17 INFO - 'tests': ['tp5n']}, 10:56:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:56:17 INFO - 'talos_options': ['--xperf_path', 10:56:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:56:17 INFO - 'tests': ['tp5n']}}, 10:56:17 INFO - 'talos.zip': {'path': '', 10:56:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:56:17 INFO - Running post-action listener: _resource_record_post_action 10:56:17 INFO - [mozharness: 2017-05-23 17:56:17.298199Z] Finished populate-webroot step (success) 10:56:17 INFO - [mozharness: 2017-05-23 17:56:17.298303Z] Running create-virtualenv step. 10:56:17 INFO - Running pre-action listener: _resource_record_pre_action 10:56:17 INFO - Running main action method: create_virtualenv 10:56:17 INFO - Creating virtualenv /builds/slave/test/build/venv 10:56:17 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 10:56:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:56:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:56:17 INFO - Using real prefix '/usr' 10:56:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:56:18 INFO - Installing distribute.............................................................................................................................................................................................done. 10:56:20 INFO - Installing pip.................done. 10:56:20 INFO - Return code: 0 10:56:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:56:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:56:20 INFO - Reading from file tmpfile_stdout 10:56:20 INFO - Output received: 10:56:20 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) 10:56:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:20 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 0x20751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2313310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2310400>, '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 0x23113b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2311840>, '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': 'cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790', '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 10:56:20 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 10:56:20 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 10:56:20 INFO - Using env: {'DISPLAY': ':0', 10:56:20 INFO - 'HOME': '/home/cltbld', 10:56:20 INFO - 'LANG': 'en_US.UTF-8', 10:56:20 INFO - 'LANGUAGE': 'en_US:en', 10:56:20 INFO - 'LOGNAME': 'cltbld', 10:56:20 INFO - 'MAIL': '/var/mail/cltbld', 10:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:20 INFO - 'MOZ_NO_REMOTE': '1', 10:56:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:20 INFO - 'NO_EM_RESTART': '1', 10:56:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:20 INFO - 'PWD': '/builds/slave/test', 10:56:20 INFO - 'SHELL': '/bin/bash', 10:56:20 INFO - 'SHLVL': '1', 10:56:20 INFO - 'TERM': 'linux', 10:56:20 INFO - 'TMOUT': '86400', 10:56:20 INFO - 'USER': 'cltbld', 10:56:20 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790', 10:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:20 INFO - '_': '/tools/buildbot/bin/python'} 10:56:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:20 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 10:56:20 INFO - Cleaning up... 10:56:20 INFO - Return code: 0 10:56:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:20 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 0x20751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2313310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2310400>, '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 0x23113b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2311840>, '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': 'cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790', '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 10:56:20 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 10:56:20 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 10:56:20 INFO - Using env: {'DISPLAY': ':0', 10:56:20 INFO - 'HOME': '/home/cltbld', 10:56:20 INFO - 'LANG': 'en_US.UTF-8', 10:56:20 INFO - 'LANGUAGE': 'en_US:en', 10:56:20 INFO - 'LOGNAME': 'cltbld', 10:56:20 INFO - 'MAIL': '/var/mail/cltbld', 10:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:20 INFO - 'MOZ_NO_REMOTE': '1', 10:56:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:20 INFO - 'NO_EM_RESTART': '1', 10:56:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:20 INFO - 'PWD': '/builds/slave/test', 10:56:20 INFO - 'SHELL': '/bin/bash', 10:56:20 INFO - 'SHLVL': '1', 10:56:20 INFO - 'TERM': 'linux', 10:56:20 INFO - 'TMOUT': '86400', 10:56:20 INFO - 'USER': 'cltbld', 10:56:20 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790', 10:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:20 INFO - '_': '/tools/buildbot/bin/python'} 10:56:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:20 INFO - Downloading/unpacking psutil>=3.1.1 10:56: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 10:56: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 10:56: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 10:56: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 10:56:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:56:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:56:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:56:22 INFO - Installing collected packages: psutil 10:56:22 INFO - Running setup.py install for psutil 10:56:22 INFO - building 'psutil._psutil_linux' extension 10:56:22 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 10:56:23 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 10:56:23 INFO - building 'psutil._psutil_posix' extension 10:56:23 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 10:56:23 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 10:56:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:56:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:56:23 INFO - Successfully installed psutil 10:56:23 INFO - Cleaning up... 10:56:23 INFO - Return code: 0 10:56:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:23 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 0x20751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2313310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2310400>, '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 0x23113b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2311840>, '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': 'cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790', '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 10:56:23 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 10:56:23 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 10:56:23 INFO - Using env: {'DISPLAY': ':0', 10:56:23 INFO - 'HOME': '/home/cltbld', 10:56:23 INFO - 'LANG': 'en_US.UTF-8', 10:56:23 INFO - 'LANGUAGE': 'en_US:en', 10:56:23 INFO - 'LOGNAME': 'cltbld', 10:56:23 INFO - 'MAIL': '/var/mail/cltbld', 10:56:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:23 INFO - 'MOZ_NO_REMOTE': '1', 10:56:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:23 INFO - 'NO_EM_RESTART': '1', 10:56:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:23 INFO - 'PWD': '/builds/slave/test', 10:56:23 INFO - 'SHELL': '/bin/bash', 10:56:23 INFO - 'SHLVL': '1', 10:56:23 INFO - 'TERM': 'linux', 10:56:23 INFO - 'TMOUT': '86400', 10:56:23 INFO - 'USER': 'cltbld', 10:56:23 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790', 10:56:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:23 INFO - '_': '/tools/buildbot/bin/python'} 10:56:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:56:23 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 10:56:23 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 10:56:23 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 10:56:23 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 10:56:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:56:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:56:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:56:25 INFO - Installing collected packages: mozsystemmonitor 10:56:25 INFO - Running setup.py install for mozsystemmonitor 10:56:25 INFO - Successfully installed mozsystemmonitor 10:56:25 INFO - Cleaning up... 10:56:25 INFO - Return code: 0 10:56:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:56:25 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')]} 10:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:25 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')]} 10:56:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:25 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 0x20751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2313310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2310400>, '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 0x23113b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2311840>, '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': 'cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790', '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 10:56:25 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 10:56:25 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 10:56:25 INFO - Using env: {'DISPLAY': ':0', 10:56:25 INFO - 'HOME': '/home/cltbld', 10:56:25 INFO - 'LANG': 'en_US.UTF-8', 10:56:25 INFO - 'LANGUAGE': 'en_US:en', 10:56:25 INFO - 'LOGNAME': 'cltbld', 10:56:25 INFO - 'MAIL': '/var/mail/cltbld', 10:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:25 INFO - 'MOZ_NO_REMOTE': '1', 10:56:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:25 INFO - 'NO_EM_RESTART': '1', 10:56:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:25 INFO - 'PWD': '/builds/slave/test', 10:56:25 INFO - 'SHELL': '/bin/bash', 10:56:25 INFO - 'SHLVL': '1', 10:56:25 INFO - 'TERM': 'linux', 10:56:25 INFO - 'TMOUT': '86400', 10:56:25 INFO - 'USER': 'cltbld', 10:56:25 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790', 10:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:25 INFO - '_': '/tools/buildbot/bin/python'} 10:56:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:25 INFO - Downloading/unpacking jsonschema==2.5.1 10:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:56:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:26 INFO - Downloading functools32-3.2.3-2.tar.gz 10:56:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:56:26 INFO - warning: no files found matching '*.txt' 10:56:26 INFO - no previously-included directories found matching 'build' 10:56:26 INFO - no previously-included directories found matching 'dist' 10:56:26 INFO - no previously-included directories found matching '.git*' 10:56:26 INFO - Installing collected packages: jsonschema, functools32 10:56:26 INFO - Running setup.py install for functools32 10:56:26 INFO - warning: no files found matching '*.txt' 10:56:26 INFO - no previously-included directories found matching 'build' 10:56:26 INFO - no previously-included directories found matching 'dist' 10:56:26 INFO - no previously-included directories found matching '.git*' 10:56:26 INFO - Successfully installed jsonschema functools32 10:56:26 INFO - Cleaning up... 10:56:26 INFO - Return code: 0 10:56:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:26 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 0x20751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2313310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2310400>, '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 0x23113b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2311840>, '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': 'cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790', '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 10:56:26 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 10:56:26 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 10:56:26 INFO - Using env: {'DISPLAY': ':0', 10:56:26 INFO - 'HOME': '/home/cltbld', 10:56:26 INFO - 'LANG': 'en_US.UTF-8', 10:56:26 INFO - 'LANGUAGE': 'en_US:en', 10:56:26 INFO - 'LOGNAME': 'cltbld', 10:56:26 INFO - 'MAIL': '/var/mail/cltbld', 10:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:26 INFO - 'MOZ_NO_REMOTE': '1', 10:56:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:26 INFO - 'NO_EM_RESTART': '1', 10:56:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:26 INFO - 'PWD': '/builds/slave/test', 10:56:26 INFO - 'SHELL': '/bin/bash', 10:56:26 INFO - 'SHLVL': '1', 10:56:26 INFO - 'TERM': 'linux', 10:56:26 INFO - 'TMOUT': '86400', 10:56:26 INFO - 'USER': 'cltbld', 10:56:26 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790', 10:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:26 INFO - '_': '/tools/buildbot/bin/python'} 10:56:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:56:27 INFO - Cleaning up... 10:56:27 INFO - Return code: 0 10:56:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:56:27 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')]} 10:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:27 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')]} 10:56:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:27 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 0x20751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2313310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2310400>, '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 0x23113b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2311840>, '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': 'cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790', '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 10:56:27 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 10:56:27 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 10:56:27 INFO - Using env: {'DISPLAY': ':0', 10:56:27 INFO - 'HOME': '/home/cltbld', 10:56:27 INFO - 'LANG': 'en_US.UTF-8', 10:56:27 INFO - 'LANGUAGE': 'en_US:en', 10:56:27 INFO - 'LOGNAME': 'cltbld', 10:56:27 INFO - 'MAIL': '/var/mail/cltbld', 10:56:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:27 INFO - 'MOZ_NO_REMOTE': '1', 10:56:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:27 INFO - 'NO_EM_RESTART': '1', 10:56:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:27 INFO - 'PWD': '/builds/slave/test', 10:56:27 INFO - 'SHELL': '/bin/bash', 10:56:27 INFO - 'SHLVL': '1', 10:56:27 INFO - 'TERM': 'linux', 10:56:27 INFO - 'TMOUT': '86400', 10:56:27 INFO - 'USER': 'cltbld', 10:56:27 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790', 10:56:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:27 INFO - '_': '/tools/buildbot/bin/python'} 10:56:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:27 INFO - Downloading/unpacking blobuploader==1.2.4 10:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:28 INFO - Downloading blobuploader-1.2.4.tar.gz 10:56:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:56:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:56:28 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 10:56:28 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 10:56:28 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 10:56:28 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 10:56:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:56:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:56:28 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 10:56:28 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 10:56:28 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 10:56:28 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 10:56:28 INFO - Downloading docopt-0.6.1.tar.gz 10:56:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:56:29 INFO - Installing collected packages: blobuploader, requests, docopt 10:56:29 INFO - Running setup.py install for blobuploader 10:56:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:56:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:56:29 INFO - Running setup.py install for requests 10:56:29 INFO - Running setup.py install for docopt 10:56:29 INFO - Successfully installed blobuploader requests docopt 10:56:29 INFO - Cleaning up... 10:56:29 INFO - Return code: 0 10:56:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:29 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 0x20751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2313310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2310400>, '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 0x23113b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2311840>, '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': 'cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790', '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 10:56:29 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 10:56:29 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 10:56:29 INFO - Using env: {'DISPLAY': ':0', 10:56:29 INFO - 'HOME': '/home/cltbld', 10:56:29 INFO - 'LANG': 'en_US.UTF-8', 10:56:29 INFO - 'LANGUAGE': 'en_US:en', 10:56:29 INFO - 'LOGNAME': 'cltbld', 10:56:29 INFO - 'MAIL': '/var/mail/cltbld', 10:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:29 INFO - 'MOZ_NO_REMOTE': '1', 10:56:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:29 INFO - 'NO_EM_RESTART': '1', 10:56:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:29 INFO - 'PWD': '/builds/slave/test', 10:56:29 INFO - 'SHELL': '/bin/bash', 10:56:29 INFO - 'SHLVL': '1', 10:56:29 INFO - 'TERM': 'linux', 10:56:29 INFO - 'TMOUT': '86400', 10:56:29 INFO - 'USER': 'cltbld', 10:56:29 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790', 10:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:29 INFO - '_': '/tools/buildbot/bin/python'} 10:56:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:56:29 INFO - Running setup.py (path:/tmp/pip-ShTeDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:56:29 INFO - Running setup.py (path:/tmp/pip-m6Xjse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:56:29 INFO - Running setup.py (path:/tmp/pip-oE4vDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:56:30 INFO - Running setup.py (path:/tmp/pip-bYmgJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:56:30 INFO - Running setup.py (path:/tmp/pip-wzx4Lg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:56:30 INFO - Running setup.py (path:/tmp/pip-1jr1o2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:56:30 INFO - Running setup.py (path:/tmp/pip-AF4Ujt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:56:30 INFO - Running setup.py (path:/tmp/pip-p2jvE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:56:30 INFO - Running setup.py (path:/tmp/pip-APUTEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:56:30 INFO - Running setup.py (path:/tmp/pip-_8_2DB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:56:30 INFO - Running setup.py (path:/tmp/pip-Z8_7Gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:56:30 INFO - Running setup.py (path:/tmp/pip-cLBsCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:56:30 INFO - Running setup.py (path:/tmp/pip-FvFFK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:56:30 INFO - Running setup.py (path:/tmp/pip-k4UPB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:56:30 INFO - Running setup.py (path:/tmp/pip-LRtK7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:56:30 INFO - Running setup.py (path:/tmp/pip-vFKfAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:56:31 INFO - Running setup.py (path:/tmp/pip-DqkS1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:56:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:56:31 INFO - Running setup.py install for manifestparser 10:56:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:56:31 INFO - Running setup.py install for mozcrash 10:56:31 INFO - Running setup.py install for mozdebug 10:56:31 INFO - Running setup.py install for mozdevice 10:56:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:56:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:56:31 INFO - Running setup.py install for mozfile 10:56:31 INFO - Running setup.py install for mozhttpd 10:56:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:56:31 INFO - Running setup.py install for mozinfo 10:56:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:56:31 INFO - Running setup.py install for mozInstall 10:56:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:56:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:56:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:56:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:56:31 INFO - Running setup.py install for mozleak 10:56:31 INFO - Running setup.py install for mozlog 10:56:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:56:32 INFO - Running setup.py install for moznetwork 10:56:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:56:32 INFO - Running setup.py install for mozprocess 10:56:32 INFO - Running setup.py install for mozprofile 10:56:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:56:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:56:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:56:32 INFO - Running setup.py install for mozrunner 10:56:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:56:32 INFO - Running setup.py install for mozscreenshot 10:56:32 INFO - Running setup.py install for moztest 10:56:32 INFO - Running setup.py install for mozversion 10:56:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:56:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:56:32 INFO - Cleaning up... 10:56:32 INFO - Return code: 0 10:56:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:56: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')]} 10:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56: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')]} 10:56:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:32 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 0x20751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2313310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2310400>, '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 0x23113b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2311840>, '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': 'cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790', '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 10:56:32 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 10:56:32 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 10:56:32 INFO - Using env: {'DISPLAY': ':0', 10:56:32 INFO - 'HOME': '/home/cltbld', 10:56:32 INFO - 'LANG': 'en_US.UTF-8', 10:56:32 INFO - 'LANGUAGE': 'en_US:en', 10:56:32 INFO - 'LOGNAME': 'cltbld', 10:56:32 INFO - 'MAIL': '/var/mail/cltbld', 10:56:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:32 INFO - 'MOZ_NO_REMOTE': '1', 10:56:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:32 INFO - 'NO_EM_RESTART': '1', 10:56:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:32 INFO - 'PWD': '/builds/slave/test', 10:56:32 INFO - 'SHELL': '/bin/bash', 10:56:32 INFO - 'SHLVL': '1', 10:56:32 INFO - 'TERM': 'linux', 10:56:32 INFO - 'TMOUT': '86400', 10:56:32 INFO - 'USER': 'cltbld', 10:56:32 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790', 10:56:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:32 INFO - '_': '/tools/buildbot/bin/python'} 10:56:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:56:33 INFO - Running setup.py (path:/tmp/pip-cpkfqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:56:33 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)) 10:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:56:33 INFO - Running setup.py (path:/tmp/pip-iSu5Xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:56:33 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)) 10:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:56:33 INFO - Running setup.py (path:/tmp/pip-Kq1EXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:56:33 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)) 10:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:56:33 INFO - Running setup.py (path:/tmp/pip-2AivIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:56:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 10:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:56:33 INFO - Running setup.py (path:/tmp/pip-GBDJSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:56:33 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)) 10:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:56:33 INFO - Running setup.py (path:/tmp/pip-cOlxJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:56:33 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)) 10:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:56:33 INFO - Running setup.py (path:/tmp/pip-g1u7zo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:56:33 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)) 10:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:56:33 INFO - Running setup.py (path:/tmp/pip-B7vXkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:56:33 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)) 10:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:56:33 INFO - Running setup.py (path:/tmp/pip-e5OvJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:56:33 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)) 10:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:56:33 INFO - Running setup.py (path:/tmp/pip-AAJJbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:56:33 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)) 10:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:56:33 INFO - Running setup.py (path:/tmp/pip-1Vrvka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:56:33 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)) 10:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:56:33 INFO - Running setup.py (path:/tmp/pip-RzIVkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:56:33 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)) 10:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:56:33 INFO - Running setup.py (path:/tmp/pip-3Aj5ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:56:34 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)) 10:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:56:34 INFO - Running setup.py (path:/tmp/pip-VbctF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:56:34 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)) 10:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:56:34 INFO - Running setup.py (path:/tmp/pip-LTHrVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:56:34 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)) 10:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:56:34 INFO - Running setup.py (path:/tmp/pip-XqJuIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:56:34 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)) 10:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:56:34 INFO - Running setup.py (path:/tmp/pip-2fPKr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:56:34 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)) 10:56:34 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)) 10:56:34 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)) 10:56:34 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)) 10:56:34 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:56:34 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:56:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:35 INFO - Downloading blessings-1.6.tar.gz 10:56:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:56:35 INFO - Installing collected packages: blessings 10:56:35 INFO - Running setup.py install for blessings 10:56:35 INFO - Successfully installed blessings 10:56:35 INFO - Cleaning up... 10:56:35 INFO - Return code: 0 10:56:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:56:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:56:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:56:35 INFO - Reading from file tmpfile_stdout 10:56:35 INFO - Current package versions: 10:56:35 INFO - argparse == 1.2.1 10:56:35 INFO - blessings == 1.6 10:56:35 INFO - blobuploader == 1.2.4 10:56:35 INFO - docopt == 0.6.1 10:56:35 INFO - functools32 == 3.2.3-2 10:56:35 INFO - jsonschema == 2.5.1 10:56:35 INFO - manifestparser == 1.1 10:56:35 INFO - mozInstall == 1.12 10:56:35 INFO - mozcrash == 1.0 10:56:35 INFO - mozdebug == 0.1 10:56:35 INFO - mozdevice == 0.49 10:56:35 INFO - mozfile == 1.2 10:56:35 INFO - mozhttpd == 0.7 10:56:35 INFO - mozinfo == 0.9 10:56:35 INFO - mozleak == 0.1 10:56:35 INFO - mozlog == 3.4 10:56:35 INFO - moznetwork == 0.27 10:56:35 INFO - mozprocess == 0.25 10:56:35 INFO - mozprofile == 0.28 10:56:35 INFO - mozrunner == 6.13 10:56:35 INFO - mozscreenshot == 0.1 10:56:35 INFO - mozsystemmonitor == 0.3 10:56:35 INFO - moztest == 0.8 10:56:35 INFO - mozversion == 1.4 10:56:35 INFO - psutil == 3.1.1 10:56:35 INFO - requests == 1.2.3 10:56:35 INFO - wsgiref == 0.1.2 10:56:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:35 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 0x20751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2313310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2310400>, '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 0x23113b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2311840>, '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': 'cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790', '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 10:56:35 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 10:56:35 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 10:56:35 INFO - Using env: {'DISPLAY': ':0', 10:56:35 INFO - 'HOME': '/home/cltbld', 10:56:35 INFO - 'LANG': 'en_US.UTF-8', 10:56:35 INFO - 'LANGUAGE': 'en_US:en', 10:56:35 INFO - 'LOGNAME': 'cltbld', 10:56:35 INFO - 'MAIL': '/var/mail/cltbld', 10:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:35 INFO - 'MOZ_NO_REMOTE': '1', 10:56:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:35 INFO - 'NO_EM_RESTART': '1', 10:56:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:35 INFO - 'PWD': '/builds/slave/test', 10:56:35 INFO - 'SHELL': '/bin/bash', 10:56:35 INFO - 'SHLVL': '1', 10:56:35 INFO - 'TERM': 'linux', 10:56:35 INFO - 'TMOUT': '86400', 10:56:35 INFO - 'USER': 'cltbld', 10:56:35 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790', 10:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:35 INFO - '_': '/tools/buildbot/bin/python'} 10:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:36 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)) 10:56:36 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)) 10:56:36 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)) 10:56:36 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)) 10:56:36 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)) 10:56:36 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)) 10:56:36 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)) 10:56:36 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)) 10:56:36 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)) 10:56:36 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)) 10:56:36 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)) 10:56:36 INFO - Cleaning up... 10:56:36 INFO - Return code: 0 10:56:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:56:36 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')]} 10:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:36 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')]} 10:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:36 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 0x20751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2313310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2310400>, '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 0x23113b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2311840>, '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': 'cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790', '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 10:56:36 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 10:56:36 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 10:56:36 INFO - Using env: {'DISPLAY': ':0', 10:56:36 INFO - 'HOME': '/home/cltbld', 10:56:36 INFO - 'LANG': 'en_US.UTF-8', 10:56:36 INFO - 'LANGUAGE': 'en_US:en', 10:56:36 INFO - 'LOGNAME': 'cltbld', 10:56:36 INFO - 'MAIL': '/var/mail/cltbld', 10:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:36 INFO - 'MOZ_NO_REMOTE': '1', 10:56:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:36 INFO - 'NO_EM_RESTART': '1', 10:56:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:36 INFO - 'PWD': '/builds/slave/test', 10:56:36 INFO - 'SHELL': '/bin/bash', 10:56:36 INFO - 'SHLVL': '1', 10:56:36 INFO - 'TERM': 'linux', 10:56:36 INFO - 'TMOUT': '86400', 10:56:36 INFO - 'USER': 'cltbld', 10:56:36 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790', 10:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:36 INFO - '_': '/tools/buildbot/bin/python'} 10:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:56:36 INFO - Cleaning up... 10:56:36 INFO - Return code: 0 10:56:36 INFO - Running post-action listener: _resource_record_post_action 10:56:36 INFO - Running post-action listener: _start_resource_monitoring 10:56:36 INFO - Starting resource monitoring. 10:56:36 INFO - [mozharness: 2017-05-23 17:56:36.394394Z] Finished create-virtualenv step (success) 10:56:36 INFO - [mozharness: 2017-05-23 17:56:36.395342Z] Running install step. 10:56:36 INFO - Running pre-action listener: _resource_record_pre_action 10:56:36 INFO - Running main action method: install 10:56:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:56:36 INFO - Reading from file tmpfile_stdout 10:56:36 INFO - Detecting whether we're running mozinstall >=1.0... 10:56:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:56:36 INFO - Reading from file tmpfile_stdout 10:56:36 INFO - Output received: 10:56:36 INFO - Usage: mozinstall [options] installer 10:56:36 INFO - Options: 10:56:36 INFO - -h, --help show this help message and exit 10:56:36 INFO - -d DEST, --destination=DEST 10:56:36 INFO - Directory to install application into. [default: 10:56:36 INFO - "/builds/slave/test"] 10:56:36 INFO - --app=APP Application being installed. [default: firefox] 10:56:36 INFO - mkdir: /builds/slave/test/build/application 10:56:36 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'] 10:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:56:50 INFO - Reading from file tmpfile_stdout 10:56:50 INFO - Output received: 10:56:50 INFO - /builds/slave/test/build/application/firefox/firefox 10:56:50 INFO - Running post-action listener: _resource_record_post_action 10:56:50 INFO - [mozharness: 2017-05-23 17:56:50.737225Z] Finished install step (success) 10:56:50 INFO - [mozharness: 2017-05-23 17:56:50.737472Z] Running run-tests step. 10:56:50 INFO - Running pre-action listener: _resource_record_pre_action 10:56:50 INFO - Running main action method: run_tests 10:56:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:56:50 INFO - Python 2.7.3 10:56:50 INFO - Return code: 0 10:56:50 INFO - grabbing minidump binary from tooltool 10:56:50 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')]} 10:56:50 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 0x2310400>, '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 0x23113b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2311840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:56:50 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 10:56:50 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 10:56:50 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 10:56:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:56:50 INFO - Return code: 0 10:56:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:56:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:56:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:56:50 INFO - ENV: RUST_BACKTRACE is now 1 10:56:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:56:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:56:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:56:50 INFO - Using env: {'DISPLAY': ':0', 10:56:50 INFO - 'HOME': '/home/cltbld', 10:56:50 INFO - 'LANG': 'en_US.UTF-8', 10:56:50 INFO - 'LANGUAGE': 'en_US:en', 10:56:50 INFO - 'LOGNAME': 'cltbld', 10:56:50 INFO - 'MAIL': '/var/mail/cltbld', 10:56:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:56:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:50 INFO - 'MOZ_NO_REMOTE': '1', 10:56:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:50 INFO - 'NO_EM_RESTART': '1', 10:56:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:50 INFO - 'PWD': '/builds/slave/test', 10:56:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:56:50 INFO - 'RUST_BACKTRACE': '1', 10:56:50 INFO - 'SHELL': '/bin/bash', 10:56:50 INFO - 'SHLVL': '1', 10:56:50 INFO - 'TERM': 'linux', 10:56:50 INFO - 'TMOUT': '86400', 10:56:50 INFO - 'USER': 'cltbld', 10:56:50 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790', 10:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:50 INFO - '_': '/tools/buildbot/bin/python'} 10:56:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:56:51 INFO - mozversion application_buildid: 20170523170400 10:56:51 INFO - mozversion application_changeset: a2d407b9da248932f50c95533d13cd8043ca2e21 10:56:51 INFO - mozversion application_display_name: Firefox 10:56:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:56:51 INFO - mozversion application_name: Firefox 10:56:51 INFO - mozversion application_remotingname: firefox 10:56:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:56:51 INFO - mozversion application_vendor: Mozilla 10:56:51 INFO - mozversion application_version: 54.0 10:56:51 INFO - mozversion platform_buildid: 20170523170400 10:56:51 INFO - mozversion platform_changeset: a2d407b9da248932f50c95533d13cd8043ca2e21 10:56:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:56:51 INFO - mozversion platform_version: 54.0 10:56:51 INFO - using testdate: 1495562211 10:56:51 INFO - actual date: 1495562211 10:56:51 INFO - starting webserver on 'localhost:51654' 10:56:51 INFO - SUITE-START | Running 2 tests 10:56:51 INFO - TEST-START | dromaeo_css 10:56:51 INFO - operating with platform_type : linux_ 10:56:51 INFO - Initialising browser for dromaeo_css test... 10:56:51 INFO - TEST-INFO | started process 3333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX_Xlcr/profile http://localhost:51654/getInfo.html) 10:56:55 INFO - PROCESS | 3333 | __metrics Screen width/height:1600/1200 10:56:55 INFO - PROCESS | 3333 | colorDepth:24 10:56:55 INFO - PROCESS | 3333 | Browser inner width/height: 1024/697 10:56:55 INFO - PROCESS | 3333 | __metrics 10:56:56 INFO - PROCESS | 3333 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:56:56 INFO - PROCESS | 3333 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:56:57 INFO - PROCESS | 3333 | console.error: PushService: 10:56:57 INFO - PROCESS | 3333 | stateChangeProcessEnqueue: Error transitioning state 10:56:57 INFO - PROCESS | 3333 | UnknownError 10:56:57 INFO - TEST-INFO | 3333: exit 0 10:56:57 INFO - Browser initialized. 10:56:57 INFO - Running cycle 1/1 for dromaeo_css test... 10:56:57 INFO - TEST-INFO | started process 3428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX_Xlcr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:57:09 INFO - PROCESS | 3428 | RSS: Main: 141803520 10:57:09 INFO - PROCESS | 3428 | 11:00:11 INFO - PROCESS | 3428 | Cycle 1(1): loaded http://localhost:51654/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51654/tests/dromaeo/cssquery-ext.html) 11:00:13 INFO - PROCESS | 3428 | RSS: Main: 285376512 11:00:13 INFO - PROCESS | 3428 | 11:03:15 INFO - PROCESS | 3428 | Cycle 1(1): loaded http://localhost:51654/tests/dromaeo/cssquery-ext.html (next: http://localhost:51654/tests/dromaeo/cssquery-jquery.html) 11:03:15 INFO - PROCESS | 3428 | RSS: Main: 226279424 11:03:15 INFO - PROCESS | 3428 | 11:06:17 INFO - PROCESS | 3428 | Cycle 1(1): loaded http://localhost:51654/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51654/tests/dromaeo/cssquery-mootools.html) 11:06:18 INFO - PROCESS | 3428 | RSS: Main: 224047104 11:06:18 INFO - PROCESS | 3428 | 11:09:20 INFO - PROCESS | 3428 | Cycle 1(1): loaded http://localhost:51654/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51654/tests/dromaeo/cssquery-prototype.html) 11:09:20 INFO - PROCESS | 3428 | RSS: Main: 201031680 11:09:20 INFO - PROCESS | 3428 | 11:12:23 INFO - PROCESS | 3428 | Cycle 1(1): loaded http://localhost:51654/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51654/tests/dromaeo/cssquery-yui.html) 11:12:24 INFO - PROCESS | 3428 | RSS: Main: 172060672 11:12:24 INFO - PROCESS | 3428 | 11:15:26 INFO - PROCESS | 3428 | Cycle 1(1): loaded http://localhost:51654/tests/dromaeo/cssquery-yui.html (next: http://localhost:51654/tests/dromaeo/cssquery-dojo.html) 11:15:26 INFO - PROCESS | 3428 | RSS: Main: 262729728 11:15:26 INFO - PROCESS | 3428 | 11:15:26 INFO - PROCESS | 3428 | __start_tp_report 11:15:26 INFO - PROCESS | 3428 | _x_x_mozilla_page_load 11:15:26 INFO - PROCESS | 3428 | _x_x_mozilla_page_load_details 11:15:26 INFO - PROCESS | 3428 | |i|pagename|runs| 11:15:26 INFO - PROCESS | 3428 | |0;dojo.html;3382.577177852768;3409.3863104641155;3418.5043168740526;3432.588089429266;3460.948085778714;5748.396418376073;5845.7953971611005;5849.532037437006;5857.4435428634315;5872.61827981182;5826.446487583683;5878.823635290937;5890.116482527623;5895;5895.85260368491;5288.894222115556;5310.230016647583;5313.176457649051;5389.6496727712765;5395.325584301962;5153.871153221162;5198.116320225552;5370.43610420906;5385.111456609655;5386.973065134669;5267.28891599633;5275.920861187066;5276.182191760283;5285.973570132144;5292.655977361459;5370.785168593252;5382.085045542267;5383.4616538346045;5388.084025715638;5417.972910135424;5136.280920671109;5241.187615919539;5293.285406470116;5357.035733567956;5358.11591087474;5659.717014149276;5718.828435146952;5721.742521586497;5731.541476681856;5739.225204597367;6188.721507532172;6200.038993955944;6231.189945307126;6233.2208473940755;6233.376662333776;6242.282137554149;6275.592086514362;6275.592086514362;6280.748770049193;6292.779752708633;5663.858403539944;5705.286839145107;5764.250647415809;5801.042827933428;5815.767369305265;6366.618002919747;6366.745330186834;6367.172267605181;6369;6377.74489020434;6056;6161.353057928943;6162.691865406712;6172;6173.32093469718;6007.729652165663;6046.969765151234;6142.069075791497;6164.291106522717;6242.406971337807;6007.909881351783;6244.313125556185;6259.092431597484;6262.906056409158;6271.090691849657;6112.1387513176505;6116.974953844038;6137.907931380943;6142.897836592581;6146.631202127886;4297.806598703066;4306.590873866978;4352.368906508538;4360.585744354281;4367.10474352757;3806.3909774435956;3813.4851795007876;3851.980740096282;3862.6523612874976;3899.2786334528205;5946.256717910262;5952.8809423812145;5961.360262248012;5966.612170208922;5972.552058595623;6260.311365749764;6267.6866156692895;6279.96860015697;6285.685715714196;6287.276963149205;5720.342160651495;5743.851229754066;5944.970275148597;5945.405459454107;5981.192539007178;5249.632525723163;5258.368995720538;5278.841634750964;5286.048511267932;5288.497592728685;6496.545241833026;6535.411812936763;6539.280679125292;6542.084108224853;6543.443807276435;6046.637201767908;6246.656433896179;6253.468455181361;6275.780347687809;6311.116443697978;6372.522060845363;6423.42189202974;6433.420992110545;6462.741490340334;6474.838129046811;6204.844878878064;6207.16203312547;6210.937890621217;6214.1921550198185;6221.440070393686;6310.936890631218;6316.968415157895;6320;6320.336364681642;6320.5575609706875;5797.072468405035;5917.526597872074;6016.608920420159;6054.152418661479;6082.817515474543;6107.6640784757265;6113.962834745988;6119.837693858789;6123.1606109212;6124.8775024500155;5829.47534721877;6087.634741915499;6089.299730530868;6092.299385570716;6105.9084113737445;5957.49361304294;6016.639001659914;6071.908921366271;6130.47890929276;6166.630002199882;5996.910046349395;6028.306744724413;6037.818865434044;6055.636661800306;6073.271207455134 11:15:26 INFO - PROCESS | 3428 | |1;ext.html;750.3809357280245;835.3985130705892;851.2508992086963;913.593450914343;915.2586405011937;31727.365452690934;42552;43626;43741.56258437414;43745;40699;40841;40910.38634420486;45113.32330015052;45338.54661453384;7446.329830315271;7596.582187979687;9015.999999999984;9149.085091490864;9149.22231610314;10564.471776411187;10654.09440197584;10728.839067413996;10752.73118172048;10757.515911783988;10755.085817705505;10794.622188223413;10800.621978230763;10809.135269178447;10813.134949204084;10698.572057117706;10735.78528429427;10748.838767418494;10753.83869241962;10757.246992710514;10573.788524229549;10633.46832658364;10636.521356538897;10640.201984851166;10643.946780266126;42421.36367954483;42575;42647;42752.144957100994;43038.78480607577;3956.268090403256;4001.779902105383;4014.578469260744;4081.3061779497557;4108.91782164358;30011.699883001107;30077.548836767248;30276.848615757;30298.394032119453;30396.392072158655;4118.361653943643;4176.1230141670285;4225.084691562812;4235.97882010588;4320.1143765527995;352774;358405;360444;361882;362018.1899090514;42758.57241427608;42922;42948.3557746634;42964.14071718548;42999.78500107479;44606;44649.55350446519;44712.77643611826;44748;44774;14728.779068313985;14835;14854.183019933791;15308.846911530965;15309.923450382677;11979.682234954149;12180.695482613006;13510.93244533771;13515.324233788271;13584.86415135836;12606.621801345975;12697.492100315883;12802.487900483877;12860.16408933435;12919.418626161845;5550.528205102531;5613.298337707786;5634.492895639412;5660.094384898396;5662.886742265132;1004.3572113847143;1010.4695035106628;1016.7508960304773;1021.3820638513592;1034.5861655337926;29360.559591606143;29572.852135739184;29689.257768555526;29926.40147197044;30081.247968800955;1086.8587083679229;1087.7715679707192;1122.3995162587976;1125.128025780027;1125.1617544928918;14869.702605947821;15685.607859803597;15719.135447550267;15758.606034849221;15922.283497242652;338585;339637;340080;340365;341720;58001;58325.70837145787;58558.707206463696;58594;58855.41144588585;1505.9774103388459;1510.7582786754285;1525.7787620795145;1557.4315374888083;1573.4414282929624;26803.73196268012;28125.437491250468;28233.858830705714;28320.291992700346;28396.85801570979;23037.88481057584;23052.769472305063;23081.88459057694;23088;23149.189778357675;303992;308085;309381;309542;309663;27521.724782751917;28108.156755297372;32623.18442038873;33223.501647474826;33387.332253355286;43356;43574.34638480362;44309.778451108825;44886.77556612196;48575.5142448571;34608;35289.47065794066;35399.292014160084;35674.643253567134;35726.46410303796;35139;35264.471032934016;35321.823390882884;35342.293154136256;35554.11114722153;39774;39806.402903957045;39948.2010359797;40048.59951400448;41160.176796464504;33687.32625347529;33860.66139338575;34312;34520.48219276663;34553.136171595914;26630;26993.325166870985;27530.862345688143;27609.171724848286;27705.86147069252 11:15:26 INFO - PROCESS | 3428 | |2;jquery.html;391.8706826747174;451.67479414821315;452.066482713197;463.837656820113;466.82260740918457;20152.294669686544;20869.165233390664;21457.141714331407;21573.892130539327;21589.1364345426;21771.6734248986;22144.8892755536;22313.888430557865;22820.8858955705;23408.76591234087;6592.077109204703;6810.250872404032;6818.5908845469185;7343.37581305587;7629.504082234665;7462.776116716507;7653.923460765404;7701.422393320496;7711.074671039483;7727.343175830033;7727.150013498511;7785.3771698264;7791;7794.181610930856;7796.220377962187;7282.380997615182;7303.853922921512;7322.853542929165;7387.298206670358;7741.109772376192;7105.644717764091;7146.106736657918;7148.49960502765;7185.173705023937;7583.203763604853;26154.34614134643;26221.344466388302;26412.4908133727;26684.866575666998;26807.329816754544;3368.292658541685;3579.6420357963993;3591.3894637911617;3650.7444478886487;3672.6510981456718;15662;16230;16455.67088658232;16653.916730416393;16950;2255.6390977443693;2333.2183718454166;2362.5393048355577;2395.73646898841;2406.7352591214953;116233.41883290614;119947.40026299813;120024.39987800093;120234.39882800617;121319;14658.128403368064;17359.392421265195;17443.21505532254;18909.81090189108;18980.240790368505;32267.838660806545;32287.192820179214;32530.186745331557;32599.837000814845;32727;10853.728656783644;10875.347479151276;10936;11062.391568463812;11159.051480624237;9201.125893040151;9300.255979521622;9365.033342997911;9564.378315409476;9583.568739406743;8922.509261990523;9235.367920142728;9450.291228157777;9456.52717364129;9519.958061858702;3935.311320518898;3998.4002399640285;3998.980005099956;4087.1621317629815;4094.2835003874798;956.6364781383169;966.8646389505475;973.6786860336072;981.2101258486987;990.6681261777385;20660.17359305641;21694.674579881314;21833;21869;21886.343409697736;987.6197663899451;996.5714742660725;997.5610731278215;999.1706883286854;1003.6687892995294;10842.512086956105;11460.484278207501;11490.597829075943;11517.308961462171;11677.416129193507;611824;613436;628812;637897;644898;97735;98786;110910;120275.39862300808;121832.39083804525;1352.6618345413647;1386.0990356268505;1411.5624156511515;1415.6956254405352;1418.5035237666734;14529.854701453272;18355.174017169527;18887.672629669214;20167.394978150678;20219.59560808805;51774.482255178475;52066.47933520616;52916.73541632267;53088;53240.043486500974;61222.38777612167;62565.68717156385;66025;73355;73859.63070184615;12804.487820487077;12923.224606523263;13031.152975056591;13155;13284.335783210607;13888.375023124187;14163.716725665636;14342.713145736818;14627.049241799248;14752;12605.30670813114;12830.16603920742;12912.548060817826;13177.209367437985;13185.736285274432;11758.70603234926;12085.758284834079;12317.568885088978;12417.813732794197;12860.099793014399;12683.11218214753;13188.538401155913;13194.34028298562;13238;13489.932550337186;13014.869851301366;13242.271675057964;13310.800337994744;13312.46750129984;13316.267605281802;13017.544385946447;13084.934575327063;13123.212607243597;13152.934235328763;13468.730625387241 11:15:26 INFO - PROCESS | 3428 | |3;mootools.html;1515.227234110604;1522.9010114342573;1555.300114948273;1568.1061794776979;1575.3383578896862;10574.206934479906;11349.602763903275;11353.375564343958;11361.034312083473;11368.60209892654;10975.341479511235;11285.943570282157;11293.943530282357;11304.434778261075;11328;2380.809535237181;2403.062805505854;2414.058517178302;2414.927552173429;2416.903323867043;2171.4462811983003;2175.0647221694667;2196.143504033428;2204;2348.5772560939026;2353.7646235376496;2419.758024197584;2426.3206302235403;2510.8242423030397;2523.1673547729297;2275.112706044644;2298.2415802785126;2305.5043165719367;2307.5038866643667;2339.1462116327416;2362.881855907198;2369.3010561884284;2372.5847976604027;2377.940551486209;2382;11246.55013799447;11287.266327688674;11325.830112548318;11332.603358882481;11344.546218151265;5469.398366179717;5749.741261643236;5786.04530252512;5788.392218817005;5793.13103034544;3335.232896433834;3403.5235067090625;3426.372473075269;3465.5668041494814;3482.2165012872156;1256.5036810459817;1272.6245757501558;1283.9422225999851;1319.8152258683792;1320.7028418605832;14202;14491.855081449261;15728.37086516538;17170.22733976974;17447.12764361777;4795.712257264575;4866.221404575251;4873.244647079709;4893.266010098514;4925.901481970341;13042.608721738363;13050.477980880658;13051.412686429134;13065.150765200231;13070.673233169247;5018.473060328686;5168.379794424618;5790.420957904176;5894.734736936848;5987.730552125165;5329.280547126166;5377.677339359651;5399.406065332811;5408.350997880201;5414.40441551429;4029.6574791142493;4076.2255171517318;4137.441445404832;4153.584641535822;4153.8961525962095;1056.9524371403306;1065.7655315830505;1069.983950240747;1078.8219943709357;1082.6697857153645;1035.1201478743158;1043.7286305560608;1055.1400608504198;1056.693558867935;1063.3566692151292;6838.111045564045;6977.1278590176225;6986.161660600659;7077.646117694095;7126.821829454305;1012.291396022787;1046.7801761629992;1057.9947100264449;1103.5530610102921;1124.5895248234335;4548.363229147922;4605.4933957264675;4636.35091087248;4665.206914824488;4673.182193116191;13801.861981380258;14405.135691858522;14410.351534180987;14419.855801442061;14447.85552144486;13865.514706985206;14237.928810355881;14276.42894284217;14297.356618952172;14328.928355358365;10252.43611601369;10299.073083422378;10384.065434110966;10403.115735162595;10408.375497470024;7116.359527642537;7169.856602868018;7197.532160409557;7203.639818009184;7220.8916866246;12879.80680289815;12953.805692914802;13211.075224734177;13289.66775830612;13311;9834.114929656365;12662.113652044269;12723.936380318039;13184.868151318364;13485.258310793;9891.406515609087;10001.34991225568;10031.598736050477;10039.04629060238;10078.748031299276;10803.621873234399;10813.459327033774;10858.728531786768;10884.891151088388;11007.06439952613;9256.72229833106;9310.30172737061;9314.301427392837;9337.253019758538;9442.48066356357;8933.46399216049;9128.45229286245;9138.588763505792;9157.542122893696;9233;8542.316614670686;8613.741587752378;8682.392232543662;8685.652573897227;8712.956435217784;6339.080833279241;6411.294757576569;6419.807405777834;6444.709988050643;6521.771737989147;6057.818265452043;6234.438900498795;6286.088517165077;6340.270868850142;6441.227052753699 11:15:26 INFO - PROCESS | 3428 | |4;prototype.html;398.8982809383607;401.5783427401228;416.0015961691939;419.9622034016938;422.2784156113847;5038.596912247021;5145.253938178962;5317.38850032246;5320.334958130234;5331.573474122066;5077.5176358246;5216.24364467152;5222.4255331913555;5232.7383630818495;5240.292560504331;4578.473475550304;4605.240135377659;4610.4467463904375;4630.560096790799;4631.583157515823;4469.418975533176;4551.795169217393;4595.103954728829;4666.2767271073035;4688.968426946067;4502.096147984548;4569.9314510282375;4589.475788316429;4597.678162528624;4627.408651155347;4596.977015114937;4608.861734147981;4632.8146874125;4636.860894173146;4666.253399456071;4355.499117601485;4387.868363949086;4448.466184057901;4529.026259354222;4539.546045395467;5166.225066240057;5178.637495375326;5193.558547523465;5199.6360254782185;5207.765650545734;5268.947310526884;5317.41508434072;5354.250404943311;5374.7850085996515;5386.542143917772;5244.895102097937;5446.591505637093;5548.140038294071;5578.776848926038;5591.245181900432;4607.67312507185;4632;4642.489326174118;4655.534446555352;4655.837045703384;5748.19525266463;5769.394213607595;5776.422357764232;5781.4507621775865;5794.97102514489;4470.256599926031;4718.386609740712;4729.527047295243;4751.168545504523;4842.564169224786;4807.278908163804;4836.911694868626;4856.98435149409;4865.854024379274;4868.513148685174;5094.936550696973;5158.4067832199025;5161.870953226125;5178.844634660966;5185.429602743695;5281.329476014133;5454.236406903036;5494.395616482184;5545.528630066489;5549.805756798492;1584.2633175573415;1619.4898606938777;1657.6904245646047;1683.671684021604;1690.5773556610848;1268.8287081243914;1294.6569159172827;1302.863199364072;1310.087272582041;1325.6354502511695;5314.5748340132695;5334.413214546396;5351.3043304370185;5395.190721391823;5402.324709411324;5600.795828896726;5626.43735626434;5628.352739434936;5629.480040389072;5665.413684168439;5243.973780131151;5285.920711189336;5353.625246232804;5369.221462887859;5422.53908417781;2976.407621922261;2979.0467050544053;2983.701629836999;2988.44713727961;2999.43010827942;5551.195076713854;5864.777360300577;5890.352061273256;5899.410058994066;5911.733971971272;5671.914921276184;5682.6361673198135;5712.971435142797;5723.599348045597;5744.712764361765;5735.3977832327;5766.740496677576;5801;5909.3795151508475;5918.763249469973;5495.890082198413;5599.796043850592;5667.659940403589;5693.572982026281;5711.828645140652;5548.500634942713;5566.359868615161;5573.21974923503;5595.440455954372;5596.38439771633;5546.898411747046;5787.8553036174435;5824.388439213991;5853.560982926212;5857.209276747755;4719.244920812654;4726.503717109654;4741.5495527924795;4747.667663263538;4756.524347565216;5425.620206585501;5574.9442505574425;5591.266707320744;5699.430056994267;5726.255586773693;5484.451554844483;5528.612997090165;5588.636738611977;5590.440955904377;5616.326040875121;5514.558835293086;5524.293096382824;5537.501624853782;5543.835794483042;5558.91661625084;5281.947180528299;5492.835214943558;5511.586631002771;5514.751836167302;5587.010949142189;5544.390117087037;5615.6630602164005;5643.633163844337;5662.745176466987;5670.688112153706;5257.237700533325;5420;5428.83713488596;5499.212755854283;5514.5864060196445 11:15:26 INFO - PROCESS | 3428 | |5;yui.html;853.3130829682103;874.3474832566446;914.4147745442917;916.6931511202923;956.4643799472294;17362;18391.08044597768;18421;18426.907865460653;18443.17005734742;12196.390180490984;16813.66372672546;16989.2354844032;17001;17026;893.8033632600834;917.1837065012145;919.1589695428675;919.1635611593418;920.3465539466987;908.5275656658533;908.5275656658533;908.6910450446846;908.8818453601056;911.1753862754218;957.3011701457905;957.7701351675618;958.1855422890523;958.2142643032716;958.702802131338;944.527736131934;944.603266628011;953.9744774367548;955.5508910811873;955.5508910811907;691.7544271783495;692.4771797293062;693.715576613586;700.5411455496658;700.5971566349318;15814.051156930505;15846.445374411956;15949;15953.601159971093;15998.920005400016;16304.83695163045;16432.671346573003;16663.583410414714;16674.666506669797;17670.204840782197;12937.159084659466;13143.34283285832;13167.266866954482;13190;13247.668808279774;4157.168566286755;4171.749695018309;4182.079942412664;4213.47331583552;4314.9784251078545;48969;50226.54940958346;53910.730446347516;69476;85566.57216713938;12748.107632465639;12961.546345877849;12998.935005324913;13070.607881763563;13258.668533286746;25475.36311592225;25581.48837023249;25706.48587028249;25745.485090298465;25793.097241596828;9086.500242486594;9110.544472776335;9195.540222988824;9211.40125891815;9211.631534738535;5061.873453163626;5080.339555857789;5126.794928202905;5135;5257;3669.743117981769;3765.6046115157515;3768.6231376862643;3771.132639492932;3786.772793632391;617.5059952038351;672.7981605518324;689.2142957028991;701.3792793377897;702.357343031131;735.8123678461958;742.38011260598;745.1803016681607;755.0524092264174;760.7983884270673;11100.222984391177;11793.351365674971;12110.384937944422;12182.512699492097;12286.631401057983;797.3023604346197;810.2221867007738;810.3598157455544;825.2449009156675;829.088003196479;5515.227868098469;5544.276586851418;5557.777688892399;5600.215969764236;5622.24099746529;59167.70416147892;66402.66798666073;68315.65842170856;71018.64490677617;87004;54688.17967730487;59603;64677.67661161664;65456.67271663611;67144;61541;62140.37859621437;62463.37536624575;62533.68733156305;64004.359956400775;10608.522616482123;11212.66362009141;11225.66323010311;11240.943795280971;11358;37089;37531;42401.36397953972;43682.34476482919;44391.77804110959;56094;56280.43719562916;56958.430415695315;57857.4214257852;57970;13213.603591892259;13398.933005334911;13556.322183890568;13787.103838250883;13995.090319129224;16163.272652730891;16387.9180604101;16469.752953705465;16575.088370139758;16918.57703557421;15599;15641.673267475031;15769.921150394175;16365.099919504542;16417.753733694244;14377.065490743069;14396.856031439971;14429.49496767608;14456.349464273922;14547;14956.40174393012;14980.85019149838;15467.613309667347;16259.75610365869;16276.43032493857;9793.706188814347;9900.554475048784;9981.950090249502;10210.234232432449;10337.224708147069;11827.704307392383;12310.507579696712;12447.502099916264;12652.367381631066;12715.491380344683 11:15:26 INFO - PROCESS | 3428 | __end_tp_report 11:15:26 INFO - PROCESS | 3428 | __start_cc_report 11:15:26 INFO - PROCESS | 3428 | _x_x_mozilla_cycle_collect,1512 11:15:26 INFO - PROCESS | 3428 | __end_cc_report 11:15:26 INFO - PROCESS | 3428 | __startTimestamp1495563326886__endTimestamp 11:15:26 INFO - PROCESS | 3428 | 11:15:26 INFO - PROCESS | 3428 | ------- Summary: start ------- 11:15:26 INFO - PROCESS | 3428 | Number of tests: 6 11:15:26 INFO - PROCESS | 3428 | 11:15:26 INFO - PROCESS | 3428 | [#0] dojo.html Cycles:165 Average:5762.62 Median:6016.61 stddev:709.16 (11.8%) stddev-sans-first:686.32 11:15:26 INFO - PROCESS | 3428 | Values: 3382.6 3409.4 3418.5 3432.6 3460.9 5748.4 5845.8 5849.5 5857.4 5872.6 5826.4 5878.8 5890.1 5895.0 5895.9 5288.9 5310.2 5313.2 5389.6 5395.3 5153.9 5198.1 5370.4 5385.1 5387.0 5267.3 5275.9 5276.2 5286.0 5292.7 5370.8 5382.1 5383.5 5388.1 5418.0 5136.3 5241.2 5293.3 5357.0 5358.1 5659.7 5718.8 5721.7 5731.5 5739.2 6188.7 6200.0 6231.2 6233.2 6233.4 6242.3 6275.6 6275.6 6280.7 6292.8 5663.9 5705.3 5764.3 5801.0 5815.8 6366.6 6366.7 6367.2 6369.0 6377.7 6056.0 6161.4 6162.7 6172.0 6173.3 6007.7 6047.0 6142.1 6164.3 6242.4 6007.9 6244.3 6259.1 6262.9 6271.1 6112.1 6117.0 6137.9 6142.9 6146.6 4297.8 4306.6 4352.4 4360.6 4367.1 3806.4 3813.5 3852.0 3862.7 3899.3 5946.3 5952.9 5961.4 5966.6 5972.6 6260.3 6267.7 6280.0 6285.7 6287.3 5720.3 5743.9 5945.0 5945.4 5981.2 5249.6 5258.4 5278.8 5286.0 5288.5 6496.5 6535.4 6539.3 6542.1 6543.4 6046.6 6246.7 6253.5 6275.8 6311.1 6372.5 6423.4 6433.4 6462.7 6474.8 6204.8 6207.2 6210.9 6214.2 6221.4 6310.9 6317.0 6320.0 6320.3 6320.6 5797.1 5917.5 6016.6 6054.2 6082.8 6107.7 6114.0 6119.8 6123.2 6124.9 5829.5 6087.6 6089.3 6092.3 6105.9 5957.5 6016.6 6071.9 6130.5 6166.6 5996.9 6028.3 6037.8 6055.6 6073.3 11:15:26 INFO - PROCESS | 3428 | 11:15:26 INFO - PROCESS | 3428 | [#1] ext.html Cycles:180 Average:49027.33 Median:33537.33 stddev:88307.23 (263.3%) stddev-sans-first:88480.56 11:15:26 INFO - PROCESS | 3428 | Values: 750.4 835.4 851.3 913.6 915.3 31727.4 42552.0 43626.0 43741.6 43745.0 40699.0 40841.0 40910.4 45113.3 45338.5 7446.3 7596.6 9016.0 9149.1 9149.2 10564.5 10654.1 10728.8 10752.7 10757.5 10755.1 10794.6 10800.6 10809.1 10813.1 10698.6 10735.8 10748.8 10753.8 10757.2 10573.8 10633.5 10636.5 10640.2 10643.9 42421.4 42575.0 42647.0 42752.1 43038.8 3956.3 4001.8 4014.6 4081.3 4108.9 30011.7 30077.5 30276.8 30298.4 30396.4 4118.4 4176.1 4225.1 4236.0 4320.1 352774.0 358405.0 360444.0 361882.0 362018.2 42758.6 42922.0 42948.4 42964.1 42999.8 44606.0 44649.6 44712.8 44748.0 44774.0 14728.8 14835.0 14854.2 15308.8 15309.9 11979.7 12180.7 13510.9 13515.3 13584.9 12606.6 12697.5 12802.5 12860.2 12919.4 5550.5 5613.3 5634.5 5660.1 5662.9 1004.4 1010.5 1016.8 1021.4 1034.6 29360.6 29572.9 29689.3 29926.4 30081.2 1086.9 1087.8 1122.4 1125.1 1125.2 14869.7 15685.6 15719.1 15758.6 15922.3 338585.0 339637.0 340080.0 340365.0 341720.0 58001.0 58325.7 58558.7 58594.0 58855.4 1506.0 1510.8 1525.8 1557.4 1573.4 26803.7 28125.4 28233.9 28320.3 28396.9 23037.9 23052.8 23081.9 23088.0 23149.2 303992.0 308085.0 309381.0 309542.0 309663.0 27521.7 28108.2 32623.2 33223.5 33387.3 43356.0 43574.3 44309.8 44886.8 48575.5 34608.0 35289.5 35399.3 35674.6 35726.5 35139.0 35264.5 35321.8 35342.3 35554.1 39774.0 39806.4 39948.2 40048.6 41160.2 33687.3 33860.7 34312.0 34520.5 34553.1 26630.0 26993.3 27530.9 27609.2 27705.9 11:15:26 INFO - PROCESS | 3428 | 11:15:26 INFO - PROCESS | 3428 | [#2] jquery.html Cycles:180 Average:37151.43 Median:12885.65 stddev:103561.29 (803.7%) stddev-sans-first:103815.02 11:15:26 INFO - PROCESS | 3428 | Values: 391.9 451.7 452.1 463.8 466.8 20152.3 20869.2 21457.1 21573.9 21589.1 21771.7 22144.9 22313.9 22820.9 23408.8 6592.1 6810.3 6818.6 7343.4 7629.5 7462.8 7653.9 7701.4 7711.1 7727.3 7727.2 7785.4 7791.0 7794.2 7796.2 7282.4 7303.9 7322.9 7387.3 7741.1 7105.6 7146.1 7148.5 7185.2 7583.2 26154.3 26221.3 26412.5 26684.9 26807.3 3368.3 3579.6 3591.4 3650.7 3672.7 15662.0 16230.0 16455.7 16653.9 16950.0 2255.6 2333.2 2362.5 2395.7 2406.7 116233.4 119947.4 120024.4 120234.4 121319.0 14658.1 17359.4 17443.2 18909.8 18980.2 32267.8 32287.2 32530.2 32599.8 32727.0 10853.7 10875.3 10936.0 11062.4 11159.1 9201.1 9300.3 9365.0 9564.4 9583.6 8922.5 9235.4 9450.3 9456.5 9520.0 3935.3 3998.4 3999.0 4087.2 4094.3 956.6 966.9 973.7 981.2 990.7 20660.2 21694.7 21833.0 21869.0 21886.3 987.6 996.6 997.6 999.2 1003.7 10842.5 11460.5 11490.6 11517.3 11677.4 611824.0 613436.0 628812.0 637897.0 644898.0 97735.0 98786.0 110910.0 120275.4 121832.4 1352.7 1386.1 1411.6 1415.7 1418.5 14529.9 18355.2 18887.7 20167.4 20219.6 51774.5 52066.5 52916.7 53088.0 53240.0 61222.4 62565.7 66025.0 73355.0 73859.6 12804.5 12923.2 13031.2 13155.0 13284.3 13888.4 14163.7 14342.7 14627.0 14752.0 12605.3 12830.2 12912.5 13177.2 13185.7 11758.7 12085.8 12317.6 12417.8 12860.1 12683.1 13188.5 13194.3 13238.0 13489.9 13014.9 13242.3 13310.8 13312.5 13316.3 13017.5 13084.9 13123.2 13152.9 13468.7 11:15:26 INFO - PROCESS | 3428 | 11:15:26 INFO - PROCESS | 3428 | [#3] mootools.html Cycles:180 Average:7036.39 Median:2323.33 stddev:4442.54 (191.2%) stddev-sans-first:4435.63 11:15:26 INFO - PROCESS | 3428 | Values: 1515.2 1522.9 1555.3 1568.1 1575.3 10574.2 11349.6 11353.4 11361.0 11368.6 10975.3 11285.9 11293.9 11304.4 11328.0 2380.8 2403.1 2414.1 2414.9 2416.9 2171.4 2175.1 2196.1 2204.0 2348.6 2353.8 2419.8 2426.3 2510.8 2523.2 2275.1 2298.2 2305.5 2307.5 2339.1 2362.9 2369.3 2372.6 2377.9 2382.0 11246.6 11287.3 11325.8 11332.6 11344.5 5469.4 5749.7 5786.0 5788.4 5793.1 3335.2 3403.5 3426.4 3465.6 3482.2 1256.5 1272.6 1283.9 1319.8 1320.7 14202.0 14491.9 15728.4 17170.2 17447.1 4795.7 4866.2 4873.2 4893.3 4925.9 13042.6 13050.5 13051.4 13065.2 13070.7 5018.5 5168.4 5790.4 5894.7 5987.7 5329.3 5377.7 5399.4 5408.4 5414.4 4029.7 4076.2 4137.4 4153.6 4153.9 1057.0 1065.8 1070.0 1078.8 1082.7 1035.1 1043.7 1055.1 1056.7 1063.4 6838.1 6977.1 6986.2 7077.6 7126.8 1012.3 1046.8 1058.0 1103.6 1124.6 4548.4 4605.5 4636.4 4665.2 4673.2 13801.9 14405.1 14410.4 14419.9 14447.9 13865.5 14237.9 14276.4 14297.4 14328.9 10252.4 10299.1 10384.1 10403.1 10408.4 7116.4 7169.9 7197.5 7203.6 7220.9 12879.8 12953.8 13211.1 13289.7 13311.0 9834.1 12662.1 12723.9 13184.9 13485.3 9891.4 10001.3 10031.6 10039.0 10078.7 10803.6 10813.5 10858.7 10884.9 11007.1 9256.7 9310.3 9314.3 9337.3 9442.5 8933.5 9128.5 9138.6 9157.5 9233.0 8542.3 8613.7 8682.4 8685.7 8713.0 6339.1 6411.3 6419.8 6444.7 6521.8 6057.8 6234.4 6286.1 6340.3 6441.2 11:15:26 INFO - PROCESS | 3428 | 11:15:26 INFO - PROCESS | 3428 | [#4] prototype.html Cycles:180 Average:4857.36 Median:5317.40 stddev:1268.80 (23.9%) stddev-sans-first:1227.44 11:15:26 INFO - PROCESS | 3428 | Values: 398.9 401.6 416.0 420.0 422.3 5038.6 5145.3 5317.4 5320.3 5331.6 5077.5 5216.2 5222.4 5232.7 5240.3 4578.5 4605.2 4610.4 4630.6 4631.6 4469.4 4551.8 4595.1 4666.3 4689.0 4502.1 4569.9 4589.5 4597.7 4627.4 4597.0 4608.9 4632.8 4636.9 4666.3 4355.5 4387.9 4448.5 4529.0 4539.5 5166.2 5178.6 5193.6 5199.6 5207.8 5268.9 5317.4 5354.3 5374.8 5386.5 5244.9 5446.6 5548.1 5578.8 5591.2 4607.7 4632.0 4642.5 4655.5 4655.8 5748.2 5769.4 5776.4 5781.5 5795.0 4470.3 4718.4 4729.5 4751.2 4842.6 4807.3 4836.9 4857.0 4865.9 4868.5 5094.9 5158.4 5161.9 5178.8 5185.4 5281.3 5454.2 5494.4 5545.5 5549.8 1584.3 1619.5 1657.7 1683.7 1690.6 1268.8 1294.7 1302.9 1310.1 1325.6 5314.6 5334.4 5351.3 5395.2 5402.3 5600.8 5626.4 5628.4 5629.5 5665.4 5244.0 5285.9 5353.6 5369.2 5422.5 2976.4 2979.0 2983.7 2988.4 2999.4 5551.2 5864.8 5890.4 5899.4 5911.7 5671.9 5682.6 5713.0 5723.6 5744.7 5735.4 5766.7 5801.0 5909.4 5918.8 5495.9 5599.8 5667.7 5693.6 5711.8 5548.5 5566.4 5573.2 5595.4 5596.4 5546.9 5787.9 5824.4 5853.6 5857.2 4719.2 4726.5 4741.5 4747.7 4756.5 5425.6 5574.9 5591.3 5699.4 5726.3 5484.5 5528.6 5588.6 5590.4 5616.3 5514.6 5524.3 5537.5 5543.8 5558.9 5281.9 5492.8 5511.6 5514.8 5587.0 5544.4 5615.7 5643.6 5662.7 5670.7 5257.2 5420.0 5428.8 5499.2 5514.6 11:15:26 INFO - PROCESS | 3428 | 11:15:26 INFO - PROCESS | 3428 | [#5] yui.html Cycles:180 Average:17514.66 Median:44037.06 stddev:20291.14 (46.1%) stddev-sans-first:20309.48 11:15:26 INFO - PROCESS | 3428 | Values: 853.3 874.3 914.4 916.7 956.5 17362.0 18391.1 18421.0 18426.9 18443.2 12196.4 16813.7 16989.2 17001.0 17026.0 893.8 917.2 919.2 919.2 920.3 908.5 908.5 908.7 908.9 911.2 957.3 957.8 958.2 958.2 958.7 944.5 944.6 954.0 955.6 955.6 691.8 692.5 693.7 700.5 700.6 15814.1 15846.4 15949.0 15953.6 15998.9 16304.8 16432.7 16663.6 16674.7 17670.2 12937.2 13143.3 13167.3 13190.0 13247.7 4157.2 4171.7 4182.1 4213.5 4315.0 48969.0 50226.5 53910.7 69476.0 85566.6 12748.1 12961.5 12998.9 13070.6 13258.7 25475.4 25581.5 25706.5 25745.5 25793.1 9086.5 9110.5 9195.5 9211.4 9211.6 5061.9 5080.3 5126.8 5135.0 5257.0 3669.7 3765.6 3768.6 3771.1 3786.8 617.5 672.8 689.2 701.4 702.4 735.8 742.4 745.2 755.1 760.8 11100.2 11793.4 12110.4 12182.5 12286.6 797.3 810.2 810.4 825.2 829.1 5515.2 5544.3 5557.8 5600.2 5622.2 59167.7 66402.7 68315.7 71018.6 87004.0 54688.2 59603.0 64677.7 65456.7 67144.0 61541.0 62140.4 62463.4 62533.7 64004.4 10608.5 11212.7 11225.7 11240.9 11358.0 37089.0 37531.0 42401.4 43682.3 44391.8 56094.0 56280.4 56958.4 57857.4 57970.0 13213.6 13398.9 13556.3 13787.1 13995.1 16163.3 16387.9 16469.8 16575.1 16918.6 15599.0 15641.7 15769.9 16365.1 16417.8 14377.1 14396.9 14429.5 14456.3 14547.0 14956.4 14980.9 15467.6 16259.8 16276.4 9793.7 9900.6 9982.0 10210.2 10337.2 11827.7 12310.5 12447.5 12652.4 12715.5 11:15:26 INFO - PROCESS | 3428 | -------- Summary: end -------- 11:15:26 INFO - PROCESS | 3428 | 11:15:27 INFO - TEST-INFO | 3428: exit 0 11:15:27 INFO - TEST-OK | dromaeo_css | took 1116473ms 11:15:27 INFO - TEST-START | kraken 11:15:27 INFO - operating with platform_type : linux_ 11:15:27 INFO - Initialising browser for kraken test... 11:15:27 INFO - TEST-INFO | started process 3735 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIbJrRJ/profile http://localhost:51654/getInfo.html) 11:15:31 INFO - PROCESS | 3735 | __metrics Screen width/height:1600/1200 11:15:31 INFO - PROCESS | 3735 | colorDepth:24 11:15:31 INFO - PROCESS | 3735 | Browser inner width/height: 1024/697 11:15:31 INFO - PROCESS | 3735 | __metrics 11:15:32 INFO - PROCESS | 3735 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:15:32 INFO - PROCESS | 3735 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:15:33 INFO - PROCESS | 3735 | console.error: PushService: 11:15:33 INFO - PROCESS | 3735 | stateChangeProcessEnqueue: Error transitioning state 11:15:33 INFO - PROCESS | 3735 | UnknownError 11:15:33 INFO - TEST-INFO | 3735: exit 0 11:15:33 INFO - Browser initialized. 11:15:33 INFO - Running cycle 1/1 for kraken test... 11:15:33 INFO - TEST-INFO | started process 3827 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIbJrRJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:15:45 INFO - PROCESS | 3827 | RSS: Main: 141508608 11:15:45 INFO - PROCESS | 3827 | 11:15:48 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:51654/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51654/tests/kraken/driver.html?testName=audio-beat-detection) 11:15:49 INFO - PROCESS | 3827 | RSS: Main: 184250368 11:15:49 INFO - PROCESS | 3827 | 11:15:51 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:51654/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51654/tests/kraken/driver.html?testName=audio-dft) 11:15:52 INFO - PROCESS | 3827 | RSS: Main: 173203456 11:15:52 INFO - PROCESS | 3827 | 11:15:54 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:51654/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51654/tests/kraken/driver.html?testName=audio-fft) 11:15:55 INFO - PROCESS | 3827 | RSS: Main: 265121792 11:15:55 INFO - PROCESS | 3827 | 11:15:57 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:51654/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51654/tests/kraken/driver.html?testName=audio-oscillator) 11:15:58 INFO - PROCESS | 3827 | RSS: Main: 171765760 11:15:58 INFO - PROCESS | 3827 | 11:16:00 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:51654/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51654/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:16:00 INFO - PROCESS | 3827 | RSS: Main: 174276608 11:16:00 INFO - PROCESS | 3827 | 11:16:03 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:51654/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51654/tests/kraken/driver.html?testName=imaging-darkroom) 11:16:04 INFO - PROCESS | 3827 | RSS: Main: 211079168 11:16:04 INFO - PROCESS | 3827 | 11:16:07 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:51654/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51654/tests/kraken/driver.html?testName=imaging-desaturate) 11:16:08 INFO - PROCESS | 3827 | RSS: Main: 212979712 11:16:08 INFO - PROCESS | 3827 | 11:16:11 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:51654/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51654/tests/kraken/driver.html?testName=json-parse-financial) 11:16:11 INFO - PROCESS | 3827 | RSS: Main: 211677184 11:16:11 INFO - PROCESS | 3827 | 11:16:13 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:51654/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51654/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:16:13 INFO - PROCESS | 3827 | RSS: Main: 173846528 11:16:13 INFO - PROCESS | 3827 | 11:16:15 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:51654/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51654/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:16:16 INFO - PROCESS | 3827 | RSS: Main: 180011008 11:16:16 INFO - PROCESS | 3827 | 11:16:18 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:51654/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51654/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:16:18 INFO - PROCESS | 3827 | RSS: Main: 190201856 11:16:18 INFO - PROCESS | 3827 | 11:16:21 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:51654/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51654/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:16:21 INFO - PROCESS | 3827 | RSS: Main: 198696960 11:16:21 INFO - PROCESS | 3827 | 11:16:24 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:51654/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51654/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:16:25 INFO - PROCESS | 3827 | RSS: Main: 195215360 11:16:25 INFO - PROCESS | 3827 | 11:16:26 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:51654/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51654/tests/kraken/driver.html?testName=ai-astar) 11:16:27 INFO - PROCESS | 3827 | RSS: Main: 245968896 11:16:27 INFO - PROCESS | 3827 | 11:16:27 INFO - PROCESS | 3827 | __start_tp_report 11:16:27 INFO - PROCESS | 3827 | _x_x_mozilla_page_load 11:16:27 INFO - PROCESS | 3827 | _x_x_mozilla_page_load_details 11:16:27 INFO - PROCESS | 3827 | |i|pagename|runs| 11:16:27 INFO - PROCESS | 3827 | |0;ai-astar;105;115;114;115;115;115;115;113;114;114 11:16:27 INFO - PROCESS | 3827 | |1;audio-beat-detection;137;115;115;154;118;116;117;120;140;116 11:16:27 INFO - PROCESS | 3827 | |2;audio-dft;161;160;161;161;161;160;160;160;163;159 11:16:27 INFO - PROCESS | 3827 | |3;audio-fft;74;75;75;111;76;76;77;75;95;75 11:16:27 INFO - PROCESS | 3827 | |4;audio-oscillator;81;82;103;83;81;82;96;82;82;105 11:16:27 INFO - PROCESS | 3827 | |5;imaging-gaussian-blur;112;113;113;114;114;113;113;113;113;113 11:16:27 INFO - PROCESS | 3827 | |6;imaging-darkroom;147;146;146;146;146;145;146;146;147;146 11:16:27 INFO - PROCESS | 3827 | |7;imaging-desaturate;94;94;93;94;94;94;94;94;94;94 11:16:27 INFO - PROCESS | 3827 | |8;json-parse-financial;57;53;54;53;57;54;54;57;54;53 11:16:27 INFO - PROCESS | 3827 | |9;json-stringify-tinderbox;52;52;52;53;54;53;53;53;53;53 11:16:27 INFO - PROCESS | 3827 | |10;stanford-crypto-aes;79;76;80;79;79;80;80;81;78;76 11:16:27 INFO - PROCESS | 3827 | |11;stanford-crypto-ccm;126;119;120;131;118;119;120;117;166;125 11:16:27 INFO - PROCESS | 3827 | |12;stanford-crypto-pbkdf2;163;164;162;162;160;162;161;158;159;158 11:16:27 INFO - PROCESS | 3827 | |13;stanford-crypto-sha256-iterative;59;62;62;65;64;62;60;60;59;59 11:16:27 INFO - PROCESS | 3827 | __end_tp_report 11:16:27 INFO - PROCESS | 3827 | __start_cc_report 11:16:27 INFO - PROCESS | 3827 | _x_x_mozilla_cycle_collect,1643 11:16:27 INFO - PROCESS | 3827 | __end_cc_report 11:16:27 INFO - PROCESS | 3827 | __startTimestamp1495563387157__endTimestamp 11:16:27 INFO - PROCESS | 3827 | 11:16:27 INFO - PROCESS | 3827 | ------- Summary: start ------- 11:16:27 INFO - PROCESS | 3827 | Number of tests: 14 11:16:27 INFO - PROCESS | 3827 | 11:16:27 INFO - PROCESS | 3827 | [#0] ai-astar Cycles:10 Average:113.50 Median:115.00 stddev:3.06 (2.7%) stddev-sans-first:0.73 11:16:27 INFO - PROCESS | 3827 | Values: 105.0 115.0 114.0 115.0 115.0 115.0 115.0 113.0 114.0 114.0 11:16:27 INFO - PROCESS | 3827 | 11:16:27 INFO - PROCESS | 3827 | [#1] audio-beat-detection Cycles:10 Average:124.80 Median:119.00 stddev:13.78 (11.6%) stddev-sans-first:13.89 11:16:27 INFO - PROCESS | 3827 | Values: 137.0 115.0 115.0 154.0 118.0 116.0 117.0 120.0 140.0 116.0 11:16:27 INFO - PROCESS | 3827 | 11:16:27 INFO - PROCESS | 3827 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 11:16:27 INFO - PROCESS | 3827 | Values: 161.0 160.0 161.0 161.0 161.0 160.0 160.0 160.0 163.0 159.0 11:16:27 INFO - PROCESS | 3827 | 11:16:27 INFO - PROCESS | 3827 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.50 stddev:12.27 (16.3%) stddev-sans-first:12.76 11:16:27 INFO - PROCESS | 3827 | Values: 74.0 75.0 75.0 111.0 76.0 76.0 77.0 75.0 95.0 75.0 11:16:27 INFO - PROCESS | 3827 | 11:16:27 INFO - PROCESS | 3827 | [#4] audio-oscillator Cycles:10 Average:87.70 Median:82.00 stddev:9.68 (11.8%) stddev-sans-first:9.96 11:16:27 INFO - PROCESS | 3827 | Values: 81.0 82.0 103.0 83.0 81.0 82.0 96.0 82.0 82.0 105.0 11:16:27 INFO - PROCESS | 3827 | 11:16:27 INFO - PROCESS | 3827 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 11:16:27 INFO - PROCESS | 3827 | Values: 112.0 113.0 113.0 114.0 114.0 113.0 113.0 113.0 113.0 113.0 11:16:27 INFO - PROCESS | 3827 | 11:16:27 INFO - PROCESS | 3827 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 11:16:27 INFO - PROCESS | 3827 | Values: 147.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 147.0 146.0 11:16:27 INFO - PROCESS | 3827 | 11:16:27 INFO - PROCESS | 3827 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:16:27 INFO - PROCESS | 3827 | Values: 94.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 11:16:27 INFO - PROCESS | 3827 | 11:16:27 INFO - PROCESS | 3827 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.00 stddev:1.71 (3.2%) stddev-sans-first:1.58 11:16:27 INFO - PROCESS | 3827 | Values: 57.0 53.0 54.0 53.0 57.0 54.0 54.0 57.0 54.0 53.0 11:16:27 INFO - PROCESS | 3827 | 11:16:27 INFO - PROCESS | 3827 | [#9] json-stringify-tinderbox Cycles:10 Average:52.80 Median:53.00 stddev:0.63 (1.2%) stddev-sans-first:0.60 11:16:27 INFO - PROCESS | 3827 | Values: 52.0 52.0 52.0 53.0 54.0 53.0 53.0 53.0 53.0 53.0 11:16:27 INFO - PROCESS | 3827 | 11:16:27 INFO - PROCESS | 3827 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:79.50 stddev:1.69 (2.1%) stddev-sans-first:1.79 11:16:27 INFO - PROCESS | 3827 | Values: 79.0 76.0 80.0 79.0 79.0 80.0 80.0 81.0 78.0 76.0 11:16:27 INFO - PROCESS | 3827 | 11:16:27 INFO - PROCESS | 3827 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:122.50 stddev:14.69 (12.0%) stddev-sans-first:15.58 11:16:27 INFO - PROCESS | 3827 | Values: 126.0 119.0 120.0 131.0 118.0 119.0 120.0 117.0 166.0 125.0 11:16:27 INFO - PROCESS | 3827 | 11:16:27 INFO - PROCESS | 3827 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:162.00 stddev:2.08 (1.3%) stddev-sans-first:2.06 11:16:27 INFO - PROCESS | 3827 | Values: 163.0 164.0 162.0 162.0 160.0 162.0 161.0 158.0 159.0 158.0 11:16:27 INFO - PROCESS | 3827 | 11:16:27 INFO - PROCESS | 3827 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.20 Median:62.00 stddev:2.15 (3.5%) stddev-sans-first:2.13 11:16:27 INFO - PROCESS | 3827 | Values: 59.0 62.0 62.0 65.0 64.0 62.0 60.0 60.0 59.0 59.0 11:16:27 INFO - PROCESS | 3827 | -------- Summary: end -------- 11:16:27 INFO - PROCESS | 3827 | 11:16:28 INFO - TEST-INFO | 3827: exit 0 11:16:28 INFO - TEST-OK | kraken | took 60609ms 11:16:28 INFO - SUITE-END | took 1177s 11:16:28 INFO - Completed test suite (00:19:37) 11:16:28 INFO - javascript benchmark 11:16:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7874.563706748788, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3382.577177852768, 3409.3863104641155, 3418.5043168740526, 3432.588089429266, 3460.948085778714, 5748.396418376073, 5845.7953971611005, 5849.532037437006, 5857.4435428634315, 5872.61827981182, 5826.446487583683, 5878.823635290937, 5890.116482527623, 5895.0, 5895.85260368491, 5288.894222115556, 5310.230016647583, 5313.176457649051, 5389.6496727712765, 5395.325584301962, 5153.871153221162, 5198.116320225552, 5370.43610420906, 5385.111456609655, 5386.973065134669, 5267.28891599633, 5275.920861187066, 5276.182191760283, 5285.973570132144, 5292.655977361459, 5370.785168593252, 5382.085045542267, 5383.4616538346045, 5388.084025715638, 5417.972910135424, 5136.280920671109, 5241.187615919539, 5293.285406470116, 5357.035733567956, 5358.11591087474, 5659.717014149276, 5718.828435146952, 5721.742521586497, 5731.541476681856, 5739.225204597367, 6188.721507532172, 6200.038993955944, 6231.189945307126, 6233.2208473940755, 6233.376662333776, 6242.282137554149, 6275.592086514362, 6275.592086514362, 6280.748770049193, 6292.779752708633, 5663.858403539944, 5705.286839145107, 5764.250647415809, 5801.042827933428, 5815.767369305265, 6366.618002919747, 6366.745330186834, 6367.172267605181, 6369.0, 6377.74489020434, 6056.0, 6161.353057928943, 6162.691865406712, 6172.0, 6173.32093469718, 6007.729652165663, 6046.969765151234, 6142.069075791497, 6164.291106522717, 6242.406971337807, 6007.909881351783, 6244.313125556185, 6259.092431597484, 6262.906056409158, 6271.090691849657, 6112.1387513176505, 6116.974953844038, 6137.907931380943, 6142.897836592581, 6146.631202127886, 4297.806598703066, 4306.590873866978, 4352.368906508538, 4360.585744354281, 4367.10474352757, 3806.3909774435956, 3813.4851795007876, 3851.980740096282, 3862.6523612874976, 3899.2786334528205, 5946.256717910262, 5952.8809423812145, 5961.360262248012, 5966.612170208922, 5972.552058595623, 6260.311365749764, 6267.6866156692895, 6279.96860015697, 6285.685715714196, 6287.276963149205, 5720.342160651495, 5743.851229754066, 5944.970275148597, 5945.405459454107, 5981.192539007178, 5249.632525723163, 5258.368995720538, 5278.841634750964, 5286.048511267932, 5288.497592728685, 6496.545241833026, 6535.411812936763, 6539.280679125292, 6542.084108224853, 6543.443807276435, 6046.637201767908, 6246.656433896179, 6253.468455181361, 6275.780347687809, 6311.116443697978, 6372.522060845363, 6423.42189202974, 6433.420992110545, 6462.741490340334, 6474.838129046811, 6204.844878878064, 6207.16203312547, 6210.937890621217, 6214.1921550198185, 6221.440070393686, 6310.936890631218, 6316.968415157895, 6320.0, 6320.336364681642, 6320.5575609706875, 5797.072468405035, 5917.526597872074, 6016.608920420159, 6054.152418661479, 6082.817515474543, 6107.6640784757265, 6113.962834745988, 6119.837693858789, 6123.1606109212, 6124.8775024500155, 5829.47534721877, 6087.634741915499, 6089.299730530868, 6092.299385570716, 6105.9084113737445, 5957.49361304294, 6016.639001659914, 6071.908921366271, 6130.47890929276, 6166.630002199882, 5996.910046349395, 6028.306744724413, 6037.818865434044, 6055.636661800306, 6073.271207455134], "value": 5710.5281578389395, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.3809357280245, 835.3985130705892, 851.2508992086963, 913.593450914343, 915.2586405011937, 31727.365452690934, 42552.0, 43626.0, 43741.56258437414, 43745.0, 40699.0, 40841.0, 40910.38634420486, 45113.32330015052, 45338.54661453384, 7446.329830315271, 7596.582187979687, 9015.999999999984, 9149.085091490864, 9149.22231610314, 10564.471776411187, 10654.09440197584, 10728.839067413996, 10752.73118172048, 10757.515911783988, 10755.085817705505, 10794.622188223413, 10800.621978230763, 10809.135269178447, 10813.134949204084, 10698.572057117706, 10735.78528429427, 10748.838767418494, 10753.83869241962, 10757.246992710514, 10573.788524229549, 10633.46832658364, 10636.521356538897, 10640.201984851166, 10643.946780266126, 42421.36367954483, 42575.0, 42647.0, 42752.144957100994, 43038.78480607577, 3956.268090403256, 4001.779902105383, 4014.578469260744, 4081.3061779497557, 4108.91782164358, 30011.699883001107, 30077.548836767248, 30276.848615757, 30298.394032119453, 30396.392072158655, 4118.361653943643, 4176.1230141670285, 4225.084691562812, 4235.97882010588, 4320.1143765527995, 352774.0, 358405.0, 360444.0, 361882.0, 362018.1899090514, 42758.57241427608, 42922.0, 42948.3557746634, 42964.14071718548, 42999.78500107479, 44606.0, 44649.55350446519, 44712.77643611826, 44748.0, 44774.0, 14728.779068313985, 14835.0, 14854.183019933791, 15308.846911530965, 15309.923450382677, 11979.682234954149, 12180.695482613006, 13510.93244533771, 13515.324233788271, 13584.86415135836, 12606.621801345975, 12697.492100315883, 12802.487900483877, 12860.16408933435, 12919.418626161845, 5550.528205102531, 5613.298337707786, 5634.492895639412, 5660.094384898396, 5662.886742265132, 1004.3572113847143, 1010.4695035106628, 1016.7508960304773, 1021.3820638513592, 1034.5861655337926, 29360.559591606143, 29572.852135739184, 29689.257768555526, 29926.40147197044, 30081.247968800955, 1086.8587083679229, 1087.7715679707192, 1122.3995162587976, 1125.128025780027, 1125.1617544928918, 14869.702605947821, 15685.607859803597, 15719.135447550267, 15758.606034849221, 15922.283497242652, 338585.0, 339637.0, 340080.0, 340365.0, 341720.0, 58001.0, 58325.70837145787, 58558.707206463696, 58594.0, 58855.41144588585, 1505.9774103388459, 1510.7582786754285, 1525.7787620795145, 1557.4315374888083, 1573.4414282929624, 26803.73196268012, 28125.437491250468, 28233.858830705714, 28320.291992700346, 28396.85801570979, 23037.88481057584, 23052.769472305063, 23081.88459057694, 23088.0, 23149.189778357675, 303992.0, 308085.0, 309381.0, 309542.0, 309663.0, 27521.724782751917, 28108.156755297372, 32623.18442038873, 33223.501647474826, 33387.332253355286, 43356.0, 43574.34638480362, 44309.778451108825, 44886.77556612196, 48575.5142448571, 34608.0, 35289.47065794066, 35399.292014160084, 35674.643253567134, 35726.46410303796, 35139.0, 35264.471032934016, 35321.823390882884, 35342.293154136256, 35554.11114722153, 39774.0, 39806.402903957045, 39948.2010359797, 40048.59951400448, 41160.176796464504, 33687.32625347529, 33860.66139338575, 34312.0, 34520.48219276663, 34553.136171595914, 26630.0, 26993.325166870985, 27530.862345688143, 27609.171724848286, 27705.86147069252], "value": 18791.647736930747, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.8706826747174, 451.67479414821315, 452.066482713197, 463.837656820113, 466.82260740918457, 20152.294669686544, 20869.165233390664, 21457.141714331407, 21573.892130539327, 21589.1364345426, 21771.6734248986, 22144.8892755536, 22313.888430557865, 22820.8858955705, 23408.76591234087, 6592.077109204703, 6810.250872404032, 6818.5908845469185, 7343.37581305587, 7629.504082234665, 7462.776116716507, 7653.923460765404, 7701.422393320496, 7711.074671039483, 7727.343175830033, 7727.150013498511, 7785.3771698264, 7791.0, 7794.181610930856, 7796.220377962187, 7282.380997615182, 7303.853922921512, 7322.853542929165, 7387.298206670358, 7741.109772376192, 7105.644717764091, 7146.106736657918, 7148.49960502765, 7185.173705023937, 7583.203763604853, 26154.34614134643, 26221.344466388302, 26412.4908133727, 26684.866575666998, 26807.329816754544, 3368.292658541685, 3579.6420357963993, 3591.3894637911617, 3650.7444478886487, 3672.6510981456718, 15662.0, 16230.0, 16455.67088658232, 16653.916730416393, 16950.0, 2255.6390977443693, 2333.2183718454166, 2362.5393048355577, 2395.73646898841, 2406.7352591214953, 116233.41883290614, 119947.40026299813, 120024.39987800093, 120234.39882800617, 121319.0, 14658.128403368064, 17359.392421265195, 17443.21505532254, 18909.81090189108, 18980.240790368505, 32267.838660806545, 32287.192820179214, 32530.186745331557, 32599.837000814845, 32727.0, 10853.728656783644, 10875.347479151276, 10936.0, 11062.391568463812, 11159.051480624237, 9201.125893040151, 9300.255979521622, 9365.033342997911, 9564.378315409476, 9583.568739406743, 8922.509261990523, 9235.367920142728, 9450.291228157777, 9456.52717364129, 9519.958061858702, 3935.311320518898, 3998.4002399640285, 3998.980005099956, 4087.1621317629815, 4094.2835003874798, 956.6364781383169, 966.8646389505475, 973.6786860336072, 981.2101258486987, 990.6681261777385, 20660.17359305641, 21694.674579881314, 21833.0, 21869.0, 21886.343409697736, 987.6197663899451, 996.5714742660725, 997.5610731278215, 999.1706883286854, 1003.6687892995294, 10842.512086956105, 11460.484278207501, 11490.597829075943, 11517.308961462171, 11677.416129193507, 611824.0, 613436.0, 628812.0, 637897.0, 644898.0, 97735.0, 98786.0, 110910.0, 120275.39862300808, 121832.39083804525, 1352.6618345413647, 1386.0990356268505, 1411.5624156511515, 1415.6956254405352, 1418.5035237666734, 14529.854701453272, 18355.174017169527, 18887.672629669214, 20167.394978150678, 20219.59560808805, 51774.482255178475, 52066.47933520616, 52916.73541632267, 53088.0, 53240.043486500974, 61222.38777612167, 62565.68717156385, 66025.0, 73355.0, 73859.63070184615, 12804.487820487077, 12923.224606523263, 13031.152975056591, 13155.0, 13284.335783210607, 13888.375023124187, 14163.716725665636, 14342.713145736818, 14627.049241799248, 14752.0, 12605.30670813114, 12830.16603920742, 12912.548060817826, 13177.209367437985, 13185.736285274432, 11758.70603234926, 12085.758284834079, 12317.568885088978, 12417.813732794197, 12860.099793014399, 12683.11218214753, 13188.538401155913, 13194.34028298562, 13238.0, 13489.932550337186, 13014.869851301366, 13242.271675057964, 13310.800337994744, 13312.46750129984, 13316.267605281802, 13017.544385946447, 13084.934575327063, 13123.212607243597, 13152.934235328763, 13468.730625387241], "value": 11862.905214609107, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1515.227234110604, 1522.9010114342573, 1555.300114948273, 1568.1061794776979, 1575.3383578896862, 10574.206934479906, 11349.602763903275, 11353.375564343958, 11361.034312083473, 11368.60209892654, 10975.341479511235, 11285.943570282157, 11293.943530282357, 11304.434778261075, 11328.0, 2380.809535237181, 2403.062805505854, 2414.058517178302, 2414.927552173429, 2416.903323867043, 2171.4462811983003, 2175.0647221694667, 2196.143504033428, 2204.0, 2348.5772560939026, 2353.7646235376496, 2419.758024197584, 2426.3206302235403, 2510.8242423030397, 2523.1673547729297, 2275.112706044644, 2298.2415802785126, 2305.5043165719367, 2307.5038866643667, 2339.1462116327416, 2362.881855907198, 2369.3010561884284, 2372.5847976604027, 2377.940551486209, 2382.0, 11246.55013799447, 11287.266327688674, 11325.830112548318, 11332.603358882481, 11344.546218151265, 5469.398366179717, 5749.741261643236, 5786.04530252512, 5788.392218817005, 5793.13103034544, 3335.232896433834, 3403.5235067090625, 3426.372473075269, 3465.5668041494814, 3482.2165012872156, 1256.5036810459817, 1272.6245757501558, 1283.9422225999851, 1319.8152258683792, 1320.7028418605832, 14202.0, 14491.855081449261, 15728.37086516538, 17170.22733976974, 17447.12764361777, 4795.712257264575, 4866.221404575251, 4873.244647079709, 4893.266010098514, 4925.901481970341, 13042.608721738363, 13050.477980880658, 13051.412686429134, 13065.150765200231, 13070.673233169247, 5018.473060328686, 5168.379794424618, 5790.420957904176, 5894.734736936848, 5987.730552125165, 5329.280547126166, 5377.677339359651, 5399.406065332811, 5408.350997880201, 5414.40441551429, 4029.6574791142493, 4076.2255171517318, 4137.441445404832, 4153.584641535822, 4153.8961525962095, 1056.9524371403306, 1065.7655315830505, 1069.983950240747, 1078.8219943709357, 1082.6697857153645, 1035.1201478743158, 1043.7286305560608, 1055.1400608504198, 1056.693558867935, 1063.3566692151292, 6838.111045564045, 6977.1278590176225, 6986.161660600659, 7077.646117694095, 7126.821829454305, 1012.291396022787, 1046.7801761629992, 1057.9947100264449, 1103.5530610102921, 1124.5895248234335, 4548.363229147922, 4605.4933957264675, 4636.35091087248, 4665.206914824488, 4673.182193116191, 13801.861981380258, 14405.135691858522, 14410.351534180987, 14419.855801442061, 14447.85552144486, 13865.514706985206, 14237.928810355881, 14276.42894284217, 14297.356618952172, 14328.928355358365, 10252.43611601369, 10299.073083422378, 10384.065434110966, 10403.115735162595, 10408.375497470024, 7116.359527642537, 7169.856602868018, 7197.532160409557, 7203.639818009184, 7220.8916866246, 12879.80680289815, 12953.805692914802, 13211.075224734177, 13289.66775830612, 13311.0, 9834.114929656365, 12662.113652044269, 12723.936380318039, 13184.868151318364, 13485.258310793, 9891.406515609087, 10001.34991225568, 10031.598736050477, 10039.04629060238, 10078.748031299276, 10803.621873234399, 10813.459327033774, 10858.728531786768, 10884.891151088388, 11007.06439952613, 9256.72229833106, 9310.30172737061, 9314.301427392837, 9337.253019758538, 9442.48066356357, 8933.46399216049, 9128.45229286245, 9138.588763505792, 9157.542122893696, 9233.0, 8542.316614670686, 8613.741587752378, 8682.392232543662, 8685.652573897227, 8712.956435217784, 6339.080833279241, 6411.294757576569, 6419.807405777834, 6444.709988050643, 6521.771737989147, 6057.818265452043, 6234.438900498795, 6286.088517165077, 6340.270868850142, 6441.227052753699], "value": 5337.163124283214, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.8982809383607, 401.5783427401228, 416.0015961691939, 419.9622034016938, 422.2784156113847, 5038.596912247021, 5145.253938178962, 5317.38850032246, 5320.334958130234, 5331.573474122066, 5077.5176358246, 5216.24364467152, 5222.4255331913555, 5232.7383630818495, 5240.292560504331, 4578.473475550304, 4605.240135377659, 4610.4467463904375, 4630.560096790799, 4631.583157515823, 4469.418975533176, 4551.795169217393, 4595.103954728829, 4666.2767271073035, 4688.968426946067, 4502.096147984548, 4569.9314510282375, 4589.475788316429, 4597.678162528624, 4627.408651155347, 4596.977015114937, 4608.861734147981, 4632.8146874125, 4636.860894173146, 4666.253399456071, 4355.499117601485, 4387.868363949086, 4448.466184057901, 4529.026259354222, 4539.546045395467, 5166.225066240057, 5178.637495375326, 5193.558547523465, 5199.6360254782185, 5207.765650545734, 5268.947310526884, 5317.41508434072, 5354.250404943311, 5374.7850085996515, 5386.542143917772, 5244.895102097937, 5446.591505637093, 5548.140038294071, 5578.776848926038, 5591.245181900432, 4607.67312507185, 4632.0, 4642.489326174118, 4655.534446555352, 4655.837045703384, 5748.19525266463, 5769.394213607595, 5776.422357764232, 5781.4507621775865, 5794.97102514489, 4470.256599926031, 4718.386609740712, 4729.527047295243, 4751.168545504523, 4842.564169224786, 4807.278908163804, 4836.911694868626, 4856.98435149409, 4865.854024379274, 4868.513148685174, 5094.936550696973, 5158.4067832199025, 5161.870953226125, 5178.844634660966, 5185.429602743695, 5281.329476014133, 5454.236406903036, 5494.395616482184, 5545.528630066489, 5549.805756798492, 1584.2633175573415, 1619.4898606938777, 1657.6904245646047, 1683.671684021604, 1690.5773556610848, 1268.8287081243914, 1294.6569159172827, 1302.863199364072, 1310.087272582041, 1325.6354502511695, 5314.5748340132695, 5334.413214546396, 5351.3043304370185, 5395.190721391823, 5402.324709411324, 5600.795828896726, 5626.43735626434, 5628.352739434936, 5629.480040389072, 5665.413684168439, 5243.973780131151, 5285.920711189336, 5353.625246232804, 5369.221462887859, 5422.53908417781, 2976.407621922261, 2979.0467050544053, 2983.701629836999, 2988.44713727961, 2999.43010827942, 5551.195076713854, 5864.777360300577, 5890.352061273256, 5899.410058994066, 5911.733971971272, 5671.914921276184, 5682.6361673198135, 5712.971435142797, 5723.599348045597, 5744.712764361765, 5735.3977832327, 5766.740496677576, 5801.0, 5909.3795151508475, 5918.763249469973, 5495.890082198413, 5599.796043850592, 5667.659940403589, 5693.572982026281, 5711.828645140652, 5548.500634942713, 5566.359868615161, 5573.21974923503, 5595.440455954372, 5596.38439771633, 5546.898411747046, 5787.8553036174435, 5824.388439213991, 5853.560982926212, 5857.209276747755, 4719.244920812654, 4726.503717109654, 4741.5495527924795, 4747.667663263538, 4756.524347565216, 5425.620206585501, 5574.9442505574425, 5591.266707320744, 5699.430056994267, 5726.255586773693, 5484.451554844483, 5528.612997090165, 5588.636738611977, 5590.440955904377, 5616.326040875121, 5514.558835293086, 5524.293096382824, 5537.501624853782, 5543.835794483042, 5558.91661625084, 5281.947180528299, 5492.835214943558, 5511.586631002771, 5514.751836167302, 5587.010949142189, 5544.390117087037, 5615.6630602164005, 5643.633163844337, 5662.745176466987, 5670.688112153706, 5257.237700533325, 5420.0, 5428.83713488596, 5499.212755854283, 5514.5864060196445], "value": 4484.491283147032, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [853.3130829682103, 874.3474832566446, 914.4147745442917, 916.6931511202923, 956.4643799472294, 17362.0, 18391.08044597768, 18421.0, 18426.907865460653, 18443.17005734742, 12196.390180490984, 16813.66372672546, 16989.2354844032, 17001.0, 17026.0, 893.8033632600834, 917.1837065012145, 919.1589695428675, 919.1635611593418, 920.3465539466987, 908.5275656658533, 908.5275656658533, 908.6910450446846, 908.8818453601056, 911.1753862754218, 957.3011701457905, 957.7701351675618, 958.1855422890523, 958.2142643032716, 958.702802131338, 944.527736131934, 944.603266628011, 953.9744774367548, 955.5508910811873, 955.5508910811907, 691.7544271783495, 692.4771797293062, 693.715576613586, 700.5411455496658, 700.5971566349318, 15814.051156930505, 15846.445374411956, 15949.0, 15953.601159971093, 15998.920005400016, 16304.83695163045, 16432.671346573003, 16663.583410414714, 16674.666506669797, 17670.204840782197, 12937.159084659466, 13143.34283285832, 13167.266866954482, 13190.0, 13247.668808279774, 4157.168566286755, 4171.749695018309, 4182.079942412664, 4213.47331583552, 4314.9784251078545, 48969.0, 50226.54940958346, 53910.730446347516, 69476.0, 85566.57216713938, 12748.107632465639, 12961.546345877849, 12998.935005324913, 13070.607881763563, 13258.668533286746, 25475.36311592225, 25581.48837023249, 25706.48587028249, 25745.485090298465, 25793.097241596828, 9086.500242486594, 9110.544472776335, 9195.540222988824, 9211.40125891815, 9211.631534738535, 5061.873453163626, 5080.339555857789, 5126.794928202905, 5135.0, 5257.0, 3669.743117981769, 3765.6046115157515, 3768.6231376862643, 3771.132639492932, 3786.772793632391, 617.5059952038351, 672.7981605518324, 689.2142957028991, 701.3792793377897, 702.357343031131, 735.8123678461958, 742.38011260598, 745.1803016681607, 755.0524092264174, 760.7983884270673, 11100.222984391177, 11793.351365674971, 12110.384937944422, 12182.512699492097, 12286.631401057983, 797.3023604346197, 810.2221867007738, 810.3598157455544, 825.2449009156675, 829.088003196479, 5515.227868098469, 5544.276586851418, 5557.777688892399, 5600.215969764236, 5622.24099746529, 59167.70416147892, 66402.66798666073, 68315.65842170856, 71018.64490677617, 87004.0, 54688.17967730487, 59603.0, 64677.67661161664, 65456.67271663611, 67144.0, 61541.0, 62140.37859621437, 62463.37536624575, 62533.68733156305, 64004.359956400775, 10608.522616482123, 11212.66362009141, 11225.66323010311, 11240.943795280971, 11358.0, 37089.0, 37531.0, 42401.36397953972, 43682.34476482919, 44391.77804110959, 56094.0, 56280.43719562916, 56958.430415695315, 57857.4214257852, 57970.0, 13213.603591892259, 13398.933005334911, 13556.322183890568, 13787.103838250883, 13995.090319129224, 16163.272652730891, 16387.9180604101, 16469.752953705465, 16575.088370139758, 16918.57703557421, 15599.0, 15641.673267475031, 15769.921150394175, 16365.099919504542, 16417.753733694244, 14377.065490743069, 14396.856031439971, 14429.49496767608, 14456.349464273922, 14547.0, 14956.40174393012, 14980.85019149838, 15467.613309667347, 16259.75610365869, 16276.43032493857, 9793.706188814347, 9900.554475048784, 9981.950090249502, 10210.234232432449, 10337.224708147069, 11827.704307392383, 12310.507579696712, 12447.502099916264, 12652.367381631066, 12715.491380344683], "value": 7824.643725626503, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1455.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 114.0, 115.0, 115.0, 115.0, 115.0, 113.0, 114.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 115.0, 115.0, 154.0, 118.0, 116.0, 117.0, 120.0, 140.0, 116.0], "value": 124.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 161.0, 160.0, 160.0, 160.0, 163.0, 159.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 111.0, 76.0, 76.0, 77.0, 75.0, 95.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 103.0, 83.0, 81.0, 82.0, 96.0, 82.0, 82.0, 105.0], "value": 87.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 113.0, 114.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 147.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 54.0, 53.0, 57.0, 54.0, 54.0, 57.0, 54.0, 53.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 53.0, 54.0, 53.0, 53.0, 53.0, 53.0, 53.0], "value": 52.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 80.0, 79.0, 79.0, 80.0, 80.0, 81.0, 78.0, 76.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 119.0, 120.0, 131.0, 118.0, 119.0, 120.0, 117.0, 166.0, 125.0], "value": 126.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 162.0, 160.0, 162.0, 161.0, 158.0, 159.0, 158.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 62.0, 65.0, 64.0, 62.0, 60.0, 60.0, 59.0, 59.0], "value": 61.2, "unit": "score"}]}]} 11:16:28 INFO - Return code: 0 11:16:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:16:28 INFO - # TBPL SUCCESS # 11:16:28 INFO - Running post-action listener: _resource_record_post_action 11:16:28 INFO - [mozharness: 2017-05-23 18:16:28.490142Z] Finished run-tests step (success) 11:16:28 INFO - Running post-run listener: _resource_record_post_run 11:16:28 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 7471104; Write bytes: 337625088; Read time: 880; Write time: 212596 11:16:28 INFO - TinderboxPrint: CPU usage
13.1% 11:16:28 INFO - TinderboxPrint: I/O read bytes / time
7,471,104 / 880 11:16:28 INFO - TinderboxPrint: I/O write bytes / time
337,625,088 / 212,596 11:16:28 INFO - TinderboxPrint: CPU idle
8,264.8 (86.8%) 11:16:28 INFO - TinderboxPrint: CPU user
1,200.1 (12.6%) 11:16:28 INFO - TinderboxPrint: Swap in / out
0 / 0 11:16:28 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 112984064; Read time: 0; Write time: 98256 11:16:28 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 5255168; Write bytes: 224641024; Read time: 656; Write time: 114340 11:16:29 INFO - Running post-run listener: _upload_blobber_files 11:16:29 INFO - Blob upload gear active. 11:16:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:16:29 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 11:16:29 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:16:29 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:16:29 INFO - (blobuploader) - INFO - Open directory for files ... 11:16:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:16:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:16:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:16:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:16:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:16:30 INFO - (blobuploader) - INFO - Done attempting. 11:16:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:16:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:16:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:16:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:16:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:16:33 INFO - (blobuploader) - INFO - Done attempting. 11:16:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:16:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:16:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:16:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:16:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:16:34 INFO - (blobuploader) - INFO - Done attempting. 11:16:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:16:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:16:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:16:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:16:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:16:35 INFO - (blobuploader) - INFO - Done attempting. 11:16:35 INFO - (blobuploader) - INFO - Iteration through files over. 11:16:35 INFO - Return code: 0 11:16:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:16:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:16:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6e18fb9dedba340027eef155838bf0879e10a5b32b7a00e3391477b16370809dabfab478301b2f6ea192b6f61dd4abfb951dc2cac858995bc12eae6feecafa2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/750696a6170db29764245704b087de5885041e72d945b0db2c56c073192fa5da0babcb39fbeec9c67f9f76d866a4979a57ea42e11d2c7e94a5576d472fbac517", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5962fa1a1c9bc4622cef35dd8f9ed88090731a2913df6c12685e38b514602ed7e3766111ac6d788a76906183e4f65995f4c28834525daf9679fc0799a93c7505", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e6ef567d49f24155795b2a01734ed7a2920e3a231789e2306a8397507d3bc0e2e7992a25382aa19e415e82018a708e0c350ed6c14da850581eed12228b74ee18"} 11:16:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:16:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:16:35 INFO - Contents: 11:16:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6e18fb9dedba340027eef155838bf0879e10a5b32b7a00e3391477b16370809dabfab478301b2f6ea192b6f61dd4abfb951dc2cac858995bc12eae6feecafa2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/750696a6170db29764245704b087de5885041e72d945b0db2c56c073192fa5da0babcb39fbeec9c67f9f76d866a4979a57ea42e11d2c7e94a5576d472fbac517", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5962fa1a1c9bc4622cef35dd8f9ed88090731a2913df6c12685e38b514602ed7e3766111ac6d788a76906183e4f65995f4c28834525daf9679fc0799a93c7505", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e6ef567d49f24155795b2a01734ed7a2920e3a231789e2306a8397507d3bc0e2e7992a25382aa19e415e82018a708e0c350ed6c14da850581eed12228b74ee18"} 11:16:35 INFO - Running post-run listener: copy_logs_to_upload_dir 11:16:35 INFO - Copying logs to upload dir... 11:16:35 INFO - mkdir: /builds/slave/test/build/upload/logs 11:16:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.041981 ========= master_lag: 0.53 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-23 11:16:35.656102) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-23 11:16:35.663757) ========= 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=cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6e18fb9dedba340027eef155838bf0879e10a5b32b7a00e3391477b16370809dabfab478301b2f6ea192b6f61dd4abfb951dc2cac858995bc12eae6feecafa2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/750696a6170db29764245704b087de5885041e72d945b0db2c56c073192fa5da0babcb39fbeec9c67f9f76d866a4979a57ea42e11d2c7e94a5576d472fbac517", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5962fa1a1c9bc4622cef35dd8f9ed88090731a2913df6c12685e38b514602ed7e3766111ac6d788a76906183e4f65995f4c28834525daf9679fc0799a93c7505", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e6ef567d49f24155795b2a01734ed7a2920e3a231789e2306a8397507d3bc0e2e7992a25382aa19e415e82018a708e0c350ed6c14da850581eed12228b74ee18"} build_url:https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011185 build_url: 'https://queue.taskcluster.net/v1/task/PT7dQbQpTOWk_qKq63Ul6A/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6e18fb9dedba340027eef155838bf0879e10a5b32b7a00e3391477b16370809dabfab478301b2f6ea192b6f61dd4abfb951dc2cac858995bc12eae6feecafa2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/750696a6170db29764245704b087de5885041e72d945b0db2c56c073192fa5da0babcb39fbeec9c67f9f76d866a4979a57ea42e11d2c7e94a5576d472fbac517", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5962fa1a1c9bc4622cef35dd8f9ed88090731a2913df6c12685e38b514602ed7e3766111ac6d788a76906183e4f65995f4c28834525daf9679fc0799a93c7505", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e6ef567d49f24155795b2a01734ed7a2920e3a231789e2306a8397507d3bc0e2e7992a25382aa19e415e82018a708e0c350ed6c14da850581eed12228b74ee18"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-23 11:16:35.688532) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 11:16:35.688860) ========= 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=cbe409c6de289db6ac707de3000001d4-1495562138.227343-1184611790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 11:16:35.770069) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-23 11:16:35.773415) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-23 11:16:35.773713) ========= ========= Total master_lag: 0.68 =========