builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-057 starttime: 1494443904.39 results: success (0) revision: ce2218406119c36a551e3faea4e192186ee46cc5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:24.387740) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:24.388173) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:24.388461) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:24.403075) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:24.403350) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-10 12:18:24-- 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% 37.2M=0s 2017-05-10 12:18:24 (37.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132969 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:24.550989) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:24.551303) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015665 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:24.604119) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:24.607530) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ce2218406119c36a551e3faea4e192186ee46cc5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev ce2218406119c36a551e3faea4e192186ee46cc5 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-10 12:18:24,800 truncating revision to first 12 chars 2017-05-10 12:18:24,800 Setting DEBUG logging. 2017-05-10 12:18:24,800 attempt 1/10 2017-05-10 12:18:24,800 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ce2218406119?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-10 12:18:25,187 unpacking tar archive at: mozilla-central-ce2218406119/testing/mozharness/ program finished with exit code 0 elapsedTime=0.710099 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:25.331149) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:25.331511) ========= script_repo_revision: ce2218406119c36a551e3faea4e192186ee46cc5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:25.331878) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:25.332143) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:25.346206) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-10 12:18:25.346618) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:18:25 INFO - MultiFileLogger online at 20170510 12:18:25 in /builds/slave/test 12:18:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:18:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:18:25 INFO - {'append_to_log': False, 12:18:25 INFO - 'base_work_dir': '/builds/slave/test', 12:18:25 INFO - 'blob_upload_branch': 'Firefox', 12:18:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:18:25 INFO - 'branch': 'Firefox', 12:18:25 INFO - 'buildbot_json_path': 'buildprops.json', 12:18:25 INFO - 'config_files': ('talos/linux_config.py',), 12:18:25 INFO - 'default_actions': ('clobber', 12:18:25 INFO - 'read-buildbot-config', 12:18:25 INFO - 'download-and-extract', 12:18:25 INFO - 'populate-webroot', 12:18:25 INFO - 'create-virtualenv', 12:18:25 INFO - 'install', 12:18:25 INFO - 'run-tests'), 12:18:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:18:25 INFO - 'download_minidump_stackwalk': True, 12:18:25 INFO - 'download_symbols': 'ondemand', 12:18:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:18:25 INFO - 'tooltool.py': '/tools/tooltool.py', 12:18:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:18:25 INFO - '/tools/misc-python/virtualenv.py')}, 12:18:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:18:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:18:25 INFO - 'gecko_profile': False, 12:18:25 INFO - 'gecko_profile_interval': 0, 12:18:25 INFO - 'installer_path': 'installer.exe', 12:18:25 INFO - 'log_level': 'info', 12:18:25 INFO - 'log_name': 'talos', 12:18:25 INFO - 'log_to_console': True, 12:18:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:18:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:18:25 INFO - 'opt_config_files': (), 12:18:25 INFO - 'pip_index': False, 12:18:25 INFO - 'suite': 'dromaeojs-e10s', 12:18:25 INFO - 'system_bits': '32', 12:18:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:18:25 INFO - 'title': 'talos-linux64-ix-057', 12:18:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:18:25 INFO - 'use_talos_json': True, 12:18:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:18:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:18:25 INFO - 'work_dir': 'build'} 12:18:25 INFO - [mozharness: 2017-05-10 19:18:25.633785Z] Running clobber step. 12:18:25 INFO - Running pre-action listener: _resource_record_pre_action 12:18:25 INFO - Running main action method: clobber 12:18:25 INFO - rmtree: /builds/slave/test/build 12:18:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:18:26 INFO - Running post-action listener: _resource_record_post_action 12:18:26 INFO - [mozharness: 2017-05-10 19:18:26.566857Z] Finished clobber step (success) 12:18:26 INFO - [mozharness: 2017-05-10 19:18:26.566957Z] Running read-buildbot-config step. 12:18:26 INFO - Running pre-action listener: _resource_record_pre_action 12:18:26 INFO - Running main action method: read_buildbot_config 12:18:26 INFO - Using buildbot properties: 12:18:26 INFO - { 12:18:26 INFO - "project": "", 12:18:26 INFO - "product": "firefox", 12:18:26 INFO - "who": "kwierso@gmail.com", 12:18:26 INFO - "installer_path": "public/build/target.tar.bz2", 12:18:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 12:18:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 12:18:26 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 12:18:26 INFO - "stage_platform": "linux64-stylo", 12:18:26 INFO - "basedir": "/builds/slave/test", 12:18:26 INFO - "buildnumber": 87, 12:18:26 INFO - "platform": "ubuntu64_hw_stylo", 12:18:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:18:26 INFO - "slavebuilddir": "test", 12:18:26 INFO - "taskId": "fq3dHXKuRR-JxI0FW0DIFw", 12:18:26 INFO - "branch": "mozilla-central", 12:18:26 INFO - "script_repo_revision": "production", 12:18:26 INFO - "revision": "ce2218406119c36a551e3faea4e192186ee46cc5", 12:18:26 INFO - "slavename": "talos-linux64-ix-057", 12:18:26 INFO - "repo_path": "mozilla-central" 12:18:26 INFO - } 12:18:26 INFO - Finding installer, test and symbols from parent task. 12:18:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fq3dHXKuRR-JxI0FW0DIFw'}, attempt #1 12:18:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fq3dHXKuRR-JxI0FW0DIFw'}, attempt #1 12:18:27 INFO - Task dependencies: F-mTYJ2kS6G5HaE6SdLqng 12:18:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng'}, attempt #1 12:18:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/target.tar.bz2 12:18:27 INFO - Set test_url: https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/test_packages.json 12:18:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/target.crashreporter-symbols.zip 12:18:27 INFO - Running post-action listener: _resource_record_post_action 12:18:27 INFO - [mozharness: 2017-05-10 19:18:27.922905Z] Finished read-buildbot-config step (success) 12:18:27 INFO - [mozharness: 2017-05-10 19:18:27.923124Z] Running download-and-extract step. 12:18:27 INFO - Running pre-action listener: _resource_record_pre_action 12:18:27 INFO - Running main action method: download_and_extract 12:18:27 INFO - mkdir: /builds/slave/test/build/tests 12:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:18:27 INFO - trying https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/target.test_packages.json 12:18:27 INFO - Downloading https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:18:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:18:28 INFO - Downloaded 986 bytes. 12:18:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:18:28 INFO - Using the following test package requirements: 12:18:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:18:28 INFO - u'common': [u'target.common.tests.zip'], 12:18:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:18:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:18:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:18:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:18:28 INFO - u'mozbase': [u'target.common.tests.zip'], 12:18:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:18:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:18:28 INFO - u'web-platform': [u'target.common.tests.zip', 12:18:28 INFO - u'target.web-platform.tests.zip'], 12:18:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:18:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:18:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/target.common.tests.zip 12:18:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:18:28 INFO - Fetch https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/target.common.tests.zip into memory 12:18:29 INFO - Content-Length response header: 58593270 12:18:29 INFO - Bytes received: 58593270 12:18:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:18:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/target.common.tests.zip 12:18:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:18:39 INFO - Fetch https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/target.common.tests.zip into memory 12:18:40 INFO - Content-Length response header: 58593270 12:18:40 INFO - Bytes received: 58593270 12:18:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/target.talos.tests.zip 12:18:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:18:51 INFO - Fetch https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/target.talos.tests.zip into memory 12:18:51 INFO - Content-Length response header: 14409362 12:18:51 INFO - Bytes received: 14409362 12:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:18:52 INFO - trying https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/target.tar.bz2 12:18:52 INFO - Downloading https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:18:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:18:53 INFO - Downloaded 64519447 bytes. 12:18:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/target.tar.bz2 12:18:53 INFO - mkdir: /builds/slave/test/properties 12:18:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:18:53 INFO - Writing to file /builds/slave/test/properties/build_url 12:18:53 INFO - Contents: 12:18:53 INFO - build_url:https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/target.tar.bz2 12:18:53 INFO - Running post-action listener: _resource_record_post_action 12:18:53 INFO - Running post-action listener: set_extra_try_arguments 12:18:53 INFO - [mozharness: 2017-05-10 19:18:53.326159Z] Finished download-and-extract step (success) 12:18:53 INFO - [mozharness: 2017-05-10 19:18:53.326256Z] Running populate-webroot step. 12:18:53 INFO - Running pre-action listener: _resource_record_pre_action 12:18:53 INFO - Running main action method: populate_webroot 12:18:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:18:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:18:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:18:53 INFO - '--tppagecycles', 12:18:53 INFO - '7'], 12:18:53 INFO - 'tests': ['tsvgm']}}, 12:18:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:18:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:18:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:18:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:18:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:18:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:18:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:18:53 INFO - 'talos_options': ['--disable-e10s'], 12:18:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:18:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:18:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:18:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:18:53 INFO - 'talos_options': ['--disable-e10s'], 12:18:53 INFO - 'tests': ['damp', 'tps']}, 12:18:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:18:53 INFO - 'tests': ['damp', 'tps']}, 12:18:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:18:53 INFO - 'tests': ['dromaeo_dom']}, 12:18:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:18:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:18:53 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 12:18:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:18:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:18:53 INFO - 'tests': ['a11yr', 12:18:53 INFO - 'ts_paint', 12:18:53 INFO - 'tpaint', 12:18:53 INFO - 'sessionrestore', 12:18:53 INFO - 'sessionrestore_no_auto_restore', 12:18:53 INFO - 'tabpaint']}, 12:18:53 INFO - 'other-e10s': {'tests': ['a11yr', 12:18:53 INFO - 'ts_paint', 12:18:53 INFO - 'tpaint', 12:18:53 INFO - 'sessionrestore', 12:18:53 INFO - 'sessionrestore_no_auto_restore', 12:18:53 INFO - 'tabpaint']}, 12:18:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:18:53 INFO - 'ts_paint', 12:18:53 INFO - 'tpaint', 12:18:53 INFO - 'sessionrestore', 12:18:53 INFO - 'sessionrestore_no_auto_restore', 12:18:53 INFO - 'tabpaint']}, 12:18:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:18:53 INFO - 'ts_paint', 12:18:53 INFO - 'tpaint', 12:18:53 INFO - 'sessionrestore', 12:18:53 INFO - 'sessionrestore_no_auto_restore', 12:18:53 INFO - 'tabpaint']}, 12:18:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:18:53 INFO - 'tests': ['a11yr', 12:18:53 INFO - 'ts_paint', 12:18:53 INFO - 'tpaint', 12:18:53 INFO - 'sessionrestore', 12:18:53 INFO - 'sessionrestore_no_auto_restore', 12:18:53 INFO - 'tabpaint']}, 12:18:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:18:53 INFO - 'tests': ['a11yr', 12:18:53 INFO - 'ts_paint', 12:18:53 INFO - 'tpaint', 12:18:53 INFO - 'sessionrestore', 12:18:53 INFO - 'sessionrestore_no_auto_restore', 12:18:53 INFO - 'tabpaint']}, 12:18:53 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 12:18:53 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 12:18:53 INFO - 'bloom_basic_ref']}, 12:18:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:18:53 INFO - 'tests': ['tsvgx', 12:18:53 INFO - 'tsvgr_opacity', 12:18:53 INFO - 'tart', 12:18:53 INFO - 'tscrollx', 12:18:53 INFO - 'cart', 12:18:53 INFO - 'tsvg_static']}, 12:18:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:18:53 INFO - 'tsvgr_opacity', 12:18:53 INFO - 'tart', 12:18:53 INFO - 'tscrollx', 12:18:53 INFO - 'cart', 12:18:53 INFO - 'tsvg_static']}, 12:18:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:18:53 INFO - 'talos_options': ['--disable-e10s'], 12:18:53 INFO - 'tests': ['tp5o']}, 12:18:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:18:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:18:53 INFO - 'talos_options': ['--disable-e10s', 12:18:53 INFO - '--xperf_path', 12:18:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:18:53 INFO - 'tests': ['tp5n']}, 12:18:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:18:53 INFO - 'talos_options': ['--xperf_path', 12:18:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:18:53 INFO - 'tests': ['tp5n']}}, 12:18:53 INFO - 'talos.zip': {'path': '', 12:18:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:18:53 INFO - Running post-action listener: _resource_record_post_action 12:18:53 INFO - [mozharness: 2017-05-10 19:18:53.340017Z] Finished populate-webroot step (success) 12:18:53 INFO - [mozharness: 2017-05-10 19:18:53.340106Z] Running create-virtualenv step. 12:18:53 INFO - Running pre-action listener: _resource_record_pre_action 12:18:53 INFO - Running main action method: create_virtualenv 12:18:53 INFO - Creating virtualenv /builds/slave/test/build/venv 12:18:53 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 12:18:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:18:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:18:53 INFO - Using real prefix '/usr' 12:18:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:18:53 INFO - Installing distribute.............................................................................................................................................................................................done. 12:18:55 INFO - Installing pip.................done. 12:18:55 INFO - Return code: 0 12:18:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:18:56 INFO - Reading from file tmpfile_stdout 12:18:56 INFO - Output received: 12:18:56 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) 12:18:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:56 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x19091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c78a30>, '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 0x1c797f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c79ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095', '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 12:18:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:18:56 INFO - Using env: {'DISPLAY': ':0', 12:18:56 INFO - 'HOME': '/home/cltbld', 12:18:56 INFO - 'LANG': 'en_US.UTF-8', 12:18:56 INFO - 'LANGUAGE': 'en_US:en', 12:18:56 INFO - 'LOGNAME': 'cltbld', 12:18:56 INFO - 'MAIL': '/var/mail/cltbld', 12:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:56 INFO - 'MOZ_NO_REMOTE': '1', 12:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:56 INFO - 'NO_EM_RESTART': '1', 12:18:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:56 INFO - 'PWD': '/builds/slave/test', 12:18:56 INFO - 'SHELL': '/bin/bash', 12:18:56 INFO - 'SHLVL': '1', 12:18:56 INFO - 'TERM': 'linux', 12:18:56 INFO - 'TMOUT': '86400', 12:18:56 INFO - 'USER': 'cltbld', 12:18:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095', 12:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:56 INFO - '_': '/tools/buildbot/bin/python'} 12:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:56 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 12:18:56 INFO - Cleaning up... 12:18:56 INFO - Return code: 0 12:18:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:56 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x19091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c78a30>, '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 0x1c797f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c79ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095', '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 12:18:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:18:56 INFO - Using env: {'DISPLAY': ':0', 12:18:56 INFO - 'HOME': '/home/cltbld', 12:18:56 INFO - 'LANG': 'en_US.UTF-8', 12:18:56 INFO - 'LANGUAGE': 'en_US:en', 12:18:56 INFO - 'LOGNAME': 'cltbld', 12:18:56 INFO - 'MAIL': '/var/mail/cltbld', 12:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:56 INFO - 'MOZ_NO_REMOTE': '1', 12:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:56 INFO - 'NO_EM_RESTART': '1', 12:18:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:56 INFO - 'PWD': '/builds/slave/test', 12:18:56 INFO - 'SHELL': '/bin/bash', 12:18:56 INFO - 'SHLVL': '1', 12:18:56 INFO - 'TERM': 'linux', 12:18:56 INFO - 'TMOUT': '86400', 12:18:56 INFO - 'USER': 'cltbld', 12:18:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095', 12:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:56 INFO - '_': '/tools/buildbot/bin/python'} 12:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:56 INFO - Downloading/unpacking psutil>=3.1.1 12:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:18:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:18:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:18:57 INFO - Installing collected packages: psutil 12:18:57 INFO - Running setup.py install for psutil 12:18:57 INFO - building 'psutil._psutil_linux' extension 12:18:57 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 12:18:58 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 12:18:58 INFO - building 'psutil._psutil_posix' extension 12:18:58 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 12:18:58 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 12:18:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:18:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:18:58 INFO - Successfully installed psutil 12:18:58 INFO - Cleaning up... 12:18:58 INFO - Return code: 0 12:18:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:58 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x19091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c78a30>, '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 0x1c797f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c79ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095', '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 12:18:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:18:58 INFO - Using env: {'DISPLAY': ':0', 12:18:58 INFO - 'HOME': '/home/cltbld', 12:18:58 INFO - 'LANG': 'en_US.UTF-8', 12:18:58 INFO - 'LANGUAGE': 'en_US:en', 12:18:58 INFO - 'LOGNAME': 'cltbld', 12:18:58 INFO - 'MAIL': '/var/mail/cltbld', 12:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:58 INFO - 'MOZ_NO_REMOTE': '1', 12:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:58 INFO - 'NO_EM_RESTART': '1', 12:18:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:58 INFO - 'PWD': '/builds/slave/test', 12:18:58 INFO - 'SHELL': '/bin/bash', 12:18:58 INFO - 'SHLVL': '1', 12:18:58 INFO - 'TERM': 'linux', 12:18:58 INFO - 'TMOUT': '86400', 12:18:58 INFO - 'USER': 'cltbld', 12:18:58 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095', 12:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:58 INFO - '_': '/tools/buildbot/bin/python'} 12:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:18:58 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 12:18:58 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 12:18:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:58 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 12:18:58 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 12:18:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:18:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:18:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:18:59 INFO - Installing collected packages: mozsystemmonitor 12:18:59 INFO - Running setup.py install for mozsystemmonitor 12:18:59 INFO - Successfully installed mozsystemmonitor 12:18:59 INFO - Cleaning up... 12:18:59 INFO - Return code: 0 12:18:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:59 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x19091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c78a30>, '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 0x1c797f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c79ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095', '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 12:18:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:18:59 INFO - Using env: {'DISPLAY': ':0', 12:18:59 INFO - 'HOME': '/home/cltbld', 12:18:59 INFO - 'LANG': 'en_US.UTF-8', 12:18:59 INFO - 'LANGUAGE': 'en_US:en', 12:18:59 INFO - 'LOGNAME': 'cltbld', 12:18:59 INFO - 'MAIL': '/var/mail/cltbld', 12:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:59 INFO - 'MOZ_NO_REMOTE': '1', 12:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:59 INFO - 'NO_EM_RESTART': '1', 12:18:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:59 INFO - 'PWD': '/builds/slave/test', 12:18:59 INFO - 'SHELL': '/bin/bash', 12:18:59 INFO - 'SHLVL': '1', 12:18:59 INFO - 'TERM': 'linux', 12:18:59 INFO - 'TMOUT': '86400', 12:18:59 INFO - 'USER': 'cltbld', 12:18:59 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095', 12:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:59 INFO - '_': '/tools/buildbot/bin/python'} 12:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:00 INFO - Downloading/unpacking jsonschema==2.5.1 12:19:00 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 12:19:00 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 12:19:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:00 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 12:19:00 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 12:19:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:19:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:19:01 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 12:19:01 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 12:19:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:01 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 12:19:01 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 12:19:01 INFO - Downloading functools32-3.2.3-2.tar.gz 12:19:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:19:01 INFO - warning: no files found matching '*.txt' 12:19:01 INFO - no previously-included directories found matching 'build' 12:19:01 INFO - no previously-included directories found matching 'dist' 12:19:01 INFO - no previously-included directories found matching '.git*' 12:19:01 INFO - Installing collected packages: jsonschema, functools32 12:19:01 INFO - Running setup.py install for functools32 12:19:01 INFO - warning: no files found matching '*.txt' 12:19:01 INFO - no previously-included directories found matching 'build' 12:19:01 INFO - no previously-included directories found matching 'dist' 12:19:01 INFO - no previously-included directories found matching '.git*' 12:19:01 INFO - Successfully installed jsonschema functools32 12:19:01 INFO - Cleaning up... 12:19:01 INFO - Return code: 0 12:19:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:01 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x19091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c78a30>, '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 0x1c797f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c79ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095', '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 12:19:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:19:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:19:01 INFO - Using env: {'DISPLAY': ':0', 12:19:01 INFO - 'HOME': '/home/cltbld', 12:19:01 INFO - 'LANG': 'en_US.UTF-8', 12:19:01 INFO - 'LANGUAGE': 'en_US:en', 12:19:01 INFO - 'LOGNAME': 'cltbld', 12:19:01 INFO - 'MAIL': '/var/mail/cltbld', 12:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:01 INFO - 'MOZ_NO_REMOTE': '1', 12:19:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:01 INFO - 'NO_EM_RESTART': '1', 12:19:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:01 INFO - 'PWD': '/builds/slave/test', 12:19:01 INFO - 'SHELL': '/bin/bash', 12:19:01 INFO - 'SHLVL': '1', 12:19:01 INFO - 'TERM': 'linux', 12:19:01 INFO - 'TMOUT': '86400', 12:19:01 INFO - 'USER': 'cltbld', 12:19:01 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095', 12:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:01 INFO - '_': '/tools/buildbot/bin/python'} 12:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:19:01 INFO - Cleaning up... 12:19:01 INFO - Return code: 0 12:19:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:01 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x19091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c78a30>, '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 0x1c797f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c79ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095', '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 12:19:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:19:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:19:01 INFO - Using env: {'DISPLAY': ':0', 12:19:01 INFO - 'HOME': '/home/cltbld', 12:19:01 INFO - 'LANG': 'en_US.UTF-8', 12:19:01 INFO - 'LANGUAGE': 'en_US:en', 12:19:01 INFO - 'LOGNAME': 'cltbld', 12:19:01 INFO - 'MAIL': '/var/mail/cltbld', 12:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:01 INFO - 'MOZ_NO_REMOTE': '1', 12:19:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:01 INFO - 'NO_EM_RESTART': '1', 12:19:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:01 INFO - 'PWD': '/builds/slave/test', 12:19:01 INFO - 'SHELL': '/bin/bash', 12:19:01 INFO - 'SHLVL': '1', 12:19:01 INFO - 'TERM': 'linux', 12:19:01 INFO - 'TMOUT': '86400', 12:19:01 INFO - 'USER': 'cltbld', 12:19:01 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095', 12:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:01 INFO - '_': '/tools/buildbot/bin/python'} 12:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:02 INFO - Downloading/unpacking blobuploader==1.2.4 12:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:04 INFO - Downloading blobuploader-1.2.4.tar.gz 12:19:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:19:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:19:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:04 INFO - Downloading docopt-0.6.1.tar.gz 12:19:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:19:04 INFO - Installing collected packages: blobuploader, requests, docopt 12:19:04 INFO - Running setup.py install for blobuploader 12:19:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:19:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:19:04 INFO - Running setup.py install for requests 12:19:05 INFO - Running setup.py install for docopt 12:19:05 INFO - Successfully installed blobuploader requests docopt 12:19:05 INFO - Cleaning up... 12:19:05 INFO - Return code: 0 12:19:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:05 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x19091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c78a30>, '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 0x1c797f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c79ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095', '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 12:19:05 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:19:05 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:19:05 INFO - Using env: {'DISPLAY': ':0', 12:19:05 INFO - 'HOME': '/home/cltbld', 12:19:05 INFO - 'LANG': 'en_US.UTF-8', 12:19:05 INFO - 'LANGUAGE': 'en_US:en', 12:19:05 INFO - 'LOGNAME': 'cltbld', 12:19:05 INFO - 'MAIL': '/var/mail/cltbld', 12:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:05 INFO - 'MOZ_NO_REMOTE': '1', 12:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:05 INFO - 'NO_EM_RESTART': '1', 12:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:05 INFO - 'PWD': '/builds/slave/test', 12:19:05 INFO - 'SHELL': '/bin/bash', 12:19:05 INFO - 'SHLVL': '1', 12:19:05 INFO - 'TERM': 'linux', 12:19:05 INFO - 'TMOUT': '86400', 12:19:05 INFO - 'USER': 'cltbld', 12:19:05 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095', 12:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:05 INFO - '_': '/tools/buildbot/bin/python'} 12:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:19:05 INFO - Running setup.py (path:/tmp/pip-XZhFR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:19:05 INFO - Running setup.py (path:/tmp/pip-_fKqP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:19:05 INFO - Running setup.py (path:/tmp/pip-JKiQ14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:19:05 INFO - Running setup.py (path:/tmp/pip-eNYDDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:19:05 INFO - Running setup.py (path:/tmp/pip-Nm1KoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:19:05 INFO - Running setup.py (path:/tmp/pip-6qxsvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:19:06 INFO - Running setup.py (path:/tmp/pip-Ie1bqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:19:06 INFO - Running setup.py (path:/tmp/pip-67GlY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:19:06 INFO - Running setup.py (path:/tmp/pip-E_wdsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:19:06 INFO - Running setup.py (path:/tmp/pip-E3_0o3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:19:06 INFO - Running setup.py (path:/tmp/pip-74qprH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:19:06 INFO - Running setup.py (path:/tmp/pip-N8MY_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:19:06 INFO - Running setup.py (path:/tmp/pip-hlKJ87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:19:06 INFO - Running setup.py (path:/tmp/pip-W8kTq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:06 INFO - Running setup.py (path:/tmp/pip-BcQRJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:19:06 INFO - Running setup.py (path:/tmp/pip-vbJV26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:19:06 INFO - Running setup.py (path:/tmp/pip-fOdXgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:19:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:19:06 INFO - Running setup.py install for manifestparser 12:19:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:19:06 INFO - Running setup.py install for mozcrash 12:19:07 INFO - Running setup.py install for mozdebug 12:19:07 INFO - Running setup.py install for mozdevice 12:19:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:19:07 INFO - Running setup.py install for mozfile 12:19:07 INFO - Running setup.py install for mozhttpd 12:19:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:19:07 INFO - Running setup.py install for mozinfo 12:19:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:19:07 INFO - Running setup.py install for mozInstall 12:19:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:19:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:19:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:19:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:19:07 INFO - Running setup.py install for mozleak 12:19:07 INFO - Running setup.py install for mozlog 12:19:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:19:07 INFO - Running setup.py install for moznetwork 12:19:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:19:07 INFO - Running setup.py install for mozprocess 12:19:08 INFO - Running setup.py install for mozprofile 12:19:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:19:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:19:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:19:08 INFO - Running setup.py install for mozrunner 12:19:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:19:08 INFO - Running setup.py install for mozscreenshot 12:19:08 INFO - Running setup.py install for moztest 12:19:08 INFO - Running setup.py install for mozversion 12:19:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:19:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:19:08 INFO - Cleaning up... 12:19:08 INFO - Return code: 0 12:19:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:08 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x19091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c78a30>, '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 0x1c797f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c79ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095', '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 12:19:08 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:19:08 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:19:08 INFO - Using env: {'DISPLAY': ':0', 12:19:08 INFO - 'HOME': '/home/cltbld', 12:19:08 INFO - 'LANG': 'en_US.UTF-8', 12:19:08 INFO - 'LANGUAGE': 'en_US:en', 12:19:08 INFO - 'LOGNAME': 'cltbld', 12:19:08 INFO - 'MAIL': '/var/mail/cltbld', 12:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:08 INFO - 'MOZ_NO_REMOTE': '1', 12:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:08 INFO - 'NO_EM_RESTART': '1', 12:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:08 INFO - 'PWD': '/builds/slave/test', 12:19:08 INFO - 'SHELL': '/bin/bash', 12:19:08 INFO - 'SHLVL': '1', 12:19:08 INFO - 'TERM': 'linux', 12:19:08 INFO - 'TMOUT': '86400', 12:19:08 INFO - 'USER': 'cltbld', 12:19:08 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095', 12:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:08 INFO - '_': '/tools/buildbot/bin/python'} 12:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:19:08 INFO - Running setup.py (path:/tmp/pip-vQM7ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:19:08 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)) 12:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:19:08 INFO - Running setup.py (path:/tmp/pip-FVlanX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:19:08 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)) 12:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:19:08 INFO - Running setup.py (path:/tmp/pip-w72XNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:19:09 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)) 12:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:19:09 INFO - Running setup.py (path:/tmp/pip-_vqn0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 12:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:19:09 INFO - Running setup.py (path:/tmp/pip-SA_NIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:19:09 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)) 12:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:19:09 INFO - Running setup.py (path:/tmp/pip-5CsvzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:19:09 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)) 12:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:19:09 INFO - Running setup.py (path:/tmp/pip-aeFxzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:19:09 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)) 12:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:19:09 INFO - Running setup.py (path:/tmp/pip-g7XUQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:19:09 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)) 12:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:19:09 INFO - Running setup.py (path:/tmp/pip-TLtwuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:19:09 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)) 12:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:19:09 INFO - Running setup.py (path:/tmp/pip-fG0qpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:19:09 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)) 12:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:19:09 INFO - Running setup.py (path:/tmp/pip-DEGzz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:19:09 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)) 12:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:19:09 INFO - Running setup.py (path:/tmp/pip-QRAkhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:19:09 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)) 12:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:19:09 INFO - Running setup.py (path:/tmp/pip-Tiocor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:19:09 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)) 12:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:19:09 INFO - Running setup.py (path:/tmp/pip-170bM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:19:09 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)) 12:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:09 INFO - Running setup.py (path:/tmp/pip-pct7qf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:09 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)) 12:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:19:09 INFO - Running setup.py (path:/tmp/pip-0qtwg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:19:09 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)) 12:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:19:10 INFO - Running setup.py (path:/tmp/pip-RKNjDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:19:10 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)) 12:19:10 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)) 12:19:10 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)) 12:19:10 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)) 12:19:10 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:19:10 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:19:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:11 INFO - Downloading blessings-1.6.tar.gz 12:19:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:19:11 INFO - Installing collected packages: blessings 12:19:11 INFO - Running setup.py install for blessings 12:19:11 INFO - Successfully installed blessings 12:19:11 INFO - Cleaning up... 12:19:11 INFO - Return code: 0 12:19:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:19:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:19:11 INFO - Reading from file tmpfile_stdout 12:19:11 INFO - Current package versions: 12:19:11 INFO - argparse == 1.2.1 12:19:11 INFO - blessings == 1.6 12:19:11 INFO - blobuploader == 1.2.4 12:19:11 INFO - docopt == 0.6.1 12:19:11 INFO - functools32 == 3.2.3-2 12:19:11 INFO - jsonschema == 2.5.1 12:19:11 INFO - manifestparser == 1.1 12:19:11 INFO - mozInstall == 1.12 12:19:11 INFO - mozcrash == 1.0 12:19:11 INFO - mozdebug == 0.1 12:19:11 INFO - mozdevice == 0.50 12:19:11 INFO - mozfile == 1.2 12:19:11 INFO - mozhttpd == 0.7 12:19:11 INFO - mozinfo == 0.9 12:19:11 INFO - mozleak == 0.1 12:19:11 INFO - mozlog == 3.4 12:19:11 INFO - moznetwork == 0.27 12:19:11 INFO - mozprocess == 0.25 12:19:11 INFO - mozprofile == 0.28 12:19:11 INFO - mozrunner == 6.13 12:19:11 INFO - mozscreenshot == 0.1 12:19:11 INFO - mozsystemmonitor == 0.3 12:19:11 INFO - moztest == 0.8 12:19:11 INFO - mozversion == 1.4 12:19:11 INFO - psutil == 3.1.1 12:19:11 INFO - requests == 1.2.3 12:19:11 INFO - wsgiref == 0.1.2 12:19:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:11 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x19091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c78a30>, '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 0x1c797f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c79ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095', '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 12:19:11 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:19:11 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:19:11 INFO - Using env: {'DISPLAY': ':0', 12:19:11 INFO - 'HOME': '/home/cltbld', 12:19:11 INFO - 'LANG': 'en_US.UTF-8', 12:19:11 INFO - 'LANGUAGE': 'en_US:en', 12:19:11 INFO - 'LOGNAME': 'cltbld', 12:19:11 INFO - 'MAIL': '/var/mail/cltbld', 12:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:11 INFO - 'MOZ_NO_REMOTE': '1', 12:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:11 INFO - 'NO_EM_RESTART': '1', 12:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:11 INFO - 'PWD': '/builds/slave/test', 12:19:11 INFO - 'SHELL': '/bin/bash', 12:19:11 INFO - 'SHLVL': '1', 12:19:11 INFO - 'TERM': 'linux', 12:19:11 INFO - 'TMOUT': '86400', 12:19:11 INFO - 'USER': 'cltbld', 12:19:11 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095', 12:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:11 INFO - '_': '/tools/buildbot/bin/python'} 12:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:11 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)) 12:19:11 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)) 12:19:11 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)) 12:19:11 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)) 12:19:11 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)) 12:19:11 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)) 12:19:11 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)) 12:19:11 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)) 12:19:11 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)) 12:19:11 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)) 12:19:11 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)) 12:19:11 INFO - Cleaning up... 12:19:11 INFO - Return code: 0 12:19:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x19091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c78a30>, '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 0x1c797f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c79ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095', '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 12:19:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:19:11 INFO - Using env: {'DISPLAY': ':0', 12:19:11 INFO - 'HOME': '/home/cltbld', 12:19:11 INFO - 'LANG': 'en_US.UTF-8', 12:19:11 INFO - 'LANGUAGE': 'en_US:en', 12:19:11 INFO - 'LOGNAME': 'cltbld', 12:19:11 INFO - 'MAIL': '/var/mail/cltbld', 12:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:11 INFO - 'MOZ_NO_REMOTE': '1', 12:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:11 INFO - 'NO_EM_RESTART': '1', 12:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:11 INFO - 'PWD': '/builds/slave/test', 12:19:11 INFO - 'SHELL': '/bin/bash', 12:19:11 INFO - 'SHLVL': '1', 12:19:11 INFO - 'TERM': 'linux', 12:19:11 INFO - 'TMOUT': '86400', 12:19:11 INFO - 'USER': 'cltbld', 12:19:11 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095', 12:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:11 INFO - '_': '/tools/buildbot/bin/python'} 12:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:19:12 INFO - Cleaning up... 12:19:12 INFO - Return code: 0 12:19:12 INFO - Running post-action listener: _resource_record_post_action 12:19:12 INFO - Running post-action listener: _start_resource_monitoring 12:19:12 INFO - Starting resource monitoring. 12:19:12 INFO - [mozharness: 2017-05-10 19:19:12.144940Z] Finished create-virtualenv step (success) 12:19:12 INFO - [mozharness: 2017-05-10 19:19:12.145435Z] Running install step. 12:19:12 INFO - Running pre-action listener: _resource_record_pre_action 12:19:12 INFO - Running main action method: install 12:19:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:19:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:19:12 INFO - Reading from file tmpfile_stdout 12:19:12 INFO - Detecting whether we're running mozinstall >=1.0... 12:19:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:19:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:19:12 INFO - Reading from file tmpfile_stdout 12:19:12 INFO - Output received: 12:19:12 INFO - Usage: mozinstall [options] installer 12:19:12 INFO - Options: 12:19:12 INFO - -h, --help show this help message and exit 12:19:12 INFO - -d DEST, --destination=DEST 12:19:12 INFO - Directory to install application into. [default: 12:19:12 INFO - "/builds/slave/test"] 12:19:12 INFO - --app=APP Application being installed. [default: firefox] 12:19:12 INFO - mkdir: /builds/slave/test/build/application 12:19:12 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'] 12:19:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:19:28 INFO - Reading from file tmpfile_stdout 12:19:28 INFO - Output received: 12:19:28 INFO - /builds/slave/test/build/application/firefox/firefox 12:19:28 INFO - Running post-action listener: _resource_record_post_action 12:19:28 INFO - [mozharness: 2017-05-10 19:19:28.700057Z] Finished install step (success) 12:19:28 INFO - [mozharness: 2017-05-10 19:19:28.700335Z] Running run-tests step. 12:19:28 INFO - Running pre-action listener: _resource_record_pre_action 12:19:28 INFO - Running main action method: run_tests 12:19:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:19:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:19:28 INFO - Python 2.7.3 12:19:28 INFO - Return code: 0 12:19:28 INFO - grabbing minidump binary from tooltool 12:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:19:28 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 0x1c78a30>, '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 0x1c797f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c79ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:19:28 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 12:19:28 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 12:19:28 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 12:19:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:19:28 INFO - Return code: 0 12:19:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:19:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:19:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:19:28 INFO - ENV: RUST_BACKTRACE is now 1 12:19:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:19:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:19:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:19:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:19:28 INFO - Using env: {'DISPLAY': ':0', 12:19:28 INFO - 'HOME': '/home/cltbld', 12:19:28 INFO - 'LANG': 'en_US.UTF-8', 12:19:28 INFO - 'LANGUAGE': 'en_US:en', 12:19:28 INFO - 'LOGNAME': 'cltbld', 12:19:28 INFO - 'MAIL': '/var/mail/cltbld', 12:19:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:19:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:28 INFO - 'MOZ_NO_REMOTE': '1', 12:19:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:19:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:28 INFO - 'NO_EM_RESTART': '1', 12:19:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:28 INFO - 'PWD': '/builds/slave/test', 12:19:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:19:28 INFO - 'RUST_BACKTRACE': '1', 12:19:28 INFO - 'SHELL': '/bin/bash', 12:19:28 INFO - 'SHLVL': '1', 12:19:28 INFO - 'TERM': 'linux', 12:19:28 INFO - 'TMOUT': '86400', 12:19:28 INFO - 'USER': 'cltbld', 12:19:28 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095', 12:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:28 INFO - '_': '/tools/buildbot/bin/python'} 12:19:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:19:28 INFO - mozversion application_buildid: 20170510183120 12:19:28 INFO - mozversion application_changeset: ce2218406119c36a551e3faea4e192186ee46cc5 12:19:28 INFO - mozversion application_display_name: Nightly 12:19:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:19:28 INFO - mozversion application_name: Firefox 12:19:28 INFO - mozversion application_remotingname: firefox 12:19:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:19:28 INFO - mozversion application_vendor: Mozilla 12:19:28 INFO - mozversion application_version: 55.0a1 12:19:28 INFO - mozversion platform_buildid: 20170510183120 12:19:28 INFO - mozversion platform_changeset: ce2218406119c36a551e3faea4e192186ee46cc5 12:19:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:19:28 INFO - mozversion platform_version: 55.0a1 12:19:28 INFO - using testdate: 1494443968 12:19:28 INFO - actual date: 1494443968 12:19:28 INFO - starting webserver on 'localhost:41914' 12:19:28 INFO - SUITE-START | Running 2 tests 12:19:28 INFO - TEST-START | dromaeo_css 12:19:28 INFO - operating with platform_type : linux_ 12:19:28 INFO - Initialising browser for dromaeo_css test... 12:19:29 INFO - TEST-INFO | started process 11664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeJcVIo/profile http://localhost:41914/getInfo.html) 12:19:33 INFO - PID 11664 | __metrics Screen width/height:1600/1200 12:19:33 INFO - PID 11664 | colorDepth:24 12:19:33 INFO - PID 11664 | Browser inner width/height: 1024/695 12:19:33 INFO - PID 11664 | __metrics 12:19:35 INFO - TEST-INFO | 11664: exit 0 12:19:35 INFO - Browser initialized. 12:19:35 INFO - Running cycle 1/1 for dromaeo_css test... 12:19:35 INFO - TEST-INFO | started process 11854 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeJcVIo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:19:46 INFO - PID 11854 | RSS: Main: 168497152 12:19:46 INFO - PID 11854 | 12:22:52 INFO - PID 11854 | Cycle 1(1): loaded http://localhost:41914/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41914/tests/dromaeo/cssquery-ext.html) 12:22:53 INFO - PID 11854 | RSS: Main: 183148544 12:22:53 INFO - PID 11854 | 12:25:55 INFO - PID 11854 | Cycle 1(1): loaded http://localhost:41914/tests/dromaeo/cssquery-ext.html (next: http://localhost:41914/tests/dromaeo/cssquery-jquery.html) 12:25:56 INFO - PID 11854 | RSS: Main: 181170176 12:25:56 INFO - PID 11854 | 12:28:58 INFO - PID 11854 | Cycle 1(1): loaded http://localhost:41914/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41914/tests/dromaeo/cssquery-mootools.html) 12:28:58 INFO - PID 11854 | RSS: Main: 191021056 12:28:58 INFO - PID 11854 | 12:32:00 INFO - PID 11854 | Cycle 1(1): loaded http://localhost:41914/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41914/tests/dromaeo/cssquery-prototype.html) 12:32:01 INFO - PID 11854 | RSS: Main: 182816768 12:32:01 INFO - PID 11854 | 12:35:04 INFO - PID 11854 | Cycle 1(1): loaded http://localhost:41914/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41914/tests/dromaeo/cssquery-yui.html) 12:35:04 INFO - PID 11854 | RSS: Main: 188682240 12:35:04 INFO - PID 11854 | 12:38:06 INFO - PID 11854 | Cycle 1(1): loaded http://localhost:41914/tests/dromaeo/cssquery-yui.html (next: http://localhost:41914/tests/dromaeo/cssquery-dojo.html) 12:38:06 INFO - PID 11854 | RSS: Main: 193097728 12:38:06 INFO - PID 11854 | 12:38:06 INFO - PID 11854 | __start_tp_report 12:38:06 INFO - PID 11854 | _x_x_mozilla_page_load 12:38:06 INFO - PID 11854 | _x_x_mozilla_page_load_details 12:38:06 INFO - PID 11854 | |i|pagename|runs| 12:38:06 INFO - PID 11854 | |0;dojo.html;2776.472470230656;2781.6105745195687;2798.384355441802;2815.3524689321457;2816.4085542036173;5089.821856235032;5173.353330833651;5182.637215394924;5200.531952124308;5215.92176117358;5171.198464238049;5221.973890130554;5237.973810130953;5244.527992480676;5339.279197308372;4612.815487380509;4633.976830115862;4659.394278743775;4666.276727107287;4713.505081966396;4683.063387322532;4691.741954192518;4711.481737008926;4738.549837765407;4746.21687421575;4589.862304130848;4618.2610782275015;4650.25595904657;4657.813687452498;4676.8363107291425;4571.3143028545655;4616.746078965655;4624.375709279271;4636.86089417318;4682.063587282557;4555.293929440942;4589.839355622571;4595.080983803253;4621.976890115561;4643.582077612998;4991.725455099968;4999.200127979506;5004.724740139291;5044.192929131322;5056.241563765428;5673.375928647845;5674;5699.772009119631;5703.087505999062;5750.252467179282;5629.521490673298;5700.201971723962;5700.7719691212305;5702.287214098238;5707.001274776898;5163.741812909339;5228.424873263938;5264.263003179558;5279.181726832308;5342;5722.685252311079;5733.913991290134;5811.593188476851;5818.0981947798155;5825.650460972355;5450.236966824647;5504.0643090674685;5510.559155267569;5590.888182236333;5608.831735047874;5557.44425557441;5630.4369563043365;5635.549156067505;5666.206731057655;5672.404397538282;5532.1425179097305;5608.1587761835235;5615.971920140373;5623.128415095667;5638.35158956717;5562.916556251659;5602.4957753802355;5608.186812912105;5635.6618602883955;5681.318241810926;4726.456457507362;4729.266963620645;4736.928946065812;4745.905081898342;4785.306130611042;4003.7197396181987;4038.9394159087637;4049.230646177276;4052.0477687743355;4075.9796201018803;4865.221564549655;4871.050145221648;4877.09773691861;4878.048780487771;4891.3396691446915;5637.633553818989;5679.77280908759;5688.857778555569;5696.3449203341315;5704.030314846486;4866.075445665312;4868.172410690191;4874.829380971649;4882.145624515695;4883.267509873476;5004.074246264453;5038.193888977746;5038.949610503922;5043.646944713835;5044.1929291313945;5303.681779093266;5305.071612467726;5307.548858347083;5313.149896016542;5318.7074710891275;5658.03813351723;5696.287964004499;5762.049261871744;5768.480836724715;5811.4188581143235;5310.495502927216;5320.973395133;5322.33470816148;5324.334458192726;5326.680399176062;5513.862153446035;5589.811732035427;5613.859653508532;5618.831435056954;5633.661980281032;5605.80379686709;5693.3168019837885;5710.457506536873;5757.165211044291;5763.279590051244;5517.69652669107;5520.309961254843;5528.640638358494;5544.390117087198;5558.166275058774;5506.146547285177;5522.502974732293;5523.447655234444;5525.309336332958;5533.806316778893;5330.200469929541;5337.9466205339;5394.811181608625;5400.270963419888;5466.8906621866545;5559.972200138974;5566.944330556643;5571.582131340247;5580.35825880029;5599.580031497572;5386.165144402624;5399.5950303726595;5429.375621803543;5430.864228394322;5436.945630543644 12:38:06 INFO - PID 11854 | |1;ext.html;599.4934280532948;644.8774732800767;657.4083325007491;1080.3409919948824;1086.375334182845;31857.84071079644;32370.190745231383;32375.99999999997;32412.837935810287;32461.67538324616;30135.698643013562;30332.24169395766;30409.543856842167;30498.54252186219;30613.540796888065;6108.602940808833;6121.632702037869;6143.846403839895;6159.476444502223;6181.350958149385;6763.256041835394;6799.5920244785475;6849.794506164798;6868.793936181923;6872.312768723113;6783.219929708072;6836.350546698056;6851.280615535372;6866.27904070073;6877.931220687779;6801.18385793703;6858.382745552874;6860.519763616574;6863.485238607124;6864.9656751716175;6749.527533072687;6785.355391237825;6811.659417029129;6814.829629259259;6826;29756.256093597618;29951;30023.399532009236;30121.246968825737;30278.09165725032;3012.9096127116222;3048.131282584475;3053.2214285357313;3063.0657649416917;3093.6442309134286;23180.65229021566;23280.534389312117;23295.7670423297;23333.300000999996;23351.88324058386;3063.816171029723;3079.2148002259282;3117.2986078132467;3139.4976803711525;3156.731677807389;131422;132220;133015.33492332572;138385.308073459;142486.28756856252;36743.81628091842;36904.63095369012;37089.25821483555;37110.628893711255;37142;38073.42889856654;38205.42691859624;41399.379009314885;41633.583664163576;42062.36906446406;12414.379281035912;12555.874441255653;12583.559575415;12603;12605.235267062619;9783.510824458748;9785.119339259501;9794.65718699842;9862.802743945082;9877.506124693737;12206.389680515938;12279.38603069843;12418.316992565315;12481.188722733175;12665.113442059152;5311.867203319948;5331.680099194061;5348.491893270133;5412.161115027177;5443.537299329601;874.3180319350917;909.5861383070687;916.6058594804165;925.3291363761219;939.1547607153616;19727.506812329808;20434.79565204329;20444.897775511326;20728.58542829135;20734.79265207359;976.7118699983522;983.2036050798876;987.6691308411619;987.76293689514;1002.6390499420203;10913.945430272797;10941.726456838484;10970.451477426097;10988.560457581607;11061.446927653586;180264;180424.09787950976;182476;182565;182647;37914.8104259477;38090.61909380926;38251;38271.61728382736;38280.234395311934;1206.6621346023128;1238.3560548514902;1242;1247.2329517346766;1253.9310337931502;19700.310489133386;19731.21075157035;20315.796842031392;20690.17239310411;23481.17815876436;37234.62765372312;37369.25261494809;37550.624493754716;37637.05907352338;37642.623573763914;159088;159687.20156399143;159739;160007;160941;28544.42911141807;29250.707492924797;29262.853685731436;29266.853665731534;29271.7072829269;33891.66108338885;34412;34498.48252276268;34608.30783384268;34854;26141.90864730855;26426.735732643196;26599.202023939313;26621.467570648867;27566.724332756417;27119.322016949733;27220.863895680395;27339.86330068337;27345.589816153173;27832.721672783013;29749.702502974695;29756.10731678053;29770.702292977658;29804.403911922072;29882.252943676584;25172.74827251704;25782.8710856452;25849.353766155997;26328.868355658098;27338.316542085813;19024.239030438628;21785.782142178374;21845.235416760337;21931.780682192973;21949.231776887733 12:38:06 INFO - PID 11854 | |2;jquery.html;416.3920961903943;423.758457679123;433.5815937620197;439.0253636926024;441.3423998242619;16909.323627054902;17262.741058884127;17534.561635959093;18105.09474526272;18171;18506.25974961003;18719.719204211946;18950.715739263924;19151.712724309145;19206.711899321486;5231.2153177023465;5365.087935051031;5490.890182196354;5493.560515158798;5503.174523821419;5244.292020577231;5292.364916210041;5382.085045542267;5382.2195781611645;5450.155225939966;5415.810446634368;5419.918701219465;5431.972840135793;5440.6735595864375;5449.64577302474;5316.38861530925;5365.812196573121;5388.299521062276;5398.109311963522;5419.783208671648;4895.167821470359;4903.092927808331;4905.779239934212;4923.433805112422;4924.975375123137;21116.15535378583;21369;21882.23412180582;22079.66880496794;22196.11215551376;1642.7289497232941;1685.2837544043855;1685.3511398111693;1690.687222863762;1691.6024734187456;14329.928350358286;14536.491222807152;14838.554843354717;14941.327640256215;15050.924745376313;2054.7123402723632;2056.814886660208;2059.938201853947;2079.958400831975;2093.623147833405;78683;86927;89360;97318.0268197316;98923.50538247262;10854.169894397075;10874.238803283693;11073;11266;11424.257423267461;15609.609759756097;15695.372185112468;15707.607309817346;15714.68570628581;15781.763273550905;7865.528068315919;7910.090339610903;8003.839923201504;8145.918540814635;8224.671013159526;6395.936040639627;6455.548111632141;6790.1851777786;7109.324614161646;7123.786286411416;6852.314768523108;6973.442124630017;7002.159740831031;7113.608751518716;7130.679119439534;1939.94180174595;1943.3878328326814;1945.6984167454068;1946.883187008784;2138.807507324348;849.5752123938031;876.1982785750967;876.509154873273;879.9780005499914;912.2018234045211;15919.283632236346;16179.919100404422;16183.190840458166;16848.91575542139;16975.74536381955;874.8775171475999;876.3952872517942;884.35883984111;887.6937456577471;890.1543533643065;11009.2843965142;11610.187286890006;11891.108166887345;12039.879601204051;12047.277163370225;377764;380105;386037;392664;394556;74331;78460;79606.6019669898;82219;83384.16615833885;1061.5647584490323;1083.268793564341;1106.7233191702076;1111.5220455204178;1117.8155604325357;16985.235664394884;17072.975621462752;17695.203715833075;18104.456866294033;18330.541736456697;37543.061423464635;38802.417963730004;39108.74260118367;39994.2001159981;40119.799401002805;49271;49352.25971610357;49374.753126234136;49595.25607115968;51584.22623660573;8224.876626850482;8277.337812975067;8469.830603388022;8488.787780305542;8643.611037503202;11443.542258309575;11506.137039721887;11783.764324713286;11986.64040078799;12720.427580759073;10010.449425281387;10817.675469735921;10900.291481053706;11228.55085796559;11289.153313501356;9176.724698259062;9544.522773861418;9785.266105042008;9812.754681132743;9888;9785.755356116155;9965.202783777135;10142.340747851662;10207.438590877573;10210.591576336863;7715.1513333534385;7869.48848324857;7939.682412703427;7945.8410831784195;8180.509169449852;10815.837762433412;10925.125989920629;10984.560617575527;11162.162837787037;11205.383703896037 12:38:06 INFO - PID 11854 | |3;mootools.html;1237.4864431261028;1266.4744131185557;1301.3363184775762;1302.4724986380506;1320.207875274835;9866.260030497715;10134.898651013487;10267.743306417335;10289.742756431093;10402.687919362412;10161.390316580992;10327.84508232377;10331;10331.483425828697;10354.482275886214;2236.7539570647255;2275.590393729128;2281.292799232235;2282.6005449046434;2286.85135466195;2156.967645485319;2202.0751284460484;2220.2784095169054;2222.622154233776;2227.899744511493;2183.351569564976;2195.7584665686763;2203.7796220377995;2229.5317983223545;2238.183063181935;2093.1418118571464;2155.0948601587293;2174.1629472653062;2187.3109970359287;2190.1348967157883;2032.6849338352579;2154.504463973279;2178.4880553070016;2179.5422961178015;2202.053117159621;10018.799624007479;10053.648122315684;10071.09360157582;10090.848637270446;10102.9494852526;5562.916556251659;5824.88350232993;5828.708564571754;5833.591648584601;5838.795642152504;3281.409346317662;3406.267652454709;3431.0564594736647;3488.389531831919;3492.5634295713035;1128.2215271462665;1152.4698638626242;1171.953121875124;1174.712195512105;1178.3695722788352;14985.32566034531;15035.699286014218;15201.239938003166;15235.923820380827;15273.38906443741;4471.374007638933;4669.18289299378;4827.927581086286;4846.248831431134;4861.29511220871;10681.092107170822;10709.78580428387;10725.14198864089;10747.516361763739;10781.62264320745;5464.836054918359;5496.560275177976;5500.669959802424;5500.779968801283;5508.063629183049;5056.747162641853;5110.540051395392;5138.049460849755;5151.072806894795;5221.738913054332;3799.544054713452;3917.5690674025836;3934.940975885364;3948.151147503243;3969.960300396959;1131.4851742457163;1136.1649187846926;1141.4806263150247;1151.228676786555;1154.8267759836092;634.9428551430393;653.6404977262487;679.2290749998787;680.9182898052167;682.6006786030129;5133.845984620468;5219.712915789592;5335.199720041947;5339.985402773461;5368.436314187033;523.3092318140019;529.3753371022153;533.8932213557304;536.0378121272325;542.9212764149177;3099.9535006974916;3152.4640811062172;3209.951850722241;3421.503881937155;3468.497067925137;13235.338233088307;13239.73520529584;13397.732045359038;13498.055136140376;13558.728825423435;13189;13325.321786111683;13421.463141474233;13469.663258418423;13480.325983700775;7097.680604372816;7238.710451581983;7372.889406659012;7381.741639042608;7395.889061664079;5115.616328775282;5182.1190397631735;5258.368995720538;5352.464753524772;5450.1007333789485;11912.404379780803;11954.462049207981;12140.15018948665;12185.634430967086;12192.817107743569;12123.393830308625;12267.263964161823;12412.131150819356;12589.118761686594;12617.369131543202;7568.8486230276185;7587.962060189884;7676.654550545127;7678.424118191047;7718.035245594301;9496.097870702271;9620.086091821266;9704.951475242578;9708.320417570701;9709.951450242703;8182.959085204536;8316.334693224648;8392.16078392156;8438.282745966662;8594.871076933727;7968.851395197969;8027.478213916077;8052.114267430461;8330.333573314;8353.164683531599;7077.858442831218;7220.638968051471;7244.094488188976;7245.637718114179;7254.89117663246;4735.597474214593;4796.35249241348;4839;4896.436909755281;4935.136351138464;5038.420581633012;5065.772040258271;5115;5152.098382783073;5174.14626586624 12:38:06 INFO - PID 11854 | |4;prototype.html;395.7139297283828;396.839280091563;399.1179493319763;399.16375193968645;405.51338393927296;5425.674459532426;5475.397706252309;5492.121260598305;5495.560355171587;5497.642653227543;5012.824551140701;5232.843014709555;5291.497307755757;5331.866703332418;5359.624826262163;4022.396640503933;4024.4164596133614;4035.3946907963896;4040;4045.393191021341;4037.7577345359373;4039.3738970459626;4045.757254564721;4055.776932268724;4061.2689715851284;3936.4488971544006;4004.159126583421;4020.5778393268724;4021.3766866135797;4033.616806403387;3979.701522385818;3985.8078057068788;3985.880423587268;4016.116454380032;4024.094578719794;3505.158761897126;3527.3827080260853;3528;3529.311784202056;3534.628863969272;5073.315102461157;5091;5113.974430127825;5129.410117836459;5132.384113906355;4590.586847183769;4722.291656251556;4738.857834264978;4741.6097490294605;4768.73771942543;5615.241942337773;5619.943800561983;5623.381428042912;5637.787875606723;5651.604387692863;3957.34703773877;3958.3968492760478;3964.306246406867;3971.1660551284267;3977.8773662674953;5777.59556831022;5811.970940145315;5944.821655350346;5963.360075979141;6007.80715039012;3984.4820173377275;4004.6996475264473;4023.5976402360116;4029.4157347184496;4045.554988951213;4066.2274167908004;4072.165206132736;4081.3061779497557;4084.9591504085174;4087.754734715867;4712.670113092051;4727.810887564459;4733.526647335308;4737.620990320766;4905.8226025753565;5723.771049157987;5736.737917658109;5738;5743.655380677173;5773.826785196451;1583.9049657020616;1604.1177352456102;1608.1959020489755;1612.9838701613069;1616.0869108953405;1092.5684354679856;1167.7372591167089;1171.9296842189497;1174.1135442740676;1179.8820117988132;4967.690024138793;4975.5522003019905;4977.925331120036;4978.47725988766;4992.276119962585;5922.703864806743;5935.465808077293;5944.613600116065;5959.374265702126;5962.910556341659;4927.95072049282;4956.950430495721;4971.751412429364;4992.650514463952;5005.89988200234;3079.3687294104657;3112.9221769455944;3126.9524709222665;3130.591233944734;3141.607299087614;5316.255724198615;5506.476884695948;5519.889602207933;5526.889462210734;5538.196961440649;5954.3152537458745;5976.9402305977255;6009.939900601025;6014.458698717049;6039.245094363205;5475.09660905946;5490.231367608538;5502.9174562382395;5519.2824932758485;5551.361593416808;5733.312002559553;5815.41845815415;5874.265716785402;5899.528037756883;5901.734421951109;5768.653880767168;5795.449432303924;5821.76712931478;5827.358990510956;5837.854053648693;5321.281626980308;5439.809606663748;5513.3108361454815;5527.5577953764405;5533;4000.1999600079516;4004.3392840181045;4006.358982562776;4009.7794621296107;4021.4973128358956;5852.7416605430035;5942.168096466412;5955.970220148872;5962;5968.343482217039;5681.289838770153;5732.942670573241;5734.598578099493;5741.3397459291045;5742.913856292243;5616.129499927518;5702.714864256854;5710.714464276853;5715.485606295453;5717.742701578356;5475.589330800126;5572.944270557405;5584.441555844383;5612.915806262828;5641.746121424464;5725.742341594555;5740.253767010262;5743.368229494668;5745.6552606843725;5756.65460072397;5461.563074953915;5553.583481238842;5576.525995290283;5584.86037849057;5594.720263986703 12:38:06 INFO - PID 11854 | |5;yui.html;736.7237286017744;752.7252552818223;756.9697212111516;757.3713817531448;778.1012930065774;11529.365884876328;12043.337616431092;12940.35298235088;13856.584302470941;13929.860701392983;14545.854541454582;14616.12303261805;14625;14693.853061469383;14793.630159246024;820.2003047029143;836.3685417509802;838.170211490626;839.3201506779528;841.8484672758901;884.9159329863685;893.8122994171232;894.0746327550986;894.2845723421269;896.3277541843618;901.3104974694364;901.923336516397;902.5848109869468;903.6791938861675;930.3534043839534;896.9103089691044;897.7306807957652;899.5727029660957;900.2932697832204;930.7580029192425;657.8322527755439;657.9934200658028;659.36700767263;669.4610838275187;684.1072400517323;13668.726625467534;13686.247256400893;13793.724125517434;14538.563843084725;14672.19302938338;15522.301496432689;15800.841991580168;15831.366745330173;15909.204539773082;16040.75938860918;12164.330961797097;12208.940201007532;12259.754804903852;12288.754224915452;12432.75134497314;2849.415869746697;2855.5573886047696;2865.4842128416876;2866.7419932206203;2867.16852112887;67121;67124.6643766783;67614;68095.3190468094;68571;10434.426106564211;10523.684289471328;11298;11619.941900290445;11662.88337116618;21393.03731332094;21810.563788724136;21975.23086691958;22125.00437480317;22174.113035478724;6319.557630965788;6448;6514.739410423625;6541.47668186544;6556.541042127005;2973.6431628204755;2982.4333376658365;2993.670696223414;3004.519276915683;3007.203091180839;3386.847591858372;3425.07522968802;3447.4311738563356;3461.13471632092;3465.428204346305;725.350811024141;729.4820677319162;729.9781006569812;730.3317464520011;731.8646050480678;591.9437653422918;620.6632030405527;625.6621424430756;632.9746810127635;636.3477435628517;9477;9706.573356660834;9738.074882886114;9744.512774361254;10010.49947502622;620.6648409858626;628.8679377330811;628.8868003759367;638.1193952345733;648.3289795062088;4098.52866920302;4195.3916682081535;4299.634531064832;4311.180875633682;4423.248047831877;61878.38121618726;62902;62971.685141574;63768.36231637717;64354.35645643577;55043;55336.44663553393;55603.88792224133;55918;58281.417185828446;50517.49482505202;50783.746081270096;51811.74094129581;51852;52365.2145217822;8543.829123417621;8654.740357789276;8675.175858293453;8694.869576956224;8909.777255568662;27128;27272.318192045357;27389.31526711848;27410.862945685145;28156.296092597848;32424;32635.510467342534;32663.510047348835;33186.17034574155;33471.16322091967;11605.941970290094;11878.643640690792;13438;13868.93065534666;14036.087654302437;14339.641508962359;14658.853411465749;14923.776143357642;15797;16019.759703604688;12942.611721647989;13012.21926684402;13206;13246.403911823798;13853.584392468241;12923.547675831302;13045.478180872658;13612.65968350799;13902.37439315213;14218.715625687635;12768.6807829805;12941.611751647466;13058.477660893457;13170.60488185356;13177.275249860966;10213.846792297973;10247.333923294962;10287;10569.418681972566;10858.619948301772;10528.684139475828;10529.526171322463;10857.131429485464;10861;11016.394098324668 12:38:06 INFO - PID 11854 | __end_tp_report 12:38:06 INFO - PID 11854 | __start_cc_report 12:38:06 INFO - PID 11854 | _x_x_mozilla_cycle_collect,371 12:38:06 INFO - PID 11854 | __end_cc_report 12:38:06 INFO - PID 11854 | __startTimestamp1494445086807__endTimestamp 12:38:06 INFO - PID 11854 | 12:38:06 INFO - PID 11854 | ------- Summary: start ------- 12:38:06 INFO - PID 11854 | Number of tests: 6 12:38:06 INFO - PID 11854 | 12:38:06 INFO - PID 11854 | [#0] dojo.html Cycles:165 Average:5170.98 Median:5326.68 stddev:604.79 (11.4%) stddev-sans-first:576.74 12:38:06 INFO - PID 11854 | Values: 2776.5 2781.6 2798.4 2815.4 2816.4 5089.8 5173.4 5182.6 5200.5 5215.9 5171.2 5222.0 5238.0 5244.5 5339.3 4612.8 4634.0 4659.4 4666.3 4713.5 4683.1 4691.7 4711.5 4738.5 4746.2 4589.9 4618.3 4650.3 4657.8 4676.8 4571.3 4616.7 4624.4 4636.9 4682.1 4555.3 4589.8 4595.1 4622.0 4643.6 4991.7 4999.2 5004.7 5044.2 5056.2 5673.4 5674.0 5699.8 5703.1 5750.3 5629.5 5700.2 5700.8 5702.3 5707.0 5163.7 5228.4 5264.3 5279.2 5342.0 5722.7 5733.9 5811.6 5818.1 5825.7 5450.2 5504.1 5510.6 5590.9 5608.8 5557.4 5630.4 5635.5 5666.2 5672.4 5532.1 5608.2 5616.0 5623.1 5638.4 5562.9 5602.5 5608.2 5635.7 5681.3 4726.5 4729.3 4736.9 4745.9 4785.3 4003.7 4038.9 4049.2 4052.0 4076.0 4865.2 4871.1 4877.1 4878.0 4891.3 5637.6 5679.8 5688.9 5696.3 5704.0 4866.1 4868.2 4874.8 4882.1 4883.3 5004.1 5038.2 5038.9 5043.6 5044.2 5303.7 5305.1 5307.5 5313.1 5318.7 5658.0 5696.3 5762.0 5768.5 5811.4 5310.5 5321.0 5322.3 5324.3 5326.7 5513.9 5589.8 5613.9 5618.8 5633.7 5605.8 5693.3 5710.5 5757.2 5763.3 5517.7 5520.3 5528.6 5544.4 5558.2 5506.1 5522.5 5523.4 5525.3 5533.8 5330.2 5337.9 5394.8 5400.3 5466.9 5560.0 5566.9 5571.6 5580.4 5599.6 5386.2 5399.6 5429.4 5430.9 5436.9 12:38:06 INFO - PID 11854 | 12:38:06 INFO - PID 11854 | [#1] ext.html Cycles:180 Average:29908.87 Median:30370.89 stddev:41343.40 (136.1%) stddev-sans-first:41400.80 12:38:06 INFO - PID 11854 | Values: 599.5 644.9 657.4 1080.3 1086.4 31857.8 32370.2 32376.0 32412.8 32461.7 30135.7 30332.2 30409.5 30498.5 30613.5 6108.6 6121.6 6143.8 6159.5 6181.4 6763.3 6799.6 6849.8 6868.8 6872.3 6783.2 6836.4 6851.3 6866.3 6877.9 6801.2 6858.4 6860.5 6863.5 6865.0 6749.5 6785.4 6811.7 6814.8 6826.0 29756.3 29951.0 30023.4 30121.2 30278.1 3012.9 3048.1 3053.2 3063.1 3093.6 23180.7 23280.5 23295.8 23333.3 23351.9 3063.8 3079.2 3117.3 3139.5 3156.7 131422.0 132220.0 133015.3 138385.3 142486.3 36743.8 36904.6 37089.3 37110.6 37142.0 38073.4 38205.4 41399.4 41633.6 42062.4 12414.4 12555.9 12583.6 12603.0 12605.2 9783.5 9785.1 9794.7 9862.8 9877.5 12206.4 12279.4 12418.3 12481.2 12665.1 5311.9 5331.7 5348.5 5412.2 5443.5 874.3 909.6 916.6 925.3 939.2 19727.5 20434.8 20444.9 20728.6 20734.8 976.7 983.2 987.7 987.8 1002.6 10913.9 10941.7 10970.5 10988.6 11061.4 180264.0 180424.1 182476.0 182565.0 182647.0 37914.8 38090.6 38251.0 38271.6 38280.2 1206.7 1238.4 1242.0 1247.2 1253.9 19700.3 19731.2 20315.8 20690.2 23481.2 37234.6 37369.3 37550.6 37637.1 37642.6 159088.0 159687.2 159739.0 160007.0 160941.0 28544.4 29250.7 29262.9 29266.9 29271.7 33891.7 34412.0 34498.5 34608.3 34854.0 26141.9 26426.7 26599.2 26621.5 27566.7 27119.3 27220.9 27339.9 27345.6 27832.7 29749.7 29756.1 29770.7 29804.4 29882.3 25172.7 25782.9 25849.4 26328.9 27338.3 19024.2 21785.8 21845.2 21931.8 21949.2 12:38:06 INFO - PID 11854 | 12:38:06 INFO - PID 11854 | [#2] jquery.html Cycles:180 Average:25491.77 Median:217275.10 stddev:64263.76 (29.6%) stddev-sans-first:64416.46 12:38:06 INFO - PID 11854 | Values: 416.4 423.8 433.6 439.0 441.3 16909.3 17262.7 17534.6 18105.1 18171.0 18506.3 18719.7 18950.7 19151.7 19206.7 5231.2 5365.1 5490.9 5493.6 5503.2 5244.3 5292.4 5382.1 5382.2 5450.2 5415.8 5419.9 5432.0 5440.7 5449.6 5316.4 5365.8 5388.3 5398.1 5419.8 4895.2 4903.1 4905.8 4923.4 4925.0 21116.2 21369.0 21882.2 22079.7 22196.1 1642.7 1685.3 1685.4 1690.7 1691.6 14329.9 14536.5 14838.6 14941.3 15050.9 2054.7 2056.8 2059.9 2080.0 2093.6 78683.0 86927.0 89360.0 97318.0 98923.5 10854.2 10874.2 11073.0 11266.0 11424.3 15609.6 15695.4 15707.6 15714.7 15781.8 7865.5 7910.1 8003.8 8145.9 8224.7 6395.9 6455.5 6790.2 7109.3 7123.8 6852.3 6973.4 7002.2 7113.6 7130.7 1939.9 1943.4 1945.7 1946.9 2138.8 849.6 876.2 876.5 880.0 912.2 15919.3 16179.9 16183.2 16848.9 16975.7 874.9 876.4 884.4 887.7 890.2 11009.3 11610.2 11891.1 12039.9 12047.3 377764.0 380105.0 386037.0 392664.0 394556.0 74331.0 78460.0 79606.6 82219.0 83384.2 1061.6 1083.3 1106.7 1111.5 1117.8 16985.2 17073.0 17695.2 18104.5 18330.5 37543.1 38802.4 39108.7 39994.2 40119.8 49271.0 49352.3 49374.8 49595.3 51584.2 8224.9 8277.3 8469.8 8488.8 8643.6 11443.5 11506.1 11783.8 11986.6 12720.4 10010.4 10817.7 10900.3 11228.6 11289.2 9176.7 9544.5 9785.3 9812.8 9888.0 9785.8 9965.2 10142.3 10207.4 10210.6 7715.2 7869.5 7939.7 7945.8 8180.5 10815.8 10925.1 10984.6 11162.2 11205.4 12:38:06 INFO - PID 11854 | 12:38:06 INFO - PID 11854 | [#3] mootools.html Cycles:180 Average:6223.47 Median:3449.78 stddev:4085.62 (118.4%) stddev-sans-first:4079.91 12:38:06 INFO - PID 11854 | Values: 1237.5 1266.5 1301.3 1302.5 1320.2 9866.3 10134.9 10267.7 10289.7 10402.7 10161.4 10327.8 10331.0 10331.5 10354.5 2236.8 2275.6 2281.3 2282.6 2286.9 2157.0 2202.1 2220.3 2222.6 2227.9 2183.4 2195.8 2203.8 2229.5 2238.2 2093.1 2155.1 2174.2 2187.3 2190.1 2032.7 2154.5 2178.5 2179.5 2202.1 10018.8 10053.6 10071.1 10090.8 10102.9 5562.9 5824.9 5828.7 5833.6 5838.8 3281.4 3406.3 3431.1 3488.4 3492.6 1128.2 1152.5 1172.0 1174.7 1178.4 14985.3 15035.7 15201.2 15235.9 15273.4 4471.4 4669.2 4827.9 4846.2 4861.3 10681.1 10709.8 10725.1 10747.5 10781.6 5464.8 5496.6 5500.7 5500.8 5508.1 5056.7 5110.5 5138.0 5151.1 5221.7 3799.5 3917.6 3934.9 3948.2 3970.0 1131.5 1136.2 1141.5 1151.2 1154.8 634.9 653.6 679.2 680.9 682.6 5133.8 5219.7 5335.2 5340.0 5368.4 523.3 529.4 533.9 536.0 542.9 3100.0 3152.5 3210.0 3421.5 3468.5 13235.3 13239.7 13397.7 13498.1 13558.7 13189.0 13325.3 13421.5 13469.7 13480.3 7097.7 7238.7 7372.9 7381.7 7395.9 5115.6 5182.1 5258.4 5352.5 5450.1 11912.4 11954.5 12140.2 12185.6 12192.8 12123.4 12267.3 12412.1 12589.1 12617.4 7568.8 7588.0 7676.7 7678.4 7718.0 9496.1 9620.1 9705.0 9708.3 9710.0 8183.0 8316.3 8392.2 8438.3 8594.9 7968.9 8027.5 8052.1 8330.3 8353.2 7077.9 7220.6 7244.1 7245.6 7254.9 4735.6 4796.4 4839.0 4896.4 4935.1 5038.4 5065.8 5115.0 5152.1 5174.1 12:38:06 INFO - PID 11854 | 12:38:06 INFO - PID 11854 | [#4] prototype.html Cycles:180 Average:4688.15 Median:5182.61 stddev:1364.89 (26.3%) stddev-sans-first:1330.16 12:38:06 INFO - PID 11854 | Values: 395.7 396.8 399.1 399.2 405.5 5425.7 5475.4 5492.1 5495.6 5497.6 5012.8 5232.8 5291.5 5331.9 5359.6 4022.4 4024.4 4035.4 4040.0 4045.4 4037.8 4039.4 4045.8 4055.8 4061.3 3936.4 4004.2 4020.6 4021.4 4033.6 3979.7 3985.8 3985.9 4016.1 4024.1 3505.2 3527.4 3528.0 3529.3 3534.6 5073.3 5091.0 5114.0 5129.4 5132.4 4590.6 4722.3 4738.9 4741.6 4768.7 5615.2 5619.9 5623.4 5637.8 5651.6 3957.3 3958.4 3964.3 3971.2 3977.9 5777.6 5812.0 5944.8 5963.4 6007.8 3984.5 4004.7 4023.6 4029.4 4045.6 4066.2 4072.2 4081.3 4085.0 4087.8 4712.7 4727.8 4733.5 4737.6 4905.8 5723.8 5736.7 5738.0 5743.7 5773.8 1583.9 1604.1 1608.2 1613.0 1616.1 1092.6 1167.7 1171.9 1174.1 1179.9 4967.7 4975.6 4977.9 4978.5 4992.3 5922.7 5935.5 5944.6 5959.4 5962.9 4928.0 4957.0 4971.8 4992.7 5005.9 3079.4 3112.9 3127.0 3130.6 3141.6 5316.3 5506.5 5519.9 5526.9 5538.2 5954.3 5976.9 6009.9 6014.5 6039.2 5475.1 5490.2 5502.9 5519.3 5551.4 5733.3 5815.4 5874.3 5899.5 5901.7 5768.7 5795.4 5821.8 5827.4 5837.9 5321.3 5439.8 5513.3 5527.6 5533.0 4000.2 4004.3 4006.4 4009.8 4021.5 5852.7 5942.2 5956.0 5962.0 5968.3 5681.3 5732.9 5734.6 5741.3 5742.9 5616.1 5702.7 5710.7 5715.5 5717.7 5475.6 5572.9 5584.4 5612.9 5641.7 5725.7 5740.3 5743.4 5745.7 5756.7 5461.6 5553.6 5576.5 5584.9 5594.7 12:38:06 INFO - PID 11854 | 12:38:06 INFO - PID 11854 | [#5] yui.html Cycles:180 Average:14887.36 Median:18429.01 stddev:17707.14 (96.1%) stddev-sans-first:17724.93 12:38:06 INFO - PID 11854 | Values: 736.7 752.7 757.0 757.4 778.1 11529.4 12043.3 12940.4 13856.6 13929.9 14545.9 14616.1 14625.0 14693.9 14793.6 820.2 836.4 838.2 839.3 841.8 884.9 893.8 894.1 894.3 896.3 901.3 901.9 902.6 903.7 930.4 896.9 897.7 899.6 900.3 930.8 657.8 658.0 659.4 669.5 684.1 13668.7 13686.2 13793.7 14538.6 14672.2 15522.3 15800.8 15831.4 15909.2 16040.8 12164.3 12208.9 12259.8 12288.8 12432.8 2849.4 2855.6 2865.5 2866.7 2867.2 67121.0 67124.7 67614.0 68095.3 68571.0 10434.4 10523.7 11298.0 11619.9 11662.9 21393.0 21810.6 21975.2 22125.0 22174.1 6319.6 6448.0 6514.7 6541.5 6556.5 2973.6 2982.4 2993.7 3004.5 3007.2 3386.8 3425.1 3447.4 3461.1 3465.4 725.4 729.5 730.0 730.3 731.9 591.9 620.7 625.7 633.0 636.3 9477.0 9706.6 9738.1 9744.5 10010.5 620.7 628.9 628.9 638.1 648.3 4098.5 4195.4 4299.6 4311.2 4423.2 61878.4 62902.0 62971.7 63768.4 64354.4 55043.0 55336.4 55603.9 55918.0 58281.4 50517.5 50783.7 51811.7 51852.0 52365.2 8543.8 8654.7 8675.2 8694.9 8909.8 27128.0 27272.3 27389.3 27410.9 28156.3 32424.0 32635.5 32663.5 33186.2 33471.2 11605.9 11878.6 13438.0 13868.9 14036.1 14339.6 14658.9 14923.8 15797.0 16019.8 12942.6 13012.2 13206.0 13246.4 13853.6 12923.5 13045.5 13612.7 13902.4 14218.7 12768.7 12941.6 13058.5 13170.6 13177.3 10213.8 10247.3 10287.0 10569.4 10858.6 10528.7 10529.5 10857.1 10861.0 11016.4 12:38:06 INFO - PID 11854 | -------- Summary: end -------- 12:38:06 INFO - PID 11854 | 12:38:07 INFO - TEST-INFO | 11854: exit 0 12:38:07 INFO - TEST-OK | dromaeo_css | took 1118618ms 12:38:07 INFO - TEST-START | kraken 12:38:07 INFO - operating with platform_type : linux_ 12:38:07 INFO - Initialising browser for kraken test... 12:38:07 INFO - TEST-INFO | started process 12291 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpla01lL/profile http://localhost:41914/getInfo.html) 12:38:11 INFO - PID 12291 | __metrics Screen width/height:1600/1200 12:38:11 INFO - PID 12291 | colorDepth:24 12:38:11 INFO - PID 12291 | Browser inner width/height: 1024/695 12:38:11 INFO - PID 12291 | __metrics 12:38:13 INFO - TEST-INFO | 12291: exit 0 12:38:13 INFO - Browser initialized. 12:38:13 INFO - Running cycle 1/1 for kraken test... 12:38:13 INFO - TEST-INFO | started process 12482 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpla01lL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:38:25 INFO - PID 12482 | RSS: Main: 169742336 12:38:25 INFO - PID 12482 | 12:38:28 INFO - PID 12482 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41914/tests/kraken/driver.html?testName=audio-beat-detection) 12:38:29 INFO - PID 12482 | RSS: Main: 178528256 12:38:29 INFO - PID 12482 | 12:38:31 INFO - PID 12482 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41914/tests/kraken/driver.html?testName=audio-dft) 12:38:32 INFO - PID 12482 | RSS: Main: 177545216 12:38:32 INFO - PID 12482 | 12:38:35 INFO - PID 12482 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41914/tests/kraken/driver.html?testName=audio-fft) 12:38:36 INFO - PID 12482 | RSS: Main: 173776896 12:38:36 INFO - PID 12482 | 12:38:38 INFO - PID 12482 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41914/tests/kraken/driver.html?testName=audio-oscillator) 12:38:38 INFO - PID 12482 | RSS: Main: 174596096 12:38:38 INFO - PID 12482 | 12:38:40 INFO - PID 12482 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41914/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:38:41 INFO - PID 12482 | RSS: Main: 174813184 12:38:41 INFO - PID 12482 | 12:38:44 INFO - PID 12482 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41914/tests/kraken/driver.html?testName=imaging-darkroom) 12:38:45 INFO - PID 12482 | RSS: Main: 178679808 12:38:45 INFO - PID 12482 | 12:38:48 INFO - PID 12482 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41914/tests/kraken/driver.html?testName=imaging-desaturate) 12:38:49 INFO - PID 12482 | RSS: Main: 176291840 12:38:49 INFO - PID 12482 | 12:38:52 INFO - PID 12482 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41914/tests/kraken/driver.html?testName=json-parse-financial) 12:38:53 INFO - PID 12482 | RSS: Main: 177799168 12:38:53 INFO - PID 12482 | 12:38:54 INFO - PID 12482 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41914/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:38:55 INFO - PID 12482 | RSS: Main: 178077696 12:38:55 INFO - PID 12482 | 12:38:57 INFO - PID 12482 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41914/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:38:57 INFO - PID 12482 | RSS: Main: 179007488 12:38:57 INFO - PID 12482 | 12:38:59 INFO - PID 12482 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41914/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:39:00 INFO - PID 12482 | RSS: Main: 179474432 12:39:00 INFO - PID 12482 | 12:39:03 INFO - PID 12482 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41914/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:39:04 INFO - PID 12482 | RSS: Main: 179376128 12:39:04 INFO - PID 12482 | 12:39:07 INFO - PID 12482 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41914/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:39:07 INFO - PID 12482 | RSS: Main: 179175424 12:39:07 INFO - PID 12482 | 12:39:09 INFO - PID 12482 | Cycle 1(1): loaded http://localhost:41914/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41914/tests/kraken/driver.html?testName=ai-astar) 12:39:09 INFO - PID 12482 | RSS: Main: 180989952 12:39:09 INFO - PID 12482 | 12:39:09 INFO - PID 12482 | __start_tp_report 12:39:09 INFO - PID 12482 | _x_x_mozilla_page_load 12:39:09 INFO - PID 12482 | _x_x_mozilla_page_load_details 12:39:09 INFO - PID 12482 | |i|pagename|runs| 12:39:09 INFO - PID 12482 | |0;ai-astar;104;112;113;112;111;112;111;112;112;113 12:39:09 INFO - PID 12482 | |1;audio-beat-detection;158;131;130;167;125;125;124;123;146;129 12:39:09 INFO - PID 12482 | |2;audio-dft;165;166;166;168;168;167;167;165;165;165 12:39:09 INFO - PID 12482 | |3;audio-fft;75;76;76;107;75;75;77;75;93;75 12:39:09 INFO - PID 12482 | |4;audio-oscillator;84;84;106;84;83;83;95;83;84;107 12:39:09 INFO - PID 12482 | |5;imaging-gaussian-blur;114;114;113;114;114;113;114;117;115;117 12:39:09 INFO - PID 12482 | |6;imaging-darkroom;150;152;151;155;150;150;150;153;151;150 12:39:09 INFO - PID 12482 | |7;imaging-desaturate;95;97;98;95;96;96;96;94;95;95 12:39:09 INFO - PID 12482 | |8;json-parse-financial;53;53;61;60;55;57;62;54;56;55 12:39:09 INFO - PID 12482 | |9;json-stringify-tinderbox;56;55;55;55;56;54;55;56;55;56 12:39:09 INFO - PID 12482 | |10;stanford-crypto-aes;82;81;81;81;83;81;82;82;82;84 12:39:09 INFO - PID 12482 | |11;stanford-crypto-ccm;143;134;131;137;130;133;131;136;181;134 12:39:09 INFO - PID 12482 | |12;stanford-crypto-pbkdf2;184;192;190;201;197;207;199;181;192;193 12:39:09 INFO - PID 12482 | |13;stanford-crypto-sha256-iterative;75;82;75;73;84;79;75;76;72;75 12:39:09 INFO - PID 12482 | __end_tp_report 12:39:09 INFO - PID 12482 | __start_cc_report 12:39:09 INFO - PID 12482 | _x_x_mozilla_cycle_collect,844 12:39:09 INFO - PID 12482 | __end_cc_report 12:39:09 INFO - PID 12482 | __startTimestamp1494445149960__endTimestamp 12:39:09 INFO - PID 12482 | 12:39:09 INFO - PID 12482 | ------- Summary: start ------- 12:39:09 INFO - PID 12482 | Number of tests: 14 12:39:09 INFO - PID 12482 | 12:39:09 INFO - PID 12482 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:2.62 (2.3%) stddev-sans-first:0.71 12:39:09 INFO - PID 12482 | Values: 104.0 112.0 113.0 112.0 111.0 112.0 111.0 112.0 112.0 113.0 12:39:09 INFO - PID 12482 | 12:39:09 INFO - PID 12482 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:130.50 stddev:15.67 (12.0%) stddev-sans-first:14.41 12:39:09 INFO - PID 12482 | Values: 158.0 131.0 130.0 167.0 125.0 125.0 124.0 123.0 146.0 129.0 12:39:09 INFO - PID 12482 | 12:39:09 INFO - PID 12482 | [#2] audio-dft Cycles:10 Average:166.20 Median:166.50 stddev:1.23 (0.7%) stddev-sans-first:1.22 12:39:09 INFO - PID 12482 | Values: 165.0 166.0 166.0 168.0 168.0 167.0 167.0 165.0 165.0 165.0 12:39:09 INFO - PID 12482 | 12:39:09 INFO - PID 12482 | [#3] audio-fft Cycles:10 Average:80.40 Median:75.50 stddev:10.86 (14.4%) stddev-sans-first:11.35 12:39:09 INFO - PID 12482 | Values: 75.0 76.0 76.0 107.0 75.0 75.0 77.0 75.0 93.0 75.0 12:39:09 INFO - PID 12482 | 12:39:09 INFO - PID 12482 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:84.00 stddev:9.75 (11.6%) stddev-sans-first:10.15 12:39:09 INFO - PID 12482 | Values: 84.0 84.0 106.0 84.0 83.0 83.0 95.0 83.0 84.0 107.0 12:39:09 INFO - PID 12482 | 12:39:09 INFO - PID 12482 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.00 stddev:1.43 (1.3%) stddev-sans-first:1.51 12:39:09 INFO - PID 12482 | Values: 114.0 114.0 113.0 114.0 114.0 113.0 114.0 117.0 115.0 117.0 12:39:09 INFO - PID 12482 | 12:39:09 INFO - PID 12482 | [#6] imaging-darkroom Cycles:10 Average:151.20 Median:151.00 stddev:1.69 (1.1%) stddev-sans-first:1.73 12:39:09 INFO - PID 12482 | Values: 150.0 152.0 151.0 155.0 150.0 150.0 150.0 153.0 151.0 150.0 12:39:09 INFO - PID 12482 | 12:39:09 INFO - PID 12482 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:1.16 (1.2%) stddev-sans-first:1.20 12:39:09 INFO - PID 12482 | Values: 95.0 97.0 98.0 95.0 96.0 96.0 96.0 94.0 95.0 95.0 12:39:09 INFO - PID 12482 | 12:39:09 INFO - PID 12482 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.50 stddev:3.31 (5.9%) stddev-sans-first:3.24 12:39:09 INFO - PID 12482 | Values: 53.0 53.0 61.0 60.0 55.0 57.0 62.0 54.0 56.0 55.0 12:39:09 INFO - PID 12482 | 12:39:09 INFO - PID 12482 | [#9] json-stringify-tinderbox Cycles:10 Average:55.30 Median:55.50 stddev:0.67 (1.2%) stddev-sans-first:0.67 12:39:09 INFO - PID 12482 | Values: 56.0 55.0 55.0 55.0 56.0 54.0 55.0 56.0 55.0 56.0 12:39:09 INFO - PID 12482 | 12:39:09 INFO - PID 12482 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:0.99 (1.2%) stddev-sans-first:1.05 12:39:09 INFO - PID 12482 | Values: 82.0 81.0 81.0 81.0 83.0 81.0 82.0 82.0 82.0 84.0 12:39:09 INFO - PID 12482 | 12:39:09 INFO - PID 12482 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:135.00 stddev:15.23 (11.3%) stddev-sans-first:16.09 12:39:09 INFO - PID 12482 | Values: 143.0 134.0 131.0 137.0 130.0 133.0 131.0 136.0 181.0 134.0 12:39:09 INFO - PID 12482 | 12:39:09 INFO - PID 12482 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.60 Median:195.00 stddev:7.78 (4.0%) stddev-sans-first:7.43 12:39:09 INFO - PID 12482 | Values: 184.0 192.0 190.0 201.0 197.0 207.0 199.0 181.0 192.0 193.0 12:39:09 INFO - PID 12482 | 12:39:09 INFO - PID 12482 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.60 Median:75.50 stddev:3.86 (5.1%) stddev-sans-first:4.06 12:39:09 INFO - PID 12482 | Values: 75.0 82.0 75.0 73.0 84.0 79.0 75.0 76.0 72.0 75.0 12:39:09 INFO - PID 12482 | -------- Summary: end -------- 12:39:09 INFO - PID 12482 | 12:39:11 INFO - TEST-INFO | 12482: exit 0 12:39:11 INFO - TEST-OK | kraken | took 63574ms 12:39:11 INFO - SUITE-END | took 1182s 12:39:11 INFO - Completed test suite (00:19:42) 12:39:11 INFO - javascript benchmark 12:39:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6635.212659096522, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2776.472470230656, 2781.6105745195687, 2798.384355441802, 2815.3524689321457, 2816.4085542036173, 5089.821856235032, 5173.353330833651, 5182.637215394924, 5200.531952124308, 5215.92176117358, 5171.198464238049, 5221.973890130554, 5237.973810130953, 5244.527992480676, 5339.279197308372, 4612.815487380509, 4633.976830115862, 4659.394278743775, 4666.276727107287, 4713.505081966396, 4683.063387322532, 4691.741954192518, 4711.481737008926, 4738.549837765407, 4746.21687421575, 4589.862304130848, 4618.2610782275015, 4650.25595904657, 4657.813687452498, 4676.8363107291425, 4571.3143028545655, 4616.746078965655, 4624.375709279271, 4636.86089417318, 4682.063587282557, 4555.293929440942, 4589.839355622571, 4595.080983803253, 4621.976890115561, 4643.582077612998, 4991.725455099968, 4999.200127979506, 5004.724740139291, 5044.192929131322, 5056.241563765428, 5673.375928647845, 5674.0, 5699.772009119631, 5703.087505999062, 5750.252467179282, 5629.521490673298, 5700.201971723962, 5700.7719691212305, 5702.287214098238, 5707.001274776898, 5163.741812909339, 5228.424873263938, 5264.263003179558, 5279.181726832308, 5342.0, 5722.685252311079, 5733.913991290134, 5811.593188476851, 5818.0981947798155, 5825.650460972355, 5450.236966824647, 5504.0643090674685, 5510.559155267569, 5590.888182236333, 5608.831735047874, 5557.44425557441, 5630.4369563043365, 5635.549156067505, 5666.206731057655, 5672.404397538282, 5532.1425179097305, 5608.1587761835235, 5615.971920140373, 5623.128415095667, 5638.35158956717, 5562.916556251659, 5602.4957753802355, 5608.186812912105, 5635.6618602883955, 5681.318241810926, 4726.456457507362, 4729.266963620645, 4736.928946065812, 4745.905081898342, 4785.306130611042, 4003.7197396181987, 4038.9394159087637, 4049.230646177276, 4052.0477687743355, 4075.9796201018803, 4865.221564549655, 4871.050145221648, 4877.09773691861, 4878.048780487771, 4891.3396691446915, 5637.633553818989, 5679.77280908759, 5688.857778555569, 5696.3449203341315, 5704.030314846486, 4866.075445665312, 4868.172410690191, 4874.829380971649, 4882.145624515695, 4883.267509873476, 5004.074246264453, 5038.193888977746, 5038.949610503922, 5043.646944713835, 5044.1929291313945, 5303.681779093266, 5305.071612467726, 5307.548858347083, 5313.149896016542, 5318.7074710891275, 5658.03813351723, 5696.287964004499, 5762.049261871744, 5768.480836724715, 5811.4188581143235, 5310.495502927216, 5320.973395133, 5322.33470816148, 5324.334458192726, 5326.680399176062, 5513.862153446035, 5589.811732035427, 5613.859653508532, 5618.831435056954, 5633.661980281032, 5605.80379686709, 5693.3168019837885, 5710.457506536873, 5757.165211044291, 5763.279590051244, 5517.69652669107, 5520.309961254843, 5528.640638358494, 5544.390117087198, 5558.166275058774, 5506.146547285177, 5522.502974732293, 5523.447655234444, 5525.309336332958, 5533.806316778893, 5330.200469929541, 5337.9466205339, 5394.811181608625, 5400.270963419888, 5466.8906621866545, 5559.972200138974, 5566.944330556643, 5571.582131340247, 5580.35825880029, 5599.580031497572, 5386.165144402624, 5399.5950303726595, 5429.375621803543, 5430.864228394322, 5436.945630543644], "value": 5127.850599195693, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.4934280532948, 644.8774732800767, 657.4083325007491, 1080.3409919948824, 1086.375334182845, 31857.84071079644, 32370.190745231383, 32375.99999999997, 32412.837935810287, 32461.67538324616, 30135.698643013562, 30332.24169395766, 30409.543856842167, 30498.54252186219, 30613.540796888065, 6108.602940808833, 6121.632702037869, 6143.846403839895, 6159.476444502223, 6181.350958149385, 6763.256041835394, 6799.5920244785475, 6849.794506164798, 6868.793936181923, 6872.312768723113, 6783.219929708072, 6836.350546698056, 6851.280615535372, 6866.27904070073, 6877.931220687779, 6801.18385793703, 6858.382745552874, 6860.519763616574, 6863.485238607124, 6864.9656751716175, 6749.527533072687, 6785.355391237825, 6811.659417029129, 6814.829629259259, 6826.0, 29756.256093597618, 29951.0, 30023.399532009236, 30121.246968825737, 30278.09165725032, 3012.9096127116222, 3048.131282584475, 3053.2214285357313, 3063.0657649416917, 3093.6442309134286, 23180.65229021566, 23280.534389312117, 23295.7670423297, 23333.300000999996, 23351.88324058386, 3063.816171029723, 3079.2148002259282, 3117.2986078132467, 3139.4976803711525, 3156.731677807389, 131422.0, 132220.0, 133015.33492332572, 138385.308073459, 142486.28756856252, 36743.81628091842, 36904.63095369012, 37089.25821483555, 37110.628893711255, 37142.0, 38073.42889856654, 38205.42691859624, 41399.379009314885, 41633.583664163576, 42062.36906446406, 12414.379281035912, 12555.874441255653, 12583.559575415, 12603.0, 12605.235267062619, 9783.510824458748, 9785.119339259501, 9794.65718699842, 9862.802743945082, 9877.506124693737, 12206.389680515938, 12279.38603069843, 12418.316992565315, 12481.188722733175, 12665.113442059152, 5311.867203319948, 5331.680099194061, 5348.491893270133, 5412.161115027177, 5443.537299329601, 874.3180319350917, 909.5861383070687, 916.6058594804165, 925.3291363761219, 939.1547607153616, 19727.506812329808, 20434.79565204329, 20444.897775511326, 20728.58542829135, 20734.79265207359, 976.7118699983522, 983.2036050798876, 987.6691308411619, 987.76293689514, 1002.6390499420203, 10913.945430272797, 10941.726456838484, 10970.451477426097, 10988.560457581607, 11061.446927653586, 180264.0, 180424.09787950976, 182476.0, 182565.0, 182647.0, 37914.8104259477, 38090.61909380926, 38251.0, 38271.61728382736, 38280.234395311934, 1206.6621346023128, 1238.3560548514902, 1242.0, 1247.2329517346766, 1253.9310337931502, 19700.310489133386, 19731.21075157035, 20315.796842031392, 20690.17239310411, 23481.17815876436, 37234.62765372312, 37369.25261494809, 37550.624493754716, 37637.05907352338, 37642.623573763914, 159088.0, 159687.20156399143, 159739.0, 160007.0, 160941.0, 28544.42911141807, 29250.707492924797, 29262.853685731436, 29266.853665731534, 29271.7072829269, 33891.66108338885, 34412.0, 34498.48252276268, 34608.30783384268, 34854.0, 26141.90864730855, 26426.735732643196, 26599.202023939313, 26621.467570648867, 27566.724332756417, 27119.322016949733, 27220.863895680395, 27339.86330068337, 27345.589816153173, 27832.721672783013, 29749.702502974695, 29756.10731678053, 29770.702292977658, 29804.403911922072, 29882.252943676584, 25172.74827251704, 25782.8710856452, 25849.353766155997, 26328.868355658098, 27338.316542085813, 19024.239030438628, 21785.782142178374, 21845.235416760337, 21931.780682192973, 21949.231776887733], "value": 14207.723029673367, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.3920961903943, 423.758457679123, 433.5815937620197, 439.0253636926024, 441.3423998242619, 16909.323627054902, 17262.741058884127, 17534.561635959093, 18105.09474526272, 18171.0, 18506.25974961003, 18719.719204211946, 18950.715739263924, 19151.712724309145, 19206.711899321486, 5231.2153177023465, 5365.087935051031, 5490.890182196354, 5493.560515158798, 5503.174523821419, 5244.292020577231, 5292.364916210041, 5382.085045542267, 5382.2195781611645, 5450.155225939966, 5415.810446634368, 5419.918701219465, 5431.972840135793, 5440.6735595864375, 5449.64577302474, 5316.38861530925, 5365.812196573121, 5388.299521062276, 5398.109311963522, 5419.783208671648, 4895.167821470359, 4903.092927808331, 4905.779239934212, 4923.433805112422, 4924.975375123137, 21116.15535378583, 21369.0, 21882.23412180582, 22079.66880496794, 22196.11215551376, 1642.7289497232941, 1685.2837544043855, 1685.3511398111693, 1690.687222863762, 1691.6024734187456, 14329.928350358286, 14536.491222807152, 14838.554843354717, 14941.327640256215, 15050.924745376313, 2054.7123402723632, 2056.814886660208, 2059.938201853947, 2079.958400831975, 2093.623147833405, 78683.0, 86927.0, 89360.0, 97318.0268197316, 98923.50538247262, 10854.169894397075, 10874.238803283693, 11073.0, 11266.0, 11424.257423267461, 15609.609759756097, 15695.372185112468, 15707.607309817346, 15714.68570628581, 15781.763273550905, 7865.528068315919, 7910.090339610903, 8003.839923201504, 8145.918540814635, 8224.671013159526, 6395.936040639627, 6455.548111632141, 6790.1851777786, 7109.324614161646, 7123.786286411416, 6852.314768523108, 6973.442124630017, 7002.159740831031, 7113.608751518716, 7130.679119439534, 1939.94180174595, 1943.3878328326814, 1945.6984167454068, 1946.883187008784, 2138.807507324348, 849.5752123938031, 876.1982785750967, 876.509154873273, 879.9780005499914, 912.2018234045211, 15919.283632236346, 16179.919100404422, 16183.190840458166, 16848.91575542139, 16975.74536381955, 874.8775171475999, 876.3952872517942, 884.35883984111, 887.6937456577471, 890.1543533643065, 11009.2843965142, 11610.187286890006, 11891.108166887345, 12039.879601204051, 12047.277163370225, 377764.0, 380105.0, 386037.0, 392664.0, 394556.0, 74331.0, 78460.0, 79606.6019669898, 82219.0, 83384.16615833885, 1061.5647584490323, 1083.268793564341, 1106.7233191702076, 1111.5220455204178, 1117.8155604325357, 16985.235664394884, 17072.975621462752, 17695.203715833075, 18104.456866294033, 18330.541736456697, 37543.061423464635, 38802.417963730004, 39108.74260118367, 39994.2001159981, 40119.799401002805, 49271.0, 49352.25971610357, 49374.753126234136, 49595.25607115968, 51584.22623660573, 8224.876626850482, 8277.337812975067, 8469.830603388022, 8488.787780305542, 8643.611037503202, 11443.542258309575, 11506.137039721887, 11783.764324713286, 11986.64040078799, 12720.427580759073, 10010.449425281387, 10817.675469735921, 10900.291481053706, 11228.55085796559, 11289.153313501356, 9176.724698259062, 9544.522773861418, 9785.266105042008, 9812.754681132743, 9888.0, 9785.755356116155, 9965.202783777135, 10142.340747851662, 10207.438590877573, 10210.591576336863, 7715.1513333534385, 7869.48848324857, 7939.682412703427, 7945.8410831784195, 8180.509169449852, 10815.837762433412, 10925.125989920629, 10984.560617575527, 11162.162837787037, 11205.383703896037], "value": 8856.612160886207, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1237.4864431261028, 1266.4744131185557, 1301.3363184775762, 1302.4724986380506, 1320.207875274835, 9866.260030497715, 10134.898651013487, 10267.743306417335, 10289.742756431093, 10402.687919362412, 10161.390316580992, 10327.84508232377, 10331.0, 10331.483425828697, 10354.482275886214, 2236.7539570647255, 2275.590393729128, 2281.292799232235, 2282.6005449046434, 2286.85135466195, 2156.967645485319, 2202.0751284460484, 2220.2784095169054, 2222.622154233776, 2227.899744511493, 2183.351569564976, 2195.7584665686763, 2203.7796220377995, 2229.5317983223545, 2238.183063181935, 2093.1418118571464, 2155.0948601587293, 2174.1629472653062, 2187.3109970359287, 2190.1348967157883, 2032.6849338352579, 2154.504463973279, 2178.4880553070016, 2179.5422961178015, 2202.053117159621, 10018.799624007479, 10053.648122315684, 10071.09360157582, 10090.848637270446, 10102.9494852526, 5562.916556251659, 5824.88350232993, 5828.708564571754, 5833.591648584601, 5838.795642152504, 3281.409346317662, 3406.267652454709, 3431.0564594736647, 3488.389531831919, 3492.5634295713035, 1128.2215271462665, 1152.4698638626242, 1171.953121875124, 1174.712195512105, 1178.3695722788352, 14985.32566034531, 15035.699286014218, 15201.239938003166, 15235.923820380827, 15273.38906443741, 4471.374007638933, 4669.18289299378, 4827.927581086286, 4846.248831431134, 4861.29511220871, 10681.092107170822, 10709.78580428387, 10725.14198864089, 10747.516361763739, 10781.62264320745, 5464.836054918359, 5496.560275177976, 5500.669959802424, 5500.779968801283, 5508.063629183049, 5056.747162641853, 5110.540051395392, 5138.049460849755, 5151.072806894795, 5221.738913054332, 3799.544054713452, 3917.5690674025836, 3934.940975885364, 3948.151147503243, 3969.960300396959, 1131.4851742457163, 1136.1649187846926, 1141.4806263150247, 1151.228676786555, 1154.8267759836092, 634.9428551430393, 653.6404977262487, 679.2290749998787, 680.9182898052167, 682.6006786030129, 5133.845984620468, 5219.712915789592, 5335.199720041947, 5339.985402773461, 5368.436314187033, 523.3092318140019, 529.3753371022153, 533.8932213557304, 536.0378121272325, 542.9212764149177, 3099.9535006974916, 3152.4640811062172, 3209.951850722241, 3421.503881937155, 3468.497067925137, 13235.338233088307, 13239.73520529584, 13397.732045359038, 13498.055136140376, 13558.728825423435, 13189.0, 13325.321786111683, 13421.463141474233, 13469.663258418423, 13480.325983700775, 7097.680604372816, 7238.710451581983, 7372.889406659012, 7381.741639042608, 7395.889061664079, 5115.616328775282, 5182.1190397631735, 5258.368995720538, 5352.464753524772, 5450.1007333789485, 11912.404379780803, 11954.462049207981, 12140.15018948665, 12185.634430967086, 12192.817107743569, 12123.393830308625, 12267.263964161823, 12412.131150819356, 12589.118761686594, 12617.369131543202, 7568.8486230276185, 7587.962060189884, 7676.654550545127, 7678.424118191047, 7718.035245594301, 9496.097870702271, 9620.086091821266, 9704.951475242578, 9708.320417570701, 9709.951450242703, 8182.959085204536, 8316.334693224648, 8392.16078392156, 8438.282745966662, 8594.871076933727, 7968.851395197969, 8027.478213916077, 8052.114267430461, 8330.333573314, 8353.164683531599, 7077.858442831218, 7220.638968051471, 7244.094488188976, 7245.637718114179, 7254.89117663246, 4735.597474214593, 4796.35249241348, 4839.0, 4896.436909755281, 4935.136351138464, 5038.420581633012, 5065.772040258271, 5115.0, 5152.098382783073, 5174.14626586624], "value": 4626.496134915674, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.7139297283828, 396.839280091563, 399.1179493319763, 399.16375193968645, 405.51338393927296, 5425.674459532426, 5475.397706252309, 5492.121260598305, 5495.560355171587, 5497.642653227543, 5012.824551140701, 5232.843014709555, 5291.497307755757, 5331.866703332418, 5359.624826262163, 4022.396640503933, 4024.4164596133614, 4035.3946907963896, 4040.0, 4045.393191021341, 4037.7577345359373, 4039.3738970459626, 4045.757254564721, 4055.776932268724, 4061.2689715851284, 3936.4488971544006, 4004.159126583421, 4020.5778393268724, 4021.3766866135797, 4033.616806403387, 3979.701522385818, 3985.8078057068788, 3985.880423587268, 4016.116454380032, 4024.094578719794, 3505.158761897126, 3527.3827080260853, 3528.0, 3529.311784202056, 3534.628863969272, 5073.315102461157, 5091.0, 5113.974430127825, 5129.410117836459, 5132.384113906355, 4590.586847183769, 4722.291656251556, 4738.857834264978, 4741.6097490294605, 4768.73771942543, 5615.241942337773, 5619.943800561983, 5623.381428042912, 5637.787875606723, 5651.604387692863, 3957.34703773877, 3958.3968492760478, 3964.306246406867, 3971.1660551284267, 3977.8773662674953, 5777.59556831022, 5811.970940145315, 5944.821655350346, 5963.360075979141, 6007.80715039012, 3984.4820173377275, 4004.6996475264473, 4023.5976402360116, 4029.4157347184496, 4045.554988951213, 4066.2274167908004, 4072.165206132736, 4081.3061779497557, 4084.9591504085174, 4087.754734715867, 4712.670113092051, 4727.810887564459, 4733.526647335308, 4737.620990320766, 4905.8226025753565, 5723.771049157987, 5736.737917658109, 5738.0, 5743.655380677173, 5773.826785196451, 1583.9049657020616, 1604.1177352456102, 1608.1959020489755, 1612.9838701613069, 1616.0869108953405, 1092.5684354679856, 1167.7372591167089, 1171.9296842189497, 1174.1135442740676, 1179.8820117988132, 4967.690024138793, 4975.5522003019905, 4977.925331120036, 4978.47725988766, 4992.276119962585, 5922.703864806743, 5935.465808077293, 5944.613600116065, 5959.374265702126, 5962.910556341659, 4927.95072049282, 4956.950430495721, 4971.751412429364, 4992.650514463952, 5005.89988200234, 3079.3687294104657, 3112.9221769455944, 3126.9524709222665, 3130.591233944734, 3141.607299087614, 5316.255724198615, 5506.476884695948, 5519.889602207933, 5526.889462210734, 5538.196961440649, 5954.3152537458745, 5976.9402305977255, 6009.939900601025, 6014.458698717049, 6039.245094363205, 5475.09660905946, 5490.231367608538, 5502.9174562382395, 5519.2824932758485, 5551.361593416808, 5733.312002559553, 5815.41845815415, 5874.265716785402, 5899.528037756883, 5901.734421951109, 5768.653880767168, 5795.449432303924, 5821.76712931478, 5827.358990510956, 5837.854053648693, 5321.281626980308, 5439.809606663748, 5513.3108361454815, 5527.5577953764405, 5533.0, 4000.1999600079516, 4004.3392840181045, 4006.358982562776, 4009.7794621296107, 4021.4973128358956, 5852.7416605430035, 5942.168096466412, 5955.970220148872, 5962.0, 5968.343482217039, 5681.289838770153, 5732.942670573241, 5734.598578099493, 5741.3397459291045, 5742.913856292243, 5616.129499927518, 5702.714864256854, 5710.714464276853, 5715.485606295453, 5717.742701578356, 5475.589330800126, 5572.944270557405, 5584.441555844383, 5612.915806262828, 5641.746121424464, 5725.742341594555, 5740.253767010262, 5743.368229494668, 5745.6552606843725, 5756.65460072397, 5461.563074953915, 5553.583481238842, 5576.525995290283, 5584.86037849057, 5594.720263986703], "value": 4291.75323512729, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.7237286017744, 752.7252552818223, 756.9697212111516, 757.3713817531448, 778.1012930065774, 11529.365884876328, 12043.337616431092, 12940.35298235088, 13856.584302470941, 13929.860701392983, 14545.854541454582, 14616.12303261805, 14625.0, 14693.853061469383, 14793.630159246024, 820.2003047029143, 836.3685417509802, 838.170211490626, 839.3201506779528, 841.8484672758901, 884.9159329863685, 893.8122994171232, 894.0746327550986, 894.2845723421269, 896.3277541843618, 901.3104974694364, 901.923336516397, 902.5848109869468, 903.6791938861675, 930.3534043839534, 896.9103089691044, 897.7306807957652, 899.5727029660957, 900.2932697832204, 930.7580029192425, 657.8322527755439, 657.9934200658028, 659.36700767263, 669.4610838275187, 684.1072400517323, 13668.726625467534, 13686.247256400893, 13793.724125517434, 14538.563843084725, 14672.19302938338, 15522.301496432689, 15800.841991580168, 15831.366745330173, 15909.204539773082, 16040.75938860918, 12164.330961797097, 12208.940201007532, 12259.754804903852, 12288.754224915452, 12432.75134497314, 2849.415869746697, 2855.5573886047696, 2865.4842128416876, 2866.7419932206203, 2867.16852112887, 67121.0, 67124.6643766783, 67614.0, 68095.3190468094, 68571.0, 10434.426106564211, 10523.684289471328, 11298.0, 11619.941900290445, 11662.88337116618, 21393.03731332094, 21810.563788724136, 21975.23086691958, 22125.00437480317, 22174.113035478724, 6319.557630965788, 6448.0, 6514.739410423625, 6541.47668186544, 6556.541042127005, 2973.6431628204755, 2982.4333376658365, 2993.670696223414, 3004.519276915683, 3007.203091180839, 3386.847591858372, 3425.07522968802, 3447.4311738563356, 3461.13471632092, 3465.428204346305, 725.350811024141, 729.4820677319162, 729.9781006569812, 730.3317464520011, 731.8646050480678, 591.9437653422918, 620.6632030405527, 625.6621424430756, 632.9746810127635, 636.3477435628517, 9477.0, 9706.573356660834, 9738.074882886114, 9744.512774361254, 10010.49947502622, 620.6648409858626, 628.8679377330811, 628.8868003759367, 638.1193952345733, 648.3289795062088, 4098.52866920302, 4195.3916682081535, 4299.634531064832, 4311.180875633682, 4423.248047831877, 61878.38121618726, 62902.0, 62971.685141574, 63768.36231637717, 64354.35645643577, 55043.0, 55336.44663553393, 55603.88792224133, 55918.0, 58281.417185828446, 50517.49482505202, 50783.746081270096, 51811.74094129581, 51852.0, 52365.2145217822, 8543.829123417621, 8654.740357789276, 8675.175858293453, 8694.869576956224, 8909.777255568662, 27128.0, 27272.318192045357, 27389.31526711848, 27410.862945685145, 28156.296092597848, 32424.0, 32635.510467342534, 32663.510047348835, 33186.17034574155, 33471.16322091967, 11605.941970290094, 11878.643640690792, 13438.0, 13868.93065534666, 14036.087654302437, 14339.641508962359, 14658.853411465749, 14923.776143357642, 15797.0, 16019.759703604688, 12942.611721647989, 13012.21926684402, 13206.0, 13246.403911823798, 13853.584392468241, 12923.547675831302, 13045.478180872658, 13612.65968350799, 13902.37439315213, 14218.715625687635, 12768.6807829805, 12941.611751647466, 13058.477660893457, 13170.60488185356, 13177.275249860966, 10213.846792297973, 10247.333923294962, 10287.0, 10569.418681972566, 10858.619948301772, 10528.684139475828, 10529.526171322463, 10857.131429485464, 10861.0, 11016.394098324668], "value": 6660.131718314169, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 112.0, 111.0, 112.0, 111.0, 112.0, 112.0, 113.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 131.0, 130.0, 167.0, 125.0, 125.0, 124.0, 123.0, 146.0, 129.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 166.0, 168.0, 168.0, 167.0, 167.0, 165.0, 165.0, 165.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 107.0, 75.0, 75.0, 77.0, 75.0, 93.0, 75.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 106.0, 84.0, 83.0, 83.0, 95.0, 83.0, 84.0, 107.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 114.0, 114.0, 113.0, 114.0, 117.0, 115.0, 117.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 151.0, 155.0, 150.0, 150.0, 150.0, 153.0, 151.0, 150.0], "value": 151.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 98.0, 95.0, 96.0, 96.0, 96.0, 94.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 61.0, 60.0, 55.0, 57.0, 62.0, 54.0, 56.0, 55.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 55.0, 56.0, 54.0, 55.0, 56.0, 55.0, 56.0], "value": 55.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 81.0, 81.0, 83.0, 81.0, 82.0, 82.0, 82.0, 84.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 134.0, 131.0, 137.0, 130.0, 133.0, 131.0, 136.0, 181.0, 134.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 192.0, 190.0, 201.0, 197.0, 207.0, 199.0, 181.0, 192.0, 193.0], "value": 193.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 82.0, 75.0, 73.0, 84.0, 79.0, 75.0, 76.0, 72.0, 75.0], "value": 76.6, "unit": "score"}]}]} 12:39:11 INFO - Return code: 0 12:39:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:39:11 INFO - # TBPL SUCCESS # 12:39:11 INFO - Running post-action listener: _resource_record_post_action 12:39:11 INFO - [mozharness: 2017-05-10 19:39:11.748177Z] Finished run-tests step (success) 12:39:11 INFO - Running post-run listener: _resource_record_post_run 12:39:11 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 375869440; Read time: 8; Write time: 298512 12:39:11 INFO - TinderboxPrint: CPU usage
13.3% 12:39:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 12:39:11 INFO - TinderboxPrint: I/O write bytes / time
375,869,440 / 298,512 12:39:11 INFO - TinderboxPrint: CPU idle
8,293.9 (86.7%) 12:39:11 INFO - TinderboxPrint: CPU user
1,220.5 (12.8%) 12:39:11 INFO - TinderboxPrint: Swap in / out
0 / 0 12:39:11 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 107950080; Read time: 0; Write time: 136280 12:39:11 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 267919360; Read time: 0; Write time: 162232 12:39:12 INFO - Running post-run listener: _upload_blobber_files 12:39:12 INFO - Blob upload gear active. 12:39:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:39:12 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 12:39:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:39:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:39:12 INFO - (blobuploader) - INFO - Open directory for files ... 12:39:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:39:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:39:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:14 INFO - (blobuploader) - INFO - Done attempting. 12:39:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:39:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:39:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:18 INFO - (blobuploader) - INFO - Done attempting. 12:39:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:39:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:39:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:19 INFO - (blobuploader) - INFO - Done attempting. 12:39:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:39:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:39:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:20 INFO - (blobuploader) - INFO - Done attempting. 12:39:20 INFO - (blobuploader) - INFO - Iteration through files over. 12:39:20 INFO - Return code: 0 12:39:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:39:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:39:20 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/434e563a43a7428aae560636cbfbbf1664604fcfafcf04b536d9dc07c19542132df49829b2e3d6e2c78b069d1c889c8b275645fec5d0e6f5863e7f4d337563bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64fe7f54e7f2b58973b21d4a218aace3bc7c602c7cd5f3a5b24b509b57204f94517ee1597abebf48ab0429b3697b148d8b78a6625549c9402cac707b449d9872", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/759ce78b412b86f227cc9222b0fda02829aa94229c6422dd788c696b63c90d5786bb39a7d2ee70daf2cd25574943b0d5b7f3aa0b999e87979dbaddf9377bc017", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7caa0ccac89aa91139beb41cd19a9248a6f31394034c0b740a6c53c116959aeb2bef2a2e4bac43594c95b500eb8ae0b546aa8befd974e5e7803c53d1d217173"} 12:39:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:39:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:39:20 INFO - Contents: 12:39:20 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/434e563a43a7428aae560636cbfbbf1664604fcfafcf04b536d9dc07c19542132df49829b2e3d6e2c78b069d1c889c8b275645fec5d0e6f5863e7f4d337563bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64fe7f54e7f2b58973b21d4a218aace3bc7c602c7cd5f3a5b24b509b57204f94517ee1597abebf48ab0429b3697b148d8b78a6625549c9402cac707b449d9872", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/759ce78b412b86f227cc9222b0fda02829aa94229c6422dd788c696b63c90d5786bb39a7d2ee70daf2cd25574943b0d5b7f3aa0b999e87979dbaddf9377bc017", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7caa0ccac89aa91139beb41cd19a9248a6f31394034c0b740a6c53c116959aeb2bef2a2e4bac43594c95b500eb8ae0b546aa8befd974e5e7803c53d1d217173"} 12:39:20 INFO - Running post-run listener: copy_logs_to_upload_dir 12:39:20 INFO - Copying logs to upload dir... 12:39:20 INFO - mkdir: /builds/slave/test/build/upload/logs 12:39:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.009813 ========= master_lag: 0.18 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-10 12:39:20.540798) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 12:39:20.549081) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/434e563a43a7428aae560636cbfbbf1664604fcfafcf04b536d9dc07c19542132df49829b2e3d6e2c78b069d1c889c8b275645fec5d0e6f5863e7f4d337563bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64fe7f54e7f2b58973b21d4a218aace3bc7c602c7cd5f3a5b24b509b57204f94517ee1597abebf48ab0429b3697b148d8b78a6625549c9402cac707b449d9872", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/759ce78b412b86f227cc9222b0fda02829aa94229c6422dd788c696b63c90d5786bb39a7d2ee70daf2cd25574943b0d5b7f3aa0b999e87979dbaddf9377bc017", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7caa0ccac89aa91139beb41cd19a9248a6f31394034c0b740a6c53c116959aeb2bef2a2e4bac43594c95b500eb8ae0b546aa8befd974e5e7803c53d1d217173"} build_url:https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/F-mTYJ2kS6G5HaE6SdLqng/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/434e563a43a7428aae560636cbfbbf1664604fcfafcf04b536d9dc07c19542132df49829b2e3d6e2c78b069d1c889c8b275645fec5d0e6f5863e7f4d337563bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64fe7f54e7f2b58973b21d4a218aace3bc7c602c7cd5f3a5b24b509b57204f94517ee1597abebf48ab0429b3697b148d8b78a6625549c9402cac707b449d9872", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/759ce78b412b86f227cc9222b0fda02829aa94229c6422dd788c696b63c90d5786bb39a7d2ee70daf2cd25574943b0d5b7f3aa0b999e87979dbaddf9377bc017", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7caa0ccac89aa91139beb41cd19a9248a6f31394034c0b740a6c53c116959aeb2bef2a2e4bac43594c95b500eb8ae0b546aa8befd974e5e7803c53d1d217173"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 12:39:20.581935) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:39:20.582255) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1494443903.660871-1429104095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:39:20.667474) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 12:39:20.669824) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 12:39:20.670134) ========= ========= Total master_lag: 0.35 =========