builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-089 starttime: 1490363455.59 results: success (0) revision: 473e0b20176139cff952b04e3eeff3ee155d0d3d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 06:50:55.589751) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 06:50:55.591119) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 06:50:55.591396) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 06:50:55.605988) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 06:50:55.606292) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-24 06:50:55-- 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% 65.5M=0s 2017-03-24 06:50:55 (65.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087720 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 06:50:55.707899) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 06:50:55.708197) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013778 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 06:50:55.760214) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 06:50:55.760998) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 473e0b20176139cff952b04e3eeff3ee155d0d3d --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 473e0b20176139cff952b04e3eeff3ee155d0d3d --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=8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-24 06:50:56,049 truncating revision to first 12 chars 2017-03-24 06:50:56,049 Setting DEBUG logging. 2017-03-24 06:50:56,050 attempt 1/10 2017-03-24 06:50:56,050 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/473e0b201761?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-24 06:50:56,367 unpacking tar archive at: mozilla-central-473e0b201761/testing/mozharness/ program finished with exit code 0 elapsedTime=0.621596 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 06:50:56.396612) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 06:50:56.396949) ========= script_repo_revision: 473e0b20176139cff952b04e3eeff3ee155d0d3d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 06:50:56.397308) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 06:50:56.397645) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 06:50:56.407828) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-03-24 06:50:56.408125) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:50:56 INFO - MultiFileLogger online at 20170324 06:50:56 in /builds/slave/test 06:50:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:50:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:50:56 INFO - {'append_to_log': False, 06:50:56 INFO - 'base_work_dir': '/builds/slave/test', 06:50:56 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:50:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:50:56 INFO - 'branch': 'Firefox-Non-PGO', 06:50:56 INFO - 'buildbot_json_path': 'buildprops.json', 06:50:56 INFO - 'config_files': ('talos/linux_config.py',), 06:50:56 INFO - 'default_actions': ('clobber', 06:50:56 INFO - 'read-buildbot-config', 06:50:56 INFO - 'download-and-extract', 06:50:56 INFO - 'populate-webroot', 06:50:56 INFO - 'create-virtualenv', 06:50:56 INFO - 'install', 06:50:56 INFO - 'run-tests'), 06:50:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:50:56 INFO - 'download_minidump_stackwalk': True, 06:50:56 INFO - 'download_symbols': 'ondemand', 06:50:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:50:56 INFO - 'tooltool.py': '/tools/tooltool.py', 06:50:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:50:56 INFO - '/tools/misc-python/virtualenv.py')}, 06:50:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:50:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:50:56 INFO - 'gecko_profile': False, 06:50:56 INFO - 'gecko_profile_interval': 0, 06:50:56 INFO - 'installer_path': 'installer.exe', 06:50:56 INFO - 'log_level': 'info', 06:50:56 INFO - 'log_name': 'talos', 06:50:56 INFO - 'log_to_console': True, 06:50:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:50:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:50:56 INFO - 'opt_config_files': (), 06:50:56 INFO - 'pip_index': False, 06:50:56 INFO - 'suite': 'dromaeojs-e10s', 06:50:56 INFO - 'system_bits': '32', 06:50:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:50:56 INFO - 'title': 'talos-linux64-ix-089', 06:50:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:50:56 INFO - 'use_talos_json': True, 06:50:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:50:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:50:56 INFO - 'work_dir': 'build'} 06:50:56 INFO - [mozharness: 2017-03-24 13:50:56.797792Z] Running clobber step. 06:50:56 INFO - Running pre-action listener: _resource_record_pre_action 06:50:56 INFO - Running main action method: clobber 06:50:56 INFO - rmtree: /builds/slave/test/build 06:50:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:50:57 INFO - Running post-action listener: _resource_record_post_action 06:50:57 INFO - [mozharness: 2017-03-24 13:50:57.725214Z] Finished clobber step (success) 06:50:57 INFO - [mozharness: 2017-03-24 13:50:57.725313Z] Running read-buildbot-config step. 06:50:57 INFO - Running pre-action listener: _resource_record_pre_action 06:50:57 INFO - Running main action method: read_buildbot_config 06:50:57 INFO - Using buildbot properties: 06:50:57 INFO - { 06:50:57 INFO - "project": "", 06:50:57 INFO - "product": "firefox", 06:50:57 INFO - "who": "cbook@mozilla.com", 06:50:57 INFO - "installer_path": "public/build/target.tar.bz2", 06:50:57 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:50:57 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:50:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 06:50:57 INFO - "stage_platform": "linux64", 06:50:57 INFO - "basedir": "/builds/slave/test", 06:50:57 INFO - "buildnumber": 485, 06:50:57 INFO - "platform": "ubuntu64_hw", 06:50:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:50:57 INFO - "slavebuilddir": "test", 06:50:57 INFO - "taskId": "EQf0IfP_TTWv66z-sEn9RQ", 06:50:57 INFO - "branch": "mozilla-central", 06:50:57 INFO - "script_repo_revision": "production", 06:50:57 INFO - "revision": "473e0b20176139cff952b04e3eeff3ee155d0d3d", 06:50:57 INFO - "slavename": "talos-linux64-ix-089", 06:50:57 INFO - "repo_path": "mozilla-central" 06:50:57 INFO - } 06:50:57 INFO - Finding installer, test and symbols from parent task. 06:50:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EQf0IfP_TTWv66z-sEn9RQ'}, attempt #1 06:50:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EQf0IfP_TTWv66z-sEn9RQ'}, attempt #1 06:50:58 INFO - Task dependencies: fZyHGIfwQ3ybGU91vAd-Lw 06:50:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw'}, attempt #1 06:50:59 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/target.tar.bz2 06:50:59 INFO - Set test_url: https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/test_packages.json 06:50:59 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/target.crashreporter-symbols.zip 06:50:59 INFO - Running post-action listener: _resource_record_post_action 06:50:59 INFO - [mozharness: 2017-03-24 13:50:59.117950Z] Finished read-buildbot-config step (success) 06:50:59 INFO - [mozharness: 2017-03-24 13:50:59.118170Z] Running download-and-extract step. 06:50:59 INFO - Running pre-action listener: _resource_record_pre_action 06:50:59 INFO - Running main action method: download_and_extract 06:50:59 INFO - mkdir: /builds/slave/test/build/tests 06:50: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')]} 06:50:59 INFO - trying https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/target.test_packages.json 06:50:59 INFO - Downloading https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:50:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:50:59 INFO - Downloaded 986 bytes. 06:50:59 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:50:59 INFO - Using the following test package requirements: 06:50:59 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:50:59 INFO - u'common': [u'target.common.tests.zip'], 06:50:59 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:50:59 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:50:59 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:50:59 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:50:59 INFO - u'mozbase': [u'target.common.tests.zip'], 06:50:59 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:50:59 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:50:59 INFO - u'web-platform': [u'target.common.tests.zip', 06:50:59 INFO - u'target.web-platform.tests.zip'], 06:50:59 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:50:59 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:50:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/target.common.tests.zip 06:50:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:50:59 INFO - Fetch https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/target.common.tests.zip into memory 06:51:01 INFO - Expected file size: 58131464 06:51:01 INFO - Obtained file size: 58131464 06:51:11 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:51:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/target.common.tests.zip 06:51:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:51:11 INFO - Fetch https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/target.common.tests.zip into memory 06:51:12 INFO - Expected file size: 58131464 06:51:12 INFO - Obtained file size: 58131464 06:51:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/target.talos.tests.zip 06:51:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:51:23 INFO - Fetch https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/target.talos.tests.zip into memory 06:51:24 INFO - Expected file size: 14404171 06:51:24 INFO - Obtained file size: 14404171 06:51:25 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')]} 06:51:25 INFO - trying https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/target.tar.bz2 06:51:25 INFO - Downloading https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:51:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:51:28 INFO - Downloaded 62496002 bytes. 06:51:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/target.tar.bz2 06:51:28 INFO - mkdir: /builds/slave/test/properties 06:51:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:51:28 INFO - Writing to file /builds/slave/test/properties/build_url 06:51:28 INFO - Contents: 06:51:28 INFO - build_url:https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/target.tar.bz2 06:51:28 INFO - Running post-action listener: _resource_record_post_action 06:51:28 INFO - Running post-action listener: set_extra_try_arguments 06:51:28 INFO - [mozharness: 2017-03-24 13:51:28.353356Z] Finished download-and-extract step (success) 06:51:28 INFO - [mozharness: 2017-03-24 13:51:28.353614Z] Running populate-webroot step. 06:51:28 INFO - Running pre-action listener: _resource_record_pre_action 06:51:28 INFO - Running main action method: populate_webroot 06:51:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:51:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:51:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:51:28 INFO - '--tppagecycles', 06:51:28 INFO - '7'], 06:51:28 INFO - 'tests': ['tsvgm']}}, 06:51:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:51:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:51:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:51:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:51:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:51:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:51:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:51:28 INFO - 'talos_options': ['--disable-e10s'], 06:51:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:51:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:51:28 INFO - 'talos_options': ['--disable-e10s'], 06:51:28 INFO - 'tests': ['damp', 'tps']}, 06:51:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:51:28 INFO - 'tests': ['damp', 'tps']}, 06:51:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:51:28 INFO - 'tests': ['dromaeo_dom']}, 06:51:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:51:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:51:28 INFO - 'tests': ['basic_compositor_video']}, 06:51:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:51:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:51:28 INFO - 'tests': ['a11yr', 06:51:28 INFO - 'ts_paint', 06:51:28 INFO - 'tpaint', 06:51:28 INFO - 'sessionrestore', 06:51:28 INFO - 'sessionrestore_no_auto_restore', 06:51:28 INFO - 'tabpaint']}, 06:51:28 INFO - 'other-e10s': {'tests': ['a11yr', 06:51:28 INFO - 'ts_paint', 06:51:28 INFO - 'tpaint', 06:51:28 INFO - 'sessionrestore', 06:51:28 INFO - 'sessionrestore_no_auto_restore', 06:51:28 INFO - 'tabpaint']}, 06:51:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:51:28 INFO - 'ts_paint', 06:51:28 INFO - 'tpaint', 06:51:28 INFO - 'sessionrestore', 06:51:28 INFO - 'sessionrestore_no_auto_restore', 06:51:28 INFO - 'tabpaint']}, 06:51:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:51:28 INFO - 'ts_paint', 06:51:28 INFO - 'tpaint', 06:51:28 INFO - 'sessionrestore', 06:51:28 INFO - 'sessionrestore_no_auto_restore', 06:51:28 INFO - 'tabpaint']}, 06:51:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:51:28 INFO - 'tests': ['a11yr', 06:51:28 INFO - 'ts_paint', 06:51:28 INFO - 'tpaint', 06:51:28 INFO - 'sessionrestore', 06:51:28 INFO - 'sessionrestore_no_auto_restore', 06:51:28 INFO - 'tabpaint']}, 06:51:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:51:28 INFO - 'tests': ['a11yr', 06:51:28 INFO - 'ts_paint', 06:51:28 INFO - 'tpaint', 06:51:28 INFO - 'sessionrestore', 06:51:28 INFO - 'sessionrestore_no_auto_restore', 06:51:28 INFO - 'tabpaint']}, 06:51:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:51:28 INFO - 'tests': ['tsvgx', 06:51:28 INFO - 'tsvgr_opacity', 06:51:28 INFO - 'tart', 06:51:28 INFO - 'tscrollx', 06:51:28 INFO - 'cart', 06:51:28 INFO - 'tsvg_static']}, 06:51:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:51:28 INFO - 'tsvgr_opacity', 06:51:28 INFO - 'tart', 06:51:28 INFO - 'tscrollx', 06:51:28 INFO - 'cart', 06:51:28 INFO - 'tsvg_static']}, 06:51:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:51:28 INFO - 'talos_options': ['--disable-e10s'], 06:51:28 INFO - 'tests': ['tp5o']}, 06:51:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:51:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:51:28 INFO - 'talos_options': ['--disable-e10s', 06:51:28 INFO - '--xperf_path', 06:51:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:28 INFO - 'tests': ['tp5n']}, 06:51:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:51:28 INFO - 'talos_options': ['--xperf_path', 06:51:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:28 INFO - 'tests': ['tp5n']}}, 06:51:28 INFO - 'talos.zip': {'path': '', 06:51:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:51:28 INFO - Running post-action listener: _resource_record_post_action 06:51:28 INFO - [mozharness: 2017-03-24 13:51:28.374447Z] Finished populate-webroot step (success) 06:51:28 INFO - [mozharness: 2017-03-24 13:51:28.374537Z] Running create-virtualenv step. 06:51:28 INFO - Running pre-action listener: _resource_record_pre_action 06:51:28 INFO - Running main action method: create_virtualenv 06:51:28 INFO - Creating virtualenv /builds/slave/test/build/venv 06:51:28 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 06:51:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:51:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:51:28 INFO - Using real prefix '/usr' 06:51:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:51:28 INFO - Installing distribute.............................................................................................................................................................................................done. 06:51:30 INFO - Installing pip.................done. 06:51:31 INFO - Return code: 0 06:51:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:51:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:51:31 INFO - Reading from file tmpfile_stdout 06:51:31 INFO - Output received: 06:51:31 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) 06:51:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:51:31 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')]} 06:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:31 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')]} 06:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:31 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 0x240c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a7290>, '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 0x26a7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a8040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501', '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 06:51:31 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 06:51:31 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 06:51:31 INFO - Using env: {'DISPLAY': ':0', 06:51:31 INFO - 'HOME': '/home/cltbld', 06:51:31 INFO - 'LANG': 'en_US.UTF-8', 06:51:31 INFO - 'LANGUAGE': 'en_US:en', 06:51:31 INFO - 'LOGNAME': 'cltbld', 06:51:31 INFO - 'MAIL': '/var/mail/cltbld', 06:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:31 INFO - 'MOZ_NO_REMOTE': '1', 06:51:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:31 INFO - 'NO_EM_RESTART': '1', 06:51:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:31 INFO - 'PWD': '/builds/slave/test', 06:51:31 INFO - 'SHELL': '/bin/bash', 06:51:31 INFO - 'SHLVL': '1', 06:51:31 INFO - 'TERM': 'linux', 06:51:31 INFO - 'TMOUT': '86400', 06:51:31 INFO - 'USER': 'cltbld', 06:51:31 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501', 06:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:31 INFO - '_': '/tools/buildbot/bin/python'} 06:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:31 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 06:51:31 INFO - Cleaning up... 06:51:31 INFO - Return code: 0 06:51:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:51:31 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')]} 06:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:31 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')]} 06:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:31 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 0x240c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a7290>, '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 0x26a7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a8040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501', '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 06:51:31 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 06:51:31 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 06:51:31 INFO - Using env: {'DISPLAY': ':0', 06:51:31 INFO - 'HOME': '/home/cltbld', 06:51:31 INFO - 'LANG': 'en_US.UTF-8', 06:51:31 INFO - 'LANGUAGE': 'en_US:en', 06:51:31 INFO - 'LOGNAME': 'cltbld', 06:51:31 INFO - 'MAIL': '/var/mail/cltbld', 06:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:31 INFO - 'MOZ_NO_REMOTE': '1', 06:51:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:31 INFO - 'NO_EM_RESTART': '1', 06:51:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:31 INFO - 'PWD': '/builds/slave/test', 06:51:31 INFO - 'SHELL': '/bin/bash', 06:51:31 INFO - 'SHLVL': '1', 06:51:31 INFO - 'TERM': 'linux', 06:51:31 INFO - 'TMOUT': '86400', 06:51:31 INFO - 'USER': 'cltbld', 06:51:31 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501', 06:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:31 INFO - '_': '/tools/buildbot/bin/python'} 06:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:31 INFO - Downloading/unpacking psutil>=3.1.1 06:51:31 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 06:51:31 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 06:51:31 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 06:51:31 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 06:51:31 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 06:51:31 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 06:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:51:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:51:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:51:33 INFO - Installing collected packages: psutil 06:51:33 INFO - Running setup.py install for psutil 06:51:33 INFO - building 'psutil._psutil_linux' extension 06:51:33 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 06:51:34 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 06:51:34 INFO - building 'psutil._psutil_posix' extension 06:51:34 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 06:51:34 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 06:51:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:51:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:51:34 INFO - Successfully installed psutil 06:51:34 INFO - Cleaning up... 06:51:34 INFO - Return code: 0 06:51:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:51:34 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')]} 06:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:34 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')]} 06:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:34 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 0x240c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a7290>, '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 0x26a7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a8040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501', '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 06:51:34 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 06:51:34 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 06:51:34 INFO - Using env: {'DISPLAY': ':0', 06:51:34 INFO - 'HOME': '/home/cltbld', 06:51:34 INFO - 'LANG': 'en_US.UTF-8', 06:51:34 INFO - 'LANGUAGE': 'en_US:en', 06:51:34 INFO - 'LOGNAME': 'cltbld', 06:51:34 INFO - 'MAIL': '/var/mail/cltbld', 06:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:34 INFO - 'MOZ_NO_REMOTE': '1', 06:51:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:34 INFO - 'NO_EM_RESTART': '1', 06:51:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:34 INFO - 'PWD': '/builds/slave/test', 06:51:34 INFO - 'SHELL': '/bin/bash', 06:51:34 INFO - 'SHLVL': '1', 06:51:34 INFO - 'TERM': 'linux', 06:51:34 INFO - 'TMOUT': '86400', 06:51:34 INFO - 'USER': 'cltbld', 06:51:34 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501', 06:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:34 INFO - '_': '/tools/buildbot/bin/python'} 06:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:34 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 06:51:34 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 06:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:51:36 INFO - Installing collected packages: mozsystemmonitor 06:51:36 INFO - Running setup.py install for mozsystemmonitor 06:51:36 INFO - Successfully installed mozsystemmonitor 06:51:36 INFO - Cleaning up... 06:51:36 INFO - Return code: 0 06:51:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:51:36 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')]} 06:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:36 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')]} 06:51:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x240c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a7290>, '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 0x26a7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a8040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501', '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 06:51:36 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 06:51:36 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 06:51:36 INFO - Using env: {'DISPLAY': ':0', 06:51:36 INFO - 'HOME': '/home/cltbld', 06:51:36 INFO - 'LANG': 'en_US.UTF-8', 06:51:36 INFO - 'LANGUAGE': 'en_US:en', 06:51:36 INFO - 'LOGNAME': 'cltbld', 06:51:36 INFO - 'MAIL': '/var/mail/cltbld', 06:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:36 INFO - 'MOZ_NO_REMOTE': '1', 06:51:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:36 INFO - 'NO_EM_RESTART': '1', 06:51:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:36 INFO - 'PWD': '/builds/slave/test', 06:51:36 INFO - 'SHELL': '/bin/bash', 06:51:36 INFO - 'SHLVL': '1', 06:51:36 INFO - 'TERM': 'linux', 06:51:36 INFO - 'TMOUT': '86400', 06:51:36 INFO - 'USER': 'cltbld', 06:51:36 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501', 06:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:36 INFO - '_': '/tools/buildbot/bin/python'} 06:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:37 INFO - Downloading/unpacking jsonschema==2.5.1 06:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:37 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 06:51:37 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 06:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:51:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:51:39 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 06:51:39 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 06:51:39 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 06:51:39 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 06:51:39 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 06:51:39 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 06:51:39 INFO - Downloading functools32-3.2.3-2.tar.gz 06:51:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:51:39 INFO - warning: no files found matching '*.txt' 06:51:39 INFO - no previously-included directories found matching 'build' 06:51:39 INFO - no previously-included directories found matching 'dist' 06:51:39 INFO - no previously-included directories found matching '.git*' 06:51:39 INFO - Installing collected packages: jsonschema, functools32 06:51:39 INFO - Running setup.py install for functools32 06:51:39 INFO - warning: no files found matching '*.txt' 06:51:39 INFO - no previously-included directories found matching 'build' 06:51:39 INFO - no previously-included directories found matching 'dist' 06:51:39 INFO - no previously-included directories found matching '.git*' 06:51:39 INFO - Successfully installed jsonschema functools32 06:51:39 INFO - Cleaning up... 06:51:39 INFO - Return code: 0 06:51:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:51:39 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')]} 06:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:39 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')]} 06:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:39 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 0x240c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a7290>, '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 0x26a7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a8040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501', '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 06:51:39 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 06:51:39 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 06:51:39 INFO - Using env: {'DISPLAY': ':0', 06:51:39 INFO - 'HOME': '/home/cltbld', 06:51:39 INFO - 'LANG': 'en_US.UTF-8', 06:51:39 INFO - 'LANGUAGE': 'en_US:en', 06:51:39 INFO - 'LOGNAME': 'cltbld', 06:51:39 INFO - 'MAIL': '/var/mail/cltbld', 06:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:39 INFO - 'MOZ_NO_REMOTE': '1', 06:51:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:39 INFO - 'NO_EM_RESTART': '1', 06:51:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:39 INFO - 'PWD': '/builds/slave/test', 06:51:39 INFO - 'SHELL': '/bin/bash', 06:51:39 INFO - 'SHLVL': '1', 06:51:39 INFO - 'TERM': 'linux', 06:51:39 INFO - 'TMOUT': '86400', 06:51:39 INFO - 'USER': 'cltbld', 06:51:39 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501', 06:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:39 INFO - '_': '/tools/buildbot/bin/python'} 06:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:51:39 INFO - Cleaning up... 06:51:39 INFO - Return code: 0 06:51:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:51:39 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')]} 06:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:39 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')]} 06:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:39 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 0x240c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a7290>, '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 0x26a7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a8040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501', '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 06:51:39 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 06:51:39 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 06:51:39 INFO - Using env: {'DISPLAY': ':0', 06:51:39 INFO - 'HOME': '/home/cltbld', 06:51:39 INFO - 'LANG': 'en_US.UTF-8', 06:51:39 INFO - 'LANGUAGE': 'en_US:en', 06:51:39 INFO - 'LOGNAME': 'cltbld', 06:51:39 INFO - 'MAIL': '/var/mail/cltbld', 06:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:39 INFO - 'MOZ_NO_REMOTE': '1', 06:51:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:39 INFO - 'NO_EM_RESTART': '1', 06:51:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:39 INFO - 'PWD': '/builds/slave/test', 06:51:39 INFO - 'SHELL': '/bin/bash', 06:51:39 INFO - 'SHLVL': '1', 06:51:39 INFO - 'TERM': 'linux', 06:51:39 INFO - 'TMOUT': '86400', 06:51:39 INFO - 'USER': 'cltbld', 06:51:39 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501', 06:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:39 INFO - '_': '/tools/buildbot/bin/python'} 06:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:40 INFO - Downloading/unpacking blobuploader==1.2.4 06:51:40 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 06:51:40 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 06:51:40 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 06:51:40 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 06:51:40 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 06:51:40 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 06:51:42 INFO - Downloading blobuploader-1.2.4.tar.gz 06:51:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:51:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:42 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 06:51:42 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 06:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:51:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:42 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 06:51:42 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 06:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:42 INFO - Downloading docopt-0.6.1.tar.gz 06:51:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:51:42 INFO - Installing collected packages: blobuploader, requests, docopt 06:51:42 INFO - Running setup.py install for blobuploader 06:51:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:51:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:51:42 INFO - Running setup.py install for requests 06:51:43 INFO - Running setup.py install for docopt 06:51:43 INFO - Successfully installed blobuploader requests docopt 06:51:43 INFO - Cleaning up... 06:51:43 INFO - Return code: 0 06:51:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:51:43 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')]} 06:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:43 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')]} 06:51:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:43 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 0x240c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a7290>, '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 0x26a7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a8040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501', '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 06:51:43 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 06:51:43 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 06:51:43 INFO - Using env: {'DISPLAY': ':0', 06:51:43 INFO - 'HOME': '/home/cltbld', 06:51:43 INFO - 'LANG': 'en_US.UTF-8', 06:51:43 INFO - 'LANGUAGE': 'en_US:en', 06:51:43 INFO - 'LOGNAME': 'cltbld', 06:51:43 INFO - 'MAIL': '/var/mail/cltbld', 06:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:43 INFO - 'MOZ_NO_REMOTE': '1', 06:51:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:43 INFO - 'NO_EM_RESTART': '1', 06:51:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:43 INFO - 'PWD': '/builds/slave/test', 06:51:43 INFO - 'SHELL': '/bin/bash', 06:51:43 INFO - 'SHLVL': '1', 06:51:43 INFO - 'TERM': 'linux', 06:51:43 INFO - 'TMOUT': '86400', 06:51:43 INFO - 'USER': 'cltbld', 06:51:43 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501', 06:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:43 INFO - '_': '/tools/buildbot/bin/python'} 06:51:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:51:43 INFO - Running setup.py (path:/tmp/pip-4QldGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:51:43 INFO - Running setup.py (path:/tmp/pip-Kl6PQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:51:43 INFO - Running setup.py (path:/tmp/pip-WwAAWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:51:43 INFO - Running setup.py (path:/tmp/pip-vIsMom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:51:43 INFO - Running setup.py (path:/tmp/pip-xxeAVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:51:43 INFO - Running setup.py (path:/tmp/pip-uk9P1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:51:44 INFO - Running setup.py (path:/tmp/pip-vxVrwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:51:44 INFO - Running setup.py (path:/tmp/pip-pvhEER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:51:44 INFO - Running setup.py (path:/tmp/pip-i_8xUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:51:44 INFO - Running setup.py (path:/tmp/pip-tJzfRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:51:44 INFO - Running setup.py (path:/tmp/pip-0USb89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:51:44 INFO - Running setup.py (path:/tmp/pip-L2QXnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:51:44 INFO - Running setup.py (path:/tmp/pip-tlT_1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:51:44 INFO - Running setup.py (path:/tmp/pip-hjyjVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:44 INFO - Running setup.py (path:/tmp/pip-pWm6px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:51:44 INFO - Running setup.py (path:/tmp/pip-flD8w_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:51:44 INFO - Running setup.py (path:/tmp/pip-hc9Un7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:51:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:51:44 INFO - Running setup.py install for manifestparser 06:51:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:51:44 INFO - Running setup.py install for mozcrash 06:51:45 INFO - Running setup.py install for mozdebug 06:51:45 INFO - Running setup.py install for mozdevice 06:51:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:51:45 INFO - Running setup.py install for mozfile 06:51:45 INFO - Running setup.py install for mozhttpd 06:51:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:51:45 INFO - Running setup.py install for mozinfo 06:51:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:51:45 INFO - Running setup.py install for mozInstall 06:51:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:51:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:51:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:51:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:51:45 INFO - Running setup.py install for mozleak 06:51:45 INFO - Running setup.py install for mozlog 06:51:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:51:45 INFO - Running setup.py install for moznetwork 06:51:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:51:45 INFO - Running setup.py install for mozprocess 06:51:46 INFO - Running setup.py install for mozprofile 06:51:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:51:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:51:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:51:46 INFO - Running setup.py install for mozrunner 06:51:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:51:46 INFO - Running setup.py install for mozscreenshot 06:51:46 INFO - Running setup.py install for moztest 06:51:46 INFO - Running setup.py install for mozversion 06:51:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:51:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:51:46 INFO - Cleaning up... 06:51:46 INFO - Return code: 0 06:51:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:51:46 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')]} 06:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:46 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')]} 06:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:46 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 0x240c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a7290>, '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 0x26a7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a8040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501', '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 06:51:46 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 06:51:46 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 06:51:46 INFO - Using env: {'DISPLAY': ':0', 06:51:46 INFO - 'HOME': '/home/cltbld', 06:51:46 INFO - 'LANG': 'en_US.UTF-8', 06:51:46 INFO - 'LANGUAGE': 'en_US:en', 06:51:46 INFO - 'LOGNAME': 'cltbld', 06:51:46 INFO - 'MAIL': '/var/mail/cltbld', 06:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:46 INFO - 'MOZ_NO_REMOTE': '1', 06:51:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:46 INFO - 'NO_EM_RESTART': '1', 06:51:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:46 INFO - 'PWD': '/builds/slave/test', 06:51:46 INFO - 'SHELL': '/bin/bash', 06:51:46 INFO - 'SHLVL': '1', 06:51:46 INFO - 'TERM': 'linux', 06:51:46 INFO - 'TMOUT': '86400', 06:51:46 INFO - 'USER': 'cltbld', 06:51:46 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501', 06:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:46 INFO - '_': '/tools/buildbot/bin/python'} 06:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:51:46 INFO - Running setup.py (path:/tmp/pip-PfZLBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:51:46 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)) 06:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:51:46 INFO - Running setup.py (path:/tmp/pip-S5wEq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:51:46 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)) 06:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:51:46 INFO - Running setup.py (path:/tmp/pip-y20yI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:51:47 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)) 06:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:51:47 INFO - Running setup.py (path:/tmp/pip-oYcH6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:51:47 INFO - Running setup.py (path:/tmp/pip-hWlVhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:51:47 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)) 06:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:51:47 INFO - Running setup.py (path:/tmp/pip-7KAcGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:51:47 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)) 06:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:51:47 INFO - Running setup.py (path:/tmp/pip-3N5I3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:51:47 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)) 06:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:51:47 INFO - Running setup.py (path:/tmp/pip-civuzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:51:47 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)) 06:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:51:47 INFO - Running setup.py (path:/tmp/pip-cfx669-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:51:47 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)) 06:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:51:47 INFO - Running setup.py (path:/tmp/pip-UFs_rE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:51:47 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)) 06:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:51:47 INFO - Running setup.py (path:/tmp/pip-t01zj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:51:47 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)) 06:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:51:47 INFO - Running setup.py (path:/tmp/pip-i7ZorM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:51:47 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)) 06:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:51:47 INFO - Running setup.py (path:/tmp/pip-kfp5SD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:51:47 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)) 06:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:51:47 INFO - Running setup.py (path:/tmp/pip-CObkOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:51:47 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)) 06:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:47 INFO - Running setup.py (path:/tmp/pip-DI6Gum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:47 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)) 06:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:51:47 INFO - Running setup.py (path:/tmp/pip-rWobys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:51:48 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)) 06:51:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:51:48 INFO - Running setup.py (path:/tmp/pip-5hL3EJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:51:48 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)) 06:51:48 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)) 06:51:48 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)) 06:51:48 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)) 06:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:51:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:51:48 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 06:51:48 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 06:51:48 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 06:51:48 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 06:51:48 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 06:51:48 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 06:51:50 INFO - Downloading blessings-1.6.tar.gz 06:51:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:51:50 INFO - Installing collected packages: blessings 06:51:50 INFO - Running setup.py install for blessings 06:51:50 INFO - Successfully installed blessings 06:51:50 INFO - Cleaning up... 06:51:50 INFO - Return code: 0 06:51:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:51:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:51:50 INFO - Reading from file tmpfile_stdout 06:51:50 INFO - Current package versions: 06:51:50 INFO - argparse == 1.2.1 06:51:50 INFO - blessings == 1.6 06:51:50 INFO - blobuploader == 1.2.4 06:51:50 INFO - docopt == 0.6.1 06:51:50 INFO - functools32 == 3.2.3-2 06:51:50 INFO - jsonschema == 2.5.1 06:51:50 INFO - manifestparser == 1.1 06:51:50 INFO - mozInstall == 1.12 06:51:50 INFO - mozcrash == 1.0 06:51:50 INFO - mozdebug == 0.1 06:51:50 INFO - mozdevice == 0.49 06:51:50 INFO - mozfile == 1.2 06:51:50 INFO - mozhttpd == 0.7 06:51:50 INFO - mozinfo == 0.9 06:51:50 INFO - mozleak == 0.1 06:51:50 INFO - mozlog == 3.4 06:51:50 INFO - moznetwork == 0.27 06:51:50 INFO - mozprocess == 0.25 06:51:50 INFO - mozprofile == 0.28 06:51:50 INFO - mozrunner == 6.13 06:51:50 INFO - mozscreenshot == 0.1 06:51:50 INFO - mozsystemmonitor == 0.3 06:51:50 INFO - moztest == 0.8 06:51:50 INFO - mozversion == 1.4 06:51:50 INFO - psutil == 3.1.1 06:51:50 INFO - requests == 1.2.3 06:51:50 INFO - wsgiref == 0.1.2 06:51:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:51:50 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')]} 06:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:50 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')]} 06:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:50 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 0x240c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a7290>, '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 0x26a7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a8040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501', '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 06:51:50 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 06:51:50 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 06:51:50 INFO - Using env: {'DISPLAY': ':0', 06:51:50 INFO - 'HOME': '/home/cltbld', 06:51:50 INFO - 'LANG': 'en_US.UTF-8', 06:51:50 INFO - 'LANGUAGE': 'en_US:en', 06:51:50 INFO - 'LOGNAME': 'cltbld', 06:51:50 INFO - 'MAIL': '/var/mail/cltbld', 06:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:50 INFO - 'MOZ_NO_REMOTE': '1', 06:51:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:50 INFO - 'NO_EM_RESTART': '1', 06:51:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:50 INFO - 'PWD': '/builds/slave/test', 06:51:50 INFO - 'SHELL': '/bin/bash', 06:51:50 INFO - 'SHLVL': '1', 06:51:50 INFO - 'TERM': 'linux', 06:51:50 INFO - 'TMOUT': '86400', 06:51:50 INFO - 'USER': 'cltbld', 06:51:50 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501', 06:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:50 INFO - '_': '/tools/buildbot/bin/python'} 06:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:50 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)) 06:51:50 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)) 06:51:50 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)) 06:51:50 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)) 06:51:50 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)) 06:51:50 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)) 06:51:50 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)) 06:51:50 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)) 06:51:50 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)) 06:51:50 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)) 06:51:50 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)) 06:51:50 INFO - Cleaning up... 06:51:50 INFO - Return code: 0 06:51:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:51:50 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')]} 06:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:50 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')]} 06:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:50 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 0x240c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2504a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a9b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a7290>, '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 0x26a7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a8040>, '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': '8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501', '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 06:51:50 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 06:51:50 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 06:51:50 INFO - Using env: {'DISPLAY': ':0', 06:51:50 INFO - 'HOME': '/home/cltbld', 06:51:50 INFO - 'LANG': 'en_US.UTF-8', 06:51:50 INFO - 'LANGUAGE': 'en_US:en', 06:51:50 INFO - 'LOGNAME': 'cltbld', 06:51:50 INFO - 'MAIL': '/var/mail/cltbld', 06:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:50 INFO - 'MOZ_NO_REMOTE': '1', 06:51:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:50 INFO - 'NO_EM_RESTART': '1', 06:51:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:50 INFO - 'PWD': '/builds/slave/test', 06:51:50 INFO - 'SHELL': '/bin/bash', 06:51:50 INFO - 'SHLVL': '1', 06:51:50 INFO - 'TERM': 'linux', 06:51:50 INFO - 'TMOUT': '86400', 06:51:50 INFO - 'USER': 'cltbld', 06:51:50 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501', 06:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:50 INFO - '_': '/tools/buildbot/bin/python'} 06:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:51:51 INFO - Cleaning up... 06:51:51 INFO - Return code: 0 06:51:51 INFO - Running post-action listener: _resource_record_post_action 06:51:51 INFO - Running post-action listener: _start_resource_monitoring 06:51:51 INFO - Starting resource monitoring. 06:51:51 INFO - [mozharness: 2017-03-24 13:51:51.061392Z] Finished create-virtualenv step (success) 06:51:51 INFO - [mozharness: 2017-03-24 13:51:51.061921Z] Running install step. 06:51:51 INFO - Running pre-action listener: _resource_record_pre_action 06:51:51 INFO - Running main action method: install 06:51:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:51:51 INFO - Reading from file tmpfile_stdout 06:51:51 INFO - Detecting whether we're running mozinstall >=1.0... 06:51:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:51:51 INFO - Reading from file tmpfile_stdout 06:51:51 INFO - Output received: 06:51:51 INFO - Usage: mozinstall [options] installer 06:51:51 INFO - Options: 06:51:51 INFO - -h, --help show this help message and exit 06:51:51 INFO - -d DEST, --destination=DEST 06:51:51 INFO - Directory to install application into. [default: 06:51:51 INFO - "/builds/slave/test"] 06:51:51 INFO - --app=APP Application being installed. [default: firefox] 06:51:51 INFO - mkdir: /builds/slave/test/build/application 06:51:51 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'] 06:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:52:07 INFO - Reading from file tmpfile_stdout 06:52:07 INFO - Output received: 06:52:07 INFO - /builds/slave/test/build/application/firefox/firefox 06:52:07 INFO - Running post-action listener: _resource_record_post_action 06:52:07 INFO - [mozharness: 2017-03-24 13:52:07.008966Z] Finished install step (success) 06:52:07 INFO - [mozharness: 2017-03-24 13:52:07.009240Z] Running run-tests step. 06:52:07 INFO - Running pre-action listener: _resource_record_pre_action 06:52:07 INFO - Running main action method: run_tests 06:52:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:52:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:52:07 INFO - Python 2.7.3 06:52:07 INFO - Return code: 0 06:52:07 INFO - grabbing minidump binary from tooltool 06:52:07 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')]} 06:52:07 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 0x26a7290>, '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 0x26a7b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a8040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:52:07 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 06:52:07 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 06:52:07 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 06:52:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:52:07 INFO - Return code: 0 06:52:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:52:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:52:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:52:07 INFO - ENV: RUST_BACKTRACE is now 1 06:52:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:52:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:52:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--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 06:52:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-089 --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 06:52:07 INFO - Using env: {'DISPLAY': ':0', 06:52:07 INFO - 'HOME': '/home/cltbld', 06:52:07 INFO - 'LANG': 'en_US.UTF-8', 06:52:07 INFO - 'LANGUAGE': 'en_US:en', 06:52:07 INFO - 'LOGNAME': 'cltbld', 06:52:07 INFO - 'MAIL': '/var/mail/cltbld', 06:52:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:52:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:52:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:07 INFO - 'MOZ_NO_REMOTE': '1', 06:52:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:52:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:07 INFO - 'NO_EM_RESTART': '1', 06:52:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:07 INFO - 'PWD': '/builds/slave/test', 06:52:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:52:07 INFO - 'RUST_BACKTRACE': '1', 06:52:07 INFO - 'SHELL': '/bin/bash', 06:52:07 INFO - 'SHLVL': '1', 06:52:07 INFO - 'TERM': 'linux', 06:52:07 INFO - 'TMOUT': '86400', 06:52:07 INFO - 'USER': 'cltbld', 06:52:07 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501', 06:52:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:07 INFO - '_': '/tools/buildbot/bin/python'} 06:52:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--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 06:52:07 INFO - mozversion application_buildid: 20170324132227 06:52:07 INFO - mozversion application_changeset: 473e0b20176139cff952b04e3eeff3ee155d0d3d 06:52:07 INFO - mozversion application_display_name: Nightly 06:52:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:52:07 INFO - mozversion application_name: Firefox 06:52:07 INFO - mozversion application_remotingname: firefox 06:52:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:52:07 INFO - mozversion application_vendor: Mozilla 06:52:07 INFO - mozversion application_version: 55.0a1 06:52:07 INFO - mozversion platform_buildid: 20170324132227 06:52:07 INFO - mozversion platform_changeset: 473e0b20176139cff952b04e3eeff3ee155d0d3d 06:52:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:52:07 INFO - mozversion platform_version: 55.0a1 06:52:07 INFO - using testdate: 1490363527 06:52:07 INFO - actual date: 1490363527 06:52:07 INFO - starting webserver on 'localhost:40539' 06:52:07 INFO - SUITE-START | Running 2 tests 06:52:07 INFO - TEST-START | dromaeo_css 06:52:07 INFO - operating with platform_type : linux_ 06:52:07 INFO - Initialising browser for dromaeo_css test... 06:52:07 INFO - TEST-INFO | started process 8371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphX8pxL/profile http://localhost:40539/getInfo.html) 06:52:12 INFO - PID 8371 | __metrics Screen width/height:1600/1200 06:52:12 INFO - PID 8371 | colorDepth:24 06:52:12 INFO - PID 8371 | Browser inner width/height: 1024/697 06:52:12 INFO - PID 8371 | __metrics 06:52:12 ERROR - PID 8371 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3392: TypeError: this.tabs is undefined 06:52:13 INFO - TEST-INFO | 8371: exit 0 06:52:13 INFO - Browser initialized. 06:52:13 INFO - Running cycle 1/1 for dromaeo_css test... 06:52:13 INFO - TEST-INFO | started process 8502 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphX8pxL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:52:25 INFO - PID 8502 | RSS: Main: 155172864 06:52:25 INFO - PID 8502 | 06:55:31 INFO - PID 8502 | Cycle 1(1): loaded http://localhost:40539/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40539/tests/dromaeo/cssquery-ext.html) 06:55:32 INFO - PID 8502 | RSS: Main: 163868672 06:55:32 INFO - PID 8502 | 06:57:14 INFO - PID 8502 | ************************* 06:57:14 INFO - PID 8502 | A coding exception was thrown and uncaught in a Task. 06:57:14 INFO - PID 8502 | 06:57:14 ERROR - PID 8502 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:57:14 INFO - PID 8502 | Full stack: 06:57:14 INFO - PID 8502 | ************************* 06:58:35 INFO - PID 8502 | Cycle 1(1): loaded http://localhost:40539/tests/dromaeo/cssquery-ext.html (next: http://localhost:40539/tests/dromaeo/cssquery-jquery.html) 06:58:35 INFO - PID 8502 | RSS: Main: 160571392 06:58:35 INFO - PID 8502 | 07:01:37 INFO - PID 8502 | Cycle 1(1): loaded http://localhost:40539/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40539/tests/dromaeo/cssquery-mootools.html) 07:01:38 INFO - PID 8502 | RSS: Main: 169172992 07:01:38 INFO - PID 8502 | 07:04:40 INFO - PID 8502 | Cycle 1(1): loaded http://localhost:40539/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40539/tests/dromaeo/cssquery-prototype.html) 07:04:41 INFO - PID 8502 | RSS: Main: 160972800 07:04:41 INFO - PID 8502 | 07:07:44 INFO - PID 8502 | Cycle 1(1): loaded http://localhost:40539/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40539/tests/dromaeo/cssquery-yui.html) 07:07:44 INFO - PID 8502 | RSS: Main: 169783296 07:07:44 INFO - PID 8502 | 07:10:47 INFO - PID 8502 | Cycle 1(1): loaded http://localhost:40539/tests/dromaeo/cssquery-yui.html (next: http://localhost:40539/tests/dromaeo/cssquery-dojo.html) 07:10:47 INFO - PID 8502 | RSS: Main: 162148352 07:10:47 INFO - PID 8502 | 07:10:47 INFO - PID 8502 | __start_tp_report 07:10:47 INFO - PID 8502 | _x_x_mozilla_page_load 07:10:47 INFO - PID 8502 | _x_x_mozilla_page_load_details 07:10:47 INFO - PID 8502 | |i|pagename|runs| 07:10:47 INFO - PID 8502 | |0;dojo.html;2736.2612094734422;2736.425350676358;2744.7529722325;2771.8891244350216;2783.081583077584;5189.740512974346;5302;5325.946740532593;5345.946540534594;5352.892942141159;5240.397354304256;5332.413434522209;5341.759620817063;5365.624406291551;5403.8108666196595;4812.8074877004965;4844.103840789465;4844.152273352167;4867.075255701423;4886.973735515546;4880.341153944225;4924;4924.729139897304;4938.950610493885;4982.9252561211615;4727.692699974491;4748.548887855648;4803.687760295569;4831.975840120777;4853.3690620219495;4840.782164802557;4841.2496063110275;4886.926696099561;4891.144049791273;4929.975350123263;4781.354517140211;4789.880252993668;4822.132016237111;4854.2233242681;4867.805287788484;5144.176931690911;5172.741362931876;5313.043652142613;5356.54469370104;5400.891982160374;5580.135079062752;5583.3858275589655;5584.91622625661;5602.915956260659;5608.747606357723;5606.943930560683;5620.353659329188;5635.6055076144685;5641.8589535261535;5730.312362516483;5346.545543628835;5348.866278343073;5393.541548968343;5407.297051383295;5417.756200970965;5830.766769329264;5838.241028666246;5867.70661466925;5872.0898260769645;5897.498712609477;5363.919541206885;5390.164524498709;5393.83818485446;5402.081646120169;5614.775408983676;5613;5617.354004289477;5619.353774315924;5633.690147041952;5713.914291285634;5578.97210513953;5633.126865335797;5688.089905615165;5691.601587888891;5691.743871525791;5600.159976003551;5627.352854421712;5628.859278517988;5637.379888212294;5643.238162847963;4718.669693121517;4782.641301902371;4824.300476430968;4834.492378300228;4887.120318342661;4099.631033207026;4107.630313271819;4111.958880411217;4123.731957422758;4144.585541445831;4888.388951381077;4890.510948905152;4891.706497610155;4896.045271172158;4936.210206367035;5552.86117847049;5695.829125126253;5735.799247026334;5743.483086522233;5747.8563035924435;4800.159972004885;4900.215965445512;4922.901541969212;4928.753562321941;4950.628702847301;5161.329027226437;5167.896642067213;5171.069207542603;5172.379314482211;5184.274201611777;5346.385165705994;5362.5441837442695;5362.839114826562;5375.247465354775;5403.459654034565;5610.719464026701;5652.208690783212;5730.484256416942;5771.68255745938;5772.076467765138;5331.333583302087;5332.280142180911;5334.67991920486;5336.332958380202;5385.784568617211;5632.971835140798;5637.041702910433;5641.012822756084;5646.887062258814;5679.545636349165;5526.640768350045;5561.527270181918;5678.290213723285;5707.68607726579;5738.139279108;5530;5575.052241118939;5578.497935185853;5610.551155907599;5635.013872572202;5337.866553336197;5349.384820745664;5562.610617256753;5569.470900264469;5593.440655934374;5443.374011988513;5470.64440811346;5507.091329930517;5511.22842802;5523.061079616556;5605.887882242414;5607.775688972395;5609.747561359667;5611.691356975405;5615.129654903497;5365.248865158803;5377.731113444391;5433.775244703259;5445.83662490126;5499.807506737245 07:10:47 INFO - PID 8502 | |1;ext.html;605.258558266124;652.3932742549429;669.5012215899154;1208.9153759236851;1226.429710184764;33195.170120746996;34104.65895341046;36406.45390319141;36598.817005914934;36697.449538256915;31668.366632667392;32314.67685323146;32481.837590812014;32537.511937320898;32586;7307.305805948439;7439.925600744004;7457.888131678029;7458.850822983537;7460.738874139406;7227.855442891139;7324.230955749649;7324.377427918634;7325.560466372008;7338.743143989961;7318.341349278564;7324.523905946123;7364.447666425012;7470.365018973366;7491.550506969599;7389;7484.962575187116;7496;7499.6250187490405;7505.774826755206;7401.370883474911;7408.740694075682;7436.516626419266;7455.105387353498;7459.925400746031;34283.82858085719;34678;34692.306153877034;34727.826360868035;35138.29723405518;2611.3341098020073;2615.7645811876832;2638.274474519503;2642.3262068172685;2661.0686259808913;23671.171508997104;23883.402914927094;24104.276871693877;24176.274711758677;24323.391915202086;3027.8031927924612;3035.920394529754;3057.617797775278;3074.4927087030615;3109.409212249688;110644;113757.99999999917;152522.23738881235;153584;154958;36561.45157822635;37053.81473092617;37101.25797484089;37190.256194875954;37246.62753372486;38643.227135457135;38674.226515469534;38751;38888.41667374992;38921.22157556833;12531;12553.811692824615;12595.559155429515;12612.55856045034;12739.42672579736;10572.89427105719;10575.259731818698;10582.523786429629;10613;10625.149988000941;11678.474468648932;11722;11734.11994100446;11788.115891308185;11873.762524749629;4944;4997.275395067695;5040.521150490697;5073.264376665363;5074.695518268915;878.4597472554333;904.8190361927641;906.7687739626354;908.2280061947424;940.3793496292415;20708.896455517624;21669.34991950244;21735.891320543295;21811.67282490764;21877.843209790088;977.130353984954;977.53567055648;978.1343510992823;985.482621623639;1008.9091981721533;11283.830742538868;11283.830742538868;11332.886671133349;11392.25950313227;11397.886021139848;238170;238829;239167;240219;241738;42583.78708106501;42642.147157057305;42657.57342426598;42664.57335426606;42688.14623707508;1193.2303664136584;1239.9690007749878;1247.5508816825936;1251.9687007824696;1252.486480542973;19606.705899411234;19744.703829442282;20764.273250436163;22482.437939051655;23776.52446951086;35227.64772352244;35372.46941295934;35424.64575354317;35558.866468012005;35566.64433355633;197357;197380;197520;197774;198091;21877.343679689635;22285.66571501396;27141.557259846708;27595.310117246427;29086;37658.8117059413;38017.429738553394;38248.42627360648;38422.423663645626;39380.2123957525;28466.715332847234;28851.5672264912;29035;29667.55498667565;32789.67210327962;27403;29584.852075739484;29735.553966690084;32004.67995320017;32208.35583288368;33567.664323356454;33765.15587110243;34311.65688343085;34612.134696632784;34745.65254347424;31262.843685781427;31307.530387043756;31420.52869206918;31679.52480712745;31814.04557863268;24452.51094978126;25146;25340.74659253384;25561.87219063967;25627 07:10:47 INFO - PID 8502 | |2;jquery.html;414.854800819713;415.6861569515016;426.44349124392664;433.20506869893734;442.6547293111372;17068.487945361645;17795.110244487772;17848.553786155353;18003.90998045008;18578.256869725195;18249.635007299847;18300.176492057857;19428.611427771437;19590.92249926257;19683.80316196841;5704.458076482748;5738.340090889538;5776.682282474462;5797.449242321994;5800.419958004208;5306.946930530703;5321.787128514855;5328.280682107924;5348.144296912495;5351.304330437038;5229.581633469333;5664.971675141618;5761.423857614247;5788.97105514474;5792.362840087587;5651.463111004489;5769.769209231626;5778.59549831512;5813.5349172066135;5838.2994040715175;5147.7683504242395;5180.8963820723375;5188.948110518922;5227.529522342969;5229.895402091937;21940.561188776293;22279.443013924618;22700.545989080292;22769.203077892194;22777.31668049961;1547.7833103365538;1581;1604.5346849413656;1629.226117594145;1648.3983346078594;13887.58337249884;14204;14249.287535623178;14497.855021449861;14873.70252594942;1524.9313780879777;1581.2726145972865;1622.513246026199;1662.5926647971326;1795.0845069014765;74435.62782186054;78276.60861695712;78780;94038;96139.51930240305;10976.176786741027;11091.500882460308;11167.162462815322;11201.71995700114;11335.263207891461;14556.49052283165;14568.125912445286;14860.108393496208;14894.627634309012;14906.925465372604;7809.3362064225175;7826.882596761053;7960.323372513401;7967.880481792778;8089.959550202211;7408.185099639036;7426.368758655467;7497.625118744041;7649.431866467361;7659.119201291811;6862.451003919675;6952.965235173791;6982.371586557234;7030.929690703129;7093.574385536885;1979.8714732602277;1992.4520756791708;2003.4891102768702;2045.78519255479;2139.2940329691164;826.0665448043673;842.5618678287378;843.6751850537587;864.1358641358642;871.7646235516502;16582.668346633;16674.333026678796;17530.298788048334;17846.732299015526;17847.286108555512;834.9332053435711;836.6318819719426;866.8049688819965;873.5108339329995;877.8156587116777;9068.637254509878;9115.863262051074;9490.193333566585;9594.459453408344;9635.759106022406;467830;481677;497240;497899;500720;90875.54562227147;92144.93202873772;92154.53922730478;92197;93203.533982331;1096.616184335492;1113.3264375052977;1142.8000099982469;1143.279733767721;1148.6955956671488;14735.968482206143;16274.349026038826;17759.682659915943;17885.642287154446;18091.638167236317;37929.43105853359;38828.6117138825;44251.778741106085;45137;45278.340207474066;47749.76125119352;48521.75739121282;51573.7421312891;51873.22190167075;54164.72917635387;7781.572013539083;8002.1997800219515;8087.63605637736;8284.83430331402;8577.914220857712;12275;13204.60386188416;13253.60837112128;13622.250776207404;13740.244286563935;10429.739256518647;10781.838272426077;10902.56389744433;11199.944000279946;11357.0914326852;10249;10396.480175991019;10410.68767936963;10464.00591943764;10612.522436490222;10984.286021408583;11084;11138.55445782192;11154.888451115385;11658.825117623073;8134.837303253784;8141.348692104499;8271.503709777433;8366.958165209135;8520.105388934073;10292.382457052601;10358;10644.946775266075;10893.727656808644;11131.220814542905 07:10:47 INFO - PID 8502 | |3;mootools.html;1228.944697488613;1277.195366918841;1295.5983645070035;1296.2416986063154;1297.9351032448376;9415.717528474148;9533.14201721845;9778.608855645765;9800.754981125476;9814.852777208338;10154.49227538622;10292.742681432968;10294.279400441972;10310.865804761488;10327.793444131114;2258.5821622999715;2298.885055747214;2306.769323067688;2308.6306191009444;2310.3761984264324;1829.4054432309485;1885.2835922349557;2129.84026198035;2168.6530155175174;2192.6710993351044;2225.5660146271484;2262.7284725832924;2263.0721404224273;2263.219189379661;2263.6151854184827;2081.1779347157863;2113.936581902545;2121.8302535797097;2134.9466263343384;2137.6579747240444;2064.7728749837506;2073.3676228750223;2092.9476763080893;2094.979050209509;2102.211670623516;9867;10047.246456515717;10056.195504359634;10095.949520252425;10109.129810984992;5239.083160446945;5423.620346575742;5441.646292990943;5461.781528738846;5470.589705772043;3173.587433633613;3239.64363919971;3267.57521522203;3267.9019629411155;3315.0717799016315;961.6441916490874;970.752458123174;974.3131092579714;1026.8357062869904;1046.8115739166947;14759.557213283619;14806.407743690239;14883.255837208204;14918.850811491855;14932.402703891723;4566.84016059443;4651.558101980307;4770.236762118045;4793.760311984387;4845.515448455127;10733.195010374253;10861.1854110942;10900;10931.070858976916;10932.617358392417;5439.177875411781;5444.8094316698725;5448.264484294648;5458.344998600114;5458.344998600193;4699;4934.9753251233515;5048.268001139888;5070.898582028339;5118.641695081308;3785.470034195215;3823.4073718573663;3860.82626281818;3900.3759398496104;3919.7452165609716;964.5322018820866;992.0129471176226;1083.967480975572;1104.3870651788175;1122.085500317239;693.5526585352419;697.6686074114755;699.1400577289962;714.1465948191965;721.1706537481938;5171.172612382076;5185.896282074337;5267.578593712494;6171.938280617226;6252.187215661935;808.4906508899473;809.8015986083329;811.1969150540922;814.7881550796835;840.7940054686519;3529.8411571479346;3579.910502237413;3608.83760230785;3633.109888077385;3705.2959937611768;12496.312702801433;12949.417276222594;13295.667608309675;13312.201267923761;13375.866241337462;12984.675383115498;13017.526669932682;13107;13141.277229752264;13177.275249861157;9408.670696525589;9624;9663.13031827139;9704.175145112744;9708.174805141502;5685.232493613309;5779.653220806765;5784.855378615568;5858.062709966385;5977.671228082323;11533;11728.882711172779;11734.589289374831;11911.285322880654;11993.34036627959;12095.637130886087;12141;12150.57472988441;12160.391980400767;12209.938950305192;7665.080190377191;7778.222177782177;7832.882506762289;8015.719449819228;8094.959525202336;9392.154706076486;9411.952940235255;9443.338966272295;9459.10138536838;9471.289653275893;8012.879806803019;8020.839583208186;8037.115917248981;8068.757937261891;8213.54825484604;7383.778486645409;7482.738104166328;7510.699572017058;7513.474056816189;7543.170251272246;7012.088428504262;7038.718451262097;7056.929430705627;7117.4661900358715;7117.928820711727;5088.44027157005;5125.513076257749;5215.478452154754;5224.869378265574;5270;4564.046934246286;4579.633629309581;4672.065586882569;4723.385959825201;4802.423709154924 07:10:47 INFO - PID 8502 | |4;prototype.html;393.9763614183149;397.05698964958225;400.7615468796067;402.9758214507128;409.66407545812444;5532.585056120792;5562.9986602411545;5591.916121258179;5594.517452874991;5605.187247849065;5301.204819277111;5431.918521222185;5469.097598896177;5471.343438787351;5526.640768350065;4371;4384.232759267132;4410.228210063242;4418.5197958683875;4419.204543182226;4407;4427.845025424111;4431.512533621315;4433.9778301108445;4438.844640437585;4011.65900898424;4205.978970105145;4222.261104306734;4395.340698895176;4404.713693609921;4202.243596152692;4205.642520385741;4207.978960105195;4211.663066954637;4219;3700.8149592520267;3709.7959612221316;3719.4420836874683;3726.105734623698;3731.8320675569394;5232.764525596357;5339.813106541291;5348.598855085884;5366.812161574365;5392.325959255093;4874.2444921037295;4882.705128589593;4883.267509873512;4894.339264199359;4926.261060840867;5757.251557297566;5770.971145144289;5778.8266352009505;5794.8989691958395;5802.506786923117;3948.5261768587666;4066.3290557058344;4105;4109.835606575733;4124.876253712393;5744.310682718059;5899.082798090595;6080.665563394012;6124.5100391968535;6138.877222455526;4077.4903137107863;4157.646600039031;4158.521769996489;4170.624643782014;4188.6649068074485;4226.2181496422645;4230.428892099589;4241.957580424218;4243.108947121139;4248.553901840324;4639.744814035193;4844.588210002119;4849.345338379344;4867.929055607831;4874.317595536628;5778.739956701958;5785.103308987113;5793.855153621109;5802.448767367094;5819.156222347736;1447.334226255913;1452.3537026023319;1453.876420504269;1455.9563213103625;1463.5682473670292;950.1828427552299;989.6288891665625;999.6101520407047;999.9450030248406;1001.6043662753171;5080.441151473335;5084.974575127175;5089.440161582223;5090.363704536933;5098.133317336062;5975.462208401264;6014.218151640259;6023.879522409527;6041.758329666852;6050.636961782219;4931.3589233399425;5044.066847633127;5070.543651071347;5083.399523431301;5101.183810590288;3175.4760464523556;3199.52007198922;3217.2761128746315;3228;3236.0615421527496;5646.632968857011;5648.293963254593;5650.491455769001;5650.773969041193;5651.4348565143155;5893.469587737039;6118.309971726338;6198.318184999646;6201.441870231701;6236.282827474898;5623.240862483676;5630.127330263816;5642.463965923231;5645.5483561314995;5647.7176141193595;5845.912311315419;5994.610350327215;5998.1002849572915;6016.299975514939;6064.575479716377;5882.647041177543;5922.615030023035;5942.732577033958;5953.642781433128;5972.372900845348;5306.8938621228135;5459.754311056092;5471.2887324647545;5565.916511252415;5623.100303951512;4148.108156746314;4178.080822219107;4185;4202.41166236721;4207.368894665825;5901.29184497863;6024.819255422344;6044.818655440344;6055.969720151371;6059.363766804422;5754.395788442321;5765.54067559461;5768.134779783066;5842.678652673973;5860.2967643883;5757.36668966405;5782.913256301074;5798.825440459827;5808.854778630399;5853.151293062568;5597.768490931989;5669.744861481161;5708.65748055118;5763.135529670583;5766.106253530709;5771.653700777967;5782.566307527037;5783.450572195635;5792.8551786204;5832.329282132439;5618.129189975561;5626.634268772516;5634.4365563443325;5648.039833228443;5648.350439699487 07:10:47 INFO - PID 8502 | |5;yui.html;708.1714394158835;708.9610071446072;711.7437722419929;712.1525384792097;720.9783706488807;11592.710182245448;12011.339376334297;12025.579104731336;12167.269963802179;13224.73550528989;12921;13222.53721119761;13271.867281327184;13276.867231327684;13588.796168057486;628.9559730818844;639.7089324357429;865.3899001204136;868.0711638546758;871.6731225790329;869.7955980344614;869.8347314010349;871.2289623683055;877.719129878436;881.6120906800987;907.1744712311797;907.773056735816;908.3959167153868;910.7586489580267;913.3241401362977;903.6882275614902;905.5291248550717;908.5457271364318;910.7950711090018;913.5340976102169;663.8805015097281;670.0752960913908;670.1087553553762;670.2928410526893;671.5467059734659;12829.807552886714;12839.743205135845;13053.738925221442;13116.213027218302;13189.604311870658;10855.511501982352;10879.510422031028;11047.944760276147;11145.554177832877;11356.772864542745;9154.954225228832;9227.169554740105;9227.26181905446;9353.485558294291;9411.482368469731;2696.0833316672424;2704.4185500117374;2742.204760619418;2752.6972033076345;2785.6517935258094;57190.428095718926;57541.71229143869;57821.421785782026;58021.41978580203;59714.10428843571;8010.959945200237;8074.555899425588;8130.227628375294;8216.34269258458;9906.405615663083;19478.513037174183;19694.606107877764;20607.587848243253;20610.793892060887;20686.379408617766;6357.904631430532;6496.805095847132;6515.185601799775;6557.2131344239;6821.317868213139;3302.6036875575087;3323.2356557991316;3327.5341452196712;3330.8667653294083;3369.427197376452;3226.3224722808004;3248.2529018325445;3266.248762784573;3291.0949488890747;3322.551455553518;577.8988676981511;579.3974266762519;589.3399392680226;596.2576592142723;598.4261392537685;488.67991465589387;493.8444390017133;495.4228324002569;505.11352576228484;506.6250974279007;8504.277136443348;8557.786055348666;8752.47485150893;8765.027868729612;8805.471671699719;471.2789432168787;481.1675800864524;500.3170672032649;515.5488947171225;518.1554066870976;4279.40088387626;4589.563991420877;4699.412573428322;4780.904381912412;4808.206645903457;57967.420325797044;58098.419015809304;58570.707146463996;60178.39821601728;60565.394346056855;53865;54031.72984135054;54319.72840135774;54463.18305225425;56322.43677563172;48175.036499269816;48361;48386.51613483891;48568.75715621399;49655.25517117246;9052.592633331647;9454.763630909007;9457.716268511957;9479.478628675213;9521.761955951157;24258.636120457853;24398.512029759662;25098.74901250964;25412.364690882874;25513.362165946;29129;30362;30575.08274751761;30585.694143058285;31358.216044599067;11998.460069297078;12237.75524489523;12358.196717213352;12402.25586464815;12467.87532124667;12529.18560293578;12872.35638218104;13027.283499407624;13119.27843968591;13636.727265454834;12255.632331030083;12263.69340766488;12600.87399125997;13192.736145277233;13199.274039927896;12225.877741222474;12288.447019884305;12337.629871103882;12369.072319575887;13512.93243533776;12378.75242495163;12447.439865205906;12632.462910385108;13141.080124391583;13466.730665386442;8199.42604017713;8338.374621903502;9022.639094436148;9109.635614575607;9256.496859456336;9519.381240219363;10509.684709458728;10745;10759.784804304027;10974.615888443866 07:10:47 INFO - PID 8502 | __end_tp_report 07:10:47 INFO - PID 8502 | __start_cc_report 07:10:47 INFO - PID 8502 | _x_x_mozilla_cycle_collect,393 07:10:47 INFO - PID 8502 | __end_cc_report 07:10:47 INFO - PID 8502 | __startTimestamp1490364647951__endTimestamp 07:10:47 INFO - PID 8502 | 07:10:47 INFO - PID 8502 | ------- Summary: start ------- 07:10:47 INFO - PID 8502 | Number of tests: 6 07:10:47 INFO - PID 8502 | 07:10:47 INFO - PID 8502 | [#0] dojo.html Cycles:165 Average:5232.95 Median:5377.73 stddev:582.11 (10.8%) stddev-sans-first:549.96 07:10:47 INFO - PID 8502 | Values: 2736.3 2736.4 2744.8 2771.9 2783.1 5189.7 5302.0 5325.9 5345.9 5352.9 5240.4 5332.4 5341.8 5365.6 5403.8 4812.8 4844.1 4844.2 4867.1 4887.0 4880.3 4924.0 4924.7 4939.0 4982.9 4727.7 4748.5 4803.7 4832.0 4853.4 4840.8 4841.2 4886.9 4891.1 4930.0 4781.4 4789.9 4822.1 4854.2 4867.8 5144.2 5172.7 5313.0 5356.5 5400.9 5580.1 5583.4 5584.9 5602.9 5608.7 5606.9 5620.4 5635.6 5641.9 5730.3 5346.5 5348.9 5393.5 5407.3 5417.8 5830.8 5838.2 5867.7 5872.1 5897.5 5363.9 5390.2 5393.8 5402.1 5614.8 5613.0 5617.4 5619.4 5633.7 5713.9 5579.0 5633.1 5688.1 5691.6 5691.7 5600.2 5627.4 5628.9 5637.4 5643.2 4718.7 4782.6 4824.3 4834.5 4887.1 4099.6 4107.6 4112.0 4123.7 4144.6 4888.4 4890.5 4891.7 4896.0 4936.2 5552.9 5695.8 5735.8 5743.5 5747.9 4800.2 4900.2 4922.9 4928.8 4950.6 5161.3 5167.9 5171.1 5172.4 5184.3 5346.4 5362.5 5362.8 5375.2 5403.5 5610.7 5652.2 5730.5 5771.7 5772.1 5331.3 5332.3 5334.7 5336.3 5385.8 5633.0 5637.0 5641.0 5646.9 5679.5 5526.6 5561.5 5678.3 5707.7 5738.1 5530.0 5575.1 5578.5 5610.6 5635.0 5337.9 5349.4 5562.6 5569.5 5593.4 5443.4 5470.6 5507.1 5511.2 5523.1 5605.9 5607.8 5609.7 5611.7 5615.1 5365.2 5377.7 5433.8 5445.8 5499.8 07:10:47 INFO - PID 8502 | 07:10:47 INFO - PID 8502 | [#1] ext.html Cycles:180 Average:33621.83 Median:31909.36 stddev:51114.88 (160.2%) stddev-sans-first:51198.16 07:10:47 INFO - PID 8502 | Values: 605.3 652.4 669.5 1208.9 1226.4 33195.2 34104.7 36406.5 36598.8 36697.4 31668.4 32314.7 32481.8 32537.5 32586.0 7307.3 7439.9 7457.9 7458.9 7460.7 7227.9 7324.2 7324.4 7325.6 7338.7 7318.3 7324.5 7364.4 7470.4 7491.6 7389.0 7485.0 7496.0 7499.6 7505.8 7401.4 7408.7 7436.5 7455.1 7459.9 34283.8 34678.0 34692.3 34727.8 35138.3 2611.3 2615.8 2638.3 2642.3 2661.1 23671.2 23883.4 24104.3 24176.3 24323.4 3027.8 3035.9 3057.6 3074.5 3109.4 110644.0 113758.0 152522.2 153584.0 154958.0 36561.5 37053.8 37101.3 37190.3 37246.6 38643.2 38674.2 38751.0 38888.4 38921.2 12531.0 12553.8 12595.6 12612.6 12739.4 10572.9 10575.3 10582.5 10613.0 10625.1 11678.5 11722.0 11734.1 11788.1 11873.8 4944.0 4997.3 5040.5 5073.3 5074.7 878.5 904.8 906.8 908.2 940.4 20708.9 21669.3 21735.9 21811.7 21877.8 977.1 977.5 978.1 985.5 1008.9 11283.8 11283.8 11332.9 11392.3 11397.9 238170.0 238829.0 239167.0 240219.0 241738.0 42583.8 42642.1 42657.6 42664.6 42688.1 1193.2 1240.0 1247.6 1252.0 1252.5 19606.7 19744.7 20764.3 22482.4 23776.5 35227.6 35372.5 35424.6 35558.9 35566.6 197357.0 197380.0 197520.0 197774.0 198091.0 21877.3 22285.7 27141.6 27595.3 29086.0 37658.8 38017.4 38248.4 38422.4 39380.2 28466.7 28851.6 29035.0 29667.6 32789.7 27403.0 29584.9 29735.6 32004.7 32208.4 33567.7 33765.2 34311.7 34612.1 34745.7 31262.8 31307.5 31420.5 31679.5 31814.0 24452.5 25146.0 25340.7 25561.9 25627.0 07:10:47 INFO - PID 8502 | 07:10:47 INFO - PID 8502 | [#2] jquery.html Cycles:180 Average:28706.54 Median:437.93 stddev:80721.09 (18432.4%) stddev-sans-first:80919.58 07:10:47 INFO - PID 8502 | Values: 414.9 415.7 426.4 433.2 442.7 17068.5 17795.1 17848.6 18003.9 18578.3 18249.6 18300.2 19428.6 19590.9 19683.8 5704.5 5738.3 5776.7 5797.4 5800.4 5306.9 5321.8 5328.3 5348.1 5351.3 5229.6 5665.0 5761.4 5789.0 5792.4 5651.5 5769.8 5778.6 5813.5 5838.3 5147.8 5180.9 5188.9 5227.5 5229.9 21940.6 22279.4 22700.5 22769.2 22777.3 1547.8 1581.0 1604.5 1629.2 1648.4 13887.6 14204.0 14249.3 14497.9 14873.7 1524.9 1581.3 1622.5 1662.6 1795.1 74435.6 78276.6 78780.0 94038.0 96139.5 10976.2 11091.5 11167.2 11201.7 11335.3 14556.5 14568.1 14860.1 14894.6 14906.9 7809.3 7826.9 7960.3 7967.9 8090.0 7408.2 7426.4 7497.6 7649.4 7659.1 6862.5 6953.0 6982.4 7030.9 7093.6 1979.9 1992.5 2003.5 2045.8 2139.3 826.1 842.6 843.7 864.1 871.8 16582.7 16674.3 17530.3 17846.7 17847.3 834.9 836.6 866.8 873.5 877.8 9068.6 9115.9 9490.2 9594.5 9635.8 467830.0 481677.0 497240.0 497899.0 500720.0 90875.5 92144.9 92154.5 92197.0 93203.5 1096.6 1113.3 1142.8 1143.3 1148.7 14736.0 16274.3 17759.7 17885.6 18091.6 37929.4 38828.6 44251.8 45137.0 45278.3 47749.8 48521.8 51573.7 51873.2 54164.7 7781.6 8002.2 8087.6 8284.8 8577.9 12275.0 13204.6 13253.6 13622.3 13740.2 10429.7 10781.8 10902.6 11199.9 11357.1 10249.0 10396.5 10410.7 10464.0 10612.5 10984.3 11084.0 11138.6 11154.9 11658.8 8134.8 8141.3 8271.5 8367.0 8520.1 10292.4 10358.0 10644.9 10893.7 11131.2 07:10:47 INFO - PID 8502 | 07:10:47 INFO - PID 8502 | [#3] mootools.html Cycles:180 Average:6210.62 Median:4573.24 stddev:4029.51 (88.1%) stddev-sans-first:4023.43 07:10:47 INFO - PID 8502 | Values: 1228.9 1277.2 1295.6 1296.2 1297.9 9415.7 9533.1 9778.6 9800.8 9814.9 10154.5 10292.7 10294.3 10310.9 10327.8 2258.6 2298.9 2306.8 2308.6 2310.4 1829.4 1885.3 2129.8 2168.7 2192.7 2225.6 2262.7 2263.1 2263.2 2263.6 2081.2 2113.9 2121.8 2134.9 2137.7 2064.8 2073.4 2092.9 2095.0 2102.2 9867.0 10047.2 10056.2 10095.9 10109.1 5239.1 5423.6 5441.6 5461.8 5470.6 3173.6 3239.6 3267.6 3267.9 3315.1 961.6 970.8 974.3 1026.8 1046.8 14759.6 14806.4 14883.3 14918.9 14932.4 4566.8 4651.6 4770.2 4793.8 4845.5 10733.2 10861.2 10900.0 10931.1 10932.6 5439.2 5444.8 5448.3 5458.3 5458.3 4699.0 4935.0 5048.3 5070.9 5118.6 3785.5 3823.4 3860.8 3900.4 3919.7 964.5 992.0 1084.0 1104.4 1122.1 693.6 697.7 699.1 714.1 721.2 5171.2 5185.9 5267.6 6171.9 6252.2 808.5 809.8 811.2 814.8 840.8 3529.8 3579.9 3608.8 3633.1 3705.3 12496.3 12949.4 13295.7 13312.2 13375.9 12984.7 13017.5 13107.0 13141.3 13177.3 9408.7 9624.0 9663.1 9704.2 9708.2 5685.2 5779.7 5784.9 5858.1 5977.7 11533.0 11728.9 11734.6 11911.3 11993.3 12095.6 12141.0 12150.6 12160.4 12209.9 7665.1 7778.2 7832.9 8015.7 8095.0 9392.2 9412.0 9443.3 9459.1 9471.3 8012.9 8020.8 8037.1 8068.8 8213.5 7383.8 7482.7 7510.7 7513.5 7543.2 7012.1 7038.7 7056.9 7117.5 7117.9 5088.4 5125.5 5215.5 5224.9 5270.0 4564.0 4579.6 4672.1 4723.4 4802.4 07:10:47 INFO - PID 8502 | 07:10:47 INFO - PID 8502 | [#4] prototype.html Cycles:180 Average:4807.18 Median:5470.19 stddev:1399.75 (25.6%) stddev-sans-first:1363.92 07:10:47 INFO - PID 8502 | Values: 394.0 397.1 400.8 403.0 409.7 5532.6 5563.0 5591.9 5594.5 5605.2 5301.2 5431.9 5469.1 5471.3 5526.6 4371.0 4384.2 4410.2 4418.5 4419.2 4407.0 4427.8 4431.5 4434.0 4438.8 4011.7 4206.0 4222.3 4395.3 4404.7 4202.2 4205.6 4208.0 4211.7 4219.0 3700.8 3709.8 3719.4 3726.1 3731.8 5232.8 5339.8 5348.6 5366.8 5392.3 4874.2 4882.7 4883.3 4894.3 4926.3 5757.3 5771.0 5778.8 5794.9 5802.5 3948.5 4066.3 4105.0 4109.8 4124.9 5744.3 5899.1 6080.7 6124.5 6138.9 4077.5 4157.6 4158.5 4170.6 4188.7 4226.2 4230.4 4242.0 4243.1 4248.6 4639.7 4844.6 4849.3 4867.9 4874.3 5778.7 5785.1 5793.9 5802.4 5819.2 1447.3 1452.4 1453.9 1456.0 1463.6 950.2 989.6 999.6 999.9 1001.6 5080.4 5085.0 5089.4 5090.4 5098.1 5975.5 6014.2 6023.9 6041.8 6050.6 4931.4 5044.1 5070.5 5083.4 5101.2 3175.5 3199.5 3217.3 3228.0 3236.1 5646.6 5648.3 5650.5 5650.8 5651.4 5893.5 6118.3 6198.3 6201.4 6236.3 5623.2 5630.1 5642.5 5645.5 5647.7 5845.9 5994.6 5998.1 6016.3 6064.6 5882.6 5922.6 5942.7 5953.6 5972.4 5306.9 5459.8 5471.3 5565.9 5623.1 4148.1 4178.1 4185.0 4202.4 4207.4 5901.3 6024.8 6044.8 6056.0 6059.4 5754.4 5765.5 5768.1 5842.7 5860.3 5757.4 5782.9 5798.8 5808.9 5853.2 5597.8 5669.7 5708.7 5763.1 5766.1 5771.7 5782.6 5783.5 5792.9 5832.3 5618.1 5626.6 5634.4 5648.0 5648.4 07:10:47 INFO - PID 8502 | 07:10:47 INFO - PID 8502 | [#5] yui.html Cycles:180 Average:13635.67 Median:491.26 stddev:16291.28 (3316.2%) stddev-sans-first:16308.06 07:10:47 INFO - PID 8502 | Values: 708.2 709.0 711.7 712.2 721.0 11592.7 12011.3 12025.6 12167.3 13224.7 12921.0 13222.5 13271.9 13276.9 13588.8 629.0 639.7 865.4 868.1 871.7 869.8 869.8 871.2 877.7 881.6 907.2 907.8 908.4 910.8 913.3 903.7 905.5 908.5 910.8 913.5 663.9 670.1 670.1 670.3 671.5 12829.8 12839.7 13053.7 13116.2 13189.6 10855.5 10879.5 11047.9 11145.6 11356.8 9155.0 9227.2 9227.3 9353.5 9411.5 2696.1 2704.4 2742.2 2752.7 2785.7 57190.4 57541.7 57821.4 58021.4 59714.1 8011.0 8074.6 8130.2 8216.3 9906.4 19478.5 19694.6 20607.6 20610.8 20686.4 6357.9 6496.8 6515.2 6557.2 6821.3 3302.6 3323.2 3327.5 3330.9 3369.4 3226.3 3248.3 3266.2 3291.1 3322.6 577.9 579.4 589.3 596.3 598.4 488.7 493.8 495.4 505.1 506.6 8504.3 8557.8 8752.5 8765.0 8805.5 471.3 481.2 500.3 515.5 518.2 4279.4 4589.6 4699.4 4780.9 4808.2 57967.4 58098.4 58570.7 60178.4 60565.4 53865.0 54031.7 54319.7 54463.2 56322.4 48175.0 48361.0 48386.5 48568.8 49655.3 9052.6 9454.8 9457.7 9479.5 9521.8 24258.6 24398.5 25098.7 25412.4 25513.4 29129.0 30362.0 30575.1 30585.7 31358.2 11998.5 12237.8 12358.2 12402.3 12467.9 12529.2 12872.4 13027.3 13119.3 13636.7 12255.6 12263.7 12600.9 13192.7 13199.3 12225.9 12288.4 12337.6 12369.1 13512.9 12378.8 12447.4 12632.5 13141.1 13466.7 8199.4 8338.4 9022.6 9109.6 9256.5 9519.4 10509.7 10745.0 10759.8 10974.6 07:10:47 INFO - PID 8502 | -------- Summary: end -------- 07:10:47 INFO - PID 8502 | 07:10:48 INFO - TEST-INFO | 8502: exit 0 07:10:48 INFO - TEST-OK | dromaeo_css | took 1121524ms 07:10:48 INFO - TEST-START | kraken 07:10:48 INFO - operating with platform_type : linux_ 07:10:48 INFO - Initialising browser for kraken test... 07:10:48 INFO - TEST-INFO | started process 8882 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplwkpz1/profile http://localhost:40539/getInfo.html) 07:10:53 INFO - PID 8882 | __metrics Screen width/height:1600/1200 07:10:53 INFO - PID 8882 | colorDepth:24 07:10:53 INFO - PID 8882 | Browser inner width/height: 1024/697 07:10:53 INFO - PID 8882 | __metrics 07:10:54 ERROR - PID 8882 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3392: TypeError: this.tabs is undefined 07:10:55 INFO - TEST-INFO | 8882: exit 0 07:10:55 INFO - Browser initialized. 07:10:55 INFO - Running cycle 1/1 for kraken test... 07:10:55 INFO - TEST-INFO | started process 9011 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplwkpz1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:11:07 INFO - PID 9011 | RSS: Main: 156229632 07:11:07 INFO - PID 9011 | 07:11:10 INFO - PID 9011 | Cycle 1(1): loaded http://localhost:40539/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40539/tests/kraken/driver.html?testName=audio-beat-detection) 07:11:11 INFO - PID 9011 | RSS: Main: 162295808 07:11:11 INFO - PID 9011 | 07:11:14 INFO - PID 9011 | Cycle 1(1): loaded http://localhost:40539/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40539/tests/kraken/driver.html?testName=audio-dft) 07:11:14 INFO - PID 9011 | RSS: Main: 161632256 07:11:14 INFO - PID 9011 | 07:11:17 INFO - PID 9011 | Cycle 1(1): loaded http://localhost:40539/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40539/tests/kraken/driver.html?testName=audio-fft) 07:11:18 INFO - PID 9011 | RSS: Main: 158285824 07:11:18 INFO - PID 9011 | 07:11:20 INFO - PID 9011 | Cycle 1(1): loaded http://localhost:40539/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40539/tests/kraken/driver.html?testName=audio-oscillator) 07:11:21 INFO - PID 9011 | RSS: Main: 158564352 07:11:21 INFO - PID 9011 | 07:11:23 INFO - PID 9011 | Cycle 1(1): loaded http://localhost:40539/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40539/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:11:23 INFO - PID 9011 | RSS: Main: 158859264 07:11:23 INFO - PID 9011 | 07:11:27 INFO - PID 9011 | Cycle 1(1): loaded http://localhost:40539/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40539/tests/kraken/driver.html?testName=imaging-darkroom) 07:11:27 INFO - PID 9011 | RSS: Main: 163979264 07:11:27 INFO - PID 9011 | 07:11:31 INFO - PID 9011 | Cycle 1(1): loaded http://localhost:40539/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40539/tests/kraken/driver.html?testName=imaging-desaturate) 07:11:31 INFO - PID 9011 | RSS: Main: 161406976 07:11:31 INFO - PID 9011 | 07:11:34 INFO - PID 9011 | Cycle 1(1): loaded http://localhost:40539/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40539/tests/kraken/driver.html?testName=json-parse-financial) 07:11:35 INFO - PID 9011 | RSS: Main: 162336768 07:11:35 INFO - PID 9011 | 07:11:37 INFO - PID 9011 | Cycle 1(1): loaded http://localhost:40539/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40539/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:11:37 INFO - PID 9011 | RSS: Main: 163155968 07:11:37 INFO - PID 9011 | 07:11:39 INFO - PID 9011 | Cycle 1(1): loaded http://localhost:40539/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40539/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:11:40 INFO - PID 9011 | RSS: Main: 163250176 07:11:40 INFO - PID 9011 | 07:11:42 INFO - PID 9011 | Cycle 1(1): loaded http://localhost:40539/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40539/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:11:43 INFO - PID 9011 | RSS: Main: 163524608 07:11:43 INFO - PID 9011 | 07:11:45 INFO - PID 9011 | Cycle 1(1): loaded http://localhost:40539/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40539/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:11:46 INFO - PID 9011 | RSS: Main: 163966976 07:11:46 INFO - PID 9011 | 07:11:49 INFO - PID 9011 | Cycle 1(1): loaded http://localhost:40539/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40539/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:11:50 INFO - PID 9011 | RSS: Main: 166825984 07:11:50 INFO - PID 9011 | 07:11:52 INFO - PID 9011 | Cycle 1(1): loaded http://localhost:40539/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40539/tests/kraken/driver.html?testName=ai-astar) 07:11:52 INFO - PID 9011 | RSS: Main: 167587840 07:11:52 INFO - PID 9011 | 07:11:52 INFO - PID 9011 | __start_tp_report 07:11:52 INFO - PID 9011 | _x_x_mozilla_page_load 07:11:52 INFO - PID 9011 | _x_x_mozilla_page_load_details 07:11:52 INFO - PID 9011 | |i|pagename|runs| 07:11:52 INFO - PID 9011 | |0;ai-astar;105;114;111;112;111;112;114;113;115;112 07:11:52 INFO - PID 9011 | |1;audio-beat-detection;155;129;125;173;125;142;126;126;143;127 07:11:52 INFO - PID 9011 | |2;audio-dft;166;166;166;172;168;169;163;163;165;165 07:11:52 INFO - PID 9011 | |3;audio-fft;76;77;76;111;76;75;75;81;101;77 07:11:52 INFO - PID 9011 | |4;audio-oscillator;84;85;110;86;84;84;105;84;85;110 07:11:52 INFO - PID 9011 | |5;imaging-gaussian-blur;114;114;114;114;113;116;115;114;115;114 07:11:52 INFO - PID 9011 | |6;imaging-darkroom;150;150;151;151;150;150;150;149;151;152 07:11:52 INFO - PID 9011 | |7;imaging-desaturate;95;95;94;94;95;95;95;95;95;95 07:11:52 INFO - PID 9011 | |8;json-parse-financial;69;70;70;69;72;78;71;68;70;70 07:11:52 INFO - PID 9011 | |9;json-stringify-tinderbox;58;55;55;57;57;56;55;59;56;55 07:11:52 INFO - PID 9011 | |10;stanford-crypto-aes;82;85;82;81;83;82;80;82;83;82 07:11:52 INFO - PID 9011 | |11;stanford-crypto-ccm;139;140;142;139;135;141;147;132;178;133 07:11:52 INFO - PID 9011 | |12;stanford-crypto-pbkdf2;187;191;195;199;197;207;197;195;192;202 07:11:52 INFO - PID 9011 | |13;stanford-crypto-sha256-iterative;70;74;72;70;70;73;74;70;72;69 07:11:52 INFO - PID 9011 | __end_tp_report 07:11:52 INFO - PID 9011 | __start_cc_report 07:11:52 INFO - PID 9011 | _x_x_mozilla_cycle_collect,873 07:11:52 INFO - PID 9011 | __end_cc_report 07:11:52 INFO - PID 9011 | __startTimestamp1490364712698__endTimestamp 07:11:52 INFO - PID 9011 | 07:11:52 INFO - PID 9011 | ------- Summary: start ------- 07:11:52 INFO - PID 9011 | Number of tests: 14 07:11:52 INFO - PID 9011 | 07:11:52 INFO - PID 9011 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.50 stddev:2.77 (2.5%) stddev-sans-first:1.41 07:11:52 INFO - PID 9011 | Values: 105.0 114.0 111.0 112.0 111.0 112.0 114.0 113.0 115.0 112.0 07:11:52 INFO - PID 9011 | 07:11:52 INFO - PID 9011 | [#1] audio-beat-detection Cycles:10 Average:137.10 Median:135.50 stddev:16.24 (12.0%) stddev-sans-first:15.89 07:11:52 INFO - PID 9011 | Values: 155.0 129.0 125.0 173.0 125.0 142.0 126.0 126.0 143.0 127.0 07:11:52 INFO - PID 9011 | 07:11:52 INFO - PID 9011 | [#2] audio-dft Cycles:10 Average:166.30 Median:166.00 stddev:2.75 (1.7%) stddev-sans-first:2.92 07:11:52 INFO - PID 9011 | Values: 166.0 166.0 166.0 172.0 168.0 169.0 163.0 163.0 165.0 165.0 07:11:52 INFO - PID 9011 | 07:11:52 INFO - PID 9011 | [#3] audio-fft Cycles:10 Average:82.50 Median:76.00 stddev:12.72 (16.7%) stddev-sans-first:13.27 07:11:52 INFO - PID 9011 | Values: 76.0 77.0 76.0 111.0 76.0 75.0 75.0 81.0 101.0 77.0 07:11:52 INFO - PID 9011 | 07:11:52 INFO - PID 9011 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:84.00 stddev:11.58 (13.8%) stddev-sans-first:11.94 07:11:52 INFO - PID 9011 | Values: 84.0 85.0 110.0 86.0 84.0 84.0 105.0 84.0 85.0 110.0 07:11:52 INFO - PID 9011 | 07:11:52 INFO - PID 9011 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 07:11:52 INFO - PID 9011 | Values: 114.0 114.0 114.0 114.0 113.0 116.0 115.0 114.0 115.0 114.0 07:11:52 INFO - PID 9011 | 07:11:52 INFO - PID 9011 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 07:11:52 INFO - PID 9011 | Values: 150.0 150.0 151.0 151.0 150.0 150.0 150.0 149.0 151.0 152.0 07:11:52 INFO - PID 9011 | 07:11:52 INFO - PID 9011 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:11:52 INFO - PID 9011 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 07:11:52 INFO - PID 9011 | 07:11:52 INFO - PID 9011 | [#8] json-parse-financial Cycles:10 Average:70.70 Median:70.00 stddev:2.79 (4.0%) stddev-sans-first:2.89 07:11:52 INFO - PID 9011 | Values: 69.0 70.0 70.0 69.0 72.0 78.0 71.0 68.0 70.0 70.0 07:11:52 INFO - PID 9011 | 07:11:52 INFO - PID 9011 | [#9] json-stringify-tinderbox Cycles:10 Average:56.30 Median:56.50 stddev:1.42 (2.5%) stddev-sans-first:1.36 07:11:52 INFO - PID 9011 | Values: 58.0 55.0 55.0 57.0 57.0 56.0 55.0 59.0 56.0 55.0 07:11:52 INFO - PID 9011 | 07:11:52 INFO - PID 9011 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:1.32 (1.6%) stddev-sans-first:1.39 07:11:52 INFO - PID 9011 | Values: 82.0 85.0 82.0 81.0 83.0 82.0 80.0 82.0 83.0 82.0 07:11:52 INFO - PID 9011 | 07:11:52 INFO - PID 9011 | [#11] stanford-crypto-ccm Cycles:10 Average:142.60 Median:140.50 stddev:13.21 (9.4%) stddev-sans-first:13.95 07:11:52 INFO - PID 9011 | Values: 139.0 140.0 142.0 139.0 135.0 141.0 147.0 132.0 178.0 133.0 07:11:52 INFO - PID 9011 | 07:11:52 INFO - PID 9011 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.20 Median:197.00 stddev:5.69 (2.9%) stddev-sans-first:4.97 07:11:52 INFO - PID 9011 | Values: 187.0 191.0 195.0 199.0 197.0 207.0 197.0 195.0 192.0 202.0 07:11:52 INFO - PID 9011 | 07:11:52 INFO - PID 9011 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:72.00 stddev:1.84 (2.6%) stddev-sans-first:1.88 07:11:52 INFO - PID 9011 | Values: 70.0 74.0 72.0 70.0 70.0 73.0 74.0 70.0 72.0 69.0 07:11:52 INFO - PID 9011 | -------- Summary: end -------- 07:11:52 INFO - PID 9011 | 07:11:53 INFO - TEST-INFO | 9011: exit 0 07:11:53 INFO - TEST-OK | kraken | took 65017ms 07:11:53 INFO - SUITE-END | took 1186s 07:11:53 INFO - Completed test suite (00:19:46) 07:11:53 INFO - javascript benchmark 07:11:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6661.313602744769, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2736.2612094734422, 2736.425350676358, 2744.7529722325, 2771.8891244350216, 2783.081583077584, 5189.740512974346, 5302.0, 5325.946740532593, 5345.946540534594, 5352.892942141159, 5240.397354304256, 5332.413434522209, 5341.759620817063, 5365.624406291551, 5403.8108666196595, 4812.8074877004965, 4844.103840789465, 4844.152273352167, 4867.075255701423, 4886.973735515546, 4880.341153944225, 4924.0, 4924.729139897304, 4938.950610493885, 4982.9252561211615, 4727.692699974491, 4748.548887855648, 4803.687760295569, 4831.975840120777, 4853.3690620219495, 4840.782164802557, 4841.2496063110275, 4886.926696099561, 4891.144049791273, 4929.975350123263, 4781.354517140211, 4789.880252993668, 4822.132016237111, 4854.2233242681, 4867.805287788484, 5144.176931690911, 5172.741362931876, 5313.043652142613, 5356.54469370104, 5400.891982160374, 5580.135079062752, 5583.3858275589655, 5584.91622625661, 5602.915956260659, 5608.747606357723, 5606.943930560683, 5620.353659329188, 5635.6055076144685, 5641.8589535261535, 5730.312362516483, 5346.545543628835, 5348.866278343073, 5393.541548968343, 5407.297051383295, 5417.756200970965, 5830.766769329264, 5838.241028666246, 5867.70661466925, 5872.0898260769645, 5897.498712609477, 5363.919541206885, 5390.164524498709, 5393.83818485446, 5402.081646120169, 5614.775408983676, 5613.0, 5617.354004289477, 5619.353774315924, 5633.690147041952, 5713.914291285634, 5578.97210513953, 5633.126865335797, 5688.089905615165, 5691.601587888891, 5691.743871525791, 5600.159976003551, 5627.352854421712, 5628.859278517988, 5637.379888212294, 5643.238162847963, 4718.669693121517, 4782.641301902371, 4824.300476430968, 4834.492378300228, 4887.120318342661, 4099.631033207026, 4107.630313271819, 4111.958880411217, 4123.731957422758, 4144.585541445831, 4888.388951381077, 4890.510948905152, 4891.706497610155, 4896.045271172158, 4936.210206367035, 5552.86117847049, 5695.829125126253, 5735.799247026334, 5743.483086522233, 5747.8563035924435, 4800.159972004885, 4900.215965445512, 4922.901541969212, 4928.753562321941, 4950.628702847301, 5161.329027226437, 5167.896642067213, 5171.069207542603, 5172.379314482211, 5184.274201611777, 5346.385165705994, 5362.5441837442695, 5362.839114826562, 5375.247465354775, 5403.459654034565, 5610.719464026701, 5652.208690783212, 5730.484256416942, 5771.68255745938, 5772.076467765138, 5331.333583302087, 5332.280142180911, 5334.67991920486, 5336.332958380202, 5385.784568617211, 5632.971835140798, 5637.041702910433, 5641.012822756084, 5646.887062258814, 5679.545636349165, 5526.640768350045, 5561.527270181918, 5678.290213723285, 5707.68607726579, 5738.139279108, 5530.0, 5575.052241118939, 5578.497935185853, 5610.551155907599, 5635.013872572202, 5337.866553336197, 5349.384820745664, 5562.610617256753, 5569.470900264469, 5593.440655934374, 5443.374011988513, 5470.64440811346, 5507.091329930517, 5511.22842802, 5523.061079616556, 5605.887882242414, 5607.775688972395, 5609.747561359667, 5611.691356975405, 5615.129654903497, 5365.248865158803, 5377.731113444391, 5433.775244703259, 5445.83662490126, 5499.807506737245], "value": 5191.888887420719, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.258558266124, 652.3932742549429, 669.5012215899154, 1208.9153759236851, 1226.429710184764, 33195.170120746996, 34104.65895341046, 36406.45390319141, 36598.817005914934, 36697.449538256915, 31668.366632667392, 32314.67685323146, 32481.837590812014, 32537.511937320898, 32586.0, 7307.305805948439, 7439.925600744004, 7457.888131678029, 7458.850822983537, 7460.738874139406, 7227.855442891139, 7324.230955749649, 7324.377427918634, 7325.560466372008, 7338.743143989961, 7318.341349278564, 7324.523905946123, 7364.447666425012, 7470.365018973366, 7491.550506969599, 7389.0, 7484.962575187116, 7496.0, 7499.6250187490405, 7505.774826755206, 7401.370883474911, 7408.740694075682, 7436.516626419266, 7455.105387353498, 7459.925400746031, 34283.82858085719, 34678.0, 34692.306153877034, 34727.826360868035, 35138.29723405518, 2611.3341098020073, 2615.7645811876832, 2638.274474519503, 2642.3262068172685, 2661.0686259808913, 23671.171508997104, 23883.402914927094, 24104.276871693877, 24176.274711758677, 24323.391915202086, 3027.8031927924612, 3035.920394529754, 3057.617797775278, 3074.4927087030615, 3109.409212249688, 110644.0, 113757.99999999917, 152522.23738881235, 153584.0, 154958.0, 36561.45157822635, 37053.81473092617, 37101.25797484089, 37190.256194875954, 37246.62753372486, 38643.227135457135, 38674.226515469534, 38751.0, 38888.41667374992, 38921.22157556833, 12531.0, 12553.811692824615, 12595.559155429515, 12612.55856045034, 12739.42672579736, 10572.89427105719, 10575.259731818698, 10582.523786429629, 10613.0, 10625.149988000941, 11678.474468648932, 11722.0, 11734.11994100446, 11788.115891308185, 11873.762524749629, 4944.0, 4997.275395067695, 5040.521150490697, 5073.264376665363, 5074.695518268915, 878.4597472554333, 904.8190361927641, 906.7687739626354, 908.2280061947424, 940.3793496292415, 20708.896455517624, 21669.34991950244, 21735.891320543295, 21811.67282490764, 21877.843209790088, 977.130353984954, 977.53567055648, 978.1343510992823, 985.482621623639, 1008.9091981721533, 11283.830742538868, 11283.830742538868, 11332.886671133349, 11392.25950313227, 11397.886021139848, 238170.0, 238829.0, 239167.0, 240219.0, 241738.0, 42583.78708106501, 42642.147157057305, 42657.57342426598, 42664.57335426606, 42688.14623707508, 1193.2303664136584, 1239.9690007749878, 1247.5508816825936, 1251.9687007824696, 1252.486480542973, 19606.705899411234, 19744.703829442282, 20764.273250436163, 22482.437939051655, 23776.52446951086, 35227.64772352244, 35372.46941295934, 35424.64575354317, 35558.866468012005, 35566.64433355633, 197357.0, 197380.0, 197520.0, 197774.0, 198091.0, 21877.343679689635, 22285.66571501396, 27141.557259846708, 27595.310117246427, 29086.0, 37658.8117059413, 38017.429738553394, 38248.42627360648, 38422.423663645626, 39380.2123957525, 28466.715332847234, 28851.5672264912, 29035.0, 29667.55498667565, 32789.67210327962, 27403.0, 29584.852075739484, 29735.553966690084, 32004.67995320017, 32208.35583288368, 33567.664323356454, 33765.15587110243, 34311.65688343085, 34612.134696632784, 34745.65254347424, 31262.843685781427, 31307.530387043756, 31420.52869206918, 31679.52480712745, 31814.04557863268, 24452.51094978126, 25146.0, 25340.74659253384, 25561.87219063967, 25627.0], "value": 15022.139456147941, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.854800819713, 415.6861569515016, 426.44349124392664, 433.20506869893734, 442.6547293111372, 17068.487945361645, 17795.110244487772, 17848.553786155353, 18003.90998045008, 18578.256869725195, 18249.635007299847, 18300.176492057857, 19428.611427771437, 19590.92249926257, 19683.80316196841, 5704.458076482748, 5738.340090889538, 5776.682282474462, 5797.449242321994, 5800.419958004208, 5306.946930530703, 5321.787128514855, 5328.280682107924, 5348.144296912495, 5351.304330437038, 5229.581633469333, 5664.971675141618, 5761.423857614247, 5788.97105514474, 5792.362840087587, 5651.463111004489, 5769.769209231626, 5778.59549831512, 5813.5349172066135, 5838.2994040715175, 5147.7683504242395, 5180.8963820723375, 5188.948110518922, 5227.529522342969, 5229.895402091937, 21940.561188776293, 22279.443013924618, 22700.545989080292, 22769.203077892194, 22777.31668049961, 1547.7833103365538, 1581.0, 1604.5346849413656, 1629.226117594145, 1648.3983346078594, 13887.58337249884, 14204.0, 14249.287535623178, 14497.855021449861, 14873.70252594942, 1524.9313780879777, 1581.2726145972865, 1622.513246026199, 1662.5926647971326, 1795.0845069014765, 74435.62782186054, 78276.60861695712, 78780.0, 94038.0, 96139.51930240305, 10976.176786741027, 11091.500882460308, 11167.162462815322, 11201.71995700114, 11335.263207891461, 14556.49052283165, 14568.125912445286, 14860.108393496208, 14894.627634309012, 14906.925465372604, 7809.3362064225175, 7826.882596761053, 7960.323372513401, 7967.880481792778, 8089.959550202211, 7408.185099639036, 7426.368758655467, 7497.625118744041, 7649.431866467361, 7659.119201291811, 6862.451003919675, 6952.965235173791, 6982.371586557234, 7030.929690703129, 7093.574385536885, 1979.8714732602277, 1992.4520756791708, 2003.4891102768702, 2045.78519255479, 2139.2940329691164, 826.0665448043673, 842.5618678287378, 843.6751850537587, 864.1358641358642, 871.7646235516502, 16582.668346633, 16674.333026678796, 17530.298788048334, 17846.732299015526, 17847.286108555512, 834.9332053435711, 836.6318819719426, 866.8049688819965, 873.5108339329995, 877.8156587116777, 9068.637254509878, 9115.863262051074, 9490.193333566585, 9594.459453408344, 9635.759106022406, 467830.0, 481677.0, 497240.0, 497899.0, 500720.0, 90875.54562227147, 92144.93202873772, 92154.53922730478, 92197.0, 93203.533982331, 1096.616184335492, 1113.3264375052977, 1142.8000099982469, 1143.279733767721, 1148.6955956671488, 14735.968482206143, 16274.349026038826, 17759.682659915943, 17885.642287154446, 18091.638167236317, 37929.43105853359, 38828.6117138825, 44251.778741106085, 45137.0, 45278.340207474066, 47749.76125119352, 48521.75739121282, 51573.7421312891, 51873.22190167075, 54164.72917635387, 7781.572013539083, 8002.1997800219515, 8087.63605637736, 8284.83430331402, 8577.914220857712, 12275.0, 13204.60386188416, 13253.60837112128, 13622.250776207404, 13740.244286563935, 10429.739256518647, 10781.838272426077, 10902.56389744433, 11199.944000279946, 11357.0914326852, 10249.0, 10396.480175991019, 10410.68767936963, 10464.00591943764, 10612.522436490222, 10984.286021408583, 11084.0, 11138.55445782192, 11154.888451115385, 11658.825117623073, 8134.837303253784, 8141.348692104499, 8271.503709777433, 8366.958165209135, 8520.105388934073, 10292.382457052601, 10358.0, 10644.946775266075, 10893.727656808644, 11131.220814542905], "value": 8971.79523650931, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1228.944697488613, 1277.195366918841, 1295.5983645070035, 1296.2416986063154, 1297.9351032448376, 9415.717528474148, 9533.14201721845, 9778.608855645765, 9800.754981125476, 9814.852777208338, 10154.49227538622, 10292.742681432968, 10294.279400441972, 10310.865804761488, 10327.793444131114, 2258.5821622999715, 2298.885055747214, 2306.769323067688, 2308.6306191009444, 2310.3761984264324, 1829.4054432309485, 1885.2835922349557, 2129.84026198035, 2168.6530155175174, 2192.6710993351044, 2225.5660146271484, 2262.7284725832924, 2263.0721404224273, 2263.219189379661, 2263.6151854184827, 2081.1779347157863, 2113.936581902545, 2121.8302535797097, 2134.9466263343384, 2137.6579747240444, 2064.7728749837506, 2073.3676228750223, 2092.9476763080893, 2094.979050209509, 2102.211670623516, 9867.0, 10047.246456515717, 10056.195504359634, 10095.949520252425, 10109.129810984992, 5239.083160446945, 5423.620346575742, 5441.646292990943, 5461.781528738846, 5470.589705772043, 3173.587433633613, 3239.64363919971, 3267.57521522203, 3267.9019629411155, 3315.0717799016315, 961.6441916490874, 970.752458123174, 974.3131092579714, 1026.8357062869904, 1046.8115739166947, 14759.557213283619, 14806.407743690239, 14883.255837208204, 14918.850811491855, 14932.402703891723, 4566.84016059443, 4651.558101980307, 4770.236762118045, 4793.760311984387, 4845.515448455127, 10733.195010374253, 10861.1854110942, 10900.0, 10931.070858976916, 10932.617358392417, 5439.177875411781, 5444.8094316698725, 5448.264484294648, 5458.344998600114, 5458.344998600193, 4699.0, 4934.9753251233515, 5048.268001139888, 5070.898582028339, 5118.641695081308, 3785.470034195215, 3823.4073718573663, 3860.82626281818, 3900.3759398496104, 3919.7452165609716, 964.5322018820866, 992.0129471176226, 1083.967480975572, 1104.3870651788175, 1122.085500317239, 693.5526585352419, 697.6686074114755, 699.1400577289962, 714.1465948191965, 721.1706537481938, 5171.172612382076, 5185.896282074337, 5267.578593712494, 6171.938280617226, 6252.187215661935, 808.4906508899473, 809.8015986083329, 811.1969150540922, 814.7881550796835, 840.7940054686519, 3529.8411571479346, 3579.910502237413, 3608.83760230785, 3633.109888077385, 3705.2959937611768, 12496.312702801433, 12949.417276222594, 13295.667608309675, 13312.201267923761, 13375.866241337462, 12984.675383115498, 13017.526669932682, 13107.0, 13141.277229752264, 13177.275249861157, 9408.670696525589, 9624.0, 9663.13031827139, 9704.175145112744, 9708.174805141502, 5685.232493613309, 5779.653220806765, 5784.855378615568, 5858.062709966385, 5977.671228082323, 11533.0, 11728.882711172779, 11734.589289374831, 11911.285322880654, 11993.34036627959, 12095.637130886087, 12141.0, 12150.57472988441, 12160.391980400767, 12209.938950305192, 7665.080190377191, 7778.222177782177, 7832.882506762289, 8015.719449819228, 8094.959525202336, 9392.154706076486, 9411.952940235255, 9443.338966272295, 9459.10138536838, 9471.289653275893, 8012.879806803019, 8020.839583208186, 8037.115917248981, 8068.757937261891, 8213.54825484604, 7383.778486645409, 7482.738104166328, 7510.699572017058, 7513.474056816189, 7543.170251272246, 7012.088428504262, 7038.718451262097, 7056.929430705627, 7117.4661900358715, 7117.928820711727, 5088.44027157005, 5125.513076257749, 5215.478452154754, 5224.869378265574, 5270.0, 4564.046934246286, 4579.633629309581, 4672.065586882569, 4723.385959825201, 4802.423709154924], "value": 4652.025224489565, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.9763614183149, 397.05698964958225, 400.7615468796067, 402.9758214507128, 409.66407545812444, 5532.585056120792, 5562.9986602411545, 5591.916121258179, 5594.517452874991, 5605.187247849065, 5301.204819277111, 5431.918521222185, 5469.097598896177, 5471.343438787351, 5526.640768350065, 4371.0, 4384.232759267132, 4410.228210063242, 4418.5197958683875, 4419.204543182226, 4407.0, 4427.845025424111, 4431.512533621315, 4433.9778301108445, 4438.844640437585, 4011.65900898424, 4205.978970105145, 4222.261104306734, 4395.340698895176, 4404.713693609921, 4202.243596152692, 4205.642520385741, 4207.978960105195, 4211.663066954637, 4219.0, 3700.8149592520267, 3709.7959612221316, 3719.4420836874683, 3726.105734623698, 3731.8320675569394, 5232.764525596357, 5339.813106541291, 5348.598855085884, 5366.812161574365, 5392.325959255093, 4874.2444921037295, 4882.705128589593, 4883.267509873512, 4894.339264199359, 4926.261060840867, 5757.251557297566, 5770.971145144289, 5778.8266352009505, 5794.8989691958395, 5802.506786923117, 3948.5261768587666, 4066.3290557058344, 4105.0, 4109.835606575733, 4124.876253712393, 5744.310682718059, 5899.082798090595, 6080.665563394012, 6124.5100391968535, 6138.877222455526, 4077.4903137107863, 4157.646600039031, 4158.521769996489, 4170.624643782014, 4188.6649068074485, 4226.2181496422645, 4230.428892099589, 4241.957580424218, 4243.108947121139, 4248.553901840324, 4639.744814035193, 4844.588210002119, 4849.345338379344, 4867.929055607831, 4874.317595536628, 5778.739956701958, 5785.103308987113, 5793.855153621109, 5802.448767367094, 5819.156222347736, 1447.334226255913, 1452.3537026023319, 1453.876420504269, 1455.9563213103625, 1463.5682473670292, 950.1828427552299, 989.6288891665625, 999.6101520407047, 999.9450030248406, 1001.6043662753171, 5080.441151473335, 5084.974575127175, 5089.440161582223, 5090.363704536933, 5098.133317336062, 5975.462208401264, 6014.218151640259, 6023.879522409527, 6041.758329666852, 6050.636961782219, 4931.3589233399425, 5044.066847633127, 5070.543651071347, 5083.399523431301, 5101.183810590288, 3175.4760464523556, 3199.52007198922, 3217.2761128746315, 3228.0, 3236.0615421527496, 5646.632968857011, 5648.293963254593, 5650.491455769001, 5650.773969041193, 5651.4348565143155, 5893.469587737039, 6118.309971726338, 6198.318184999646, 6201.441870231701, 6236.282827474898, 5623.240862483676, 5630.127330263816, 5642.463965923231, 5645.5483561314995, 5647.7176141193595, 5845.912311315419, 5994.610350327215, 5998.1002849572915, 6016.299975514939, 6064.575479716377, 5882.647041177543, 5922.615030023035, 5942.732577033958, 5953.642781433128, 5972.372900845348, 5306.8938621228135, 5459.754311056092, 5471.2887324647545, 5565.916511252415, 5623.100303951512, 4148.108156746314, 4178.080822219107, 4185.0, 4202.41166236721, 4207.368894665825, 5901.29184497863, 6024.819255422344, 6044.818655440344, 6055.969720151371, 6059.363766804422, 5754.395788442321, 5765.54067559461, 5768.134779783066, 5842.678652673973, 5860.2967643883, 5757.36668966405, 5782.913256301074, 5798.825440459827, 5808.854778630399, 5853.151293062568, 5597.768490931989, 5669.744861481161, 5708.65748055118, 5763.135529670583, 5766.106253530709, 5771.653700777967, 5782.566307527037, 5783.450572195635, 5792.8551786204, 5832.329282132439, 5618.129189975561, 5626.634268772516, 5634.4365563443325, 5648.039833228443, 5648.350439699487], "value": 4378.31572458875, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.1714394158835, 708.9610071446072, 711.7437722419929, 712.1525384792097, 720.9783706488807, 11592.710182245448, 12011.339376334297, 12025.579104731336, 12167.269963802179, 13224.73550528989, 12921.0, 13222.53721119761, 13271.867281327184, 13276.867231327684, 13588.796168057486, 628.9559730818844, 639.7089324357429, 865.3899001204136, 868.0711638546758, 871.6731225790329, 869.7955980344614, 869.8347314010349, 871.2289623683055, 877.719129878436, 881.6120906800987, 907.1744712311797, 907.773056735816, 908.3959167153868, 910.7586489580267, 913.3241401362977, 903.6882275614902, 905.5291248550717, 908.5457271364318, 910.7950711090018, 913.5340976102169, 663.8805015097281, 670.0752960913908, 670.1087553553762, 670.2928410526893, 671.5467059734659, 12829.807552886714, 12839.743205135845, 13053.738925221442, 13116.213027218302, 13189.604311870658, 10855.511501982352, 10879.510422031028, 11047.944760276147, 11145.554177832877, 11356.772864542745, 9154.954225228832, 9227.169554740105, 9227.26181905446, 9353.485558294291, 9411.482368469731, 2696.0833316672424, 2704.4185500117374, 2742.204760619418, 2752.6972033076345, 2785.6517935258094, 57190.428095718926, 57541.71229143869, 57821.421785782026, 58021.41978580203, 59714.10428843571, 8010.959945200237, 8074.555899425588, 8130.227628375294, 8216.34269258458, 9906.405615663083, 19478.513037174183, 19694.606107877764, 20607.587848243253, 20610.793892060887, 20686.379408617766, 6357.904631430532, 6496.805095847132, 6515.185601799775, 6557.2131344239, 6821.317868213139, 3302.6036875575087, 3323.2356557991316, 3327.5341452196712, 3330.8667653294083, 3369.427197376452, 3226.3224722808004, 3248.2529018325445, 3266.248762784573, 3291.0949488890747, 3322.551455553518, 577.8988676981511, 579.3974266762519, 589.3399392680226, 596.2576592142723, 598.4261392537685, 488.67991465589387, 493.8444390017133, 495.4228324002569, 505.11352576228484, 506.6250974279007, 8504.277136443348, 8557.786055348666, 8752.47485150893, 8765.027868729612, 8805.471671699719, 471.2789432168787, 481.1675800864524, 500.3170672032649, 515.5488947171225, 518.1554066870976, 4279.40088387626, 4589.563991420877, 4699.412573428322, 4780.904381912412, 4808.206645903457, 57967.420325797044, 58098.419015809304, 58570.707146463996, 60178.39821601728, 60565.394346056855, 53865.0, 54031.72984135054, 54319.72840135774, 54463.18305225425, 56322.43677563172, 48175.036499269816, 48361.0, 48386.51613483891, 48568.75715621399, 49655.25517117246, 9052.592633331647, 9454.763630909007, 9457.716268511957, 9479.478628675213, 9521.761955951157, 24258.636120457853, 24398.512029759662, 25098.74901250964, 25412.364690882874, 25513.362165946, 29129.0, 30362.0, 30575.08274751761, 30585.694143058285, 31358.216044599067, 11998.460069297078, 12237.75524489523, 12358.196717213352, 12402.25586464815, 12467.87532124667, 12529.18560293578, 12872.35638218104, 13027.283499407624, 13119.27843968591, 13636.727265454834, 12255.632331030083, 12263.69340766488, 12600.87399125997, 13192.736145277233, 13199.274039927896, 12225.877741222474, 12288.447019884305, 12337.629871103882, 12369.072319575887, 13512.93243533776, 12378.75242495163, 12447.439865205906, 12632.462910385108, 13141.080124391583, 13466.730665386442, 8199.42604017713, 8338.374621903502, 9022.639094436148, 9109.635614575607, 9256.496859456336, 9519.381240219363, 10509.684709458728, 10745.0, 10759.784804304027, 10974.615888443866], "value": 6129.717155804645, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1568.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 111.0, 112.0, 111.0, 112.0, 114.0, 113.0, 115.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 129.0, 125.0, 173.0, 125.0, 142.0, 126.0, 126.0, 143.0, 127.0], "value": 137.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 166.0, 172.0, 168.0, 169.0, 163.0, 163.0, 165.0, 165.0], "value": 166.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 111.0, 76.0, 75.0, 75.0, 81.0, 101.0, 77.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 110.0, 86.0, 84.0, 84.0, 105.0, 84.0, 85.0, 110.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 116.0, 115.0, 114.0, 115.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 151.0, 150.0, 150.0, 150.0, 149.0, 151.0, 152.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 70.0, 69.0, 72.0, 78.0, 71.0, 68.0, 70.0, 70.0], "value": 70.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 55.0, 57.0, 57.0, 56.0, 55.0, 59.0, 56.0, 55.0], "value": 56.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 82.0, 81.0, 83.0, 82.0, 80.0, 82.0, 83.0, 82.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 142.0, 139.0, 135.0, 141.0, 147.0, 132.0, 178.0, 133.0], "value": 142.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 191.0, 195.0, 199.0, 197.0, 207.0, 197.0, 195.0, 192.0, 202.0], "value": 196.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 72.0, 70.0, 70.0, 73.0, 74.0, 70.0, 72.0, 69.0], "value": 71.4, "unit": "score"}]}]} 07:11:53 INFO - Return code: 0 07:11:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:11:54 ERROR - # TBPL SUCCESS # 07:11:54 INFO - Running post-action listener: _resource_record_post_action 07:11:54 INFO - [mozharness: 2017-03-24 14:11:54.006724Z] Finished run-tests step (success) 07:11:54 INFO - Running post-run listener: _resource_record_post_run 07:11:54 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 365928448; Read time: 152; Write time: 224756 07:11:54 INFO - TinderboxPrint: CPU usage
13.3% 07:11:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 152 07:11:54 INFO - TinderboxPrint: I/O write bytes / time
365,928,448 / 224,756 07:11:54 INFO - TinderboxPrint: CPU idle
8,316.2 (86.7%) 07:11:54 INFO - TinderboxPrint: CPU user
1,218.4 (12.7%) 07:11:54 INFO - TinderboxPrint: Swap in / out
0 / 0 07:11:54 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106237952; Read time: 0; Write time: 91964 07:11:54 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 257380352; Read time: 152; Write time: 132600 07:11:54 INFO - Running post-run listener: _upload_blobber_files 07:11:54 INFO - Blob upload gear active. 07:11:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:11:54 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 07:11:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:11:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:11:55 INFO - (blobuploader) - INFO - Open directory for files ... 07:11:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:11:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:11:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:56 INFO - (blobuploader) - INFO - Done attempting. 07:11:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:11:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:11:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:56 INFO - (blobuploader) - INFO - Done attempting. 07:11:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:11:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:11:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:57 INFO - (blobuploader) - INFO - Done attempting. 07:11:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:11:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:12:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:12:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:12:01 INFO - (blobuploader) - INFO - Done attempting. 07:12:01 INFO - (blobuploader) - INFO - Iteration through files over. 07:12:01 INFO - Return code: 0 07:12:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:12:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:12:01 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f321bdfb57982b63a817ac6edafcc98125c1cd97e996f00b7eebdc357de29ae721f312da26e093558a654f08122c3258164be934d431313ac6e192c9b04f4b5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8057b7366e35b98bf5ea6ec17c5efb8a6b27510fad82e903841103a4dbac4d4c403d731b089574dd5f184405cea8edd8cae3ab8a3a968f73af531ee80eb59b66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a1e8d52920942ee37f86d4d194e651acc6199a504d068ddaf1a73cefd5f32c3fecadeded12a59244151575801f3bbd6f2a50ba77f7ce0cf780b48dbab2bce81", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c47047dda8bb9f4ca292f38460514ef9447a724c3bb6c429234d25023a87fc88dc9b1e65eed05f530c0d82d2ec2cd3312f2e8bbd3848b57a4a846668818b1b27"} 07:12:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:12:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:12:01 INFO - Contents: 07:12:01 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f321bdfb57982b63a817ac6edafcc98125c1cd97e996f00b7eebdc357de29ae721f312da26e093558a654f08122c3258164be934d431313ac6e192c9b04f4b5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8057b7366e35b98bf5ea6ec17c5efb8a6b27510fad82e903841103a4dbac4d4c403d731b089574dd5f184405cea8edd8cae3ab8a3a968f73af531ee80eb59b66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a1e8d52920942ee37f86d4d194e651acc6199a504d068ddaf1a73cefd5f32c3fecadeded12a59244151575801f3bbd6f2a50ba77f7ce0cf780b48dbab2bce81", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c47047dda8bb9f4ca292f38460514ef9447a724c3bb6c429234d25023a87fc88dc9b1e65eed05f530c0d82d2ec2cd3312f2e8bbd3848b57a4a846668818b1b27"} 07:12:01 INFO - Running post-run listener: copy_logs_to_upload_dir 07:12:01 INFO - Copying logs to upload dir... 07:12:01 INFO - mkdir: /builds/slave/test/build/upload/logs 07:12:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.688293 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-03-24 07:12:01.100451) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 07:12:01.106093) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f321bdfb57982b63a817ac6edafcc98125c1cd97e996f00b7eebdc357de29ae721f312da26e093558a654f08122c3258164be934d431313ac6e192c9b04f4b5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8057b7366e35b98bf5ea6ec17c5efb8a6b27510fad82e903841103a4dbac4d4c403d731b089574dd5f184405cea8edd8cae3ab8a3a968f73af531ee80eb59b66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a1e8d52920942ee37f86d4d194e651acc6199a504d068ddaf1a73cefd5f32c3fecadeded12a59244151575801f3bbd6f2a50ba77f7ce0cf780b48dbab2bce81", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c47047dda8bb9f4ca292f38460514ef9447a724c3bb6c429234d25023a87fc88dc9b1e65eed05f530c0d82d2ec2cd3312f2e8bbd3848b57a4a846668818b1b27"} build_url:https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011191 build_url: 'https://queue.taskcluster.net/v1/task/fZyHGIfwQ3ybGU91vAd-Lw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f321bdfb57982b63a817ac6edafcc98125c1cd97e996f00b7eebdc357de29ae721f312da26e093558a654f08122c3258164be934d431313ac6e192c9b04f4b5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8057b7366e35b98bf5ea6ec17c5efb8a6b27510fad82e903841103a4dbac4d4c403d731b089574dd5f184405cea8edd8cae3ab8a3a968f73af531ee80eb59b66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a1e8d52920942ee37f86d4d194e651acc6199a504d068ddaf1a73cefd5f32c3fecadeded12a59244151575801f3bbd6f2a50ba77f7ce0cf780b48dbab2bce81", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c47047dda8bb9f4ca292f38460514ef9447a724c3bb6c429234d25023a87fc88dc9b1e65eed05f530c0d82d2ec2cd3312f2e8bbd3848b57a4a846668818b1b27"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 07:12:01.131153) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 07:12:01.131472) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1490363421.943565-567013501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 07:12:01.217703) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 07:12:01.218078) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 07:12:01.218358) ========= ========= Total master_lag: 0.17 =========