builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-070 starttime: 1492678046.47 results: success (0) revision: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-20 01:47:26.470505) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-20 01:47:26.471465) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-20 01:47:26.472089) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-20 01:47:26.492515) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 01:47:26.492956) ========= 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=2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-20 01:47:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 54.1M=0s 2017-04-20 01:47:27 (54.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126560 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 01:47:26.637688) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 01:47:26.638372) ========= 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=2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014770 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 01:47:26.692319) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 01:47:26.693020) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 --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=2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-20 01:47:27,576 truncating revision to first 12 chars 2017-04-20 01:47:27,576 Setting DEBUG logging. 2017-04-20 01:47:27,576 attempt 1/10 2017-04-20 01:47:27,576 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/94b7e538af7d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-20 01:47:27,916 unpacking tar archive at: mozilla-aurora-94b7e538af7d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.712625 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 01:47:27.425188) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-20 01:47:27.426046) ========= script_repo_revision: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-20 01:47:27.427032) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-20 01:47:27.427826) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-20 01:47:27.442611) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-04-20 01:47:27.443391) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-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=2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:47:28 INFO - MultiFileLogger online at 20170420 01:47:28 in /builds/slave/test 01:47:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 01:47:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:47:28 INFO - {'append_to_log': False, 01:47:28 INFO - 'base_work_dir': '/builds/slave/test', 01:47:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 01:47:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:47:28 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 01:47:28 INFO - 'buildbot_json_path': 'buildprops.json', 01:47:28 INFO - 'config_files': ('talos/linux_config.py',), 01:47:28 INFO - 'default_actions': ('clobber', 01:47:28 INFO - 'read-buildbot-config', 01:47:28 INFO - 'download-and-extract', 01:47:28 INFO - 'populate-webroot', 01:47:28 INFO - 'create-virtualenv', 01:47:28 INFO - 'install', 01:47:28 INFO - 'run-tests'), 01:47:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:47:28 INFO - 'download_minidump_stackwalk': True, 01:47:28 INFO - 'download_symbols': 'ondemand', 01:47:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:47:28 INFO - 'tooltool.py': '/tools/tooltool.py', 01:47:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:47:28 INFO - '/tools/misc-python/virtualenv.py')}, 01:47:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:47:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:47:28 INFO - 'gecko_profile': False, 01:47:28 INFO - 'gecko_profile_interval': 0, 01:47:28 INFO - 'installer_path': 'installer.exe', 01:47:28 INFO - 'log_level': 'info', 01:47:28 INFO - 'log_name': 'talos', 01:47:28 INFO - 'log_to_console': True, 01:47:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:47:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:47:28 INFO - 'opt_config_files': (), 01:47:28 INFO - 'pip_index': False, 01:47:28 INFO - 'suite': 'dromaeojs', 01:47:28 INFO - 'system_bits': '32', 01:47:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:47:28 INFO - 'title': 'talos-linux64-ix-070', 01:47:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:47:28 INFO - 'use_talos_json': True, 01:47:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:47:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:47:28 INFO - 'work_dir': 'build'} 01:47:28 INFO - [mozharness: 2017-04-20 08:47:28.431232Z] Running clobber step. 01:47:28 INFO - Running pre-action listener: _resource_record_pre_action 01:47:28 INFO - Running main action method: clobber 01:47:28 INFO - rmtree: /builds/slave/test/build 01:47:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:47:29 INFO - Running post-action listener: _resource_record_post_action 01:47:29 INFO - [mozharness: 2017-04-20 08:47:29.874038Z] Finished clobber step (success) 01:47:29 INFO - [mozharness: 2017-04-20 08:47:29.874135Z] Running read-buildbot-config step. 01:47:29 INFO - Running pre-action listener: _resource_record_pre_action 01:47:29 INFO - Running main action method: read_buildbot_config 01:47:29 INFO - Using buildbot properties: 01:47:29 INFO - { 01:47:29 INFO - "project": "", 01:47:29 INFO - "product": "firefox", 01:47:29 INFO - "who": "nobody@mozilla.org", 01:47:29 INFO - "installer_path": "public/build/target.tar.bz2", 01:47:29 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:47:29 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora", 01:47:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 01:47:29 INFO - "stage_platform": "linux64", 01:47:29 INFO - "basedir": "/builds/slave/test", 01:47:29 INFO - "buildnumber": 133, 01:47:29 INFO - "platform": "ubuntu64_hw", 01:47:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:47:29 INFO - "slavebuilddir": "test", 01:47:29 INFO - "taskId": "D4dTR2XmS921suasVqRO-A", 01:47:29 INFO - "branch": "mozilla-aurora", 01:47:29 INFO - "script_repo_revision": "production", 01:47:29 INFO - "revision": "94b7e538af7dbb9a6567cad9125c2f5411e7fb80", 01:47:29 INFO - "slavename": "talos-linux64-ix-070", 01:47:29 INFO - "repo_path": "releases/mozilla-aurora" 01:47:29 INFO - } 01:47:29 INFO - Finding installer, test and symbols from parent task. 01:47:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D4dTR2XmS921suasVqRO-A'}, attempt #1 01:47:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D4dTR2XmS921suasVqRO-A'}, attempt #1 01:47:30 INFO - Task dependencies: Ji1ivWJTQOGswYLN_Sllpw 01:47:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw'}, attempt #1 01:47:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/target.tar.bz2 01:47:31 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/test_packages.json 01:47:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/target.crashreporter-symbols.zip 01:47:31 INFO - Running post-action listener: _resource_record_post_action 01:47:31 INFO - [mozharness: 2017-04-20 08:47:31.227327Z] Finished read-buildbot-config step (success) 01:47:31 INFO - [mozharness: 2017-04-20 08:47:31.227544Z] Running download-and-extract step. 01:47:31 INFO - Running pre-action listener: _resource_record_pre_action 01:47:31 INFO - Running main action method: download_and_extract 01:47:31 INFO - mkdir: /builds/slave/test/build/tests 01:47: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')]} 01:47:31 INFO - trying https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/target.test_packages.json 01:47:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:47:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:47:31 INFO - Downloaded 896 bytes. 01:47:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:47:31 INFO - Using the following test package requirements: 01:47:31 INFO - {u'common': [u'target.common.tests.zip'], 01:47:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:47:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:47:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:47:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:47:31 INFO - u'mozbase': [u'target.common.tests.zip'], 01:47:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:47:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:47:31 INFO - u'web-platform': [u'target.common.tests.zip', 01:47:31 INFO - u'target.web-platform.tests.zip'], 01:47:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:47:31 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 01:47:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/target.common.tests.zip 01:47:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:47:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/target.common.tests.zip into memory 01:47:33 INFO - Expected file size: 59542047 01:47:33 INFO - Obtained file size: 59542047 01:47:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 01:47:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/target.common.tests.zip 01:47:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:47:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/target.common.tests.zip into memory 01:47:44 INFO - Expected file size: 59542047 01:47:44 INFO - Obtained file size: 59542047 01:47:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/target.talos.tests.zip 01:47:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:47:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/target.talos.tests.zip into memory 01:47:56 INFO - Expected file size: 14404424 01:47:56 INFO - Obtained file size: 14404424 01:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:47:56 INFO - trying https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/target.tar.bz2 01:47:56 INFO - Downloading https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:47:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:47:58 INFO - Downloaded 66663419 bytes. 01:47:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/target.tar.bz2 01:47:58 INFO - mkdir: /builds/slave/test/properties 01:47:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:47:58 INFO - Writing to file /builds/slave/test/properties/build_url 01:47:58 INFO - Contents: 01:47:58 INFO - build_url:https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/target.tar.bz2 01:47:58 INFO - Running post-action listener: _resource_record_post_action 01:47:58 INFO - Running post-action listener: set_extra_try_arguments 01:47:58 INFO - [mozharness: 2017-04-20 08:47:58.872891Z] Finished download-and-extract step (success) 01:47:58 INFO - [mozharness: 2017-04-20 08:47:58.873116Z] Running populate-webroot step. 01:47:58 INFO - Running pre-action listener: _resource_record_pre_action 01:47:58 INFO - Running main action method: populate_webroot 01:47:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:47:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:47:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:47:58 INFO - '--tppagecycles', 01:47:58 INFO - '7'], 01:47:58 INFO - 'tests': ['tsvgm']}}, 01:47:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:47:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:47:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:47:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:47:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:47:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:47:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:47:58 INFO - 'talos_options': ['--disable-e10s'], 01:47:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:47:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:47:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:47:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:47:58 INFO - 'talos_options': ['--disable-e10s'], 01:47:58 INFO - 'tests': ['damp', 'tps']}, 01:47:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:47:58 INFO - 'tests': ['damp', 'tps']}, 01:47:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:47:58 INFO - 'tests': ['dromaeo_dom']}, 01:47:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:47:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:47:58 INFO - 'tests': ['basic_compositor_video']}, 01:47:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:47:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:47:58 INFO - 'tests': ['a11yr', 01:47:58 INFO - 'ts_paint', 01:47:58 INFO - 'tpaint', 01:47:58 INFO - 'sessionrestore', 01:47:58 INFO - 'sessionrestore_no_auto_restore', 01:47:58 INFO - 'tabpaint']}, 01:47:58 INFO - 'other-e10s': {'tests': ['a11yr', 01:47:58 INFO - 'ts_paint', 01:47:58 INFO - 'tpaint', 01:47:58 INFO - 'sessionrestore', 01:47:58 INFO - 'sessionrestore_no_auto_restore', 01:47:58 INFO - 'tabpaint']}, 01:47:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:47:58 INFO - 'ts_paint', 01:47:58 INFO - 'tpaint', 01:47:58 INFO - 'sessionrestore', 01:47:58 INFO - 'sessionrestore_no_auto_restore', 01:47:58 INFO - 'tabpaint']}, 01:47:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:47:58 INFO - 'ts_paint', 01:47:58 INFO - 'tpaint', 01:47:58 INFO - 'sessionrestore', 01:47:58 INFO - 'sessionrestore_no_auto_restore', 01:47:58 INFO - 'tabpaint']}, 01:47:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:47:58 INFO - 'tests': ['a11yr', 01:47:58 INFO - 'ts_paint', 01:47:58 INFO - 'tpaint', 01:47:58 INFO - 'sessionrestore', 01:47:58 INFO - 'sessionrestore_no_auto_restore', 01:47:58 INFO - 'tabpaint']}, 01:47:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:47:58 INFO - 'tests': ['a11yr', 01:47:58 INFO - 'ts_paint', 01:47:58 INFO - 'tpaint', 01:47:58 INFO - 'sessionrestore', 01:47:58 INFO - 'sessionrestore_no_auto_restore', 01:47:58 INFO - 'tabpaint']}, 01:47:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:47:58 INFO - 'tests': ['tsvgx', 01:47:58 INFO - 'tsvgr_opacity', 01:47:58 INFO - 'tart', 01:47:58 INFO - 'tscrollx', 01:47:58 INFO - 'cart', 01:47:58 INFO - 'tsvg_static']}, 01:47:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:47:58 INFO - 'tsvgr_opacity', 01:47:58 INFO - 'tart', 01:47:58 INFO - 'tscrollx', 01:47:58 INFO - 'cart', 01:47:58 INFO - 'tsvg_static']}, 01:47:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:47:58 INFO - 'talos_options': ['--disable-e10s'], 01:47:58 INFO - 'tests': ['tp5o']}, 01:47:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:47:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:47:58 INFO - 'talos_options': ['--disable-e10s', 01:47:58 INFO - '--xperf_path', 01:47:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:47:58 INFO - 'tests': ['tp5n']}, 01:47:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:47:58 INFO - 'talos_options': ['--xperf_path', 01:47:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:47:58 INFO - 'tests': ['tp5n']}}, 01:47:58 INFO - 'talos.zip': {'path': '', 01:47:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:47:58 INFO - Running post-action listener: _resource_record_post_action 01:47:58 INFO - [mozharness: 2017-04-20 08:47:58.893029Z] Finished populate-webroot step (success) 01:47:58 INFO - [mozharness: 2017-04-20 08:47:58.893118Z] Running create-virtualenv step. 01:47:58 INFO - Running pre-action listener: _resource_record_pre_action 01:47:58 INFO - Running main action method: create_virtualenv 01:47:58 INFO - Creating virtualenv /builds/slave/test/build/venv 01:47:58 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 01:47:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:47:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:47:58 INFO - Using real prefix '/usr' 01:47:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:47:59 INFO - Installing distribute.............................................................................................................................................................................................done. 01:48:01 INFO - Installing pip.................done. 01:48:01 INFO - Return code: 0 01:48:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:48:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:48:01 INFO - Reading from file tmpfile_stdout 01:48:01 INFO - Output received: 01:48:01 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) 01:48:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bc310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b9400>, '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 0x21ba3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ba840>, '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': '2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990', '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 01:48:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:48:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:48:01 INFO - Using env: {'DISPLAY': ':0', 01:48:01 INFO - 'HOME': '/home/cltbld', 01:48:01 INFO - 'LANG': 'en_US.UTF-8', 01:48:01 INFO - 'LANGUAGE': 'en_US:en', 01:48:01 INFO - 'LOGNAME': 'cltbld', 01:48:01 INFO - 'MAIL': '/var/mail/cltbld', 01:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:01 INFO - 'MOZ_NO_REMOTE': '1', 01:48:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:01 INFO - 'NO_EM_RESTART': '1', 01:48:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:01 INFO - 'PWD': '/builds/slave/test', 01:48:01 INFO - 'SHELL': '/bin/bash', 01:48:01 INFO - 'SHLVL': '1', 01:48:01 INFO - 'TERM': 'linux', 01:48:01 INFO - 'TMOUT': '86400', 01:48:01 INFO - 'USER': 'cltbld', 01:48:01 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990', 01:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:01 INFO - '_': '/tools/buildbot/bin/python'} 01:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:01 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 01:48:01 INFO - Cleaning up... 01:48:01 INFO - Return code: 0 01:48:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f1e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bc310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b9400>, '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 0x21ba3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ba840>, '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': '2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990', '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 01:48:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:48:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:48:01 INFO - Using env: {'DISPLAY': ':0', 01:48:01 INFO - 'HOME': '/home/cltbld', 01:48:01 INFO - 'LANG': 'en_US.UTF-8', 01:48:01 INFO - 'LANGUAGE': 'en_US:en', 01:48:01 INFO - 'LOGNAME': 'cltbld', 01:48:01 INFO - 'MAIL': '/var/mail/cltbld', 01:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:01 INFO - 'MOZ_NO_REMOTE': '1', 01:48:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:01 INFO - 'NO_EM_RESTART': '1', 01:48:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:01 INFO - 'PWD': '/builds/slave/test', 01:48:01 INFO - 'SHELL': '/bin/bash', 01:48:01 INFO - 'SHLVL': '1', 01:48:01 INFO - 'TERM': 'linux', 01:48:01 INFO - 'TMOUT': '86400', 01:48:01 INFO - 'USER': 'cltbld', 01:48:01 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990', 01:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:01 INFO - '_': '/tools/buildbot/bin/python'} 01:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:02 INFO - Downloading/unpacking psutil>=3.1.1 01:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:48:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:48:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:48:04 INFO - Installing collected packages: psutil 01:48:04 INFO - Running setup.py install for psutil 01:48:04 INFO - building 'psutil._psutil_linux' extension 01:48:04 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 01:48:04 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 01:48:04 INFO - building 'psutil._psutil_posix' extension 01:48:04 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 01:48:04 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 01:48:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:48:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:48:04 INFO - Successfully installed psutil 01:48:04 INFO - Cleaning up... 01:48:04 INFO - Return code: 0 01:48:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:48:04 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')]} 01:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:04 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')]} 01:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:04 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 0x1f1e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bc310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b9400>, '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 0x21ba3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ba840>, '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': '2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990', '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 01:48:04 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 01:48:04 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 01:48:04 INFO - Using env: {'DISPLAY': ':0', 01:48:04 INFO - 'HOME': '/home/cltbld', 01:48:04 INFO - 'LANG': 'en_US.UTF-8', 01:48:04 INFO - 'LANGUAGE': 'en_US:en', 01:48:04 INFO - 'LOGNAME': 'cltbld', 01:48:04 INFO - 'MAIL': '/var/mail/cltbld', 01:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:04 INFO - 'MOZ_NO_REMOTE': '1', 01:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:04 INFO - 'NO_EM_RESTART': '1', 01:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:04 INFO - 'PWD': '/builds/slave/test', 01:48:04 INFO - 'SHELL': '/bin/bash', 01:48:04 INFO - 'SHLVL': '1', 01:48:04 INFO - 'TERM': 'linux', 01:48:04 INFO - 'TMOUT': '86400', 01:48:04 INFO - 'USER': 'cltbld', 01:48:04 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990', 01:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:04 INFO - '_': '/tools/buildbot/bin/python'} 01:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:48:07 INFO - Installing collected packages: mozsystemmonitor 01:48:07 INFO - Running setup.py install for mozsystemmonitor 01:48:07 INFO - Successfully installed mozsystemmonitor 01:48:07 INFO - Cleaning up... 01:48:07 INFO - Return code: 0 01:48:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:48: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')]} 01:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48: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')]} 01:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1f1e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bc310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b9400>, '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 0x21ba3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ba840>, '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': '2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990', '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 01:48:07 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 01:48:07 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 01:48:07 INFO - Using env: {'DISPLAY': ':0', 01:48:07 INFO - 'HOME': '/home/cltbld', 01:48:07 INFO - 'LANG': 'en_US.UTF-8', 01:48:07 INFO - 'LANGUAGE': 'en_US:en', 01:48:07 INFO - 'LOGNAME': 'cltbld', 01:48:07 INFO - 'MAIL': '/var/mail/cltbld', 01:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:07 INFO - 'MOZ_NO_REMOTE': '1', 01:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:07 INFO - 'NO_EM_RESTART': '1', 01:48:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:07 INFO - 'PWD': '/builds/slave/test', 01:48:07 INFO - 'SHELL': '/bin/bash', 01:48:07 INFO - 'SHLVL': '1', 01:48:07 INFO - 'TERM': 'linux', 01:48:07 INFO - 'TMOUT': '86400', 01:48:07 INFO - 'USER': 'cltbld', 01:48:07 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990', 01:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:07 INFO - '_': '/tools/buildbot/bin/python'} 01:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:07 INFO - Downloading/unpacking jsonschema==2.5.1 01:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:07 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 01:48:07 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 01:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:48:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:09 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 01:48:09 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 01:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:09 INFO - Downloading functools32-3.2.3-2.tar.gz 01:48:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:48:09 INFO - warning: no files found matching '*.txt' 01:48:09 INFO - no previously-included directories found matching 'build' 01:48:09 INFO - no previously-included directories found matching 'dist' 01:48:09 INFO - no previously-included directories found matching '.git*' 01:48:09 INFO - Installing collected packages: jsonschema, functools32 01:48:09 INFO - Running setup.py install for functools32 01:48:09 INFO - warning: no files found matching '*.txt' 01:48:09 INFO - no previously-included directories found matching 'build' 01:48:09 INFO - no previously-included directories found matching 'dist' 01:48:09 INFO - no previously-included directories found matching '.git*' 01:48:09 INFO - Successfully installed jsonschema functools32 01:48:09 INFO - Cleaning up... 01:48:09 INFO - Return code: 0 01:48:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:48:09 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')]} 01:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:09 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')]} 01:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1f1e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bc310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b9400>, '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 0x21ba3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ba840>, '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': '2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990', '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 01:48:09 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 01:48:09 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 01:48:09 INFO - Using env: {'DISPLAY': ':0', 01:48:09 INFO - 'HOME': '/home/cltbld', 01:48:09 INFO - 'LANG': 'en_US.UTF-8', 01:48:09 INFO - 'LANGUAGE': 'en_US:en', 01:48:09 INFO - 'LOGNAME': 'cltbld', 01:48:09 INFO - 'MAIL': '/var/mail/cltbld', 01:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:09 INFO - 'MOZ_NO_REMOTE': '1', 01:48:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:09 INFO - 'NO_EM_RESTART': '1', 01:48:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:09 INFO - 'PWD': '/builds/slave/test', 01:48:09 INFO - 'SHELL': '/bin/bash', 01:48:09 INFO - 'SHLVL': '1', 01:48:09 INFO - 'TERM': 'linux', 01:48:09 INFO - 'TMOUT': '86400', 01:48:09 INFO - 'USER': 'cltbld', 01:48:09 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990', 01:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:09 INFO - '_': '/tools/buildbot/bin/python'} 01:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:48:10 INFO - Cleaning up... 01:48:10 INFO - Return code: 0 01:48:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:48:10 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')]} 01:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:10 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')]} 01:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1f1e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bc310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b9400>, '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 0x21ba3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ba840>, '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': '2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990', '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 01:48:10 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 01:48:10 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 01:48:10 INFO - Using env: {'DISPLAY': ':0', 01:48:10 INFO - 'HOME': '/home/cltbld', 01:48:10 INFO - 'LANG': 'en_US.UTF-8', 01:48:10 INFO - 'LANGUAGE': 'en_US:en', 01:48:10 INFO - 'LOGNAME': 'cltbld', 01:48:10 INFO - 'MAIL': '/var/mail/cltbld', 01:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:10 INFO - 'MOZ_NO_REMOTE': '1', 01:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:10 INFO - 'NO_EM_RESTART': '1', 01:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:10 INFO - 'PWD': '/builds/slave/test', 01:48:10 INFO - 'SHELL': '/bin/bash', 01:48:10 INFO - 'SHLVL': '1', 01:48:10 INFO - 'TERM': 'linux', 01:48:10 INFO - 'TMOUT': '86400', 01:48:10 INFO - 'USER': 'cltbld', 01:48:10 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990', 01:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:10 INFO - '_': '/tools/buildbot/bin/python'} 01:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:10 INFO - Downloading/unpacking blobuploader==1.2.4 01:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:12 INFO - Downloading blobuploader-1.2.4.tar.gz 01:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:48:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:12 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 01:48:12 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 01:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:48:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:12 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 01:48:12 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 01:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:13 INFO - Downloading docopt-0.6.1.tar.gz 01:48:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:48:13 INFO - Installing collected packages: blobuploader, requests, docopt 01:48:13 INFO - Running setup.py install for blobuploader 01:48:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:48:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:48:13 INFO - Running setup.py install for requests 01:48:13 INFO - Running setup.py install for docopt 01:48:13 INFO - Successfully installed blobuploader requests docopt 01:48:13 INFO - Cleaning up... 01:48:13 INFO - Return code: 0 01:48:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:48:13 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')]} 01:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:13 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')]} 01:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1f1e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bc310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b9400>, '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 0x21ba3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ba840>, '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': '2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990', '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 01:48:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 01:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.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 01:48:13 INFO - Using env: {'DISPLAY': ':0', 01:48:13 INFO - 'HOME': '/home/cltbld', 01:48:13 INFO - 'LANG': 'en_US.UTF-8', 01:48:13 INFO - 'LANGUAGE': 'en_US:en', 01:48:13 INFO - 'LOGNAME': 'cltbld', 01:48:13 INFO - 'MAIL': '/var/mail/cltbld', 01:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:13 INFO - 'MOZ_NO_REMOTE': '1', 01:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:13 INFO - 'NO_EM_RESTART': '1', 01:48:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:13 INFO - 'PWD': '/builds/slave/test', 01:48:13 INFO - 'SHELL': '/bin/bash', 01:48:13 INFO - 'SHLVL': '1', 01:48:13 INFO - 'TERM': 'linux', 01:48:13 INFO - 'TMOUT': '86400', 01:48:13 INFO - 'USER': 'cltbld', 01:48:13 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990', 01:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:13 INFO - '_': '/tools/buildbot/bin/python'} 01:48:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:48:14 INFO - Running setup.py (path:/tmp/pip-5ksMBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:48:14 INFO - Running setup.py (path:/tmp/pip-QnWI8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:48:14 INFO - Running setup.py (path:/tmp/pip-lFxkhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:48:14 INFO - Running setup.py (path:/tmp/pip-bbB9xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:48:14 INFO - Running setup.py (path:/tmp/pip-JpvYGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:48:14 INFO - Running setup.py (path:/tmp/pip-zCBMch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:48:14 INFO - Running setup.py (path:/tmp/pip-pAMWdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:48:14 INFO - Running setup.py (path:/tmp/pip-SbRhWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:48:14 INFO - Running setup.py (path:/tmp/pip-prluY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:48:14 INFO - Running setup.py (path:/tmp/pip-xQfuAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:48:14 INFO - Running setup.py (path:/tmp/pip-ufvM3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:48:14 INFO - Running setup.py (path:/tmp/pip-wAoYFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:48:14 INFO - Running setup.py (path:/tmp/pip-bLZN1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:48:15 INFO - Running setup.py (path:/tmp/pip-r1VP2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:48:15 INFO - Running setup.py (path:/tmp/pip-LRpj11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:48:15 INFO - Running setup.py (path:/tmp/pip-8Mn0AK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:48:15 INFO - Running setup.py (path:/tmp/pip-Bdd5Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:48:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:48:15 INFO - Running setup.py install for manifestparser 01:48:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:48:15 INFO - Running setup.py install for mozcrash 01:48:15 INFO - Running setup.py install for mozdebug 01:48:15 INFO - Running setup.py install for mozdevice 01:48:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:48:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:48:15 INFO - Running setup.py install for mozfile 01:48:15 INFO - Running setup.py install for mozhttpd 01:48:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:48:15 INFO - Running setup.py install for mozinfo 01:48:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:48:16 INFO - Running setup.py install for mozInstall 01:48:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:48:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:48:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:48:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:48:16 INFO - Running setup.py install for mozleak 01:48:16 INFO - Running setup.py install for mozlog 01:48:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:48:16 INFO - Running setup.py install for moznetwork 01:48:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:48:16 INFO - Running setup.py install for mozprocess 01:48:16 INFO - Running setup.py install for mozprofile 01:48:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:48:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:48:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:48:16 INFO - Running setup.py install for mozrunner 01:48:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:48:16 INFO - Running setup.py install for mozscreenshot 01:48:16 INFO - Running setup.py install for moztest 01:48:16 INFO - Running setup.py install for mozversion 01:48:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:48:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:48:17 INFO - Cleaning up... 01:48:17 INFO - Return code: 0 01:48:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:48:17 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')]} 01:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:17 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')]} 01:48:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:17 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 0x1f1e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bc310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b9400>, '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 0x21ba3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ba840>, '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': '2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990', '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 01:48:17 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 01:48:17 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 01:48:17 INFO - Using env: {'DISPLAY': ':0', 01:48:17 INFO - 'HOME': '/home/cltbld', 01:48:17 INFO - 'LANG': 'en_US.UTF-8', 01:48:17 INFO - 'LANGUAGE': 'en_US:en', 01:48:17 INFO - 'LOGNAME': 'cltbld', 01:48:17 INFO - 'MAIL': '/var/mail/cltbld', 01:48:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:17 INFO - 'MOZ_NO_REMOTE': '1', 01:48:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:17 INFO - 'NO_EM_RESTART': '1', 01:48:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:17 INFO - 'PWD': '/builds/slave/test', 01:48:17 INFO - 'SHELL': '/bin/bash', 01:48:17 INFO - 'SHLVL': '1', 01:48:17 INFO - 'TERM': 'linux', 01:48:17 INFO - 'TMOUT': '86400', 01:48:17 INFO - 'USER': 'cltbld', 01:48:17 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990', 01:48:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:17 INFO - '_': '/tools/buildbot/bin/python'} 01:48:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:48:17 INFO - Running setup.py (path:/tmp/pip-DkwHcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:48:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:48:17 INFO - Running setup.py (path:/tmp/pip-kjdDqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:48:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:48:17 INFO - Running setup.py (path:/tmp/pip-Xf7Hm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:48:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:48:17 INFO - Running setup.py (path:/tmp/pip-BMAMUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:48:17 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)) 01:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:48:17 INFO - Running setup.py (path:/tmp/pip-9mmH5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:48:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:48:17 INFO - Running setup.py (path:/tmp/pip-KnnJ0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:48:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:48:17 INFO - Running setup.py (path:/tmp/pip-aclfEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:48:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:48:17 INFO - Running setup.py (path:/tmp/pip-Y3gphw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:48:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:48:17 INFO - Running setup.py (path:/tmp/pip-MpI0z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:48:18 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)) 01:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:48:18 INFO - Running setup.py (path:/tmp/pip-MzLMRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:48:18 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)) 01:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:48:18 INFO - Running setup.py (path:/tmp/pip-RHZnbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:48:18 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)) 01:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:48:18 INFO - Running setup.py (path:/tmp/pip-7np8fN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:48:18 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)) 01:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:48:18 INFO - Running setup.py (path:/tmp/pip-OsUNfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:48:18 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)) 01:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:48:18 INFO - Running setup.py (path:/tmp/pip-RArta5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:48:18 INFO - Running setup.py (path:/tmp/pip-WN9s1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:48:18 INFO - Running setup.py (path:/tmp/pip-KWxQCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:48:18 INFO - Running setup.py (path:/tmp/pip-zQ_opp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:48:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:18 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 01:48:18 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 01:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:20 INFO - Downloading blessings-1.6.tar.gz 01:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:48:21 INFO - Installing collected packages: blessings 01:48:21 INFO - Running setup.py install for blessings 01:48:21 INFO - Successfully installed blessings 01:48:21 INFO - Cleaning up... 01:48:21 INFO - Return code: 0 01:48:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:48:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:48:21 INFO - Reading from file tmpfile_stdout 01:48:21 INFO - Current package versions: 01:48:21 INFO - argparse == 1.2.1 01:48:21 INFO - blessings == 1.6 01:48:21 INFO - blobuploader == 1.2.4 01:48:21 INFO - docopt == 0.6.1 01:48:21 INFO - functools32 == 3.2.3-2 01:48:21 INFO - jsonschema == 2.5.1 01:48:21 INFO - manifestparser == 1.1 01:48:21 INFO - mozInstall == 1.12 01:48:21 INFO - mozcrash == 1.0 01:48:21 INFO - mozdebug == 0.1 01:48:21 INFO - mozdevice == 0.49 01:48:21 INFO - mozfile == 1.2 01:48:21 INFO - mozhttpd == 0.7 01:48:21 INFO - mozinfo == 0.9 01:48:21 INFO - mozleak == 0.1 01:48:21 INFO - mozlog == 3.4 01:48:21 INFO - moznetwork == 0.27 01:48:21 INFO - mozprocess == 0.25 01:48:21 INFO - mozprofile == 0.28 01:48:21 INFO - mozrunner == 6.13 01:48:21 INFO - mozscreenshot == 0.1 01:48:21 INFO - mozsystemmonitor == 0.3 01:48:21 INFO - moztest == 0.8 01:48:21 INFO - mozversion == 1.4 01:48:21 INFO - psutil == 3.1.1 01:48:21 INFO - requests == 1.2.3 01:48:21 INFO - wsgiref == 0.1.2 01:48:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:48:21 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')]} 01:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:21 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')]} 01:48:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:21 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 0x1f1e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bc310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b9400>, '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 0x21ba3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ba840>, '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': '2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990', '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 01:48:21 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 01:48:21 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 01:48:21 INFO - Using env: {'DISPLAY': ':0', 01:48:21 INFO - 'HOME': '/home/cltbld', 01:48:21 INFO - 'LANG': 'en_US.UTF-8', 01:48:21 INFO - 'LANGUAGE': 'en_US:en', 01:48:21 INFO - 'LOGNAME': 'cltbld', 01:48:21 INFO - 'MAIL': '/var/mail/cltbld', 01:48:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:21 INFO - 'MOZ_NO_REMOTE': '1', 01:48:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:21 INFO - 'NO_EM_RESTART': '1', 01:48:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:21 INFO - 'PWD': '/builds/slave/test', 01:48:21 INFO - 'SHELL': '/bin/bash', 01:48:21 INFO - 'SHLVL': '1', 01:48:21 INFO - 'TERM': 'linux', 01:48:21 INFO - 'TMOUT': '86400', 01:48:21 INFO - 'USER': 'cltbld', 01:48:21 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990', 01:48:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:21 INFO - '_': '/tools/buildbot/bin/python'} 01:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:21 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)) 01:48:21 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)) 01:48:21 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)) 01:48:21 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)) 01:48:21 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)) 01:48:21 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)) 01:48:21 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)) 01:48:21 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)) 01:48:21 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)) 01:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:48:21 INFO - Cleaning up... 01:48:21 INFO - Return code: 0 01:48:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:48:21 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')]} 01:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:21 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')]} 01:48:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1f1e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bc310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b9400>, '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 0x21ba3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ba840>, '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': '2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990', '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 01:48:21 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 01:48:21 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 01:48:21 INFO - Using env: {'DISPLAY': ':0', 01:48:21 INFO - 'HOME': '/home/cltbld', 01:48:21 INFO - 'LANG': 'en_US.UTF-8', 01:48:21 INFO - 'LANGUAGE': 'en_US:en', 01:48:21 INFO - 'LOGNAME': 'cltbld', 01:48:21 INFO - 'MAIL': '/var/mail/cltbld', 01:48:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:21 INFO - 'MOZ_NO_REMOTE': '1', 01:48:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:21 INFO - 'NO_EM_RESTART': '1', 01:48:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:21 INFO - 'PWD': '/builds/slave/test', 01:48:21 INFO - 'SHELL': '/bin/bash', 01:48:21 INFO - 'SHLVL': '1', 01:48:21 INFO - 'TERM': 'linux', 01:48:21 INFO - 'TMOUT': '86400', 01:48:21 INFO - 'USER': 'cltbld', 01:48:21 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990', 01:48:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:21 INFO - '_': '/tools/buildbot/bin/python'} 01:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:48:21 INFO - Cleaning up... 01:48:21 INFO - Return code: 0 01:48:21 INFO - Running post-action listener: _resource_record_post_action 01:48:21 INFO - Running post-action listener: _start_resource_monitoring 01:48:21 INFO - Starting resource monitoring. 01:48:21 INFO - [mozharness: 2017-04-20 08:48:21.950999Z] Finished create-virtualenv step (success) 01:48:21 INFO - [mozharness: 2017-04-20 08:48:21.951513Z] Running install step. 01:48:21 INFO - Running pre-action listener: _resource_record_pre_action 01:48:21 INFO - Running main action method: install 01:48:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:48:22 INFO - Reading from file tmpfile_stdout 01:48:22 INFO - Detecting whether we're running mozinstall >=1.0... 01:48:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:48:22 INFO - Reading from file tmpfile_stdout 01:48:22 INFO - Output received: 01:48:22 INFO - Usage: mozinstall [options] installer 01:48:22 INFO - Options: 01:48:22 INFO - -h, --help show this help message and exit 01:48:22 INFO - -d DEST, --destination=DEST 01:48:22 INFO - Directory to install application into. [default: 01:48:22 INFO - "/builds/slave/test"] 01:48:22 INFO - --app=APP Application being installed. [default: firefox] 01:48:22 INFO - mkdir: /builds/slave/test/build/application 01:48:22 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'] 01:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:48:38 INFO - Reading from file tmpfile_stdout 01:48:38 INFO - Output received: 01:48:38 INFO - /builds/slave/test/build/application/firefox/firefox 01:48:38 INFO - Running post-action listener: _resource_record_post_action 01:48:38 INFO - [mozharness: 2017-04-20 08:48:38.838603Z] Finished install step (success) 01:48:38 INFO - [mozharness: 2017-04-20 08:48:38.838884Z] Running run-tests step. 01:48:38 INFO - Running pre-action listener: _resource_record_pre_action 01:48:38 INFO - Running main action method: run_tests 01:48:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:48:38 INFO - Python 2.7.3 01:48:38 INFO - Return code: 0 01:48:38 INFO - grabbing minidump binary from tooltool 01:48:38 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')]} 01:48:38 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 0x21b9400>, '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 0x21ba3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ba840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:48:38 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 01:48:38 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 01:48:38 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 01:48:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:48:38 INFO - Return code: 0 01:48:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:48:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:48:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:48:38 INFO - ENV: RUST_BACKTRACE is now 1 01:48:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:48:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:48:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-070 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:48:38 INFO - Using env: {'DISPLAY': ':0', 01:48:38 INFO - 'HOME': '/home/cltbld', 01:48:38 INFO - 'LANG': 'en_US.UTF-8', 01:48:38 INFO - 'LANGUAGE': 'en_US:en', 01:48:38 INFO - 'LOGNAME': 'cltbld', 01:48:38 INFO - 'MAIL': '/var/mail/cltbld', 01:48:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:48:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:38 INFO - 'MOZ_NO_REMOTE': '1', 01:48:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:38 INFO - 'NO_EM_RESTART': '1', 01:48:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:38 INFO - 'PWD': '/builds/slave/test', 01:48:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:48:38 INFO - 'RUST_BACKTRACE': '1', 01:48:38 INFO - 'SHELL': '/bin/bash', 01:48:38 INFO - 'SHLVL': '1', 01:48:38 INFO - 'TERM': 'linux', 01:48:38 INFO - 'TMOUT': '86400', 01:48:38 INFO - 'USER': 'cltbld', 01:48:38 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990', 01:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:38 INFO - '_': '/tools/buildbot/bin/python'} 01:48:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:48:39 INFO - mozversion application_buildid: 20170420074643 01:48:39 INFO - mozversion application_changeset: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 01:48:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:48:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:48:39 INFO - mozversion application_name: Firefox 01:48:39 INFO - mozversion application_remotingname: firefox-dev 01:48:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:48:39 INFO - mozversion application_vendor: Mozilla 01:48:39 INFO - mozversion application_version: 54.0a2 01:48:39 INFO - mozversion platform_buildid: 20170420074643 01:48:39 INFO - mozversion platform_changeset: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 01:48:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:48:39 INFO - mozversion platform_version: 54.0a2 01:48:39 INFO - using testdate: 1492678119 01:48:39 INFO - actual date: 1492678119 01:48:39 INFO - starting webserver on 'localhost:34346' 01:48:39 INFO - SUITE-START | Running 2 tests 01:48:39 INFO - TEST-START | dromaeo_css 01:48:39 INFO - operating with platform_type : linux_ 01:48:39 INFO - Initialising browser for dromaeo_css test... 01:48:39 INFO - TEST-INFO | started process 27179 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdqNVui/profile http://localhost:34346/getInfo.html) 01:48:43 INFO - PROCESS | 27179 | __metrics Screen width/height:1600/1200 01:48:43 INFO - PROCESS | 27179 | colorDepth:24 01:48:43 INFO - PROCESS | 27179 | Browser inner width/height: 1024/697 01:48:43 INFO - PROCESS | 27179 | __metrics 01:48:44 INFO - PROCESS | 27179 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:48:44 INFO - PROCESS | 27179 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:48:45 INFO - TEST-INFO | 27179: exit 0 01:48:45 INFO - Browser initialized. 01:48:45 INFO - Running cycle 1/1 for dromaeo_css test... 01:48:45 INFO - TEST-INFO | started process 27277 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdqNVui/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:48:56 INFO - PROCESS | 27277 | RSS: Main: 140025856 01:48:56 INFO - PROCESS | 27277 | 01:51:58 INFO - PROCESS | 27277 | Cycle 1(1): loaded http://localhost:34346/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34346/tests/dromaeo/cssquery-ext.html) 01:51:59 INFO - PROCESS | 27277 | RSS: Main: 275972096 01:51:59 INFO - PROCESS | 27277 | 01:53:46 INFO - PROCESS | 27277 | ************************* 01:53:46 INFO - PROCESS | 27277 | A coding exception was thrown and uncaught in a Task. 01:53:46 INFO - PROCESS | 27277 | 01:53:46 ERROR - PROCESS | 27277 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:53:46 INFO - PROCESS | 27277 | Full stack: 01:53:46 INFO - PROCESS | 27277 | ************************* 01:53:46 INFO - PROCESS | 27277 | ************************* 01:53:46 INFO - PROCESS | 27277 | A coding exception was thrown and uncaught in a Task. 01:53:46 INFO - PROCESS | 27277 | 01:53:46 ERROR - PROCESS | 27277 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:53:46 INFO - PROCESS | 27277 | Full stack: 01:53:46 INFO - PROCESS | 27277 | ************************* 01:53:46 INFO - PROCESS | 27277 | ************************* 01:53:46 INFO - PROCESS | 27277 | A coding exception was thrown and uncaught in a Task. 01:53:46 INFO - PROCESS | 27277 | 01:53:46 ERROR - PROCESS | 27277 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:53:46 INFO - PROCESS | 27277 | Full stack: 01:53:46 INFO - PROCESS | 27277 | ************************* 01:53:46 INFO - PROCESS | 27277 | ************************* 01:53:46 INFO - PROCESS | 27277 | A coding exception was thrown and uncaught in a Task. 01:53:46 INFO - PROCESS | 27277 | 01:53:46 ERROR - PROCESS | 27277 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:53:46 INFO - PROCESS | 27277 | Full stack: 01:53:46 INFO - PROCESS | 27277 | ************************* 01:55:02 INFO - PROCESS | 27277 | Cycle 1(1): loaded http://localhost:34346/tests/dromaeo/cssquery-ext.html (next: http://localhost:34346/tests/dromaeo/cssquery-jquery.html) 01:55:02 INFO - PROCESS | 27277 | RSS: Main: 223952896 01:55:02 INFO - PROCESS | 27277 | 01:58:04 INFO - PROCESS | 27277 | Cycle 1(1): loaded http://localhost:34346/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34346/tests/dromaeo/cssquery-mootools.html) 01:58:05 INFO - PROCESS | 27277 | RSS: Main: 209694720 01:58:05 INFO - PROCESS | 27277 | 02:01:07 INFO - PROCESS | 27277 | Cycle 1(1): loaded http://localhost:34346/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34346/tests/dromaeo/cssquery-prototype.html) 02:01:07 INFO - PROCESS | 27277 | RSS: Main: 170385408 02:01:07 INFO - PROCESS | 27277 | 02:04:10 INFO - PROCESS | 27277 | Cycle 1(1): loaded http://localhost:34346/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34346/tests/dromaeo/cssquery-yui.html) 02:04:11 INFO - PROCESS | 27277 | RSS: Main: 177139712 02:04:11 INFO - PROCESS | 27277 | 02:07:13 INFO - PROCESS | 27277 | Cycle 1(1): loaded http://localhost:34346/tests/dromaeo/cssquery-yui.html (next: http://localhost:34346/tests/dromaeo/cssquery-dojo.html) 02:07:13 INFO - PROCESS | 27277 | RSS: Main: 262590464 02:07:13 INFO - PROCESS | 27277 | 02:07:13 INFO - PROCESS | 27277 | __start_tp_report 02:07:13 INFO - PROCESS | 27277 | _x_x_mozilla_page_load 02:07:13 INFO - PROCESS | 27277 | _x_x_mozilla_page_load_details 02:07:13 INFO - PROCESS | 27277 | |i|pagename|runs| 02:07:13 INFO - PROCESS | 27277 | |0;dojo.html;3432.742544309177;3470.982645086775;3478.4434490481526;3483.2685136121413;3522.33075715614;5887.205227294314;5945.910811337833;5955;5957.314908785485;5971.641701497913;5938.40615938406;5970.164177015221;5973.970130149343;5980.312264089631;5980.342162362148;5245.213218017299;5257.316548848645;5284.524392804647;5306.681599104047;5337.492938170868;5105;5117.539421452068;5350.036993341197;5365.248865158861;5367.409584945653;5181.1451110566895;5233.110371236899;5246.947530524703;5324.920126198091;5340.759665815048;5318.893622127555;5333.2000199969925;5338.62629615927;5354.063038968165;5359.678419294835;5186.118359878829;5230.424653288135;5234.084035293847;5295.68225906443;5302.469753024667;5628.409017053233;5692.31692196939;5778.479936805707;5835.737391817378;5854.707264636793;6303.873922521524;6310.6213627182515;6313.526485513605;6314.179156709644;6318.4313411793155;6375.87248255037;6392.808215753535;6394.9360506394805;6395.712192951329;6398.488120950313;5610.298712660877;5666.036773748431;5828.12578113278;5922.615030023121;5947.821565353046;6446.387593178641;6483.902741458882;6484.124643173205;6502.122213501211;6507.544471886922;6243.125962365272;6247.531435142382;6248.593841400295;6249.156363890907;6251.718672659741;6083.9391606084255;6127.264728232641;6280.842978925563;6339.714712837934;6344.777932772331;6119.929102025404;6142.069075791497;6142.078688196806;6152.415520525543;6155.230596175478;6038.154658347835;6089.634621922699;6098.969505152446;6259.624422534663;6266.436020758154;4674.205385084544;4707.670463067552;4724.787384567703;4729.2906064089975;4736.171170045228;4242.151569686075;4263.70154089217;4272.786360681954;4276.764777937181;4280.828766849291;5906.0255057914965;5947.167396564484;6078.635281883101;6119.5104391648565;6170.56806023583;6355.332690067568;6391.296957334689;6395.552311338161;6396.5522413431545;6401.807945761541;6161.876762464725;6170.969145154335;6173.135760993465;6176.197094377792;6181;5185;5206.97396513015;5282.867928301746;5289.100852855024;5372.570194384518;6559.573627714279;6570.638614876037;6572.014197870262;6574.605523668595;6576.4410025147445;6284.622922624657;6286.308506064421;6300.590461620163;6302.810915672537;6335.303116657072;6217.689115544295;6240.53196010292;6396.9040464394;6578.868422631616;6585.341465853377;6129.450483694133;6129.847850912788;6137.376985335611;6153.538484613582;6181.752729890754;6284.120223168668;6285.371462853678;6287.497000239879;6289.811305660837;6292.528060395397;5941.970290148522;5976.252968378953;6051.515878729603;6110.7250173741395;6120.204373431426;6125.479334256638;6141.969290153521;6158.107074474086;6196.907046394398;6216.906746398718;6186.566940314135;6197.287311959182;6201.1628430163155;6201.472874805511;6202.038684003986;5891.381404952418;5905.350411454822;5962.07587823888;6101.908471373022;6201.131841542278;6040.124181993674;6057.21256236704;6060.515158787198;6086.482648974887;6095.695215239131 02:07:13 INFO - PROCESS | 27277 | |1;ext.html;778.0663204155015;827.3050637464529;858.6822875536053;915.3043686798036;943.1464524605235;31552.84223578882;44466.777666111666;45065.77467112668;45224.321635175496;45278.54721452785;46176.53823461764;46206.76896615521;46558.06883862321;46565.30152047722;46768.76615616926;7756.0692716874055;8004.759857204293;9145.908540914572;9262.861057084148;9271;10236.720409948757;10491.947540262327;10497;10497.475126243695;10786.622468213614;10452.529636166353;10537.104346130549;10542.736431589234;10553.997370249852;10560.577576896952;10477.31897426665;10497.4226417547;10507;10521.158307335394;10522.473876306192;10592.25854190207;10612.893871061267;10620.840687389695;10630.627928022483;10644.201684873588;41862.53481128146;42030;42066.36900446465;42081.368779468336;42102.78948605268;4186.2919849038735;4225.239456897757;4271.380649805761;4357.281048626973;4375.234333991539;29991.550126748116;30478.54282185769;30877.228069298224;30966;32238.6776132238;4365.2142614329405;4458.910821783578;4462.531434199427;4472.373867658531;4506.842260520866;228314;230845;231096.84451577804;231706;231861;53507.732461337444;53938.190927135336;53976.46023539714;54011.18983215255;54025;57321.426785732445;57333;57353.42646573564;57370.42629573734;57375.71312143413;16078.598035049217;16347.18264086791;16363.672726545403;16372.181390930406;16389;13067.673308167372;13163.078584498993;13930.233837139054;14243.572692819233;14249.572512824632;13796.862031379558;13955.720885582434;13959.930200349136;13976.091554048955;14069.577912662637;5560;5574.86062848432;5635.887282254332;5647.971760141255;5754.395788442153;1018.6689325969089;1029.1355261580309;1030.1295405382439;1032.488917985602;1035.177034257767;29071.709282907323;29131.271718207216;29197.854010730236;29500.409991800043;29694;1088.3905013192636;1090.4166271044953;1105.7622611138643;1122.6070875193616;1136.8351589019712;15485.22573871302;15526.37894484208;15541.689166216613;15615.453459128876;15661.373545058297;294811;295267;297432;298282;298426;54794.17808732872;59472.10791838126;59529.702351488835;59580.10629840556;59625;1499.8725108365693;1533.2563706602066;1560.5162399656142;1564.4915402494235;1574.1106274954614;26504.734952650997;27560.862195688893;27817.304567385978;27981.860090699418;28150.2962425941;43792.12415751731;43834.780826095666;43901.121977560906;43966;44076.33885491784;279081;280418;280914;281138;281630;30002.84998574993;31148.377032459677;35589.82205088958;35623.64376356307;36545.63454365529;45114.323285151404;45683.71581420982;45813.77093114513;45990.540094598626;46394.30408543807;34442;34872.47691284683;34944.475832863034;34973.47539786956;35057.64942350544;34890.302193956486;34958.475622866186;34967.475487868214;35022.47466287957;35579.82210088933;39508;40106.799466002485;40533.39199911945;41189.58810411858;41291.58708412998;32562.185945351557;33072;33096.004357082544;33133.50299745554;33797.83101084577;26030;26984.85589641656;27064.458710826068;27170;27561 02:07:13 INFO - PROCESS | 27277 | |2;jquery.html;463.60593495528803;467.3807205452776;483.388513530384;484.6897985289413;491.840151950616;18833.811661883377;20229.59540809183;20681.379558613266;21144.365669029936;21289;20613.896930515362;21202.787972120273;21665.56668866622;22287.331380058582;22310.77689223107;6800.489963252751;6850.417714494274;6904.723811047552;6961.547499412547;7024.543404678705;6771.4921380896385;6891.483138764587;6897.6206308653;7181.605011724353;7478.326950574447;7632.084149901992;7651.732189373373;7652.31129198372;7652.732154374598;7656.042994625672;7466.328030477283;7532.058492688414;7579.431542634269;7594.73418430355;7610.8477830443635;7175.569465832067;7349.816254593625;7387.963060184718;7398.852022959564;7404.4816862819625;24271.63592546113;24892.626610600855;25182.622260666103;25239.62140567893;25346.746532534624;3087.1818967973504;3188;3721.348763966322;3810.333191691443;3812.0660438192544;15614.45349412765;16216.108114053723;16557.172141393003;16752.83247167525;16929.238184281738;2232;2277.749447560767;2344.3553022918663;2354.5526349993447;2393.8324317297797;118862;122020.38989805082;122481.38759306236;123045.69340073144;123375.38312308471;18099.909500452675;18421.815781842277;18704.158312875952;18865.396441302368;19058;32047.35905281928;32239.35521289608;32276.83861580677;32344.191395215308;32445.837770810995;10851.51168197433;10871.83692244617;10883.346999180074;10941.28881622708;11308.264962777394;9309.115634014757;9332.813343733224;9364.906350936404;9540.236781057498;9595.952020239854;9221.354505184572;9269.629214831466;9289.117533834275;9500.334976551576;9641.132298093205;3791.2227993261317;3811.790351530637;3880.728349015542;4021.959780402217;4042.5755295694116;1016.065219997604;1144.553624086607;1161.1175506615034;1173.9471723772451;1186.0298792117133;20137.19451221964;21436.892815535823;21559.56880862405;21667.133314667237;21729.348119556438;1162.8255761635653;1170.1574866096396;1170.3621526268205;1185.531714972581;1205.4213977290774;11386.316820990767;11821.645350639494;11834.585789497498;11852.229605075643;11863.525458981545;668828;675981;683570;692995;701582;103449.48275258727;116703;117531;118420;120069;1250.2748405924724;1250.4560516175493;1264.0582765839508;1265.1523479268913;1279.654493286826;17612.471625851245;18263.17368263163;18390.540236494195;18396.540086497946;18431;49673;50418.49581504138;50420.98316067463;50746.238806418674;51012.74493627508;63436.36563634489;67799.66100169468;67927;68184.3181568178;68633.65683171753;12805.615831525069;14061.578152655436;14359.856401435853;14482.203478808346;14690.485832995793;15425;15516.301766420313;15701.450449234222;15910.443134490237;15993.200339983186;13636.386362613905;13691.452341906212;13692.178469291874;13776.65558361049;13826.446942122604;11989.040876730016;12157.817632735692;12198.51205951752;12341.444634991627;12382.442790074649;13371.197728136343;13526.661833454242;13563.118397304144;13650.795238071238;13792.103513271606;14255.714885702435;14453.132812031312;14469.421223150955;14505.347259373564;14548.636284092983;12806.743865122458;13027.022973276853;13261.270630115436;13328.067035307435;13350.065495415227 02:07:13 INFO - PROCESS | 27277 | |3;mootools.html;1411.4495346814738;1556.5211751734878;1561.2427972433363;1565.2330358124518;1572.096044774255;9502.904970950289;11369.374684392355;11585.246958947662;11649.592264270752;11657.41712914355;11529.538818447252;11587.36269505179;11604.767904641902;11637.243579167369;11655.067594592434;2066.7519897612306;2483.242611003643;2520.0549793827313;2522.8864701088405;2534.1510593951048;2069.8654587451842;2366.751491093436;2427.1383658801137;2433.5862903306393;2435.1720415058876;2411.7829395354415;2430.635404689293;2433.3673244956262;2437.744036876129;2441.7802397784194;2385.153270588942;2385.2009576791797;2388.5581167483983;2389.020501594338;2389.2832150354825;2298.701168848039;2316.571434284646;2322.5935461294375;2322.605157123293;2324;11602.709932251677;11721.472533735918;11852.11109166816;11854.3480108594;11864.940675296568;5875.941240587625;6025.0661147522205;6032.095185722133;6032.245969253843;6034.456898879122;3311.2218628622254;3420.401429749784;3497.9475307870403;3560.91097722559;3587.121155316938;1323.3052647360116;1336.6591519162648;1347.1714895339296;1375.7867530532683;2322.3845680894406;17837.910810445865;17936.103194840336;18077.909610451996;18123.275068997224;18178.545536361566;4757.500462451462;4854.635902307341;4868.464468908417;4895.241237608177;4921.335619691367;12796.360181990864;12810.80783788244;12817.551385701643;12829;12838.55065072718;5920.674362909996;5928.644281343047;5929.822105336847;5932.49573786233;5932.614380065282;4732.550407711262;4892.461829198785;5186.63693541456;5351.652142610717;5411.18832175169;4030.979845100756;4109.404136400205;4167.604077612683;4170.706111638648;4208;1059.7191744187796;1074.1997212077054;1074.7044562745152;1085.5766251162054;1086.9076128529164;1075.44077079918;1085.3162507620307;1091.612477570467;1092.4810714910354;1102.1568500097433;7408.073990751156;7463.776086717407;7475.4767166298925;7614;7641.312281894656;1086.8641419822522;1103;1122.6912599035331;1129.2434069173673;1145.255583870491;4709.529047095263;4863.148948933923;5035.84892453227;5048.343715316985;5090.2364645303505;14561.053531520418;14935.626609334853;15059.096454212782;15067.397304107932;15138.697226055418;14766.630834229016;14814.481493147689;15129.319180636898;15135.697286054437;15139.54581362561;10828.72928176786;10890.673279801777;10891.83662245067;10957;10982.560697572168;7290.817729556804;7409.925900741139;7436.144843342869;7452.888206677013;7530.322270995636;12823.807642885178;12946.482140714643;12957.157784743962;13038;13115.737685246433;12701.174423662433;12767.738784622929;12832.29422381778;13467.461301547828;13799.793003105162;8242.546659933761;8727.825443490967;9697.951510242403;9919.40483570988;9938.602455901972;10995.230333876552;11077.556897724;11196.38419886914;11207.159463040141;11210.103191744478;8792.919651932316;8863.379563430755;8903.821923561363;9040.773980650536;9173.08269173104;8892.555372231232;9080.500572468578;9087.54562271897;9129.178373946377;9250.629974800933;8613.31093512505;8617.224449799549;8618.09510001466;8725.258353040063;8739.082396348293;6449.516286278454;6529.9347006531225;6558.278589355072;6615.801525954229;6744.898826517508;6437.259715132633;6505.967470162619;6666.300038495888;6692.096566963398;6819.318068193339 02:07:13 INFO - PROCESS | 27277 | |4;prototype.html;412.62657295147864;427.3610951627318;434.6088520331701;439.1502442773234;444.13615517817817;5132.075471698113;5223.3731952165745;5258.579313654913;5275.762590683419;5345.545628621572;4881.511848815126;5281.287026251455;5298.337707786527;5304.681719096857;5314.76083576239;4292.806823692941;4310.698251122422;4339.39248505208;4353.303471444569;4353.804078816445;4362.5637436256275;4370.475542934836;4388.473383194021;4399.2521271383785;4428.867133985986;4404.603585677289;4407.471103467588;4413.764146039114;4428.225060614395;4435.246008178601;4197.097624010837;4340.305551111807;4352.368906508538;4366.672499562545;4381.693281470299;4078.7559794263034;4087.550369459357;4111.958880411187;4112.856050038235;4156.418101465797;5124.5131712487255;5134.743262836881;5180.456052114511;5181.844544663666;5209.583233341324;4993.575546078588;5047.242913562958;5129.179331306973;5158.039944820944;5205.791768329263;5606.243157173811;5614.29821272341;5619.157126431027;5644.774209031634;5663.405342439026;4631.768411579407;4635.6986795858165;4683.976580117112;4684.344191813149;4726.810927562893;5415.593830462692;5448;5585.2459917910965;5588.776448942078;5724.341700704431;4621.468531118897;4631.467381251132;4663.953360466419;4688.742119183477;4696.990147118386;4755.19302664992;4788.880277993078;4793.113274044244;4797.64017698674;4809.254565542346;4933.383327084114;4939.711221405137;4963.354763880672;5070.721110338893;5100.311457953203;5444.5155100735565;5454.945450545444;5462.426445223195;5487.8048780488125;5515.586331025189;1631.967360652804;1634.7466142747894;1640.3520609359236;1643.3837311008372;1646.4731285988369;1241.00248496914;1267.473998290699;1281.1672412931669;1285.9228446293253;1294.4304506017322;5337.051976028722;5345.118055520873;5404.000779567299;5407.161889907071;5433.375161856437;5576.553875689935;5578.860528486739;5586.776528938797;5672.177534257592;5708.372079071299;5295.338082739658;5295.576353891679;5366.973165134149;5438.966596346681;5445.863853403696;2896.304886827146;2945.6759756426777;2964.1107667699603;2969.7624190064744;2975.4792911240447;5775.422457754191;5854.795082172189;5873.765049398062;5890.556813580614;5911.793087241926;5797.855053623609;5800.274965629296;5805.912911306334;5833.970830145822;5837.824865254049;5870.207521984563;5878.942370170406;5879.735411906475;5981.700914954235;5984.371640977634;5373.489518495737;5621.11413518453;5635.9436405635415;5644.209810626598;5700.25896633435;5456.8267822418375;5612.803551875828;5624.268845050117;5628.774849005994;5679;5716.828495145152;5762.971185144047;5869;5871.911921321098;5890.764369425347;4736.550027747358;4742.478327384054;4747.359106520576;4764.928526072043;4766.570028991358;5471.589630777628;5635;5640.802571909963;5670.404607516316;5721.8569535761935;5488.286522752017;5510.889782204414;5547.861303467445;5585.9720701397855;5618.2134501170685;5505.421476040446;5511.696856672921;5533.972330138324;5554.944450555443;5587.385387607441;5294.655847369909;5426.348838139291;5481.451854814487;5498.945010549844;5514.200440936122;5511.283533140827;5518.586106042143;5548.334199896039;5551.278333816578;5564.888702226014;5288.338957630296;5318.574514038945;5406.918896216481;5450.700211488406;5524.1989911463415 02:07:13 INFO - PROCESS | 27277 | |5;yui.html;875.4762082617464;892.7589550821278;898.6719847255749;902.6028547439122;911.0616065452584;16956;18180.090995450242;18182.72725909109;18198.363057292998;18227.635447291064;15711.60720981976;15850.84149158508;15876.444324448647;15885;15889.682206355867;693.8646963842053;711.8967749676294;867.8784970104191;869.1221865915439;897.7710683775628;893.6068130022802;898.8157427727333;899.7390756680555;899.7570655922897;899.8470260055774;725.8548290341927;938.0572524612788;939.8543225799978;940.0693313619502;940.2759874896326;742.5952855693633;743.1899229839447;744.4900243333334;923.9307051971061;947.0907928388755;695.2560759986816;695.7634404302511;695.9686814093327;696.0742212856939;696.4393663101201;17323.133843307784;17417.04206268655;17466.864653797464;17474.126293685265;17867.106644667714;14829.925850370788;15318.846811531854;15388.692226155526;15479;16043.679126417523;14701.705965880623;15044.699106017928;15059.924700376538;15092.849071509254;15108.848911510853;4864.416270047617;4869.440014398354;4902.730349830758;4925;5049.924251136199;60982;84099.15900840974;86421.56789216076;86767;86841.56579217127;12484.655288480633;12639.1784534005;12644.178128421623;12829.743405131845;12881.871181288067;22945.31164065081;23017.769822301896;23150.65274020891;23327.766722332897;23485.17801876926;8388.32893368529;8463.619137138843;8556.786080347916;8558.486490810572;8678.609462574199;4933.753312334369;5048;5113.437521872591;5173.81891633791;5255.395629502656;3478.704310133616;3503.404421248394;3509.701675357572;3544.8936531904083;3572.1962558424148;622.3838399983983;623.3735096228352;628.1739512540994;633.5058654249692;634.5019159959502;769.3460558525209;770.9922900770921;777.4790890103644;802.7993001749562;821.5153059694809;10832.893255348186;11327.207095503236;11509.13681473876;11613.593524226611;11649.59226427071;670.5842377725842;681.7954613615896;682.3415404134935;697.4240943655507;843.6751850537464;5592.189132575753;5624.887502250014;5640.900024495266;5657.60396772222;5719.942800572025;76927.61536192395;78893;79000.60499697465;80743.59628201822;80975;71557.2844271561;72401.63799180971;76380;77781;79361.60319198483;53750.19374709383;63561.68219158875;63946.36053639497;64571.35428645653;64755;11325;11649.88350116488;11658.941705291758;11820.586279480176;12085.335306557872;37219.62780372162;39850.800745996086;40603;40739.1852162961;41006.17987640171;54597.72701136469;56608.71695641495;56954.71522642526;59014.70492647509;59392;13890.30548472552;13974.58076257714;14001.719965600427;14252.28738563047;14315.928420357832;15812.209389530708;15941.96377235476;16039.518814435585;16214.351425943301;16719.665606688042;15954;16310.102944338176;16384.83615163833;16449.871119243042;17168.570785730455;16030.51908442702;16539.91730041342;16550.629772884768;16727.83272167263;16940;15449.691006180039;15810.60473488172;16055;16202.513924582281;16667.916660417104;10993.505292262027;11062.834057489305;11205.663830084784;11383.54465821358;11495.885041149482;12652.873471265537;12785.16896401731;12871.163374380636;12895.843549849302;13068.346582671018 02:07:13 INFO - PROCESS | 27277 | __end_tp_report 02:07:13 INFO - PROCESS | 27277 | __start_cc_report 02:07:13 INFO - PROCESS | 27277 | _x_x_mozilla_cycle_collect,1325 02:07:13 INFO - PROCESS | 27277 | __end_cc_report 02:07:13 INFO - PROCESS | 27277 | __startTimestamp1492679233927__endTimestamp 02:07:13 INFO - PROCESS | 27277 | 02:07:13 INFO - PROCESS | 27277 | ------- Summary: start ------- 02:07:13 INFO - PROCESS | 27277 | Number of tests: 6 02:07:13 INFO - PROCESS | 27277 | 02:07:13 INFO - PROCESS | 27277 | [#0] dojo.html Cycles:165 Average:5829.14 Median:6098.97 stddev:676.43 (11.1%) stddev-sans-first:651.86 02:07:13 INFO - PROCESS | 27277 | Values: 3432.7 3471.0 3478.4 3483.3 3522.3 5887.2 5945.9 5955.0 5957.3 5971.6 5938.4 5970.2 5974.0 5980.3 5980.3 5245.2 5257.3 5284.5 5306.7 5337.5 5105.0 5117.5 5350.0 5365.2 5367.4 5181.1 5233.1 5246.9 5324.9 5340.8 5318.9 5333.2 5338.6 5354.1 5359.7 5186.1 5230.4 5234.1 5295.7 5302.5 5628.4 5692.3 5778.5 5835.7 5854.7 6303.9 6310.6 6313.5 6314.2 6318.4 6375.9 6392.8 6394.9 6395.7 6398.5 5610.3 5666.0 5828.1 5922.6 5947.8 6446.4 6483.9 6484.1 6502.1 6507.5 6243.1 6247.5 6248.6 6249.2 6251.7 6083.9 6127.3 6280.8 6339.7 6344.8 6119.9 6142.1 6142.1 6152.4 6155.2 6038.2 6089.6 6099.0 6259.6 6266.4 4674.2 4707.7 4724.8 4729.3 4736.2 4242.2 4263.7 4272.8 4276.8 4280.8 5906.0 5947.2 6078.6 6119.5 6170.6 6355.3 6391.3 6395.6 6396.6 6401.8 6161.9 6171.0 6173.1 6176.2 6181.0 5185.0 5207.0 5282.9 5289.1 5372.6 6559.6 6570.6 6572.0 6574.6 6576.4 6284.6 6286.3 6300.6 6302.8 6335.3 6217.7 6240.5 6396.9 6578.9 6585.3 6129.5 6129.8 6137.4 6153.5 6181.8 6284.1 6285.4 6287.5 6289.8 6292.5 5942.0 5976.3 6051.5 6110.7 6120.2 6125.5 6142.0 6158.1 6196.9 6216.9 6186.6 6197.3 6201.2 6201.5 6202.0 5891.4 5905.4 5962.1 6101.9 6201.1 6040.1 6057.2 6060.5 6086.5 6095.7 02:07:13 INFO - PROCESS | 27277 | 02:07:13 INFO - PROCESS | 27277 | [#1] ext.html Cycles:180 Average:45002.82 Median:31350.61 stddev:70463.35 (224.8%) stddev-sans-first:70582.78 02:07:13 INFO - PROCESS | 27277 | Values: 778.1 827.3 858.7 915.3 943.1 31552.8 44466.8 45065.8 45224.3 45278.5 46176.5 46206.8 46558.1 46565.3 46768.8 7756.1 8004.8 9145.9 9262.9 9271.0 10236.7 10491.9 10497.0 10497.5 10786.6 10452.5 10537.1 10542.7 10554.0 10560.6 10477.3 10497.4 10507.0 10521.2 10522.5 10592.3 10612.9 10620.8 10630.6 10644.2 41862.5 42030.0 42066.4 42081.4 42102.8 4186.3 4225.2 4271.4 4357.3 4375.2 29991.6 30478.5 30877.2 30966.0 32238.7 4365.2 4458.9 4462.5 4472.4 4506.8 228314.0 230845.0 231096.8 231706.0 231861.0 53507.7 53938.2 53976.5 54011.2 54025.0 57321.4 57333.0 57353.4 57370.4 57375.7 16078.6 16347.2 16363.7 16372.2 16389.0 13067.7 13163.1 13930.2 14243.6 14249.6 13796.9 13955.7 13959.9 13976.1 14069.6 5560.0 5574.9 5635.9 5648.0 5754.4 1018.7 1029.1 1030.1 1032.5 1035.2 29071.7 29131.3 29197.9 29500.4 29694.0 1088.4 1090.4 1105.8 1122.6 1136.8 15485.2 15526.4 15541.7 15615.5 15661.4 294811.0 295267.0 297432.0 298282.0 298426.0 54794.2 59472.1 59529.7 59580.1 59625.0 1499.9 1533.3 1560.5 1564.5 1574.1 26504.7 27560.9 27817.3 27981.9 28150.3 43792.1 43834.8 43901.1 43966.0 44076.3 279081.0 280418.0 280914.0 281138.0 281630.0 30002.8 31148.4 35589.8 35623.6 36545.6 45114.3 45683.7 45813.8 45990.5 46394.3 34442.0 34872.5 34944.5 34973.5 35057.6 34890.3 34958.5 34967.5 35022.5 35579.8 39508.0 40106.8 40533.4 41189.6 41291.6 32562.2 33072.0 33096.0 33133.5 33797.8 26030.0 26984.9 27064.5 27170.0 27561.0 02:07:13 INFO - PROCESS | 27277 | 02:07:13 INFO - PROCESS | 27277 | [#2] jquery.html Cycles:180 Average:38946.30 Median:21173.58 stddev:112797.95 (532.7%) stddev-sans-first:113077.36 02:07:13 INFO - PROCESS | 27277 | Values: 463.6 467.4 483.4 484.7 491.8 18833.8 20229.6 20681.4 21144.4 21289.0 20613.9 21202.8 21665.6 22287.3 22310.8 6800.5 6850.4 6904.7 6961.5 7024.5 6771.5 6891.5 6897.6 7181.6 7478.3 7632.1 7651.7 7652.3 7652.7 7656.0 7466.3 7532.1 7579.4 7594.7 7610.8 7175.6 7349.8 7388.0 7398.9 7404.5 24271.6 24892.6 25182.6 25239.6 25346.7 3087.2 3188.0 3721.3 3810.3 3812.1 15614.5 16216.1 16557.2 16752.8 16929.2 2232.0 2277.7 2344.4 2354.6 2393.8 118862.0 122020.4 122481.4 123045.7 123375.4 18099.9 18421.8 18704.2 18865.4 19058.0 32047.4 32239.4 32276.8 32344.2 32445.8 10851.5 10871.8 10883.3 10941.3 11308.3 9309.1 9332.8 9364.9 9540.2 9596.0 9221.4 9269.6 9289.1 9500.3 9641.1 3791.2 3811.8 3880.7 4022.0 4042.6 1016.1 1144.6 1161.1 1173.9 1186.0 20137.2 21436.9 21559.6 21667.1 21729.3 1162.8 1170.2 1170.4 1185.5 1205.4 11386.3 11821.6 11834.6 11852.2 11863.5 668828.0 675981.0 683570.0 692995.0 701582.0 103449.5 116703.0 117531.0 118420.0 120069.0 1250.3 1250.5 1264.1 1265.2 1279.7 17612.5 18263.2 18390.5 18396.5 18431.0 49673.0 50418.5 50421.0 50746.2 51012.7 63436.4 67799.7 67927.0 68184.3 68633.7 12805.6 14061.6 14359.9 14482.2 14690.5 15425.0 15516.3 15701.5 15910.4 15993.2 13636.4 13691.5 13692.2 13776.7 13826.4 11989.0 12157.8 12198.5 12341.4 12382.4 13371.2 13526.7 13563.1 13650.8 13792.1 14255.7 14453.1 14469.4 14505.3 14548.6 12806.7 13027.0 13261.3 13328.1 13350.1 02:07:13 INFO - PROCESS | 27277 | 02:07:13 INFO - PROCESS | 27277 | [#3] mootools.html Cycles:180 Average:7232.23 Median:2389.15 stddev:4645.39 (194.4%) stddev-sans-first:4637.83 02:07:13 INFO - PROCESS | 27277 | Values: 1411.4 1556.5 1561.2 1565.2 1572.1 9502.9 11369.4 11585.2 11649.6 11657.4 11529.5 11587.4 11604.8 11637.2 11655.1 2066.8 2483.2 2520.1 2522.9 2534.2 2069.9 2366.8 2427.1 2433.6 2435.2 2411.8 2430.6 2433.4 2437.7 2441.8 2385.2 2385.2 2388.6 2389.0 2389.3 2298.7 2316.6 2322.6 2322.6 2324.0 11602.7 11721.5 11852.1 11854.3 11864.9 5875.9 6025.1 6032.1 6032.2 6034.5 3311.2 3420.4 3497.9 3560.9 3587.1 1323.3 1336.7 1347.2 1375.8 2322.4 17837.9 17936.1 18077.9 18123.3 18178.5 4757.5 4854.6 4868.5 4895.2 4921.3 12796.4 12810.8 12817.6 12829.0 12838.6 5920.7 5928.6 5929.8 5932.5 5932.6 4732.6 4892.5 5186.6 5351.7 5411.2 4031.0 4109.4 4167.6 4170.7 4208.0 1059.7 1074.2 1074.7 1085.6 1086.9 1075.4 1085.3 1091.6 1092.5 1102.2 7408.1 7463.8 7475.5 7614.0 7641.3 1086.9 1103.0 1122.7 1129.2 1145.3 4709.5 4863.1 5035.8 5048.3 5090.2 14561.1 14935.6 15059.1 15067.4 15138.7 14766.6 14814.5 15129.3 15135.7 15139.5 10828.7 10890.7 10891.8 10957.0 10982.6 7290.8 7409.9 7436.1 7452.9 7530.3 12823.8 12946.5 12957.2 13038.0 13115.7 12701.2 12767.7 12832.3 13467.5 13799.8 8242.5 8727.8 9698.0 9919.4 9938.6 10995.2 11077.6 11196.4 11207.2 11210.1 8792.9 8863.4 8903.8 9040.8 9173.1 8892.6 9080.5 9087.5 9129.2 9250.6 8613.3 8617.2 8618.1 8725.3 8739.1 6449.5 6529.9 6558.3 6615.8 6744.9 6437.3 6506.0 6666.3 6692.1 6819.3 02:07:13 INFO - PROCESS | 27277 | 02:07:13 INFO - PROCESS | 27277 | [#4] prototype.html Cycles:180 Average:4811.79 Median:5301.51 stddev:1282.21 (24.2%) stddev-sans-first:1242.57 02:07:13 INFO - PROCESS | 27277 | Values: 412.6 427.4 434.6 439.2 444.1 5132.1 5223.4 5258.6 5275.8 5345.5 4881.5 5281.3 5298.3 5304.7 5314.8 4292.8 4310.7 4339.4 4353.3 4353.8 4362.6 4370.5 4388.5 4399.3 4428.9 4404.6 4407.5 4413.8 4428.2 4435.2 4197.1 4340.3 4352.4 4366.7 4381.7 4078.8 4087.6 4112.0 4112.9 4156.4 5124.5 5134.7 5180.5 5181.8 5209.6 4993.6 5047.2 5129.2 5158.0 5205.8 5606.2 5614.3 5619.2 5644.8 5663.4 4631.8 4635.7 4684.0 4684.3 4726.8 5415.6 5448.0 5585.2 5588.8 5724.3 4621.5 4631.5 4664.0 4688.7 4697.0 4755.2 4788.9 4793.1 4797.6 4809.3 4933.4 4939.7 4963.4 5070.7 5100.3 5444.5 5454.9 5462.4 5487.8 5515.6 1632.0 1634.7 1640.4 1643.4 1646.5 1241.0 1267.5 1281.2 1285.9 1294.4 5337.1 5345.1 5404.0 5407.2 5433.4 5576.6 5578.9 5586.8 5672.2 5708.4 5295.3 5295.6 5367.0 5439.0 5445.9 2896.3 2945.7 2964.1 2969.8 2975.5 5775.4 5854.8 5873.8 5890.6 5911.8 5797.9 5800.3 5805.9 5834.0 5837.8 5870.2 5878.9 5879.7 5981.7 5984.4 5373.5 5621.1 5635.9 5644.2 5700.3 5456.8 5612.8 5624.3 5628.8 5679.0 5716.8 5763.0 5869.0 5871.9 5890.8 4736.6 4742.5 4747.4 4764.9 4766.6 5471.6 5635.0 5640.8 5670.4 5721.9 5488.3 5510.9 5547.9 5586.0 5618.2 5505.4 5511.7 5534.0 5554.9 5587.4 5294.7 5426.3 5481.5 5498.9 5514.2 5511.3 5518.6 5548.3 5551.3 5564.9 5288.3 5318.6 5406.9 5450.7 5524.2 02:07:13 INFO - PROCESS | 27277 | 02:07:13 INFO - PROCESS | 27277 | [#5] yui.html Cycles:180 Average:18724.11 Median:4866.93 stddev:22938.42 (471.3%) stddev-sans-first:22963.61 02:07:13 INFO - PROCESS | 27277 | Values: 875.5 892.8 898.7 902.6 911.1 16956.0 18180.1 18182.7 18198.4 18227.6 15711.6 15850.8 15876.4 15885.0 15889.7 693.9 711.9 867.9 869.1 897.8 893.6 898.8 899.7 899.8 899.8 725.9 938.1 939.9 940.1 940.3 742.6 743.2 744.5 923.9 947.1 695.3 695.8 696.0 696.1 696.4 17323.1 17417.0 17466.9 17474.1 17867.1 14829.9 15318.8 15388.7 15479.0 16043.7 14701.7 15044.7 15059.9 15092.8 15108.8 4864.4 4869.4 4902.7 4925.0 5049.9 60982.0 84099.2 86421.6 86767.0 86841.6 12484.7 12639.2 12644.2 12829.7 12881.9 22945.3 23017.8 23150.7 23327.8 23485.2 8388.3 8463.6 8556.8 8558.5 8678.6 4933.8 5048.0 5113.4 5173.8 5255.4 3478.7 3503.4 3509.7 3544.9 3572.2 622.4 623.4 628.2 633.5 634.5 769.3 771.0 777.5 802.8 821.5 10832.9 11327.2 11509.1 11613.6 11649.6 670.6 681.8 682.3 697.4 843.7 5592.2 5624.9 5640.9 5657.6 5719.9 76927.6 78893.0 79000.6 80743.6 80975.0 71557.3 72401.6 76380.0 77781.0 79361.6 53750.2 63561.7 63946.4 64571.4 64755.0 11325.0 11649.9 11658.9 11820.6 12085.3 37219.6 39850.8 40603.0 40739.2 41006.2 54597.7 56608.7 56954.7 59014.7 59392.0 13890.3 13974.6 14001.7 14252.3 14315.9 15812.2 15942.0 16039.5 16214.4 16719.7 15954.0 16310.1 16384.8 16449.9 17168.6 16030.5 16539.9 16550.6 16727.8 16940.0 15449.7 15810.6 16055.0 16202.5 16667.9 10993.5 11062.8 11205.7 11383.5 11495.9 12652.9 12785.2 12871.2 12895.8 13068.3 02:07:13 INFO - PROCESS | 27277 | -------- Summary: end -------- 02:07:13 INFO - PROCESS | 27277 | 02:07:14 INFO - TEST-INFO | 27277: exit 0 02:07:14 INFO - TEST-OK | dromaeo_css | took 1115599ms 02:07:14 INFO - TEST-START | kraken 02:07:14 INFO - operating with platform_type : linux_ 02:07:14 INFO - Initialising browser for kraken test... 02:07:14 INFO - TEST-INFO | started process 27607 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDNCMMr/profile http://localhost:34346/getInfo.html) 02:07:18 INFO - PROCESS | 27607 | __metrics Screen width/height:1600/1200 02:07:18 INFO - PROCESS | 27607 | colorDepth:24 02:07:18 INFO - PROCESS | 27607 | Browser inner width/height: 1024/697 02:07:18 INFO - PROCESS | 27607 | __metrics 02:07:19 INFO - PROCESS | 27607 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:07:19 INFO - PROCESS | 27607 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:07:20 INFO - TEST-INFO | 27607: exit 0 02:07:20 INFO - Browser initialized. 02:07:20 INFO - Running cycle 1/1 for kraken test... 02:07:20 INFO - TEST-INFO | started process 27699 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDNCMMr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:07:32 INFO - PROCESS | 27699 | RSS: Main: 140009472 02:07:32 INFO - PROCESS | 27699 | 02:07:34 INFO - PROCESS | 27699 | Cycle 1(1): loaded http://localhost:34346/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34346/tests/kraken/driver.html?testName=audio-beat-detection) 02:07:35 INFO - PROCESS | 27699 | RSS: Main: 183623680 02:07:35 INFO - PROCESS | 27699 | 02:07:38 INFO - PROCESS | 27699 | Cycle 1(1): loaded http://localhost:34346/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34346/tests/kraken/driver.html?testName=audio-dft) 02:07:38 INFO - PROCESS | 27699 | RSS: Main: 174342144 02:07:38 INFO - PROCESS | 27699 | 02:07:41 INFO - PROCESS | 27699 | Cycle 1(1): loaded http://localhost:34346/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34346/tests/kraken/driver.html?testName=audio-fft) 02:07:42 INFO - PROCESS | 27699 | RSS: Main: 265613312 02:07:42 INFO - PROCESS | 27699 | 02:07:44 INFO - PROCESS | 27699 | Cycle 1(1): loaded http://localhost:34346/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34346/tests/kraken/driver.html?testName=audio-oscillator) 02:07:44 INFO - PROCESS | 27699 | RSS: Main: 171487232 02:07:44 INFO - PROCESS | 27699 | 02:07:46 INFO - PROCESS | 27699 | Cycle 1(1): loaded http://localhost:34346/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34346/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:07:47 INFO - PROCESS | 27699 | RSS: Main: 173920256 02:07:47 INFO - PROCESS | 27699 | 02:07:50 INFO - PROCESS | 27699 | Cycle 1(1): loaded http://localhost:34346/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34346/tests/kraken/driver.html?testName=imaging-darkroom) 02:07:51 INFO - PROCESS | 27699 | RSS: Main: 209956864 02:07:51 INFO - PROCESS | 27699 | 02:07:54 INFO - PROCESS | 27699 | Cycle 1(1): loaded http://localhost:34346/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34346/tests/kraken/driver.html?testName=imaging-desaturate) 02:07:55 INFO - PROCESS | 27699 | RSS: Main: 211591168 02:07:55 INFO - PROCESS | 27699 | 02:07:57 INFO - PROCESS | 27699 | Cycle 1(1): loaded http://localhost:34346/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34346/tests/kraken/driver.html?testName=json-parse-financial) 02:07:58 INFO - PROCESS | 27699 | RSS: Main: 210477056 02:07:58 INFO - PROCESS | 27699 | 02:07:59 INFO - PROCESS | 27699 | Cycle 1(1): loaded http://localhost:34346/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34346/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:08:00 INFO - PROCESS | 27699 | RSS: Main: 172933120 02:08:00 INFO - PROCESS | 27699 | 02:08:02 INFO - PROCESS | 27699 | Cycle 1(1): loaded http://localhost:34346/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34346/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:08:02 INFO - PROCESS | 27699 | RSS: Main: 179699712 02:08:02 INFO - PROCESS | 27699 | 02:08:04 INFO - PROCESS | 27699 | Cycle 1(1): loaded http://localhost:34346/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34346/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:08:05 INFO - PROCESS | 27699 | RSS: Main: 188985344 02:08:05 INFO - PROCESS | 27699 | 02:08:07 INFO - PROCESS | 27699 | Cycle 1(1): loaded http://localhost:34346/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34346/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:08:08 INFO - PROCESS | 27699 | RSS: Main: 198635520 02:08:08 INFO - PROCESS | 27699 | 02:08:11 INFO - PROCESS | 27699 | Cycle 1(1): loaded http://localhost:34346/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34346/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:08:12 INFO - PROCESS | 27699 | RSS: Main: 194863104 02:08:12 INFO - PROCESS | 27699 | 02:08:13 INFO - PROCESS | 27699 | Cycle 1(1): loaded http://localhost:34346/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34346/tests/kraken/driver.html?testName=ai-astar) 02:08:13 INFO - PROCESS | 27699 | RSS: Main: 245342208 02:08:13 INFO - PROCESS | 27699 | 02:08:13 INFO - PROCESS | 27699 | __start_tp_report 02:08:13 INFO - PROCESS | 27699 | _x_x_mozilla_page_load 02:08:13 INFO - PROCESS | 27699 | _x_x_mozilla_page_load_details 02:08:13 INFO - PROCESS | 27699 | |i|pagename|runs| 02:08:13 INFO - PROCESS | 27699 | |0;ai-astar;102;112;112;113;116;113;112;113;114;113 02:08:13 INFO - PROCESS | 27699 | |1;audio-beat-detection;137;114;114;159;116;118;116;115;133;120 02:08:13 INFO - PROCESS | 27699 | |2;audio-dft;161;160;162;161;160;162;161;162;162;161 02:08:13 INFO - PROCESS | 27699 | |3;audio-fft;75;76;77;110;77;75;75;76;91;76 02:08:13 INFO - PROCESS | 27699 | |4;audio-oscillator;82;83;101;81;82;82;92;81;82;109 02:08:13 INFO - PROCESS | 27699 | |5;imaging-gaussian-blur;112;113;113;112;112;113;113;114;113;113 02:08:13 INFO - PROCESS | 27699 | |6;imaging-darkroom;146;146;146;147;146;146;146;147;146;147 02:08:13 INFO - PROCESS | 27699 | |7;imaging-desaturate;95;95;95;94;93;94;93;94;94;93 02:08:13 INFO - PROCESS | 27699 | |8;json-parse-financial;57;54;60;54;55;53;54;58;53;54 02:08:13 INFO - PROCESS | 27699 | |9;json-stringify-tinderbox;52;52;54;53;53;53;53;53;54;53 02:08:13 INFO - PROCESS | 27699 | |10;stanford-crypto-aes;80;75;76;81;75;79;75;79;84;82 02:08:13 INFO - PROCESS | 27699 | |11;stanford-crypto-ccm;123;124;122;127;121;121;131;118;161;122 02:08:13 INFO - PROCESS | 27699 | |12;stanford-crypto-pbkdf2;161;162;164;164;167;161;164;165;165;158 02:08:13 INFO - PROCESS | 27699 | |13;stanford-crypto-sha256-iterative;61;61;60;63;60;62;59;58;59;58 02:08:13 INFO - PROCESS | 27699 | __end_tp_report 02:08:13 INFO - PROCESS | 27699 | __start_cc_report 02:08:13 INFO - PROCESS | 27699 | _x_x_mozilla_cycle_collect,1684 02:08:13 INFO - PROCESS | 27699 | __end_cc_report 02:08:13 INFO - PROCESS | 27699 | __startTimestamp1492679293877__endTimestamp 02:08:13 INFO - PROCESS | 27699 | 02:08:13 INFO - PROCESS | 27699 | ------- Summary: start ------- 02:08:13 INFO - PROCESS | 27699 | Number of tests: 14 02:08:13 INFO - PROCESS | 27699 | 02:08:13 INFO - PROCESS | 27699 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:3.71 (3.3%) stddev-sans-first:1.27 02:08:13 INFO - PROCESS | 27699 | Values: 102.0 112.0 112.0 113.0 116.0 113.0 112.0 113.0 114.0 113.0 02:08:13 INFO - PROCESS | 27699 | 02:08:13 INFO - PROCESS | 27699 | [#1] audio-beat-detection Cycles:10 Average:124.20 Median:119.00 stddev:14.67 (12.3%) stddev-sans-first:14.81 02:08:13 INFO - PROCESS | 27699 | Values: 137.0 114.0 114.0 159.0 116.0 118.0 116.0 115.0 133.0 120.0 02:08:13 INFO - PROCESS | 27699 | 02:08:13 INFO - PROCESS | 27699 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 02:08:13 INFO - PROCESS | 27699 | Values: 161.0 160.0 162.0 161.0 160.0 162.0 161.0 162.0 162.0 161.0 02:08:13 INFO - PROCESS | 27699 | 02:08:13 INFO - PROCESS | 27699 | [#3] audio-fft Cycles:10 Average:80.80 Median:76.00 stddev:11.33 (14.9%) stddev-sans-first:11.82 02:08:13 INFO - PROCESS | 27699 | Values: 75.0 76.0 77.0 110.0 77.0 75.0 75.0 76.0 91.0 76.0 02:08:13 INFO - PROCESS | 27699 | 02:08:13 INFO - PROCESS | 27699 | [#4] audio-oscillator Cycles:10 Average:87.50 Median:82.00 stddev:9.95 (12.1%) stddev-sans-first:10.35 02:08:13 INFO - PROCESS | 27699 | Values: 82.0 83.0 101.0 81.0 82.0 82.0 92.0 81.0 82.0 109.0 02:08:13 INFO - PROCESS | 27699 | 02:08:13 INFO - PROCESS | 27699 | [#5] imaging-gaussian-blur Cycles:10 Average:112.80 Median:113.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 02:08:13 INFO - PROCESS | 27699 | Values: 112.0 113.0 113.0 112.0 112.0 113.0 113.0 114.0 113.0 113.0 02:08:13 INFO - PROCESS | 27699 | 02:08:13 INFO - PROCESS | 27699 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 02:08:13 INFO - PROCESS | 27699 | Values: 146.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 147.0 02:08:13 INFO - PROCESS | 27699 | 02:08:13 INFO - PROCESS | 27699 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 02:08:13 INFO - PROCESS | 27699 | Values: 95.0 95.0 95.0 94.0 93.0 94.0 93.0 94.0 94.0 93.0 02:08:13 INFO - PROCESS | 27699 | 02:08:13 INFO - PROCESS | 27699 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:54.50 stddev:2.35 (4.3%) stddev-sans-first:2.40 02:08:13 INFO - PROCESS | 27699 | Values: 57.0 54.0 60.0 54.0 55.0 53.0 54.0 58.0 53.0 54.0 02:08:13 INFO - PROCESS | 27699 | 02:08:13 INFO - PROCESS | 27699 | [#9] json-stringify-tinderbox Cycles:10 Average:53.00 Median:53.00 stddev:0.67 (1.3%) stddev-sans-first:0.60 02:08:13 INFO - PROCESS | 27699 | Values: 52.0 52.0 54.0 53.0 53.0 53.0 53.0 53.0 54.0 53.0 02:08:13 INFO - PROCESS | 27699 | 02:08:13 INFO - PROCESS | 27699 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:79.50 stddev:3.24 (4.1%) stddev-sans-first:3.40 02:08:13 INFO - PROCESS | 27699 | Values: 80.0 75.0 76.0 81.0 75.0 79.0 75.0 79.0 84.0 82.0 02:08:13 INFO - PROCESS | 27699 | 02:08:13 INFO - PROCESS | 27699 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:123.50 stddev:12.47 (10.1%) stddev-sans-first:13.14 02:08:13 INFO - PROCESS | 27699 | Values: 123.0 124.0 122.0 127.0 121.0 121.0 131.0 118.0 161.0 122.0 02:08:13 INFO - PROCESS | 27699 | 02:08:13 INFO - PROCESS | 27699 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:164.00 stddev:2.60 (1.6%) stddev-sans-first:2.65 02:08:13 INFO - PROCESS | 27699 | Values: 161.0 162.0 164.0 164.0 167.0 161.0 164.0 165.0 165.0 158.0 02:08:13 INFO - PROCESS | 27699 | 02:08:13 INFO - PROCESS | 27699 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.10 Median:60.50 stddev:1.66 (2.7%) stddev-sans-first:1.73 02:08:13 INFO - PROCESS | 27699 | Values: 61.0 61.0 60.0 63.0 60.0 62.0 59.0 58.0 59.0 58.0 02:08:13 INFO - PROCESS | 27699 | -------- Summary: end -------- 02:08:13 INFO - PROCESS | 27699 | 02:08:14 INFO - TEST-INFO | 27699: exit 0 02:08:14 INFO - TEST-OK | kraken | took 60256ms 02:08:14 INFO - SUITE-END | took 1175s 02:08:15 INFO - Completed test suite (00:19:35) 02:08:15 INFO - javascript benchmark 02:08:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7983.54069287628, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3432.742544309177, 3470.982645086775, 3478.4434490481526, 3483.2685136121413, 3522.33075715614, 5887.205227294314, 5945.910811337833, 5955.0, 5957.314908785485, 5971.641701497913, 5938.40615938406, 5970.164177015221, 5973.970130149343, 5980.312264089631, 5980.342162362148, 5245.213218017299, 5257.316548848645, 5284.524392804647, 5306.681599104047, 5337.492938170868, 5105.0, 5117.539421452068, 5350.036993341197, 5365.248865158861, 5367.409584945653, 5181.1451110566895, 5233.110371236899, 5246.947530524703, 5324.920126198091, 5340.759665815048, 5318.893622127555, 5333.2000199969925, 5338.62629615927, 5354.063038968165, 5359.678419294835, 5186.118359878829, 5230.424653288135, 5234.084035293847, 5295.68225906443, 5302.469753024667, 5628.409017053233, 5692.31692196939, 5778.479936805707, 5835.737391817378, 5854.707264636793, 6303.873922521524, 6310.6213627182515, 6313.526485513605, 6314.179156709644, 6318.4313411793155, 6375.87248255037, 6392.808215753535, 6394.9360506394805, 6395.712192951329, 6398.488120950313, 5610.298712660877, 5666.036773748431, 5828.12578113278, 5922.615030023121, 5947.821565353046, 6446.387593178641, 6483.902741458882, 6484.124643173205, 6502.122213501211, 6507.544471886922, 6243.125962365272, 6247.531435142382, 6248.593841400295, 6249.156363890907, 6251.718672659741, 6083.9391606084255, 6127.264728232641, 6280.842978925563, 6339.714712837934, 6344.777932772331, 6119.929102025404, 6142.069075791497, 6142.078688196806, 6152.415520525543, 6155.230596175478, 6038.154658347835, 6089.634621922699, 6098.969505152446, 6259.624422534663, 6266.436020758154, 4674.205385084544, 4707.670463067552, 4724.787384567703, 4729.2906064089975, 4736.171170045228, 4242.151569686075, 4263.70154089217, 4272.786360681954, 4276.764777937181, 4280.828766849291, 5906.0255057914965, 5947.167396564484, 6078.635281883101, 6119.5104391648565, 6170.56806023583, 6355.332690067568, 6391.296957334689, 6395.552311338161, 6396.5522413431545, 6401.807945761541, 6161.876762464725, 6170.969145154335, 6173.135760993465, 6176.197094377792, 6181.0, 5185.0, 5206.97396513015, 5282.867928301746, 5289.100852855024, 5372.570194384518, 6559.573627714279, 6570.638614876037, 6572.014197870262, 6574.605523668595, 6576.4410025147445, 6284.622922624657, 6286.308506064421, 6300.590461620163, 6302.810915672537, 6335.303116657072, 6217.689115544295, 6240.53196010292, 6396.9040464394, 6578.868422631616, 6585.341465853377, 6129.450483694133, 6129.847850912788, 6137.376985335611, 6153.538484613582, 6181.752729890754, 6284.120223168668, 6285.371462853678, 6287.497000239879, 6289.811305660837, 6292.528060395397, 5941.970290148522, 5976.252968378953, 6051.515878729603, 6110.7250173741395, 6120.204373431426, 6125.479334256638, 6141.969290153521, 6158.107074474086, 6196.907046394398, 6216.906746398718, 6186.566940314135, 6197.287311959182, 6201.1628430163155, 6201.472874805511, 6202.038684003986, 5891.381404952418, 5905.350411454822, 5962.07587823888, 6101.908471373022, 6201.131841542278, 6040.124181993674, 6057.21256236704, 6060.515158787198, 6086.482648974887, 6095.695215239131], "value": 5783.369654031332, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [778.0663204155015, 827.3050637464529, 858.6822875536053, 915.3043686798036, 943.1464524605235, 31552.84223578882, 44466.777666111666, 45065.77467112668, 45224.321635175496, 45278.54721452785, 46176.53823461764, 46206.76896615521, 46558.06883862321, 46565.30152047722, 46768.76615616926, 7756.0692716874055, 8004.759857204293, 9145.908540914572, 9262.861057084148, 9271.0, 10236.720409948757, 10491.947540262327, 10497.0, 10497.475126243695, 10786.622468213614, 10452.529636166353, 10537.104346130549, 10542.736431589234, 10553.997370249852, 10560.577576896952, 10477.31897426665, 10497.4226417547, 10507.0, 10521.158307335394, 10522.473876306192, 10592.25854190207, 10612.893871061267, 10620.840687389695, 10630.627928022483, 10644.201684873588, 41862.53481128146, 42030.0, 42066.36900446465, 42081.368779468336, 42102.78948605268, 4186.2919849038735, 4225.239456897757, 4271.380649805761, 4357.281048626973, 4375.234333991539, 29991.550126748116, 30478.54282185769, 30877.228069298224, 30966.0, 32238.6776132238, 4365.2142614329405, 4458.910821783578, 4462.531434199427, 4472.373867658531, 4506.842260520866, 228314.0, 230845.0, 231096.84451577804, 231706.0, 231861.0, 53507.732461337444, 53938.190927135336, 53976.46023539714, 54011.18983215255, 54025.0, 57321.426785732445, 57333.0, 57353.42646573564, 57370.42629573734, 57375.71312143413, 16078.598035049217, 16347.18264086791, 16363.672726545403, 16372.181390930406, 16389.0, 13067.673308167372, 13163.078584498993, 13930.233837139054, 14243.572692819233, 14249.572512824632, 13796.862031379558, 13955.720885582434, 13959.930200349136, 13976.091554048955, 14069.577912662637, 5560.0, 5574.86062848432, 5635.887282254332, 5647.971760141255, 5754.395788442153, 1018.6689325969089, 1029.1355261580309, 1030.1295405382439, 1032.488917985602, 1035.177034257767, 29071.709282907323, 29131.271718207216, 29197.854010730236, 29500.409991800043, 29694.0, 1088.3905013192636, 1090.4166271044953, 1105.7622611138643, 1122.6070875193616, 1136.8351589019712, 15485.22573871302, 15526.37894484208, 15541.689166216613, 15615.453459128876, 15661.373545058297, 294811.0, 295267.0, 297432.0, 298282.0, 298426.0, 54794.17808732872, 59472.10791838126, 59529.702351488835, 59580.10629840556, 59625.0, 1499.8725108365693, 1533.2563706602066, 1560.5162399656142, 1564.4915402494235, 1574.1106274954614, 26504.734952650997, 27560.862195688893, 27817.304567385978, 27981.860090699418, 28150.2962425941, 43792.12415751731, 43834.780826095666, 43901.121977560906, 43966.0, 44076.33885491784, 279081.0, 280418.0, 280914.0, 281138.0, 281630.0, 30002.84998574993, 31148.377032459677, 35589.82205088958, 35623.64376356307, 36545.63454365529, 45114.323285151404, 45683.71581420982, 45813.77093114513, 45990.540094598626, 46394.30408543807, 34442.0, 34872.47691284683, 34944.475832863034, 34973.47539786956, 35057.64942350544, 34890.302193956486, 34958.475622866186, 34967.475487868214, 35022.47466287957, 35579.82210088933, 39508.0, 40106.799466002485, 40533.39199911945, 41189.58810411858, 41291.58708412998, 32562.185945351557, 33072.0, 33096.004357082544, 33133.50299745554, 33797.83101084577, 26030.0, 26984.85589641656, 27064.458710826068, 27170.0, 27561.0], "value": 19286.099416826277, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.60593495528803, 467.3807205452776, 483.388513530384, 484.6897985289413, 491.840151950616, 18833.811661883377, 20229.59540809183, 20681.379558613266, 21144.365669029936, 21289.0, 20613.896930515362, 21202.787972120273, 21665.56668866622, 22287.331380058582, 22310.77689223107, 6800.489963252751, 6850.417714494274, 6904.723811047552, 6961.547499412547, 7024.543404678705, 6771.4921380896385, 6891.483138764587, 6897.6206308653, 7181.605011724353, 7478.326950574447, 7632.084149901992, 7651.732189373373, 7652.31129198372, 7652.732154374598, 7656.042994625672, 7466.328030477283, 7532.058492688414, 7579.431542634269, 7594.73418430355, 7610.8477830443635, 7175.569465832067, 7349.816254593625, 7387.963060184718, 7398.852022959564, 7404.4816862819625, 24271.63592546113, 24892.626610600855, 25182.622260666103, 25239.62140567893, 25346.746532534624, 3087.1818967973504, 3188.0, 3721.348763966322, 3810.333191691443, 3812.0660438192544, 15614.45349412765, 16216.108114053723, 16557.172141393003, 16752.83247167525, 16929.238184281738, 2232.0, 2277.749447560767, 2344.3553022918663, 2354.5526349993447, 2393.8324317297797, 118862.0, 122020.38989805082, 122481.38759306236, 123045.69340073144, 123375.38312308471, 18099.909500452675, 18421.815781842277, 18704.158312875952, 18865.396441302368, 19058.0, 32047.35905281928, 32239.35521289608, 32276.83861580677, 32344.191395215308, 32445.837770810995, 10851.51168197433, 10871.83692244617, 10883.346999180074, 10941.28881622708, 11308.264962777394, 9309.115634014757, 9332.813343733224, 9364.906350936404, 9540.236781057498, 9595.952020239854, 9221.354505184572, 9269.629214831466, 9289.117533834275, 9500.334976551576, 9641.132298093205, 3791.2227993261317, 3811.790351530637, 3880.728349015542, 4021.959780402217, 4042.5755295694116, 1016.065219997604, 1144.553624086607, 1161.1175506615034, 1173.9471723772451, 1186.0298792117133, 20137.19451221964, 21436.892815535823, 21559.56880862405, 21667.133314667237, 21729.348119556438, 1162.8255761635653, 1170.1574866096396, 1170.3621526268205, 1185.531714972581, 1205.4213977290774, 11386.316820990767, 11821.645350639494, 11834.585789497498, 11852.229605075643, 11863.525458981545, 668828.0, 675981.0, 683570.0, 692995.0, 701582.0, 103449.48275258727, 116703.0, 117531.0, 118420.0, 120069.0, 1250.2748405924724, 1250.4560516175493, 1264.0582765839508, 1265.1523479268913, 1279.654493286826, 17612.471625851245, 18263.17368263163, 18390.540236494195, 18396.540086497946, 18431.0, 49673.0, 50418.49581504138, 50420.98316067463, 50746.238806418674, 51012.74493627508, 63436.36563634489, 67799.66100169468, 67927.0, 68184.3181568178, 68633.65683171753, 12805.615831525069, 14061.578152655436, 14359.856401435853, 14482.203478808346, 14690.485832995793, 15425.0, 15516.301766420313, 15701.450449234222, 15910.443134490237, 15993.200339983186, 13636.386362613905, 13691.452341906212, 13692.178469291874, 13776.65558361049, 13826.446942122604, 11989.040876730016, 12157.817632735692, 12198.51205951752, 12341.444634991627, 12382.442790074649, 13371.197728136343, 13526.661833454242, 13563.118397304144, 13650.795238071238, 13792.103513271606, 14255.714885702435, 14453.132812031312, 14469.421223150955, 14505.347259373564, 14548.636284092983, 12806.743865122458, 13027.022973276853, 13261.270630115436, 13328.067035307435, 13350.065495415227], "value": 12043.44213150534, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1411.4495346814738, 1556.5211751734878, 1561.2427972433363, 1565.2330358124518, 1572.096044774255, 9502.904970950289, 11369.374684392355, 11585.246958947662, 11649.592264270752, 11657.41712914355, 11529.538818447252, 11587.36269505179, 11604.767904641902, 11637.243579167369, 11655.067594592434, 2066.7519897612306, 2483.242611003643, 2520.0549793827313, 2522.8864701088405, 2534.1510593951048, 2069.8654587451842, 2366.751491093436, 2427.1383658801137, 2433.5862903306393, 2435.1720415058876, 2411.7829395354415, 2430.635404689293, 2433.3673244956262, 2437.744036876129, 2441.7802397784194, 2385.153270588942, 2385.2009576791797, 2388.5581167483983, 2389.020501594338, 2389.2832150354825, 2298.701168848039, 2316.571434284646, 2322.5935461294375, 2322.605157123293, 2324.0, 11602.709932251677, 11721.472533735918, 11852.11109166816, 11854.3480108594, 11864.940675296568, 5875.941240587625, 6025.0661147522205, 6032.095185722133, 6032.245969253843, 6034.456898879122, 3311.2218628622254, 3420.401429749784, 3497.9475307870403, 3560.91097722559, 3587.121155316938, 1323.3052647360116, 1336.6591519162648, 1347.1714895339296, 1375.7867530532683, 2322.3845680894406, 17837.910810445865, 17936.103194840336, 18077.909610451996, 18123.275068997224, 18178.545536361566, 4757.500462451462, 4854.635902307341, 4868.464468908417, 4895.241237608177, 4921.335619691367, 12796.360181990864, 12810.80783788244, 12817.551385701643, 12829.0, 12838.55065072718, 5920.674362909996, 5928.644281343047, 5929.822105336847, 5932.49573786233, 5932.614380065282, 4732.550407711262, 4892.461829198785, 5186.63693541456, 5351.652142610717, 5411.18832175169, 4030.979845100756, 4109.404136400205, 4167.604077612683, 4170.706111638648, 4208.0, 1059.7191744187796, 1074.1997212077054, 1074.7044562745152, 1085.5766251162054, 1086.9076128529164, 1075.44077079918, 1085.3162507620307, 1091.612477570467, 1092.4810714910354, 1102.1568500097433, 7408.073990751156, 7463.776086717407, 7475.4767166298925, 7614.0, 7641.312281894656, 1086.8641419822522, 1103.0, 1122.6912599035331, 1129.2434069173673, 1145.255583870491, 4709.529047095263, 4863.148948933923, 5035.84892453227, 5048.343715316985, 5090.2364645303505, 14561.053531520418, 14935.626609334853, 15059.096454212782, 15067.397304107932, 15138.697226055418, 14766.630834229016, 14814.481493147689, 15129.319180636898, 15135.697286054437, 15139.54581362561, 10828.72928176786, 10890.673279801777, 10891.83662245067, 10957.0, 10982.560697572168, 7290.817729556804, 7409.925900741139, 7436.144843342869, 7452.888206677013, 7530.322270995636, 12823.807642885178, 12946.482140714643, 12957.157784743962, 13038.0, 13115.737685246433, 12701.174423662433, 12767.738784622929, 12832.29422381778, 13467.461301547828, 13799.793003105162, 8242.546659933761, 8727.825443490967, 9697.951510242403, 9919.40483570988, 9938.602455901972, 10995.230333876552, 11077.556897724, 11196.38419886914, 11207.159463040141, 11210.103191744478, 8792.919651932316, 8863.379563430755, 8903.821923561363, 9040.773980650536, 9173.08269173104, 8892.555372231232, 9080.500572468578, 9087.54562271897, 9129.178373946377, 9250.629974800933, 8613.31093512505, 8617.224449799549, 8618.09510001466, 8725.258353040063, 8739.082396348293, 6449.516286278454, 6529.9347006531225, 6558.278589355072, 6615.801525954229, 6744.898826517508, 6437.259715132633, 6505.967470162619, 6666.300038495888, 6692.096566963398, 6819.318068193339], "value": 5478.193046887289, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.62657295147864, 427.3610951627318, 434.6088520331701, 439.1502442773234, 444.13615517817817, 5132.075471698113, 5223.3731952165745, 5258.579313654913, 5275.762590683419, 5345.545628621572, 4881.511848815126, 5281.287026251455, 5298.337707786527, 5304.681719096857, 5314.76083576239, 4292.806823692941, 4310.698251122422, 4339.39248505208, 4353.303471444569, 4353.804078816445, 4362.5637436256275, 4370.475542934836, 4388.473383194021, 4399.2521271383785, 4428.867133985986, 4404.603585677289, 4407.471103467588, 4413.764146039114, 4428.225060614395, 4435.246008178601, 4197.097624010837, 4340.305551111807, 4352.368906508538, 4366.672499562545, 4381.693281470299, 4078.7559794263034, 4087.550369459357, 4111.958880411187, 4112.856050038235, 4156.418101465797, 5124.5131712487255, 5134.743262836881, 5180.456052114511, 5181.844544663666, 5209.583233341324, 4993.575546078588, 5047.242913562958, 5129.179331306973, 5158.039944820944, 5205.791768329263, 5606.243157173811, 5614.29821272341, 5619.157126431027, 5644.774209031634, 5663.405342439026, 4631.768411579407, 4635.6986795858165, 4683.976580117112, 4684.344191813149, 4726.810927562893, 5415.593830462692, 5448.0, 5585.2459917910965, 5588.776448942078, 5724.341700704431, 4621.468531118897, 4631.467381251132, 4663.953360466419, 4688.742119183477, 4696.990147118386, 4755.19302664992, 4788.880277993078, 4793.113274044244, 4797.64017698674, 4809.254565542346, 4933.383327084114, 4939.711221405137, 4963.354763880672, 5070.721110338893, 5100.311457953203, 5444.5155100735565, 5454.945450545444, 5462.426445223195, 5487.8048780488125, 5515.586331025189, 1631.967360652804, 1634.7466142747894, 1640.3520609359236, 1643.3837311008372, 1646.4731285988369, 1241.00248496914, 1267.473998290699, 1281.1672412931669, 1285.9228446293253, 1294.4304506017322, 5337.051976028722, 5345.118055520873, 5404.000779567299, 5407.161889907071, 5433.375161856437, 5576.553875689935, 5578.860528486739, 5586.776528938797, 5672.177534257592, 5708.372079071299, 5295.338082739658, 5295.576353891679, 5366.973165134149, 5438.966596346681, 5445.863853403696, 2896.304886827146, 2945.6759756426777, 2964.1107667699603, 2969.7624190064744, 2975.4792911240447, 5775.422457754191, 5854.795082172189, 5873.765049398062, 5890.556813580614, 5911.793087241926, 5797.855053623609, 5800.274965629296, 5805.912911306334, 5833.970830145822, 5837.824865254049, 5870.207521984563, 5878.942370170406, 5879.735411906475, 5981.700914954235, 5984.371640977634, 5373.489518495737, 5621.11413518453, 5635.9436405635415, 5644.209810626598, 5700.25896633435, 5456.8267822418375, 5612.803551875828, 5624.268845050117, 5628.774849005994, 5679.0, 5716.828495145152, 5762.971185144047, 5869.0, 5871.911921321098, 5890.764369425347, 4736.550027747358, 4742.478327384054, 4747.359106520576, 4764.928526072043, 4766.570028991358, 5471.589630777628, 5635.0, 5640.802571909963, 5670.404607516316, 5721.8569535761935, 5488.286522752017, 5510.889782204414, 5547.861303467445, 5585.9720701397855, 5618.2134501170685, 5505.421476040446, 5511.696856672921, 5533.972330138324, 5554.944450555443, 5587.385387607441, 5294.655847369909, 5426.348838139291, 5481.451854814487, 5498.945010549844, 5514.200440936122, 5511.283533140827, 5518.586106042143, 5548.334199896039, 5551.278333816578, 5564.888702226014, 5288.338957630296, 5318.574514038945, 5406.918896216481, 5450.700211488406, 5524.1989911463415], "value": 4441.88799458843, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [875.4762082617464, 892.7589550821278, 898.6719847255749, 902.6028547439122, 911.0616065452584, 16956.0, 18180.090995450242, 18182.72725909109, 18198.363057292998, 18227.635447291064, 15711.60720981976, 15850.84149158508, 15876.444324448647, 15885.0, 15889.682206355867, 693.8646963842053, 711.8967749676294, 867.8784970104191, 869.1221865915439, 897.7710683775628, 893.6068130022802, 898.8157427727333, 899.7390756680555, 899.7570655922897, 899.8470260055774, 725.8548290341927, 938.0572524612788, 939.8543225799978, 940.0693313619502, 940.2759874896326, 742.5952855693633, 743.1899229839447, 744.4900243333334, 923.9307051971061, 947.0907928388755, 695.2560759986816, 695.7634404302511, 695.9686814093327, 696.0742212856939, 696.4393663101201, 17323.133843307784, 17417.04206268655, 17466.864653797464, 17474.126293685265, 17867.106644667714, 14829.925850370788, 15318.846811531854, 15388.692226155526, 15479.0, 16043.679126417523, 14701.705965880623, 15044.699106017928, 15059.924700376538, 15092.849071509254, 15108.848911510853, 4864.416270047617, 4869.440014398354, 4902.730349830758, 4925.0, 5049.924251136199, 60982.0, 84099.15900840974, 86421.56789216076, 86767.0, 86841.56579217127, 12484.655288480633, 12639.1784534005, 12644.178128421623, 12829.743405131845, 12881.871181288067, 22945.31164065081, 23017.769822301896, 23150.65274020891, 23327.766722332897, 23485.17801876926, 8388.32893368529, 8463.619137138843, 8556.786080347916, 8558.486490810572, 8678.609462574199, 4933.753312334369, 5048.0, 5113.437521872591, 5173.81891633791, 5255.395629502656, 3478.704310133616, 3503.404421248394, 3509.701675357572, 3544.8936531904083, 3572.1962558424148, 622.3838399983983, 623.3735096228352, 628.1739512540994, 633.5058654249692, 634.5019159959502, 769.3460558525209, 770.9922900770921, 777.4790890103644, 802.7993001749562, 821.5153059694809, 10832.893255348186, 11327.207095503236, 11509.13681473876, 11613.593524226611, 11649.59226427071, 670.5842377725842, 681.7954613615896, 682.3415404134935, 697.4240943655507, 843.6751850537464, 5592.189132575753, 5624.887502250014, 5640.900024495266, 5657.60396772222, 5719.942800572025, 76927.61536192395, 78893.0, 79000.60499697465, 80743.59628201822, 80975.0, 71557.2844271561, 72401.63799180971, 76380.0, 77781.0, 79361.60319198483, 53750.19374709383, 63561.68219158875, 63946.36053639497, 64571.35428645653, 64755.0, 11325.0, 11649.88350116488, 11658.941705291758, 11820.586279480176, 12085.335306557872, 37219.62780372162, 39850.800745996086, 40603.0, 40739.1852162961, 41006.17987640171, 54597.72701136469, 56608.71695641495, 56954.71522642526, 59014.70492647509, 59392.0, 13890.30548472552, 13974.58076257714, 14001.719965600427, 14252.28738563047, 14315.928420357832, 15812.209389530708, 15941.96377235476, 16039.518814435585, 16214.351425943301, 16719.665606688042, 15954.0, 16310.102944338176, 16384.83615163833, 16449.871119243042, 17168.570785730455, 16030.51908442702, 16539.91730041342, 16550.629772884768, 16727.83272167263, 16940.0, 15449.691006180039, 15810.60473488172, 16055.0, 16202.513924582281, 16667.916660417104, 10993.505292262027, 11062.834057489305, 11205.663830084784, 11383.54465821358, 11495.885041149482, 12652.873471265537, 12785.16896401731, 12871.163374380636, 12895.843549849302, 13068.346582671018], "value": 7920.510773543027, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1455.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 112.0, 113.0, 116.0, 113.0, 112.0, 113.0, 114.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 114.0, 114.0, 159.0, 116.0, 118.0, 116.0, 115.0, 133.0, 120.0], "value": 124.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 161.0, 160.0, 162.0, 161.0, 162.0, 162.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 110.0, 77.0, 75.0, 75.0, 76.0, 91.0, 76.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 101.0, 81.0, 82.0, 82.0, 92.0, 81.0, 82.0, 109.0], "value": 87.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 113.0, 112.0, 112.0, 113.0, 113.0, 114.0, 113.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 93.0, 94.0, 93.0, 94.0, 94.0, 93.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 60.0, 54.0, 55.0, 53.0, 54.0, 58.0, 53.0, 54.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 54.0, 53.0, 53.0, 53.0, 53.0, 53.0, 54.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 75.0, 76.0, 81.0, 75.0, 79.0, 75.0, 79.0, 84.0, 82.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 124.0, 122.0, 127.0, 121.0, 121.0, 131.0, 118.0, 161.0, 122.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 164.0, 164.0, 167.0, 161.0, 164.0, 165.0, 165.0, 158.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 63.0, 60.0, 62.0, 59.0, 58.0, 59.0, 58.0], "value": 60.1, "unit": "score"}]}]} 02:08:15 INFO - Return code: 0 02:08:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:08:15 ERROR - # TBPL SUCCESS # 02:08:15 INFO - Running post-action listener: _resource_record_post_action 02:08:15 INFO - [mozharness: 2017-04-20 09:08:15.181055Z] Finished run-tests step (success) 02:08:15 INFO - Running post-run listener: _resource_record_post_run 02:08:15 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 266240; Write bytes: 365527040; Read time: 32; Write time: 212732 02:08:15 INFO - TinderboxPrint: CPU usage
13.1% 02:08:15 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 02:08:15 INFO - TinderboxPrint: I/O write bytes / time
365,527,040 / 212,732 02:08:15 INFO - TinderboxPrint: CPU idle
8,271.0 (86.9%) 02:08:15 INFO - TinderboxPrint: CPU user
1,203.2 (12.6%) 02:08:15 INFO - TinderboxPrint: Swap in / out
0 / 0 02:08:15 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110997504; Read time: 0; Write time: 73944 02:08:15 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 266240; Write bytes: 254529536; Read time: 32; Write time: 138788 02:08:15 INFO - Running post-run listener: _upload_blobber_files 02:08:15 INFO - Blob upload gear active. 02:08:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:08:15 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 02:08:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:08:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:08:16 INFO - (blobuploader) - INFO - Open directory for files ... 02:08:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:08:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:08:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:08:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:08:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:08:17 INFO - (blobuploader) - INFO - Done attempting. 02:08:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:08:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:08:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:08:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:08:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:08:17 INFO - (blobuploader) - INFO - Done attempting. 02:08:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:08:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:08:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:08:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:08:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:08:18 INFO - (blobuploader) - INFO - Done attempting. 02:08:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:08:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:08:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:08:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:08:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:08:21 INFO - (blobuploader) - INFO - Done attempting. 02:08:21 INFO - (blobuploader) - INFO - Iteration through files over. 02:08:21 INFO - Return code: 0 02:08:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:08:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:08:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3cd2a2714df3fa257e23b2f6dd742d8630feceb809ebfbf96703f89376e63794eb5e33af2f3995fcacb1c908a409226158005d221de9e57f8d6c02033dbf4fd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8e9f5cd2f9429bd0a9801c10412a33065de5c86d0a570f728f1543817337821d2d31333cb26eb62e543fd94cf596ec86fb745f1ffaabfd096aaa54256fd1b483", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/617104e6011e171ae72107371cc8574f53c9cbb5d9ce296a80ad31786b2cf2a6d08c444e80792de9bed47b4ea1e2dd0aa6ada1012e7fd0ecaff665ff66b3429f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/58b4e09583145a607c2913ad62b66e97914e0af9dcd2cab47cc2af98126c86c93c5ab465f26092118ee09419f20d85d6d5a81f476e0da9b936d412b7cca77352"} 02:08:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:08:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:08:21 INFO - Contents: 02:08:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3cd2a2714df3fa257e23b2f6dd742d8630feceb809ebfbf96703f89376e63794eb5e33af2f3995fcacb1c908a409226158005d221de9e57f8d6c02033dbf4fd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8e9f5cd2f9429bd0a9801c10412a33065de5c86d0a570f728f1543817337821d2d31333cb26eb62e543fd94cf596ec86fb745f1ffaabfd096aaa54256fd1b483", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/617104e6011e171ae72107371cc8574f53c9cbb5d9ce296a80ad31786b2cf2a6d08c444e80792de9bed47b4ea1e2dd0aa6ada1012e7fd0ecaff665ff66b3429f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/58b4e09583145a607c2913ad62b66e97914e0af9dcd2cab47cc2af98126c86c93c5ab465f26092118ee09419f20d85d6d5a81f476e0da9b936d412b7cca77352"} 02:08:21 INFO - Running post-run listener: copy_logs_to_upload_dir 02:08:21 INFO - Copying logs to upload dir... 02:08:21 INFO - mkdir: /builds/slave/test/build/upload/logs 02:08:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.243751 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-04-20 02:08:20.693113) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-20 02:08:20.696370) ========= 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=2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3cd2a2714df3fa257e23b2f6dd742d8630feceb809ebfbf96703f89376e63794eb5e33af2f3995fcacb1c908a409226158005d221de9e57f8d6c02033dbf4fd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8e9f5cd2f9429bd0a9801c10412a33065de5c86d0a570f728f1543817337821d2d31333cb26eb62e543fd94cf596ec86fb745f1ffaabfd096aaa54256fd1b483", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/617104e6011e171ae72107371cc8574f53c9cbb5d9ce296a80ad31786b2cf2a6d08c444e80792de9bed47b4ea1e2dd0aa6ada1012e7fd0ecaff665ff66b3429f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/58b4e09583145a607c2913ad62b66e97914e0af9dcd2cab47cc2af98126c86c93c5ab465f26092118ee09419f20d85d6d5a81f476e0da9b936d412b7cca77352"} build_url:https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011389 build_url: 'https://queue.taskcluster.net/v1/task/Ji1ivWJTQOGswYLN_Sllpw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3cd2a2714df3fa257e23b2f6dd742d8630feceb809ebfbf96703f89376e63794eb5e33af2f3995fcacb1c908a409226158005d221de9e57f8d6c02033dbf4fd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8e9f5cd2f9429bd0a9801c10412a33065de5c86d0a570f728f1543817337821d2d31333cb26eb62e543fd94cf596ec86fb745f1ffaabfd096aaa54256fd1b483", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/617104e6011e171ae72107371cc8574f53c9cbb5d9ce296a80ad31786b2cf2a6d08c444e80792de9bed47b4ea1e2dd0aa6ada1012e7fd0ecaff665ff66b3429f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/58b4e09583145a607c2913ad62b66e97914e0af9dcd2cab47cc2af98126c86c93c5ab465f26092118ee09419f20d85d6d5a81f476e0da9b936d412b7cca77352"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-20 02:08:20.723345) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 02:08:20.723648) ========= 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=2432103b8b3de4003b23cad4000001c2-1492677499.656428-1612135990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004609 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 02:08:20.808131) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-20 02:08:20.808440) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-20 02:08:20.808738) ========= ========= Total master_lag: 0.18 =========