builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-001 starttime: 1486353423.04 results: success (0) revision: c3d208c04d8b68ed20a0b62c2f9a5bcc83aa9349 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-05 19:57:03.044088) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-05 19:57:03.044609) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-05 19:57:03.044895) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-05 19:57:03.062148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:57:03.062511) ========= 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=8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-05 19:57:03-- 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% 26.9M=0s 2017-02-05 19:57:03 (26.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122078 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:57:03.198022) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:57:03.198355) ========= 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=8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017812 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:57:03.260262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-05 19:57:03.260616) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c3d208c04d8b68ed20a0b62c2f9a5bcc83aa9349 --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 c3d208c04d8b68ed20a0b62c2f9a5bcc83aa9349 --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=8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-05 19:57:03,757 truncating revision to first 12 chars 2017-02-05 19:57:03,757 Setting DEBUG logging. 2017-02-05 19:57:03,757 attempt 1/10 2017-02-05 19:57:03,758 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c3d208c04d8b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-05 19:57:04,723 unpacking tar archive at: mozilla-aurora-c3d208c04d8b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.305405 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-05 19:57:04.578627) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-05 19:57:04.578951) ========= script_repo_revision: c3d208c04d8b68ed20a0b62c2f9a5bcc83aa9349 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-05 19:57:04.579343) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-05 19:57:04.579630) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-05 19:57:04.589336) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-02-05 19:57:04.589629) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:57:05 INFO - MultiFileLogger online at 20170205 19:57:05 in /builds/slave/test 19:57:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 19:57:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:57:05 INFO - {'append_to_log': False, 19:57:05 INFO - 'base_work_dir': '/builds/slave/test', 19:57:05 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 19:57:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:57:05 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 19:57:05 INFO - 'buildbot_json_path': 'buildprops.json', 19:57:05 INFO - 'config_files': ('talos/linux_config.py',), 19:57:05 INFO - 'default_actions': ('clobber', 19:57:05 INFO - 'read-buildbot-config', 19:57:05 INFO - 'download-and-extract', 19:57:05 INFO - 'populate-webroot', 19:57:05 INFO - 'create-virtualenv', 19:57:05 INFO - 'install', 19:57:05 INFO - 'run-tests'), 19:57:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:57:05 INFO - 'download_minidump_stackwalk': True, 19:57:05 INFO - 'download_symbols': 'ondemand', 19:57:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:57:05 INFO - 'tooltool.py': '/tools/tooltool.py', 19:57:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:57:05 INFO - '/tools/misc-python/virtualenv.py')}, 19:57:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:57:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:57:05 INFO - 'installer_path': 'installer.exe', 19:57:05 INFO - 'log_level': 'info', 19:57:05 INFO - 'log_name': 'talos', 19:57:05 INFO - 'log_to_console': True, 19:57:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:57:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:57:05 INFO - 'opt_config_files': (), 19:57:05 INFO - 'pip_index': False, 19:57:05 INFO - 'sps_profile': False, 19:57:05 INFO - 'sps_profile_interval': 0, 19:57:05 INFO - 'suite': 'dromaeojs-e10s', 19:57:05 INFO - 'system_bits': '32', 19:57:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:57:05 INFO - 'title': 'talos-linux64-ix-001', 19:57:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:57:05 INFO - 'use_talos_json': True, 19:57:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:57:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:57:05 INFO - 'work_dir': 'build'} 19:57:05 INFO - [mozharness: 2017-02-06 03:57:05.189261Z] Running clobber step. 19:57:05 INFO - Running pre-action listener: _resource_record_pre_action 19:57:05 INFO - Running main action method: clobber 19:57:05 INFO - rmtree: /builds/slave/test/build 19:57:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:57:06 INFO - Running post-action listener: _resource_record_post_action 19:57:06 INFO - [mozharness: 2017-02-06 03:57:06.223930Z] Finished clobber step (success) 19:57:06 INFO - [mozharness: 2017-02-06 03:57:06.224029Z] Running read-buildbot-config step. 19:57:06 INFO - Running pre-action listener: _resource_record_pre_action 19:57:06 INFO - Running main action method: read_buildbot_config 19:57:06 INFO - Using buildbot properties: 19:57:06 INFO - { 19:57:06 INFO - "project": "", 19:57:06 INFO - "product": "firefox", 19:57:06 INFO - "who": "philringnalda@gmail.com", 19:57:06 INFO - "installer_path": "public/build/target.tar.bz2", 19:57:06 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 19:57:06 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 19:57:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs-e10s", 19:57:06 INFO - "stage_platform": "linux64", 19:57:06 INFO - "basedir": "/builds/slave/test", 19:57:06 INFO - "buildnumber": 23, 19:57:06 INFO - "platform": "ubuntu64_hw", 19:57:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:57:06 INFO - "slavebuilddir": "test", 19:57:06 INFO - "taskId": "SzGNHj8WROaiQTfFzS_9Tw", 19:57:06 INFO - "branch": "mozilla-aurora", 19:57:06 INFO - "script_repo_revision": "production", 19:57:06 INFO - "revision": "c3d208c04d8b68ed20a0b62c2f9a5bcc83aa9349", 19:57:06 INFO - "slavename": "talos-linux64-ix-001", 19:57:06 INFO - "repo_path": "releases/mozilla-aurora" 19:57:06 INFO - } 19:57:06 INFO - Finding installer, test and symbols from parent task. 19:57:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SzGNHj8WROaiQTfFzS_9Tw'}, attempt #1 19:57:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SzGNHj8WROaiQTfFzS_9Tw'}, attempt #1 19:57:07 INFO - Task dependencies: IBIBD-rIQkmnSQbT_PewuA 19:57:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA'}, attempt #1 19:57:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/target.tar.bz2 19:57:07 INFO - Set test_url: https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/test_packages.json 19:57:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/target.crashreporter-symbols.zip 19:57:07 INFO - Running post-action listener: _resource_record_post_action 19:57:07 INFO - [mozharness: 2017-02-06 03:57:07.612385Z] Finished read-buildbot-config step (success) 19:57:07 INFO - [mozharness: 2017-02-06 03:57:07.612602Z] Running download-and-extract step. 19:57:07 INFO - Running pre-action listener: _resource_record_pre_action 19:57:07 INFO - Running main action method: download_and_extract 19:57:07 INFO - mkdir: /builds/slave/test/build/tests 19:57: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')]} 19:57:07 INFO - trying https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/target.test_packages.json 19:57:07 INFO - Downloading https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:57:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:57:08 INFO - Downloaded 896 bytes. 19:57:08 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:57:08 INFO - Using the following test package requirements: 19:57:08 INFO - {u'common': [u'target.common.tests.zip'], 19:57:08 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:57:08 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:57:08 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:57:08 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:57:08 INFO - u'mozbase': [u'target.common.tests.zip'], 19:57:08 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:57:08 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:57:08 INFO - u'web-platform': [u'target.common.tests.zip', 19:57:08 INFO - u'target.web-platform.tests.zip'], 19:57:08 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:57:08 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:57:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/target.common.tests.zip 19:57:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:57:08 INFO - Fetch https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/target.common.tests.zip into memory 19:57:08 INFO - Expected file size: 21852801 19:57:08 INFO - Obtained file size: 21852801 19:57:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:57:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/target.common.tests.zip 19:57:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:57:13 INFO - Fetch https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/target.common.tests.zip into memory 19:57:13 INFO - Expected file size: 21852801 19:57:13 INFO - Obtained file size: 21852801 19:57:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/target.talos.tests.zip 19:57:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:57:18 INFO - Fetch https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/target.talos.tests.zip into memory 19:57:19 INFO - Expected file size: 14403485 19:57:19 INFO - Obtained file size: 14403485 19:57:19 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')]} 19:57:19 INFO - trying https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/target.tar.bz2 19:57:19 INFO - Downloading https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:57:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:57:20 INFO - Downloaded 66041114 bytes. 19:57:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/target.tar.bz2 19:57:20 INFO - mkdir: /builds/slave/test/properties 19:57:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:57:20 INFO - Writing to file /builds/slave/test/properties/build_url 19:57:20 INFO - Contents: 19:57:20 INFO - build_url:https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/target.tar.bz2 19:57:20 INFO - Running post-action listener: _resource_record_post_action 19:57:20 INFO - Running post-action listener: set_extra_try_arguments 19:57:20 INFO - [mozharness: 2017-02-06 03:57:20.611595Z] Finished download-and-extract step (success) 19:57:20 INFO - [mozharness: 2017-02-06 03:57:20.611691Z] Running populate-webroot step. 19:57:20 INFO - Running pre-action listener: _resource_record_pre_action 19:57:20 INFO - Running main action method: populate_webroot 19:57:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:57:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:57:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:57:20 INFO - '--tppagecycles', 19:57:20 INFO - '7'], 19:57:20 INFO - 'tests': ['tsvgm']}}, 19:57:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:57:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:57:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:57:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:57:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:57:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:57:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:57:20 INFO - 'talos_options': ['--disable-e10s'], 19:57:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:57:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:57:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:57:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:57:20 INFO - 'talos_options': ['--disable-e10s'], 19:57:20 INFO - 'tests': ['damp', 'tps']}, 19:57:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:57:20 INFO - 'tests': ['damp', 'tps']}, 19:57:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:57:20 INFO - 'tests': ['dromaeo_dom']}, 19:57:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:57:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:57:20 INFO - 'tests': ['basic_compositor_video']}, 19:57:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:57:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:57:20 INFO - 'tests': ['a11yr', 19:57:20 INFO - 'ts_paint', 19:57:20 INFO - 'tpaint', 19:57:20 INFO - 'sessionrestore', 19:57:20 INFO - 'sessionrestore_no_auto_restore', 19:57:20 INFO - 'tabpaint']}, 19:57:20 INFO - 'other-e10s': {'tests': ['a11yr', 19:57:20 INFO - 'ts_paint', 19:57:20 INFO - 'tpaint', 19:57:20 INFO - 'sessionrestore', 19:57:20 INFO - 'sessionrestore_no_auto_restore', 19:57:20 INFO - 'tabpaint']}, 19:57:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:57:20 INFO - 'ts_paint', 19:57:20 INFO - 'tpaint', 19:57:20 INFO - 'sessionrestore', 19:57:20 INFO - 'sessionrestore_no_auto_restore', 19:57:20 INFO - 'tabpaint']}, 19:57:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:57:20 INFO - 'ts_paint', 19:57:20 INFO - 'tpaint', 19:57:20 INFO - 'sessionrestore', 19:57:20 INFO - 'sessionrestore_no_auto_restore', 19:57:20 INFO - 'tabpaint']}, 19:57:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:57:20 INFO - 'tests': ['a11yr', 19:57:20 INFO - 'ts_paint', 19:57:20 INFO - 'tpaint', 19:57:20 INFO - 'sessionrestore', 19:57:20 INFO - 'sessionrestore_no_auto_restore', 19:57:20 INFO - 'tabpaint']}, 19:57:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:57:20 INFO - 'tests': ['a11yr', 19:57:20 INFO - 'ts_paint', 19:57:20 INFO - 'tpaint', 19:57:20 INFO - 'sessionrestore', 19:57:20 INFO - 'sessionrestore_no_auto_restore', 19:57:20 INFO - 'tabpaint']}, 19:57:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:57:20 INFO - 'tests': ['tsvgx', 19:57:20 INFO - 'tsvgr_opacity', 19:57:20 INFO - 'tart', 19:57:20 INFO - 'tscrollx', 19:57:20 INFO - 'cart', 19:57:20 INFO - 'tsvg_static']}, 19:57:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:57:20 INFO - 'tsvgr_opacity', 19:57:20 INFO - 'tart', 19:57:20 INFO - 'tscrollx', 19:57:20 INFO - 'cart', 19:57:20 INFO - 'tsvg_static']}, 19:57:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:57:20 INFO - 'talos_options': ['--disable-e10s'], 19:57:20 INFO - 'tests': ['tp5o']}, 19:57:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:57:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:57:20 INFO - 'talos_options': ['--disable-e10s', 19:57:20 INFO - '--xperf_path', 19:57:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:57:20 INFO - 'tests': ['tp5n']}, 19:57:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:57:20 INFO - 'talos_options': ['--xperf_path', 19:57:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:57:20 INFO - 'tests': ['tp5n']}}, 19:57:20 INFO - 'talos.zip': {'path': '', 19:57:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:57:20 INFO - Running post-action listener: _resource_record_post_action 19:57:20 INFO - [mozharness: 2017-02-06 03:57:20.624784Z] Finished populate-webroot step (success) 19:57:20 INFO - [mozharness: 2017-02-06 03:57:20.624873Z] Running create-virtualenv step. 19:57:20 INFO - Running pre-action listener: _resource_record_pre_action 19:57:20 INFO - Running main action method: create_virtualenv 19:57:20 INFO - Creating virtualenv /builds/slave/test/build/venv 19:57:20 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 19:57:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:57:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:57:20 INFO - Using real prefix '/usr' 19:57:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:57:21 INFO - Installing distribute.............................................................................................................................................................................................done. 19:57:23 INFO - Installing pip.................done. 19:57:23 INFO - Return code: 0 19:57:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:57:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:57:23 INFO - Reading from file tmpfile_stdout 19:57:23 INFO - Output received: 19:57:23 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) 19:57:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:57:23 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')]} 19:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:23 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')]} 19:57:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1b281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e97d00>, '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 0x1e98a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e98eb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299', '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 19:57:23 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 19:57:23 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 19:57:23 INFO - Using env: {'DISPLAY': ':0', 19:57:23 INFO - 'HOME': '/home/cltbld', 19:57:23 INFO - 'LANG': 'en_US.UTF-8', 19:57:23 INFO - 'LANGUAGE': 'en_US:en', 19:57:23 INFO - 'LOGNAME': 'cltbld', 19:57:23 INFO - 'MAIL': '/var/mail/cltbld', 19:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:23 INFO - 'MOZ_NO_REMOTE': '1', 19:57:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:23 INFO - 'NO_EM_RESTART': '1', 19:57:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:23 INFO - 'PWD': '/builds/slave/test', 19:57:23 INFO - 'SHELL': '/bin/bash', 19:57:23 INFO - 'SHLVL': '1', 19:57:23 INFO - 'TERM': 'linux', 19:57:23 INFO - 'TMOUT': '86400', 19:57:23 INFO - 'USER': 'cltbld', 19:57:23 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299', 19:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:23 INFO - '_': '/tools/buildbot/bin/python'} 19:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:23 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 19:57:23 INFO - Cleaning up... 19:57:23 INFO - Return code: 0 19:57:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:57:23 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')]} 19:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:23 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')]} 19:57:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1b281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e97d00>, '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 0x1e98a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e98eb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299', '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 19:57:23 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 19:57:23 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 19:57:23 INFO - Using env: {'DISPLAY': ':0', 19:57:23 INFO - 'HOME': '/home/cltbld', 19:57:23 INFO - 'LANG': 'en_US.UTF-8', 19:57:23 INFO - 'LANGUAGE': 'en_US:en', 19:57:23 INFO - 'LOGNAME': 'cltbld', 19:57:23 INFO - 'MAIL': '/var/mail/cltbld', 19:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:23 INFO - 'MOZ_NO_REMOTE': '1', 19:57:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:23 INFO - 'NO_EM_RESTART': '1', 19:57:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:23 INFO - 'PWD': '/builds/slave/test', 19:57:23 INFO - 'SHELL': '/bin/bash', 19:57:23 INFO - 'SHLVL': '1', 19:57:23 INFO - 'TERM': 'linux', 19:57:23 INFO - 'TMOUT': '86400', 19:57:23 INFO - 'USER': 'cltbld', 19:57:23 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299', 19:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:23 INFO - '_': '/tools/buildbot/bin/python'} 19:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:23 INFO - Downloading/unpacking psutil>=3.1.1 19:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:23 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 19:57:23 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 19:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:57:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:57:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:57:25 INFO - Installing collected packages: psutil 19:57:25 INFO - Running setup.py install for psutil 19:57:26 INFO - building 'psutil._psutil_linux' extension 19:57:26 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 19:57:26 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 19:57:26 INFO - building 'psutil._psutil_posix' extension 19:57:26 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 19:57:26 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 19:57:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:57:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:57:26 INFO - Successfully installed psutil 19:57:26 INFO - Cleaning up... 19:57:26 INFO - Return code: 0 19:57:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:57:26 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')]} 19:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:26 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')]} 19:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1b281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e97d00>, '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 0x1e98a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e98eb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299', '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 19:57:26 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 19:57:26 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 19:57:26 INFO - Using env: {'DISPLAY': ':0', 19:57:26 INFO - 'HOME': '/home/cltbld', 19:57:26 INFO - 'LANG': 'en_US.UTF-8', 19:57:26 INFO - 'LANGUAGE': 'en_US:en', 19:57:26 INFO - 'LOGNAME': 'cltbld', 19:57:26 INFO - 'MAIL': '/var/mail/cltbld', 19:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:26 INFO - 'MOZ_NO_REMOTE': '1', 19:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:26 INFO - 'NO_EM_RESTART': '1', 19:57:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:26 INFO - 'PWD': '/builds/slave/test', 19:57:26 INFO - 'SHELL': '/bin/bash', 19:57:26 INFO - 'SHLVL': '1', 19:57:26 INFO - 'TERM': 'linux', 19:57:26 INFO - 'TMOUT': '86400', 19:57:26 INFO - 'USER': 'cltbld', 19:57:26 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299', 19:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:26 INFO - '_': '/tools/buildbot/bin/python'} 19:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:26 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 19:57:26 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 19:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:57:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:57:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:57:28 INFO - Installing collected packages: mozsystemmonitor 19:57:28 INFO - Running setup.py install for mozsystemmonitor 19:57:28 INFO - Successfully installed mozsystemmonitor 19:57:28 INFO - Cleaning up... 19:57:28 INFO - Return code: 0 19:57:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:57:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:28 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 0x1b281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e97d00>, '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 0x1e98a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e98eb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299', '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 19:57:28 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 19:57:28 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 19:57:28 INFO - Using env: {'DISPLAY': ':0', 19:57:28 INFO - 'HOME': '/home/cltbld', 19:57:28 INFO - 'LANG': 'en_US.UTF-8', 19:57:28 INFO - 'LANGUAGE': 'en_US:en', 19:57:28 INFO - 'LOGNAME': 'cltbld', 19:57:28 INFO - 'MAIL': '/var/mail/cltbld', 19:57:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:28 INFO - 'MOZ_NO_REMOTE': '1', 19:57:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:28 INFO - 'NO_EM_RESTART': '1', 19:57:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:28 INFO - 'PWD': '/builds/slave/test', 19:57:28 INFO - 'SHELL': '/bin/bash', 19:57:28 INFO - 'SHLVL': '1', 19:57:28 INFO - 'TERM': 'linux', 19:57:28 INFO - 'TMOUT': '86400', 19:57:28 INFO - 'USER': 'cltbld', 19:57:28 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299', 19:57:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:28 INFO - '_': '/tools/buildbot/bin/python'} 19:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:29 INFO - Downloading/unpacking jsonschema==2.5.1 19:57:29 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 19:57:29 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 19:57:29 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 19:57:29 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 19:57:29 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 19:57:29 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 19:57:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:57:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:31 INFO - Downloading functools32-3.2.3-2.tar.gz 19:57:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:57:31 INFO - warning: no files found matching '*.txt' 19:57:31 INFO - no previously-included directories found matching 'build' 19:57:31 INFO - no previously-included directories found matching 'dist' 19:57:31 INFO - no previously-included directories found matching '.git*' 19:57:31 INFO - Installing collected packages: jsonschema, functools32 19:57:31 INFO - Running setup.py install for functools32 19:57:31 INFO - warning: no files found matching '*.txt' 19:57:31 INFO - no previously-included directories found matching 'build' 19:57:31 INFO - no previously-included directories found matching 'dist' 19:57:31 INFO - no previously-included directories found matching '.git*' 19:57:31 INFO - Successfully installed jsonschema functools32 19:57:31 INFO - Cleaning up... 19:57:31 INFO - Return code: 0 19:57:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:57: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')]} 19:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57: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')]} 19:57:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e97d00>, '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 0x1e98a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e98eb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299', '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 19:57:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:57:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:57:31 INFO - Using env: {'DISPLAY': ':0', 19:57:31 INFO - 'HOME': '/home/cltbld', 19:57:31 INFO - 'LANG': 'en_US.UTF-8', 19:57:31 INFO - 'LANGUAGE': 'en_US:en', 19:57:31 INFO - 'LOGNAME': 'cltbld', 19:57:31 INFO - 'MAIL': '/var/mail/cltbld', 19:57:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:31 INFO - 'MOZ_NO_REMOTE': '1', 19:57:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:31 INFO - 'NO_EM_RESTART': '1', 19:57:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:31 INFO - 'PWD': '/builds/slave/test', 19:57:31 INFO - 'SHELL': '/bin/bash', 19:57:31 INFO - 'SHLVL': '1', 19:57:31 INFO - 'TERM': 'linux', 19:57:31 INFO - 'TMOUT': '86400', 19:57:31 INFO - 'USER': 'cltbld', 19:57:31 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299', 19:57:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:31 INFO - '_': '/tools/buildbot/bin/python'} 19:57:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:57:31 INFO - Cleaning up... 19:57:31 INFO - Return code: 0 19:57:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:57: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')]} 19:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57: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')]} 19:57:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e97d00>, '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 0x1e98a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e98eb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299', '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 19:57:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:57:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:57:31 INFO - Using env: {'DISPLAY': ':0', 19:57:31 INFO - 'HOME': '/home/cltbld', 19:57:31 INFO - 'LANG': 'en_US.UTF-8', 19:57:31 INFO - 'LANGUAGE': 'en_US:en', 19:57:31 INFO - 'LOGNAME': 'cltbld', 19:57:31 INFO - 'MAIL': '/var/mail/cltbld', 19:57:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:31 INFO - 'MOZ_NO_REMOTE': '1', 19:57:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:31 INFO - 'NO_EM_RESTART': '1', 19:57:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:31 INFO - 'PWD': '/builds/slave/test', 19:57:31 INFO - 'SHELL': '/bin/bash', 19:57:31 INFO - 'SHLVL': '1', 19:57:31 INFO - 'TERM': 'linux', 19:57:31 INFO - 'TMOUT': '86400', 19:57:31 INFO - 'USER': 'cltbld', 19:57:31 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299', 19:57:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:31 INFO - '_': '/tools/buildbot/bin/python'} 19:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:32 INFO - Downloading/unpacking blobuploader==1.2.4 19:57:32 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 19:57:32 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 19:57:32 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 19:57:32 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 19:57:32 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 19:57:32 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 19:57:34 INFO - Downloading blobuploader-1.2.4.tar.gz 19:57:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:57:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:57:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:34 INFO - Downloading docopt-0.6.1.tar.gz 19:57:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:57:34 INFO - Installing collected packages: blobuploader, requests, docopt 19:57:34 INFO - Running setup.py install for blobuploader 19:57:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:57:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:57:34 INFO - Running setup.py install for requests 19:57:35 INFO - Running setup.py install for docopt 19:57:35 INFO - Successfully installed blobuploader requests docopt 19:57:35 INFO - Cleaning up... 19:57:35 INFO - Return code: 0 19:57:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:57:35 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')]} 19:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:35 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')]} 19:57:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:35 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 0x1b281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e97d00>, '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 0x1e98a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e98eb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299', '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 19:57:35 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 19:57:35 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 19:57:35 INFO - Using env: {'DISPLAY': ':0', 19:57:35 INFO - 'HOME': '/home/cltbld', 19:57:35 INFO - 'LANG': 'en_US.UTF-8', 19:57:35 INFO - 'LANGUAGE': 'en_US:en', 19:57:35 INFO - 'LOGNAME': 'cltbld', 19:57:35 INFO - 'MAIL': '/var/mail/cltbld', 19:57:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:35 INFO - 'MOZ_NO_REMOTE': '1', 19:57:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:35 INFO - 'NO_EM_RESTART': '1', 19:57:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:35 INFO - 'PWD': '/builds/slave/test', 19:57:35 INFO - 'SHELL': '/bin/bash', 19:57:35 INFO - 'SHLVL': '1', 19:57:35 INFO - 'TERM': 'linux', 19:57:35 INFO - 'TMOUT': '86400', 19:57:35 INFO - 'USER': 'cltbld', 19:57:35 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299', 19:57:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:35 INFO - '_': '/tools/buildbot/bin/python'} 19:57:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:57:35 INFO - Running setup.py (path:/tmp/pip-1KtAnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:57:35 INFO - Running setup.py (path:/tmp/pip-rKqH2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:57:35 INFO - Running setup.py (path:/tmp/pip-EnDNj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:57:35 INFO - Running setup.py (path:/tmp/pip-3huCiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:57:36 INFO - Running setup.py (path:/tmp/pip-xhROEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:57:36 INFO - Running setup.py (path:/tmp/pip-adSvH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:57:36 INFO - Running setup.py (path:/tmp/pip-E9yyLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:57:36 INFO - Running setup.py (path:/tmp/pip-BLdhaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:57:36 INFO - Running setup.py (path:/tmp/pip-deu2VH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:57:36 INFO - Running setup.py (path:/tmp/pip-aDAXxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:57:36 INFO - Running setup.py (path:/tmp/pip-fCb7Zt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:57:36 INFO - Running setup.py (path:/tmp/pip-wun6_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:57:36 INFO - Running setup.py (path:/tmp/pip-vvg9uN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:57:36 INFO - Running setup.py (path:/tmp/pip-ZWilF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:57:36 INFO - Running setup.py (path:/tmp/pip-VFVVr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:57:36 INFO - Running setup.py (path:/tmp/pip-r8YLIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:57:36 INFO - Running setup.py (path:/tmp/pip-MB617H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:57:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:57:36 INFO - Running setup.py install for manifestparser 19:57:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:57:37 INFO - Running setup.py install for mozcrash 19:57:37 INFO - Running setup.py install for mozdebug 19:57:37 INFO - Running setup.py install for mozdevice 19:57:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:57:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:57:37 INFO - Running setup.py install for mozfile 19:57:37 INFO - Running setup.py install for mozhttpd 19:57:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:57:37 INFO - Running setup.py install for mozinfo 19:57:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:57:37 INFO - Running setup.py install for mozInstall 19:57:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:57:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:57:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:57:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:57:37 INFO - Running setup.py install for mozleak 19:57:37 INFO - Running setup.py install for mozlog 19:57:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:57:38 INFO - Running setup.py install for moznetwork 19:57:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:57:38 INFO - Running setup.py install for mozprocess 19:57:38 INFO - Running setup.py install for mozprofile 19:57:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:57:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:57:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:57:38 INFO - Running setup.py install for mozrunner 19:57:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:57:38 INFO - Running setup.py install for mozscreenshot 19:57:38 INFO - Running setup.py install for moztest 19:57:38 INFO - Running setup.py install for mozversion 19:57:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:57:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:57:38 INFO - Cleaning up... 19:57:38 INFO - Return code: 0 19:57:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:57: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')]} 19:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57: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')]} 19:57:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:38 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 0x1b281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e97d00>, '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 0x1e98a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e98eb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299', '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 19:57:38 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 19:57:38 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 19:57:38 INFO - Using env: {'DISPLAY': ':0', 19:57:38 INFO - 'HOME': '/home/cltbld', 19:57:38 INFO - 'LANG': 'en_US.UTF-8', 19:57:38 INFO - 'LANGUAGE': 'en_US:en', 19:57:38 INFO - 'LOGNAME': 'cltbld', 19:57:38 INFO - 'MAIL': '/var/mail/cltbld', 19:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:38 INFO - 'MOZ_NO_REMOTE': '1', 19:57:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:38 INFO - 'NO_EM_RESTART': '1', 19:57:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:38 INFO - 'PWD': '/builds/slave/test', 19:57:38 INFO - 'SHELL': '/bin/bash', 19:57:38 INFO - 'SHLVL': '1', 19:57:38 INFO - 'TERM': 'linux', 19:57:38 INFO - 'TMOUT': '86400', 19:57:38 INFO - 'USER': 'cltbld', 19:57:38 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299', 19:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:38 INFO - '_': '/tools/buildbot/bin/python'} 19:57:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:57:39 INFO - Running setup.py (path:/tmp/pip-ko9GC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:57:39 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)) 19:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:57:39 INFO - Running setup.py (path:/tmp/pip-EjOjpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:57:39 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)) 19:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:57:39 INFO - Running setup.py (path:/tmp/pip-YifdbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:57:39 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)) 19:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:57:39 INFO - Running setup.py (path:/tmp/pip-myjCbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:57:39 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)) 19:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:57:39 INFO - Running setup.py (path:/tmp/pip-c_lAmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:57:39 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)) 19:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:57:39 INFO - Running setup.py (path:/tmp/pip-sKRzFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:57:39 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)) 19:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:57:39 INFO - Running setup.py (path:/tmp/pip-bBU9yP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:57:39 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)) 19:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:57:39 INFO - Running setup.py (path:/tmp/pip-YBSGLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:57:39 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)) 19:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:57:39 INFO - Running setup.py (path:/tmp/pip-5LZqa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:57:39 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)) 19:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:57:39 INFO - Running setup.py (path:/tmp/pip-9pn0eS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:57:39 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)) 19:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:57:39 INFO - Running setup.py (path:/tmp/pip-lpEfef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:57:39 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)) 19:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:57:39 INFO - Running setup.py (path:/tmp/pip-gkVNR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 19:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:57:39 INFO - Running setup.py (path:/tmp/pip-bv4yVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:57:40 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)) 19:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:57:40 INFO - Running setup.py (path:/tmp/pip-2Gsmpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:57:40 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)) 19:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:57:40 INFO - Running setup.py (path:/tmp/pip-8vdGyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:57:40 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)) 19:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:57:40 INFO - Running setup.py (path:/tmp/pip-EVvIhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:57:40 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)) 19:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:57:40 INFO - Running setup.py (path:/tmp/pip-mIUASz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:57:40 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)) 19:57:40 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)) 19:57:40 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)) 19:57:40 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)) 19:57:40 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)) 19:57:40 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)) 19:57:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:42 INFO - Downloading blessings-1.6.tar.gz 19:57:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:57:42 INFO - Installing collected packages: blessings 19:57:42 INFO - Running setup.py install for blessings 19:57:42 INFO - Successfully installed blessings 19:57:42 INFO - Cleaning up... 19:57:42 INFO - Return code: 0 19:57:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:57:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:57:42 INFO - Reading from file tmpfile_stdout 19:57:42 INFO - Current package versions: 19:57:42 INFO - argparse == 1.2.1 19:57:42 INFO - blessings == 1.6 19:57:42 INFO - blobuploader == 1.2.4 19:57:42 INFO - docopt == 0.6.1 19:57:42 INFO - functools32 == 3.2.3-2 19:57:42 INFO - jsonschema == 2.5.1 19:57:42 INFO - manifestparser == 1.1 19:57:42 INFO - mozInstall == 1.12 19:57:42 INFO - mozcrash == 1.0 19:57:42 INFO - mozdebug == 0.1 19:57:42 INFO - mozdevice == 0.49 19:57:42 INFO - mozfile == 1.2 19:57:42 INFO - mozhttpd == 0.7 19:57:42 INFO - mozinfo == 0.9 19:57:42 INFO - mozleak == 0.1 19:57:42 INFO - mozlog == 3.4 19:57:42 INFO - moznetwork == 0.27 19:57:42 INFO - mozprocess == 0.24 19:57:42 INFO - mozprofile == 0.28 19:57:42 INFO - mozrunner == 6.13 19:57:42 INFO - mozscreenshot == 0.1 19:57:42 INFO - mozsystemmonitor == 0.3 19:57:42 INFO - moztest == 0.8 19:57:42 INFO - mozversion == 1.4 19:57:42 INFO - psutil == 3.1.1 19:57:42 INFO - requests == 1.2.3 19:57:42 INFO - wsgiref == 0.1.2 19:57:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:57:42 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')]} 19:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:42 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')]} 19:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:42 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 0x1b281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e97d00>, '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 0x1e98a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e98eb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299', '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 19:57:42 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 19:57:42 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 19:57:42 INFO - Using env: {'DISPLAY': ':0', 19:57:42 INFO - 'HOME': '/home/cltbld', 19:57:42 INFO - 'LANG': 'en_US.UTF-8', 19:57:42 INFO - 'LANGUAGE': 'en_US:en', 19:57:42 INFO - 'LOGNAME': 'cltbld', 19:57:42 INFO - 'MAIL': '/var/mail/cltbld', 19:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:42 INFO - 'MOZ_NO_REMOTE': '1', 19:57:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:42 INFO - 'NO_EM_RESTART': '1', 19:57:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:42 INFO - 'PWD': '/builds/slave/test', 19:57:42 INFO - 'SHELL': '/bin/bash', 19:57:42 INFO - 'SHLVL': '1', 19:57:42 INFO - 'TERM': 'linux', 19:57:42 INFO - 'TMOUT': '86400', 19:57:42 INFO - 'USER': 'cltbld', 19:57:42 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299', 19:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:42 INFO - '_': '/tools/buildbot/bin/python'} 19:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:42 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)) 19:57:42 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)) 19:57:42 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)) 19:57:42 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)) 19:57:42 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)) 19:57:42 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)) 19:57:42 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)) 19:57:42 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)) 19:57:42 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)) 19:57:42 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)) 19:57:42 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)) 19:57:42 INFO - Cleaning up... 19:57:42 INFO - Return code: 0 19:57:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:57:42 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')]} 19:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:42 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')]} 19:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:43 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 0x1b281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e97d00>, '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 0x1e98a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e98eb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299', '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 19:57:43 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 19:57:43 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 19:57:43 INFO - Using env: {'DISPLAY': ':0', 19:57:43 INFO - 'HOME': '/home/cltbld', 19:57:43 INFO - 'LANG': 'en_US.UTF-8', 19:57:43 INFO - 'LANGUAGE': 'en_US:en', 19:57:43 INFO - 'LOGNAME': 'cltbld', 19:57:43 INFO - 'MAIL': '/var/mail/cltbld', 19:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:43 INFO - 'MOZ_NO_REMOTE': '1', 19:57:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:43 INFO - 'NO_EM_RESTART': '1', 19:57:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:43 INFO - 'PWD': '/builds/slave/test', 19:57:43 INFO - 'SHELL': '/bin/bash', 19:57:43 INFO - 'SHLVL': '1', 19:57:43 INFO - 'TERM': 'linux', 19:57:43 INFO - 'TMOUT': '86400', 19:57:43 INFO - 'USER': 'cltbld', 19:57:43 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299', 19:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:43 INFO - '_': '/tools/buildbot/bin/python'} 19:57:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:57:43 INFO - Cleaning up... 19:57:43 INFO - Return code: 0 19:57:43 INFO - Running post-action listener: _resource_record_post_action 19:57:43 INFO - Running post-action listener: _start_resource_monitoring 19:57:43 INFO - Starting resource monitoring. 19:57:43 INFO - [mozharness: 2017-02-06 03:57:43.262462Z] Finished create-virtualenv step (success) 19:57:43 INFO - [mozharness: 2017-02-06 03:57:43.262911Z] Running install step. 19:57:43 INFO - Running pre-action listener: _resource_record_pre_action 19:57:43 INFO - Running main action method: install 19:57:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:57:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:57:43 INFO - Reading from file tmpfile_stdout 19:57:43 INFO - Detecting whether we're running mozinstall >=1.0... 19:57:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:57:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:57:43 INFO - Reading from file tmpfile_stdout 19:57:43 INFO - Output received: 19:57:43 INFO - Usage: mozinstall [options] installer 19:57:43 INFO - Options: 19:57:43 INFO - -h, --help show this help message and exit 19:57:43 INFO - -d DEST, --destination=DEST 19:57:43 INFO - Directory to install application into. [default: 19:57:43 INFO - "/builds/slave/test"] 19:57:43 INFO - --app=APP Application being installed. [default: firefox] 19:57:43 INFO - mkdir: /builds/slave/test/build/application 19:57:43 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'] 19:57:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:57:59 INFO - Reading from file tmpfile_stdout 19:57:59 INFO - Output received: 19:57:59 INFO - /builds/slave/test/build/application/firefox/firefox 19:57:59 INFO - Running post-action listener: _resource_record_post_action 19:57:59 INFO - [mozharness: 2017-02-06 03:57:59.982353Z] Finished install step (success) 19:57:59 INFO - [mozharness: 2017-02-06 03:57:59.982624Z] Running run-tests step. 19:57:59 INFO - Running pre-action listener: _resource_record_pre_action 19:57:59 INFO - Running main action method: run_tests 19:57:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:57:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:57:59 INFO - Python 2.7.3 19:57:59 INFO - Return code: 0 19:57:59 INFO - grabbing minidump binary from tooltool 19:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:57:59 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 0x1e97d00>, '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 0x1e98a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e98eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:57:59 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 19:57:59 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 19:57:59 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 19:58:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:58:00 INFO - Return code: 0 19:58:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:58:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:58:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:58:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:58:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:58:00 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:58:00 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:58:00 INFO - Using env: {'DISPLAY': ':0', 19:58:00 INFO - 'HOME': '/home/cltbld', 19:58:00 INFO - 'LANG': 'en_US.UTF-8', 19:58:00 INFO - 'LANGUAGE': 'en_US:en', 19:58:00 INFO - 'LOGNAME': 'cltbld', 19:58:00 INFO - 'MAIL': '/var/mail/cltbld', 19:58:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:58:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:00 INFO - 'MOZ_NO_REMOTE': '1', 19:58:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:58:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:00 INFO - 'NO_EM_RESTART': '1', 19:58:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:00 INFO - 'PWD': '/builds/slave/test', 19:58:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:58:00 INFO - 'SHELL': '/bin/bash', 19:58:00 INFO - 'SHLVL': '1', 19:58:00 INFO - 'TERM': 'linux', 19:58:00 INFO - 'TMOUT': '86400', 19:58:00 INFO - 'USER': 'cltbld', 19:58:00 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299', 19:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:00 INFO - '_': '/tools/buildbot/bin/python'} 19:58:00 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:58:00 INFO - mozversion application_buildid: 20170206025433 19:58:00 INFO - mozversion application_changeset: c3d208c04d8b68ed20a0b62c2f9a5bcc83aa9349 19:58:00 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:58:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:58:00 INFO - mozversion application_name: Firefox 19:58:00 INFO - mozversion application_remotingname: firefox-dev 19:58:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:58:00 INFO - mozversion application_vendor: Mozilla 19:58:00 INFO - mozversion application_version: 53.0a2 19:58:00 INFO - mozversion platform_buildid: 20170206025433 19:58:00 INFO - mozversion platform_changeset: c3d208c04d8b68ed20a0b62c2f9a5bcc83aa9349 19:58:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:58:00 INFO - mozversion platform_version: 53.0a2 19:58:00 INFO - using testdate: 1486353480 19:58:00 INFO - actual date: 1486353480 19:58:00 INFO - starting webserver on 'localhost:52376' 19:58:00 INFO - SUITE-START | Running 2 tests 19:58:00 INFO - TEST-START | dromaeo_css 19:58:00 INFO - operating with platform_type : linux_ 19:58:00 INFO - Initialising browser for dromaeo_css test... 19:58:00 INFO - TEST-INFO | started process 8260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH5PpDp/profile http://localhost:52376/getInfo.html) 19:58:04 INFO - PROCESS | 8260 | __metrics Screen width/height:1600/1200 19:58:04 INFO - PROCESS | 8260 | colorDepth:24 19:58:04 INFO - PROCESS | 8260 | Browser inner width/height: 1024/697 19:58:04 INFO - PROCESS | 8260 | __metrics 19:58:05 INFO - PROCESS | 8260 | 1486353485275 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmpH5PpDp/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpH5PpDp/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpH5PpDp/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpH5PpDp/profile/extensions/talos-powers@TalosPowersService.js:55:9 19:58:05 ERROR - PROCESS | 8260 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 19:58:06 INFO - TEST-INFO | 8260: exit 0 19:58:06 INFO - Browser initialized. 19:58:06 INFO - Running cycle 1/1 for dromaeo_css test... 19:58:06 INFO - TEST-INFO | started process 8388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH5PpDp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:58:18 INFO - PROCESS | 8388 | RSS: Main: 144699392 19:58:18 INFO - PROCESS | 8388 | 20:01:17 INFO - PROCESS | 8388 | Cycle 1(1): loaded http://localhost:52376/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52376/tests/dromaeo/cssquery-ext.html) 20:01:18 INFO - PROCESS | 8388 | RSS: Main: 152342528 20:01:18 INFO - PROCESS | 8388 | 20:03:06 INFO - PROCESS | 8388 | ************************* 20:03:06 INFO - PROCESS | 8388 | A coding exception was thrown and uncaught in a Task. 20:03:06 INFO - PROCESS | 8388 | 20:03:06 ERROR - PROCESS | 8388 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:03:06 INFO - PROCESS | 8388 | Full stack: 20:03:06 INFO - PROCESS | 8388 | ************************* 20:04:20 INFO - PROCESS | 8388 | Cycle 1(1): loaded http://localhost:52376/tests/dromaeo/cssquery-ext.html (next: http://localhost:52376/tests/dromaeo/cssquery-jquery.html) 20:04:21 INFO - PROCESS | 8388 | RSS: Main: 149671936 20:04:21 INFO - PROCESS | 8388 | 20:07:23 INFO - PROCESS | 8388 | Cycle 1(1): loaded http://localhost:52376/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52376/tests/dromaeo/cssquery-mootools.html) 20:07:23 INFO - PROCESS | 8388 | RSS: Main: 153321472 20:07:23 INFO - PROCESS | 8388 | 20:10:25 INFO - PROCESS | 8388 | Cycle 1(1): loaded http://localhost:52376/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52376/tests/dromaeo/cssquery-prototype.html) 20:10:26 INFO - PROCESS | 8388 | RSS: Main: 150503424 20:10:26 INFO - PROCESS | 8388 | 20:13:28 INFO - PROCESS | 8388 | Cycle 1(1): loaded http://localhost:52376/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52376/tests/dromaeo/cssquery-yui.html) 20:13:29 INFO - PROCESS | 8388 | RSS: Main: 155242496 20:13:29 INFO - PROCESS | 8388 | 20:16:31 INFO - PROCESS | 8388 | Cycle 1(1): loaded http://localhost:52376/tests/dromaeo/cssquery-yui.html (next: http://localhost:52376/tests/dromaeo/cssquery-dojo.html) 20:16:31 INFO - PROCESS | 8388 | RSS: Main: 155987968 20:16:31 INFO - PROCESS | 8388 | 20:16:31 INFO - PROCESS | 8388 | __start_tp_report 20:16:31 INFO - PROCESS | 8388 | _x_x_mozilla_page_load 20:16:31 INFO - PROCESS | 8388 | _x_x_mozilla_page_load_details 20:16:31 INFO - PROCESS | 8388 | |i|pagename|runs| 20:16:31 INFO - PROCESS | 8388 | |0;dojo.html;3319.2697606526563;3319.5850518685165;3341.7493687973392;3370.8146051967133;3373.0724050886;5520.089185284428;5559.777608895639;5567.972160139198;5630.296212973379;5662.37713851477;5526.834194974157;5531.751071201796;5547.362053363864;5568.3596386415575;5582.330120385549;4907.435644900837;4962.131626965284;5012.198048312271;5031.874203144932;5038.244263360507;5005.54950054495;5030.647854650176;5035.697858128506;5051.040302342543;5058.7976480940715;4888.633352498577;4892.730899800509;5034.421041580228;5041.672291301072;5051.722155281458;4983.377077865249;5000.224965130411;5018.7490625468945;5070.31550740649;5117.1556693145585;5040.495950404967;5085.669431486978;5088.847334579968;5090.211017292326;5096.566791822699;5582.413846546095;5621.4659607337235;5682.744276507526;5689.431056894319;5695.117256825158;5765.164051212592;5794.884102317972;5948.494377977877;5969.462748352626;5997.22036135304;6106.633601983851;6108.664023478706;6111.297200821918;6119.051547010221;6144.5698801083945;5673.6879471629045;5686.431356864363;5687.687177205252;5690.48785609293;5694;5769.9711501442225;5801.8549536261935;6038.6678732670125;6041.305249896231;6163.568550201443;5858.53131749459;5907.911381329283;5934.37689042653;5941.55438342126;5960.7019649017375;5971.641701497924;6002.309734380515;6009;6038.426349496791;6044.939550604526;5786.594938354359;5790.942090579125;5845.123231515222;5881.41185881417;5956.285245770535;5834.533237341003;5897.675627840425;5913.349531551526;5928.762849486058;5932;4550.954490455053;4560.5895469407915;4566.589006989387;4570.451545814457;4573.291139873325;4062.756234625932;4067.471228740245;4075.9796201018803;4079.4084857695466;4081.3061779497557;5815.767369305265;5838.474537291664;5853.64878107315;5874.706264686749;5961.016432288624;6064.120702498113;6096.69516524172;6113.694315284218;6118.082287656887;6128.662923539159;5562.805301814417;5768.884622307614;5792.507636850831;5899.056151015902;5910.704464776744;5156.535911767959;5178.456262092426;5190.169572868323;5206.791728330824;5218;6321.304656487782;6325.810225693236;6330.240371155491;6334.271558770801;6349.52378571609;5851.063829787384;5925.05199168131;6080.300765412034;6086.239220097488;6100.938990610214;6138.048602466625;6145.569810113249;6161.137440758387;6244.562880598314;6250.062490626442;5865.266841644794;5877.500412464818;5916.053431450947;5918.3489816121055;5922.674252916131;5921.17103605487;5951.464368206882;6003.309619393825;6005.6396616203165;6028.156058151774;5774.1916131740745;5790.363060063305;5800.564957628279;5803.883922321445;5864.32560255576;5787.450192231731;5861.413858614104;5862.589618726648;5870.324912635102;5882.23530940975;5800.50695690871;5829.8251052468495;5847.06446968483;5848.53211743051;5850.151727999331;5741.167530708108;5828.358880523054;5838.4453476919625;5861.912071318849;5949.494292985145;5806.5645076618575;5845.298564172326;5853.882922341614;5861.238039055066;5871.7651293947765 20:16:31 INFO - PROCESS | 8388 | |1;ext.html;578.9334226563943;598.5780025082317;626.9122322874796;704.8836941904586;736.0394684936156;43429;44174.33738493921;47769.76115119428;47789;48088.51911480884;48372.51627483724;49248.75375623126;49269.753651231695;49295.50704492954;49549.50450495503;9168.495732734713;10668.679939601825;11086.722831929226;11121;11439.485223164978;11054.170937179704;11076.11391088715;11108.944455277713;11139.387333696643;11139.554417823278;11171.66485005451;11203.439828008608;11245.887541124566;11253.887461125365;11290.830637540443;11033.889661103367;11047.281926674741;11086.2239643225;11172.99999999996;11190.216684832065;10905.34567925919;11006.394648294341;11021.724456888562;11117.555297788078;11142.164337674625;41413.37879931804;41428.79285603583;41450.79274603607;41684.58315416837;41905.37141942873;4226.661867050629;4249.426327445817;4264.0832221072615;4332.263515202391;4362.389265502832;31496.527552086736;31616.209594760086;32350.514742278883;32404.837975810206;33032.3393532128;4603.654725895572;4646.581807637295;4701.529847015306;4723;4735.289706544011;350167;352492;352758;354450;354647;59501;59778;60118.39881601215;60349.39650603526;60370;62495;62518.374816252166;62625.68687156535;62714;62941.37058629355;17673;18021;18499.167537460846;18533.443996680122;18555.16501757424;13729.45082196721;14391.856081439051;14450.421983120557;14451.566453006426;14509.92745036268;19713;19795.703064454046;20112.798872011386;20154.596908061758;20174.697379539317;7492.70029198826;7625.6568454419685;7656.578888161093;7695.884561731578;7787.727429539939;979;1012.7974405118858;1038.0605551975475;1039.8024375368657;1045.8483519889573;32482;32535.674643253737;32669.836650816593;32826.50760238598;33420.164495887795;1162.808136657442;1192.797224471842;1197.7185361440054;1197.868234494205;1217.2635555488803;17288.567785805455;17356.65286694259;17444.73832892482;17656.82343176552;17683.911580442014;580389;589455;590649;593317;595820;69858.3014169862;70552.64723676349;70646.293537065;70785;70822.2917770826;1558.5402306319663;1580.8023997000375;1581.4543982326309;1597.4009746344889;1604.9438269660507;31150.53274200934;32164.195895101875;32742.83628581842;33210;34108.488372673935;58262;58886.116708250265;59182;59286.40713592981;59346;529110;534240;535163;536130;537170;29338.706612933598;29963.850180748956;29982.800687972238;31598.526022110145;44536;46186.538134618226;46378.768106160605;46447.53552464432;46497.53502465067;47230.52769472399;40677.796611016754;40751.388729168495;41162.588374115876;42333.57666423296;43088.35367469553;40290;40447.59552404556;41460.1707965833;42017.36973945332;42048.15903681971;40883.38674919938;40966.590334096276;41531.792341038104;41883.16233675249;41963.580364195965;33833.323333533684;34582.30835383329;35373.29253414969;35411.468827968114;35484.29031419306;26926.59610105889;27198.1840544784;27218.183454496397;27438.45123097567;28104.43791124207 20:16:31 INFO - PROCESS | 8388 | |2;jquery.html;405.92287465381594;406.84743221292035;416.843683618643;419.3437270671399;421.191312679655;19944.401667949947;20957.8473183975;21741.23905663302;22099.226527071554;22258.777412225874;22235.888820555876;22361.329160125224;22521.662175067388;23024.07903683855;23156.189533366334;5896.233489646351;6131.14164017038;6151.538634602401;6164.691765411734;6175.444210021097;5999.550033747465;7618.504797188193;7944.483608565453;7967.920320796776;8007.559584222866;7736.303732664059;7951.244631760002;7967.561784101872;7969.681212751483;7981.401394895377;7769.883451748228;8060.476069055522;8069.475484093515;8132.471389359673;8138.633761480747;7897.368210543143;7937.44437889348;7985.800354991114;7999.920000799976;8003.399745019147;30219.395612087636;30584;30789.076327710205;30988.84505577458;30993;3155.085025342648;3276.2792185719104;3310.6854848789326;3615.2407994321225;3787.9242415151543;17102.401415950382;17673.469795906145;18007.72988405175;18370.540736481697;18876.433706988813;2231.955360892773;2253.752087270399;2280.8289378296527;2300.6549017647485;2305.896234669427;85497;87244.56377718135;104467;120298.39850800777;122870.38564807209;20771.376858694264;21150.576988460143;21204.681929771064;21340.573188536142;21616.487795612018;42685.78657106694;42838.357424638656;42860.57139428566;43019.784901075924;43139.35290970638;8957.417767845069;9154.528277365074;9382.155605995493;9464.1009104135;9622.615095396246;9037.367384283038;9052.140046695553;9055.275577953747;9212.493312867722;9274.536273186448;5201.817936372209;5245.947540524546;5292.92060619091;5294.676330917271;5675.233843431167;2223.110755697734;2227.7438094619;2268.2061278552374;2271.2511366247895;2342.6603142544236;945.1965829045394;974.0746291023556;978.3542861711236;987.7777500062429;993.1607791416242;20809.271675491284;21016.684749728767;21017.68473472899;21238.78761212399;21343;967.5597603090577;969.699393188114;974.3228456222998;975.8682577852042;977.7653363192783;11062.335381914043;11709.297442153498;11757.176997610257;11758.823617645741;11823.113266505046;481274;520062;720306;790363;802264;83051.58474207591;89253.55373223222;122951;124586;125976;1176.7881781279282;1180.451090243041;1214.319980810731;1218.2812140837125;1226.625879106881;19026.42920712381;19123.90438047801;19384.8061519383;19398.806011940265;19556.608867822848;48956.2656560159;49452;49520;49610;50525.74737126291;70814.64592677004;71126.64436677784;71591.64204178946;71683.28316716765;71738.64130679313;9166.08339166078;9198.310126740387;9301.302402319989;9415.85876211871;9556.56995435221;9968.850467242852;13805.309734513436;14343.713125737635;14498.420063197354;14728.484503042342;12195.878041219474;12515.311657858905;12555.560555380518;12738.172018818746;12801.167924084904;11759.353235572125;11813.468393922467;12217.633470995885;12240.510379585074;12255.080868935043;12585.811212831997;12992.350382481027;13028.739425211632;13046.478140874258;13073.215607063607;9110.134537218953;9117.133872282122;9269.646160272017;9275.72172834816;9291.535423228675;10653.057969858875;12565.120441569003;12664.493420263454;12886.42011109521;12950.417231224807 20:16:31 INFO - PROCESS | 8388 | |3;mootools.html;1451.114819959825;1505.2248092232503;1505.284989629926;1512.6672132130934;1529.090191336155;8667.479951202933;9044.8643270351;9249.907500924988;9252.12104850039;9260.444373337605;9016.819663606724;9116.042815504376;9149.085091490848;9164.633414663405;9187.678431254908;2379.0840526397333;2407.963880541793;2410.915617953372;2414.95170096598;2416.178499310234;2392.5932591459496;2436.756324367567;2442.670239517669;2445.2297526279253;2448.069733501267;2316.976830231693;2372.7152741671025;2414.2033129067454;2431.3799981004818;2431.878406079698;2264.62633665445;2276.829237807163;2294.8852557372065;2297.4715815362392;2301.2866011536476;2359.056377449017;2379.7263314718857;2402.4114092047384;2413.2880800163994;2415.7705018023435;9073.954630226872;9169.037251088674;9196.862047069299;9199.356045076847;9254.398464099811;5356.38401583819;5435.864103397446;5463.2078348639225;5475.534579560742;5476.26070480484;3535.522704434894;3573.4639804029603;3597.244578638489;3675.3568125578186;3715.5727091384565;1341.597520743773;1347.71697943432;1371.4856928651755;1407.2682205253313;1415.3206460898723;12178.939105304506;12201.877981220252;12295.69260768488;12321.876781232162;12338.198017128858;4745.406824146981;4745.678274298768;4844.32179494864;4863.197572400585;4867.342908707279;10090.2432317575;10094.293399462114;10105;10119.291649584458;10162;5504.697241651747;5569.10894256917;5572.275604171432;5595.776168953196;5603.467670571289;5065.56942659878;5206.661566998133;5247.344081989751;5263.236830659533;5309.946900531023;3842.2507611016144;3929.096307849211;3950.4074388841327;4010.939835902464;4017.517897852218;1185.247367921376;1188.441432526711;1191.5293459083787;1197.2517176764522;1200.4657927222477;830.8670612701939;834.7996480844554;839.7774589733725;858.1375717404094;862.4351050062219;5813.970930145407;5941.55438342126;6129.601575897553;6186.10301506279;6251.187345645128;1022.5194158745378;1037.180627304436;1075.231209685079;1075.7471994081384;1078.8219943709357;4092.4066010428323;4117.135401565645;4237.809298581571;4247.256730072225;4268;10406.11548018427;10723.624673136403;10728.892711072946;10832.512536935857;10843.945780271048;10520.736981575368;10625.46872656364;10664.573417063231;10676.733081672865;10707.411092389993;8390.412671112963;8507.659693612186;8559.871601925975;8631.093735157843;8639.568021598894;5987.461128498456;6025;6105.328413874381;6215.098810672517;6241.063840423973;9984.850227246743;10099.192064634959;10135.7466063349;10163.28856980034;10230.181585473294;9433.481158536346;9669.564869581027;9793.314467987457;9860.950695246478;10091.949540252252;7594.392448603988;7769.378449723896;7843.372530197456;7862.882056769038;8098.3116435103675;8548.273396761346;8569.10024447424;8572.957135214285;8589.699360522602;8596.699115531177;7720.845583088195;7750.6899724012665;7783.961080194563;7788.143304236416;7828.882566761389;7648.50284731513;7715.8071048222;7718.3053525183;7731.536107833548;7735.033120859893;6936.7572134975035;6957.686904089429;6966.860662786818;6976.337247961435;7037.612931288623;5094.337736094284;5204.869878253074;5259.789608415621;5298.1258092415865;5341.919871201857;5156.767945442539;5156.97421512905;5192.273081768631;5235.057689615754;5251.579873610179 20:16:31 INFO - PROCESS | 8388 | |4;prototype.html;357.1660173494889;374.7489182247892;375.1465416178196;376.6365457333673;380.8514679275082;5395.379531353886;5508.338999320077;5603.495685388314;5652.406497317784;5660.433956604337;5353.982743278774;5476.288082549273;5509.146082357231;5537.197106419567;5573.498385145336;4326.30779075348;4362.585554372329;4364.781760911949;4382.846600368987;4407.074514351973;4295.806688699;4330.826766929319;4370.453693288339;4374.803133858984;4386.210482113234;4321.9783901080455;4326.113146804897;4333.956660433402;4337.154254920292;4341.305391137419;4337.913241735163;4341.891452713676;4343.413639158704;4362.847300344489;4381.518033016366;3838.3858483151075;3964.5133075096837;3965.275105329191;3965.7620542767236;3966.7619942803526;5369.516743493065;5426.75579598919;5445.346558413015;5455.454454554552;5484.91772623411;5077.771500282496;5080.466551012164;5090.414602320743;5103.157978933472;5105.974470127663;5658.801941932013;5791.362950075489;5812.709364531799;5851.912221316641;5876.941230587682;4345.174416860818;4357.324614684729;4365.148795984785;4370.8907277318;4372.1255748850035;6034.275886893557;6036;6051.757929682807;6054.273487181523;6073.574849760518;4379.868603941887;4469.748470428285;4482.574155455227;4486.170058539181;4487;4541.704789188692;4545.136424079415;4551.249043907718;4552.248878934939;4560.814188311063;5046.217836235316;5086.77109530072;5091.3126727892;5110.061714514095;5145.614078944094;5693.4875861172695;5886.6173698709445;5903.468687818117;5922.585419020714;5934.910976335358;1405.676694360303;1425.950091746784;1439.7768345906402;1440.3734375546671;1444.714204358122;957.861110139026;988.4415305352453;993.513178542509;996.5963784667222;1002.8144793213279;5473.233747275384;5523.530499907472;5545.584081193927;5546.77812887488;5588.6646801192055;5756.712164391847;5798.26052184343;5814.76740930358;5826.73779679907;5841.328247251536;5494.230807686927;5546.362168350692;5598;5744.396838331915;5748.885022299531;3060.219643990768;3066.8006579572257;3090.2892334763133;3091.8917837876015;3092.196029032468;5977.701114944235;5992.04525013489;6030.638161710312;6055.757769689163;6057.273127224673;6050.638606313632;6070.6357618543025;6073.51411887048;6093.969530152321;6122.877542449215;6222.377762223741;6235.441139715072;6239.78160764371;6263.4362907337645;6298.968505157445;5779.884402312015;5952.404759524186;5971.4327138921735;5986.521078313812;6016.819495415145;5951.553633477593;5959.195508606456;5963.522918166623;5966.164736936919;5972.223610930551;6001.609895356788;6107.938920610737;6169.660668663267;6222.906656400067;6278.748850045947;4178.770167640688;4191.916161676689;4241;4261.595148460891;4267;5834.562407819346;6019.939800601938;6029.57792954489;6030.125631783455;6089.269287685506;5806.229100124503;5825.854353641193;5826.271716035496;5831.591788574759;5833.008388573868;5875.882482350415;5876.559258055749;5884.617499862496;5895.41045895407;5906.793262235801;5670.9432905672065;5789.884202316014;5838.211841401357;5844.240248767633;5864.413558644272;5844.298684157929;5856.9121463178935;5865.824025279248;5877.794277200449;5920.467157955804;5498.917516237339;5676.602637815313;5748.511376533042;5752.28096487939;5787.565932554991 20:16:31 INFO - PROCESS | 8388 | |5;yui.html;831.1812864328639;834.3950635789057;858.8969323681159;907.8728977943088;926.6478738079529;16252.18739063048;16999.57501062474;17127.914360428196;17927.193276302565;18232.635347293046;16392.590185245375;16508.504744857644;16673.749893751603;16686.58283542909;16894.915525422355;827.9751607451786;842.9367797415188;843.3843294395095;845.1041895590663;845.1379592815325;805.3436449293807;839.6095815445816;844.1937949258474;844.3414136973171;844.6959094725894;875.0374587953232;877.2806298834957;886.1271647427279;887.2591386192505;887.6759982606335;876.6449587916904;876.7808047988003;878.2929741558044;879.4898958604026;881.3654168998311;641.6631268583984;642.5726891617069;642.9549931504797;647.757091090841;648.6918713611044;17197.91401042999;17590.736138957927;17686;17814.287428502976;18012.00933948632;15153.621159470991;15191;15347.07917524941;15436.53690389279;15733.449329273535;13460.663483412993;13605.183688978694;13617.659558511017;13671.794923076162;13773.173609583457;3903.6486716195395;3904.746191497572;3960.108975480494;4003.15933653933;4015.337469317559;81350.59324703398;83612.58193709054;84712;84866.57566712188;86467.56766216192;11934.820977685342;12074.87925120755;12173.147879648339;12214.694632634255;12288.754224915452;24037.639435408484;24063.157789477285;24069;24131.155409560582;24362.147324843547;8280.213379729037;8343.290820280345;8445.1977062179;8632.093630168867;8702.564871756387;4525.886852828639;4665.5567721066445;4681.227597446451;4712.552307530779;4740.1230772307235;3823.713221508398;3903.2974064668065;3927.136030073379;3931.331673615492;3937.3897045957924;679.3546131175403;681.5059082165391;683.4122654517112;686.4474098350876;686.8694947959872;786.9173736757673;789.1595450844947;801.7193982106216;807.188775280839;809.9433039687283;11478.583689273955;11607.709807254887;11737.647870563897;12047.27716337005;12146.149769516049;849.0660273698882;860.3289434241302;875.92992560595;881.9470831750116;883.9116088391238;5736.598438109292;5758.712064396764;5793.362730099686;5814.447627475383;5848.239728835224;81132;84289;86562;88719.55640221758;89777.55111224533;71103.64448177726;76891.61554192193;76893.23106768973;76945;78929.60535197402;68720.6563967187;69690.30309696838;70012.64993675101;70434.88695339148;71445.28554714387;11505.42472876336;11845.23006004607;11902;11921.46353414081;12091.274523528617;43618.34572481479;44011;44073.55926440823;44309.77845110754;45170.774146130374;55696.44303556912;56386.718066409405;57256.42743572678;57932.71033644805;58804;14348.210848403438;14669.779953300922;14697.706045879237;15145;15285.388584456497;16126;16434.835651643807;16564;16652.831557965965;16817.579560511083;15520.844791552392;15545.68908621844;15551.222438878238;15800.288986995844;15979.760303595223;15431.691366172838;15790;15803.604909877346;15948;16127.516174514783;15372.769408458658;15420.614484637974;15446.84553154454;15453.845461545241;15516.37934482608;12389;12416.813747793609;12707.87292127067;12762;12913.548025819051;12212.450439730412;12704.872951270369;13006.479740810262;13082.28047457399;13143.53997610079 20:16:31 INFO - PROCESS | 8388 | __end_tp_report 20:16:31 INFO - PROCESS | 8388 | __start_cc_report 20:16:31 INFO - PROCESS | 8388 | _x_x_mozilla_cycle_collect,310 20:16:31 INFO - PROCESS | 8388 | __end_cc_report 20:16:31 INFO - PROCESS | 8388 | __startTimestamp1486354591618__endTimestamp 20:16:31 INFO - PROCESS | 8388 | 20:16:31 INFO - PROCESS | 8388 | ------- Summary: start ------- 20:16:31 INFO - PROCESS | 8388 | Number of tests: 6 20:16:31 INFO - PROCESS | 8388 | 20:16:31 INFO - PROCESS | 8388 | [#0] dojo.html Cycles:165 Average:5569.69 Median:5815.77 stddev:635.31 (10.9%) stddev-sans-first:612.24 20:16:31 INFO - PROCESS | 8388 | Values: 3319.3 3319.6 3341.7 3370.8 3373.1 5520.1 5559.8 5568.0 5630.3 5662.4 5526.8 5531.8 5547.4 5568.4 5582.3 4907.4 4962.1 5012.2 5031.9 5038.2 5005.5 5030.6 5035.7 5051.0 5058.8 4888.6 4892.7 5034.4 5041.7 5051.7 4983.4 5000.2 5018.7 5070.3 5117.2 5040.5 5085.7 5088.8 5090.2 5096.6 5582.4 5621.5 5682.7 5689.4 5695.1 5765.2 5794.9 5948.5 5969.5 5997.2 6106.6 6108.7 6111.3 6119.1 6144.6 5673.7 5686.4 5687.7 5690.5 5694.0 5770.0 5801.9 6038.7 6041.3 6163.6 5858.5 5907.9 5934.4 5941.6 5960.7 5971.6 6002.3 6009.0 6038.4 6044.9 5786.6 5790.9 5845.1 5881.4 5956.3 5834.5 5897.7 5913.3 5928.8 5932.0 4551.0 4560.6 4566.6 4570.5 4573.3 4062.8 4067.5 4076.0 4079.4 4081.3 5815.8 5838.5 5853.6 5874.7 5961.0 6064.1 6096.7 6113.7 6118.1 6128.7 5562.8 5768.9 5792.5 5899.1 5910.7 5156.5 5178.5 5190.2 5206.8 5218.0 6321.3 6325.8 6330.2 6334.3 6349.5 5851.1 5925.1 6080.3 6086.2 6100.9 6138.0 6145.6 6161.1 6244.6 6250.1 5865.3 5877.5 5916.1 5918.3 5922.7 5921.2 5951.5 6003.3 6005.6 6028.2 5774.2 5790.4 5800.6 5803.9 5864.3 5787.5 5861.4 5862.6 5870.3 5882.2 5800.5 5829.8 5847.1 5848.5 5850.2 5741.2 5828.4 5838.4 5861.9 5949.5 5806.6 5845.3 5853.9 5861.2 5871.8 20:16:31 INFO - PROCESS | 8388 | 20:16:31 INFO - PROCESS | 8388 | [#1] ext.html Cycles:180 Average:66015.32 Median:195065.65 stddev:133608.30 (68.5%) stddev-sans-first:133892.78 20:16:31 INFO - PROCESS | 8388 | Values: 578.9 598.6 626.9 704.9 736.0 43429.0 44174.3 47769.8 47789.0 48088.5 48372.5 49248.8 49269.8 49295.5 49549.5 9168.5 10668.7 11086.7 11121.0 11439.5 11054.2 11076.1 11108.9 11139.4 11139.6 11171.7 11203.4 11245.9 11253.9 11290.8 11033.9 11047.3 11086.2 11173.0 11190.2 10905.3 11006.4 11021.7 11117.6 11142.2 41413.4 41428.8 41450.8 41684.6 41905.4 4226.7 4249.4 4264.1 4332.3 4362.4 31496.5 31616.2 32350.5 32404.8 33032.3 4603.7 4646.6 4701.5 4723.0 4735.3 350167.0 352492.0 352758.0 354450.0 354647.0 59501.0 59778.0 60118.4 60349.4 60370.0 62495.0 62518.4 62625.7 62714.0 62941.4 17673.0 18021.0 18499.2 18533.4 18555.2 13729.5 14391.9 14450.4 14451.6 14509.9 19713.0 19795.7 20112.8 20154.6 20174.7 7492.7 7625.7 7656.6 7695.9 7787.7 979.0 1012.8 1038.1 1039.8 1045.8 32482.0 32535.7 32669.8 32826.5 33420.2 1162.8 1192.8 1197.7 1197.9 1217.3 17288.6 17356.7 17444.7 17656.8 17683.9 580389.0 589455.0 590649.0 593317.0 595820.0 69858.3 70552.6 70646.3 70785.0 70822.3 1558.5 1580.8 1581.5 1597.4 1604.9 31150.5 32164.2 32742.8 33210.0 34108.5 58262.0 58886.1 59182.0 59286.4 59346.0 529110.0 534240.0 535163.0 536130.0 537170.0 29338.7 29963.9 29982.8 31598.5 44536.0 46186.5 46378.8 46447.5 46497.5 47230.5 40677.8 40751.4 41162.6 42333.6 43088.4 40290.0 40447.6 41460.2 42017.4 42048.2 40883.4 40966.6 41531.8 41883.2 41963.6 33833.3 34582.3 35373.3 35411.5 35484.3 26926.6 27198.2 27218.2 27438.5 28104.4 20:16:31 INFO - PROCESS | 8388 | 20:16:31 INFO - PROCESS | 8388 | [#2] jquery.html Cycles:180 Average:37799.40 Median:406.39 stddev:111402.57 (27413.1%) stddev-sans-first:111679.70 20:16:31 INFO - PROCESS | 8388 | Values: 405.9 406.8 416.8 419.3 421.2 19944.4 20957.8 21741.2 22099.2 22258.8 22235.9 22361.3 22521.7 23024.1 23156.2 5896.2 6131.1 6151.5 6164.7 6175.4 5999.6 7618.5 7944.5 7967.9 8007.6 7736.3 7951.2 7967.6 7969.7 7981.4 7769.9 8060.5 8069.5 8132.5 8138.6 7897.4 7937.4 7985.8 7999.9 8003.4 30219.4 30584.0 30789.1 30988.8 30993.0 3155.1 3276.3 3310.7 3615.2 3787.9 17102.4 17673.5 18007.7 18370.5 18876.4 2232.0 2253.8 2280.8 2300.7 2305.9 85497.0 87244.6 104467.0 120298.4 122870.4 20771.4 21150.6 21204.7 21340.6 21616.5 42685.8 42838.4 42860.6 43019.8 43139.4 8957.4 9154.5 9382.2 9464.1 9622.6 9037.4 9052.1 9055.3 9212.5 9274.5 5201.8 5245.9 5292.9 5294.7 5675.2 2223.1 2227.7 2268.2 2271.3 2342.7 945.2 974.1 978.4 987.8 993.2 20809.3 21016.7 21017.7 21238.8 21343.0 967.6 969.7 974.3 975.9 977.8 11062.3 11709.3 11757.2 11758.8 11823.1 481274.0 520062.0 720306.0 790363.0 802264.0 83051.6 89253.6 122951.0 124586.0 125976.0 1176.8 1180.5 1214.3 1218.3 1226.6 19026.4 19123.9 19384.8 19398.8 19556.6 48956.3 49452.0 49520.0 49610.0 50525.7 70814.6 71126.6 71591.6 71683.3 71738.6 9166.1 9198.3 9301.3 9415.9 9556.6 9968.9 13805.3 14343.7 14498.4 14728.5 12195.9 12515.3 12555.6 12738.2 12801.2 11759.4 11813.5 12217.6 12240.5 12255.1 12585.8 12992.4 13028.7 13046.5 13073.2 9110.1 9117.1 9269.6 9275.7 9291.5 10653.1 12565.1 12664.5 12886.4 12950.4 20:16:31 INFO - PROCESS | 8388 | 20:16:31 INFO - PROCESS | 8388 | [#3] mootools.html Cycles:180 Average:5881.75 Median:5079.95 stddev:3265.98 (64.3%) stddev-sans-first:3258.16 20:16:31 INFO - PROCESS | 8388 | Values: 1451.1 1505.2 1505.3 1512.7 1529.1 8667.5 9044.9 9249.9 9252.1 9260.4 9016.8 9116.0 9149.1 9164.6 9187.7 2379.1 2408.0 2410.9 2415.0 2416.2 2392.6 2436.8 2442.7 2445.2 2448.1 2317.0 2372.7 2414.2 2431.4 2431.9 2264.6 2276.8 2294.9 2297.5 2301.3 2359.1 2379.7 2402.4 2413.3 2415.8 9074.0 9169.0 9196.9 9199.4 9254.4 5356.4 5435.9 5463.2 5475.5 5476.3 3535.5 3573.5 3597.2 3675.4 3715.6 1341.6 1347.7 1371.5 1407.3 1415.3 12178.9 12201.9 12295.7 12321.9 12338.2 4745.4 4745.7 4844.3 4863.2 4867.3 10090.2 10094.3 10105.0 10119.3 10162.0 5504.7 5569.1 5572.3 5595.8 5603.5 5065.6 5206.7 5247.3 5263.2 5309.9 3842.3 3929.1 3950.4 4010.9 4017.5 1185.2 1188.4 1191.5 1197.3 1200.5 830.9 834.8 839.8 858.1 862.4 5814.0 5941.6 6129.6 6186.1 6251.2 1022.5 1037.2 1075.2 1075.7 1078.8 4092.4 4117.1 4237.8 4247.3 4268.0 10406.1 10723.6 10728.9 10832.5 10843.9 10520.7 10625.5 10664.6 10676.7 10707.4 8390.4 8507.7 8559.9 8631.1 8639.6 5987.5 6025.0 6105.3 6215.1 6241.1 9984.9 10099.2 10135.7 10163.3 10230.2 9433.5 9669.6 9793.3 9861.0 10091.9 7594.4 7769.4 7843.4 7862.9 8098.3 8548.3 8569.1 8573.0 8589.7 8596.7 7720.8 7750.7 7784.0 7788.1 7828.9 7648.5 7715.8 7718.3 7731.5 7735.0 6936.8 6957.7 6966.9 6976.3 7037.6 5094.3 5204.9 5259.8 5298.1 5341.9 5156.8 5157.0 5192.3 5235.1 5251.6 20:16:31 INFO - PROCESS | 8388 | 20:16:31 INFO - PROCESS | 8388 | [#4] prototype.html Cycles:180 Average:4935.60 Median:5593.33 stddev:1438.27 (25.7%) stddev-sans-first:1400.65 20:16:31 INFO - PROCESS | 8388 | Values: 357.2 374.7 375.1 376.6 380.9 5395.4 5508.3 5603.5 5652.4 5660.4 5354.0 5476.3 5509.1 5537.2 5573.5 4326.3 4362.6 4364.8 4382.8 4407.1 4295.8 4330.8 4370.5 4374.8 4386.2 4322.0 4326.1 4334.0 4337.2 4341.3 4337.9 4341.9 4343.4 4362.8 4381.5 3838.4 3964.5 3965.3 3965.8 3966.8 5369.5 5426.8 5445.3 5455.5 5484.9 5077.8 5080.5 5090.4 5103.2 5106.0 5658.8 5791.4 5812.7 5851.9 5876.9 4345.2 4357.3 4365.1 4370.9 4372.1 6034.3 6036.0 6051.8 6054.3 6073.6 4379.9 4469.7 4482.6 4486.2 4487.0 4541.7 4545.1 4551.2 4552.2 4560.8 5046.2 5086.8 5091.3 5110.1 5145.6 5693.5 5886.6 5903.5 5922.6 5934.9 1405.7 1426.0 1439.8 1440.4 1444.7 957.9 988.4 993.5 996.6 1002.8 5473.2 5523.5 5545.6 5546.8 5588.7 5756.7 5798.3 5814.8 5826.7 5841.3 5494.2 5546.4 5598.0 5744.4 5748.9 3060.2 3066.8 3090.3 3091.9 3092.2 5977.7 5992.0 6030.6 6055.8 6057.3 6050.6 6070.6 6073.5 6094.0 6122.9 6222.4 6235.4 6239.8 6263.4 6299.0 5779.9 5952.4 5971.4 5986.5 6016.8 5951.6 5959.2 5963.5 5966.2 5972.2 6001.6 6107.9 6169.7 6222.9 6278.7 4178.8 4191.9 4241.0 4261.6 4267.0 5834.6 6019.9 6029.6 6030.1 6089.3 5806.2 5825.9 5826.3 5831.6 5833.0 5875.9 5876.6 5884.6 5895.4 5906.8 5670.9 5789.9 5838.2 5844.2 5864.4 5844.3 5856.9 5865.8 5877.8 5920.5 5498.9 5676.6 5748.5 5752.3 5787.6 20:16:31 INFO - PROCESS | 8388 | 20:16:31 INFO - PROCESS | 8388 | [#5] yui.html Cycles:180 Average:19343.05 Median:43814.67 stddev:24236.70 (55.3%) stddev-sans-first:24264.83 20:16:31 INFO - PROCESS | 8388 | Values: 831.2 834.4 858.9 907.9 926.6 16252.2 16999.6 17127.9 17927.2 18232.6 16392.6 16508.5 16673.7 16686.6 16894.9 828.0 842.9 843.4 845.1 845.1 805.3 839.6 844.2 844.3 844.7 875.0 877.3 886.1 887.3 887.7 876.6 876.8 878.3 879.5 881.4 641.7 642.6 643.0 647.8 648.7 17197.9 17590.7 17686.0 17814.3 18012.0 15153.6 15191.0 15347.1 15436.5 15733.4 13460.7 13605.2 13617.7 13671.8 13773.2 3903.6 3904.7 3960.1 4003.2 4015.3 81350.6 83612.6 84712.0 84866.6 86467.6 11934.8 12074.9 12173.1 12214.7 12288.8 24037.6 24063.2 24069.0 24131.2 24362.1 8280.2 8343.3 8445.2 8632.1 8702.6 4525.9 4665.6 4681.2 4712.6 4740.1 3823.7 3903.3 3927.1 3931.3 3937.4 679.4 681.5 683.4 686.4 686.9 786.9 789.2 801.7 807.2 809.9 11478.6 11607.7 11737.6 12047.3 12146.1 849.1 860.3 875.9 881.9 883.9 5736.6 5758.7 5793.4 5814.4 5848.2 81132.0 84289.0 86562.0 88719.6 89777.6 71103.6 76891.6 76893.2 76945.0 78929.6 68720.7 69690.3 70012.6 70434.9 71445.3 11505.4 11845.2 11902.0 11921.5 12091.3 43618.3 44011.0 44073.6 44309.8 45170.8 55696.4 56386.7 57256.4 57932.7 58804.0 14348.2 14669.8 14697.7 15145.0 15285.4 16126.0 16434.8 16564.0 16652.8 16817.6 15520.8 15545.7 15551.2 15800.3 15979.8 15431.7 15790.0 15803.6 15948.0 16127.5 15372.8 15420.6 15446.8 15453.8 15516.4 12389.0 12416.8 12707.9 12762.0 12913.5 12212.5 12704.9 13006.5 13082.3 13143.5 20:16:31 INFO - PROCESS | 8388 | -------- Summary: end -------- 20:16:31 INFO - PROCESS | 8388 | 20:16:32 INFO - TEST-INFO | 8388: exit 0 20:16:32 INFO - TEST-OK | dromaeo_css | took 1112091ms 20:16:32 INFO - TEST-START | kraken 20:16:32 INFO - operating with platform_type : linux_ 20:16:32 INFO - Initialising browser for kraken test... 20:16:32 INFO - TEST-INFO | started process 8755 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2ADoUc/profile http://localhost:52376/getInfo.html) 20:16:36 INFO - PROCESS | 8755 | __metrics Screen width/height:1600/1200 20:16:36 INFO - PROCESS | 8755 | colorDepth:24 20:16:36 INFO - PROCESS | 8755 | Browser inner width/height: 1024/697 20:16:36 INFO - PROCESS | 8755 | __metrics 20:16:37 INFO - PROCESS | 8755 | 1486354597239 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmp2ADoUc/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmp2ADoUc/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmp2ADoUc/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmp2ADoUc/profile/extensions/talos-powers@TalosPowersService.js:55:9 20:16:37 ERROR - PROCESS | 8755 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 20:16:38 INFO - TEST-INFO | 8755: exit 0 20:16:38 INFO - Browser initialized. 20:16:38 INFO - Running cycle 1/1 for kraken test... 20:16:38 INFO - TEST-INFO | started process 8883 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2ADoUc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:16:49 INFO - PROCESS | 8883 | RSS: Main: 144613376 20:16:49 INFO - PROCESS | 8883 | 20:16:52 INFO - PROCESS | 8883 | Cycle 1(1): loaded http://localhost:52376/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52376/tests/kraken/driver.html?testName=audio-beat-detection) 20:16:53 INFO - PROCESS | 8883 | RSS: Main: 151347200 20:16:53 INFO - PROCESS | 8883 | 20:16:56 INFO - PROCESS | 8883 | Cycle 1(1): loaded http://localhost:52376/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52376/tests/kraken/driver.html?testName=audio-dft) 20:16:56 INFO - PROCESS | 8883 | RSS: Main: 150360064 20:16:56 INFO - PROCESS | 8883 | 20:16:59 INFO - PROCESS | 8883 | Cycle 1(1): loaded http://localhost:52376/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52376/tests/kraken/driver.html?testName=audio-fft) 20:17:00 INFO - PROCESS | 8883 | RSS: Main: 150437888 20:17:00 INFO - PROCESS | 8883 | 20:17:02 INFO - PROCESS | 8883 | Cycle 1(1): loaded http://localhost:52376/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52376/tests/kraken/driver.html?testName=audio-oscillator) 20:17:02 INFO - PROCESS | 8883 | RSS: Main: 150487040 20:17:02 INFO - PROCESS | 8883 | 20:17:04 INFO - PROCESS | 8883 | Cycle 1(1): loaded http://localhost:52376/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52376/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:17:05 INFO - PROCESS | 8883 | RSS: Main: 150171648 20:17:05 INFO - PROCESS | 8883 | 20:17:08 INFO - PROCESS | 8883 | Cycle 1(1): loaded http://localhost:52376/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52376/tests/kraken/driver.html?testName=imaging-darkroom) 20:17:09 INFO - PROCESS | 8883 | RSS: Main: 153370624 20:17:09 INFO - PROCESS | 8883 | 20:17:12 INFO - PROCESS | 8883 | Cycle 1(1): loaded http://localhost:52376/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52376/tests/kraken/driver.html?testName=imaging-desaturate) 20:17:13 INFO - PROCESS | 8883 | RSS: Main: 153628672 20:17:13 INFO - PROCESS | 8883 | 20:17:16 INFO - PROCESS | 8883 | Cycle 1(1): loaded http://localhost:52376/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52376/tests/kraken/driver.html?testName=json-parse-financial) 20:17:16 INFO - PROCESS | 8883 | RSS: Main: 153075712 20:17:16 INFO - PROCESS | 8883 | 20:17:18 INFO - PROCESS | 8883 | Cycle 1(1): loaded http://localhost:52376/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52376/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:17:18 INFO - PROCESS | 8883 | RSS: Main: 152227840 20:17:18 INFO - PROCESS | 8883 | 20:17:20 INFO - PROCESS | 8883 | Cycle 1(1): loaded http://localhost:52376/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52376/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:17:21 INFO - PROCESS | 8883 | RSS: Main: 152215552 20:17:21 INFO - PROCESS | 8883 | 20:17:23 INFO - PROCESS | 8883 | Cycle 1(1): loaded http://localhost:52376/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52376/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:17:23 INFO - PROCESS | 8883 | RSS: Main: 152846336 20:17:23 INFO - PROCESS | 8883 | 20:17:26 INFO - PROCESS | 8883 | Cycle 1(1): loaded http://localhost:52376/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:17:27 INFO - PROCESS | 8883 | RSS: Main: 153051136 20:17:27 INFO - PROCESS | 8883 | 20:17:29 INFO - PROCESS | 8883 | Cycle 1(1): loaded http://localhost:52376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:17:30 INFO - PROCESS | 8883 | RSS: Main: 153309184 20:17:30 INFO - PROCESS | 8883 | 20:17:32 INFO - PROCESS | 8883 | Cycle 1(1): loaded http://localhost:52376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52376/tests/kraken/driver.html?testName=ai-astar) 20:17:32 INFO - PROCESS | 8883 | RSS: Main: 154808320 20:17:32 INFO - PROCESS | 8883 | 20:17:32 INFO - PROCESS | 8883 | __start_tp_report 20:17:32 INFO - PROCESS | 8883 | _x_x_mozilla_page_load 20:17:32 INFO - PROCESS | 8883 | _x_x_mozilla_page_load_details 20:17:32 INFO - PROCESS | 8883 | |i|pagename|runs| 20:17:32 INFO - PROCESS | 8883 | |0;ai-astar;103;113;112;112;112;111;113;112;112;113 20:17:32 INFO - PROCESS | 8883 | |1;audio-beat-detection;142;121;125;154;125;120;123;126;134;124 20:17:32 INFO - PROCESS | 8883 | |2;audio-dft;161;165;162;161;162;163;163;161;162;163 20:17:32 INFO - PROCESS | 8883 | |3;audio-fft;75;76;76;128;78;76;79;76;93;75 20:17:32 INFO - PROCESS | 8883 | |4;audio-oscillator;86;82;101;82;82;83;90;85;84;105 20:17:32 INFO - PROCESS | 8883 | |5;imaging-gaussian-blur;118;118;121;118;117;117;118;118;117;117 20:17:32 INFO - PROCESS | 8883 | |6;imaging-darkroom;148;149;147;148;148;149;149;148;148;152 20:17:32 INFO - PROCESS | 8883 | |7;imaging-desaturate;96;97;97;96;96;96;96;96;96;96 20:17:32 INFO - PROCESS | 8883 | |8;json-parse-financial;58;59;57;56;57;56;57;57;61;57 20:17:32 INFO - PROCESS | 8883 | |9;json-stringify-tinderbox;65;64;64;64;65;64;64;65;65;65 20:17:32 INFO - PROCESS | 8883 | |10;stanford-crypto-aes;75;76;86;75;75;76;80;75;76;75 20:17:32 INFO - PROCESS | 8883 | |11;stanford-crypto-ccm;128;130;122;122;132;120;126;132;157;127 20:17:32 INFO - PROCESS | 8883 | |12;stanford-crypto-pbkdf2;159;158;161;161;158;167;162;156;155;159 20:17:32 INFO - PROCESS | 8883 | |13;stanford-crypto-sha256-iterative;62;63;62;60;63;61;61;59;60;63 20:17:32 INFO - PROCESS | 8883 | __end_tp_report 20:17:32 INFO - PROCESS | 8883 | __start_cc_report 20:17:32 INFO - PROCESS | 8883 | _x_x_mozilla_cycle_collect,717 20:17:32 INFO - PROCESS | 8883 | __end_cc_report 20:17:32 INFO - PROCESS | 8883 | __startTimestamp1486354652407__endTimestamp 20:17:32 INFO - PROCESS | 8883 | 20:17:32 INFO - PROCESS | 8883 | ------- Summary: start ------- 20:17:32 INFO - PROCESS | 8883 | Number of tests: 14 20:17:32 INFO - PROCESS | 8883 | 20:17:32 INFO - PROCESS | 8883 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.98 (2.7%) stddev-sans-first:0.67 20:17:32 INFO - PROCESS | 8883 | Values: 103.0 113.0 112.0 112.0 112.0 111.0 113.0 112.0 112.0 113.0 20:17:32 INFO - PROCESS | 8883 | 20:17:32 INFO - PROCESS | 8883 | [#1] audio-beat-detection Cycles:10 Average:129.40 Median:125.50 stddev:10.88 (8.7%) stddev-sans-first:10.54 20:17:32 INFO - PROCESS | 8883 | Values: 142.0 121.0 125.0 154.0 125.0 120.0 123.0 126.0 134.0 124.0 20:17:32 INFO - PROCESS | 8883 | 20:17:32 INFO - PROCESS | 8883 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:1.25 (0.8%) stddev-sans-first:1.24 20:17:32 INFO - PROCESS | 8883 | Values: 161.0 165.0 162.0 161.0 162.0 163.0 163.0 161.0 162.0 163.0 20:17:32 INFO - PROCESS | 8883 | 20:17:32 INFO - PROCESS | 8883 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.00 stddev:16.63 (21.9%) stddev-sans-first:17.37 20:17:32 INFO - PROCESS | 8883 | Values: 75.0 76.0 76.0 128.0 78.0 76.0 79.0 76.0 93.0 75.0 20:17:32 INFO - PROCESS | 8883 | 20:17:32 INFO - PROCESS | 8883 | [#4] audio-oscillator Cycles:10 Average:88.00 Median:83.50 stddev:8.33 (10.0%) stddev-sans-first:8.80 20:17:32 INFO - PROCESS | 8883 | Values: 86.0 82.0 101.0 82.0 82.0 83.0 90.0 85.0 84.0 105.0 20:17:32 INFO - PROCESS | 8883 | 20:17:32 INFO - PROCESS | 8883 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.20 (1.0%) stddev-sans-first:1.27 20:17:32 INFO - PROCESS | 8883 | Values: 118.0 118.0 121.0 118.0 117.0 117.0 118.0 118.0 117.0 117.0 20:17:32 INFO - PROCESS | 8883 | 20:17:32 INFO - PROCESS | 8883 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.50 stddev:1.35 (0.9%) stddev-sans-first:1.41 20:17:32 INFO - PROCESS | 8883 | Values: 148.0 149.0 147.0 148.0 148.0 149.0 149.0 148.0 148.0 152.0 20:17:32 INFO - PROCESS | 8883 | 20:17:32 INFO - PROCESS | 8883 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:17:32 INFO - PROCESS | 8883 | Values: 96.0 97.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 20:17:32 INFO - PROCESS | 8883 | 20:17:32 INFO - PROCESS | 8883 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.00 stddev:1.51 (2.6%) stddev-sans-first:1.59 20:17:32 INFO - PROCESS | 8883 | Values: 58.0 59.0 57.0 56.0 57.0 56.0 57.0 57.0 61.0 57.0 20:17:32 INFO - PROCESS | 8883 | 20:17:32 INFO - PROCESS | 8883 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 20:17:32 INFO - PROCESS | 8883 | Values: 65.0 64.0 64.0 64.0 65.0 64.0 64.0 65.0 65.0 65.0 20:17:32 INFO - PROCESS | 8883 | 20:17:32 INFO - PROCESS | 8883 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:76.00 stddev:3.54 (4.7%) stddev-sans-first:3.69 20:17:32 INFO - PROCESS | 8883 | Values: 75.0 76.0 86.0 75.0 75.0 76.0 80.0 75.0 76.0 75.0 20:17:32 INFO - PROCESS | 8883 | 20:17:32 INFO - PROCESS | 8883 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:129.00 stddev:10.50 (8.1%) stddev-sans-first:11.12 20:17:32 INFO - PROCESS | 8883 | Values: 128.0 130.0 122.0 122.0 132.0 120.0 126.0 132.0 157.0 127.0 20:17:32 INFO - PROCESS | 8883 | 20:17:32 INFO - PROCESS | 8883 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.60 Median:160.00 stddev:3.41 (2.1%) stddev-sans-first:3.61 20:17:32 INFO - PROCESS | 8883 | Values: 159.0 158.0 161.0 161.0 158.0 167.0 162.0 156.0 155.0 159.0 20:17:32 INFO - PROCESS | 8883 | 20:17:32 INFO - PROCESS | 8883 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:62.00 stddev:1.43 (2.3%) stddev-sans-first:1.50 20:17:32 INFO - PROCESS | 8883 | Values: 62.0 63.0 62.0 60.0 63.0 61.0 61.0 59.0 60.0 63.0 20:17:32 INFO - PROCESS | 8883 | -------- Summary: end -------- 20:17:32 INFO - PROCESS | 8883 | 20:17:33 INFO - TEST-INFO | 8883: exit 0 20:17:33 INFO - TEST-OK | kraken | took 61172ms 20:17:33 INFO - SUITE-END | took 1173s 20:17:33 INFO - Completed test suite (00:19:33) 20:17:33 INFO - javascript benchmark 20:17:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7835.673039805219, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3319.2697606526563, 3319.5850518685165, 3341.7493687973392, 3370.8146051967133, 3373.0724050886, 5520.089185284428, 5559.777608895639, 5567.972160139198, 5630.296212973379, 5662.37713851477, 5526.834194974157, 5531.751071201796, 5547.362053363864, 5568.3596386415575, 5582.330120385549, 4907.435644900837, 4962.131626965284, 5012.198048312271, 5031.874203144932, 5038.244263360507, 5005.54950054495, 5030.647854650176, 5035.697858128506, 5051.040302342543, 5058.7976480940715, 4888.633352498577, 4892.730899800509, 5034.421041580228, 5041.672291301072, 5051.722155281458, 4983.377077865249, 5000.224965130411, 5018.7490625468945, 5070.31550740649, 5117.1556693145585, 5040.495950404967, 5085.669431486978, 5088.847334579968, 5090.211017292326, 5096.566791822699, 5582.413846546095, 5621.4659607337235, 5682.744276507526, 5689.431056894319, 5695.117256825158, 5765.164051212592, 5794.884102317972, 5948.494377977877, 5969.462748352626, 5997.22036135304, 6106.633601983851, 6108.664023478706, 6111.297200821918, 6119.051547010221, 6144.5698801083945, 5673.6879471629045, 5686.431356864363, 5687.687177205252, 5690.48785609293, 5694.0, 5769.9711501442225, 5801.8549536261935, 6038.6678732670125, 6041.305249896231, 6163.568550201443, 5858.53131749459, 5907.911381329283, 5934.37689042653, 5941.55438342126, 5960.7019649017375, 5971.641701497924, 6002.309734380515, 6009.0, 6038.426349496791, 6044.939550604526, 5786.594938354359, 5790.942090579125, 5845.123231515222, 5881.41185881417, 5956.285245770535, 5834.533237341003, 5897.675627840425, 5913.349531551526, 5928.762849486058, 5932.0, 4550.954490455053, 4560.5895469407915, 4566.589006989387, 4570.451545814457, 4573.291139873325, 4062.756234625932, 4067.471228740245, 4075.9796201018803, 4079.4084857695466, 4081.3061779497557, 5815.767369305265, 5838.474537291664, 5853.64878107315, 5874.706264686749, 5961.016432288624, 6064.120702498113, 6096.69516524172, 6113.694315284218, 6118.082287656887, 6128.662923539159, 5562.805301814417, 5768.884622307614, 5792.507636850831, 5899.056151015902, 5910.704464776744, 5156.535911767959, 5178.456262092426, 5190.169572868323, 5206.791728330824, 5218.0, 6321.304656487782, 6325.810225693236, 6330.240371155491, 6334.271558770801, 6349.52378571609, 5851.063829787384, 5925.05199168131, 6080.300765412034, 6086.239220097488, 6100.938990610214, 6138.048602466625, 6145.569810113249, 6161.137440758387, 6244.562880598314, 6250.062490626442, 5865.266841644794, 5877.500412464818, 5916.053431450947, 5918.3489816121055, 5922.674252916131, 5921.17103605487, 5951.464368206882, 6003.309619393825, 6005.6396616203165, 6028.156058151774, 5774.1916131740745, 5790.363060063305, 5800.564957628279, 5803.883922321445, 5864.32560255576, 5787.450192231731, 5861.413858614104, 5862.589618726648, 5870.324912635102, 5882.23530940975, 5800.50695690871, 5829.8251052468495, 5847.06446968483, 5848.53211743051, 5850.151727999331, 5741.167530708108, 5828.358880523054, 5838.4453476919625, 5861.912071318849, 5949.494292985145, 5806.5645076618575, 5845.298564172326, 5853.882922341614, 5861.238039055066, 5871.7651293947765], "value": 5527.365597388264, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.9334226563943, 598.5780025082317, 626.9122322874796, 704.8836941904586, 736.0394684936156, 43429.0, 44174.33738493921, 47769.76115119428, 47789.0, 48088.51911480884, 48372.51627483724, 49248.75375623126, 49269.753651231695, 49295.50704492954, 49549.50450495503, 9168.495732734713, 10668.679939601825, 11086.722831929226, 11121.0, 11439.485223164978, 11054.170937179704, 11076.11391088715, 11108.944455277713, 11139.387333696643, 11139.554417823278, 11171.66485005451, 11203.439828008608, 11245.887541124566, 11253.887461125365, 11290.830637540443, 11033.889661103367, 11047.281926674741, 11086.2239643225, 11172.99999999996, 11190.216684832065, 10905.34567925919, 11006.394648294341, 11021.724456888562, 11117.555297788078, 11142.164337674625, 41413.37879931804, 41428.79285603583, 41450.79274603607, 41684.58315416837, 41905.37141942873, 4226.661867050629, 4249.426327445817, 4264.0832221072615, 4332.263515202391, 4362.389265502832, 31496.527552086736, 31616.209594760086, 32350.514742278883, 32404.837975810206, 33032.3393532128, 4603.654725895572, 4646.581807637295, 4701.529847015306, 4723.0, 4735.289706544011, 350167.0, 352492.0, 352758.0, 354450.0, 354647.0, 59501.0, 59778.0, 60118.39881601215, 60349.39650603526, 60370.0, 62495.0, 62518.374816252166, 62625.68687156535, 62714.0, 62941.37058629355, 17673.0, 18021.0, 18499.167537460846, 18533.443996680122, 18555.16501757424, 13729.45082196721, 14391.856081439051, 14450.421983120557, 14451.566453006426, 14509.92745036268, 19713.0, 19795.703064454046, 20112.798872011386, 20154.596908061758, 20174.697379539317, 7492.70029198826, 7625.6568454419685, 7656.578888161093, 7695.884561731578, 7787.727429539939, 979.0, 1012.7974405118858, 1038.0605551975475, 1039.8024375368657, 1045.8483519889573, 32482.0, 32535.674643253737, 32669.836650816593, 32826.50760238598, 33420.164495887795, 1162.808136657442, 1192.797224471842, 1197.7185361440054, 1197.868234494205, 1217.2635555488803, 17288.567785805455, 17356.65286694259, 17444.73832892482, 17656.82343176552, 17683.911580442014, 580389.0, 589455.0, 590649.0, 593317.0, 595820.0, 69858.3014169862, 70552.64723676349, 70646.293537065, 70785.0, 70822.2917770826, 1558.5402306319663, 1580.8023997000375, 1581.4543982326309, 1597.4009746344889, 1604.9438269660507, 31150.53274200934, 32164.195895101875, 32742.83628581842, 33210.0, 34108.488372673935, 58262.0, 58886.116708250265, 59182.0, 59286.40713592981, 59346.0, 529110.0, 534240.0, 535163.0, 536130.0, 537170.0, 29338.706612933598, 29963.850180748956, 29982.800687972238, 31598.526022110145, 44536.0, 46186.538134618226, 46378.768106160605, 46447.53552464432, 46497.53502465067, 47230.52769472399, 40677.796611016754, 40751.388729168495, 41162.588374115876, 42333.57666423296, 43088.35367469553, 40290.0, 40447.59552404556, 41460.1707965833, 42017.36973945332, 42048.15903681971, 40883.38674919938, 40966.590334096276, 41531.792341038104, 41883.16233675249, 41963.580364195965, 33833.323333533684, 34582.30835383329, 35373.29253414969, 35411.468827968114, 35484.29031419306, 26926.59610105889, 27198.1840544784, 27218.183454496397, 27438.45123097567, 28104.43791124207], "value": 21871.00134211833, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.92287465381594, 406.84743221292035, 416.843683618643, 419.3437270671399, 421.191312679655, 19944.401667949947, 20957.8473183975, 21741.23905663302, 22099.226527071554, 22258.777412225874, 22235.888820555876, 22361.329160125224, 22521.662175067388, 23024.07903683855, 23156.189533366334, 5896.233489646351, 6131.14164017038, 6151.538634602401, 6164.691765411734, 6175.444210021097, 5999.550033747465, 7618.504797188193, 7944.483608565453, 7967.920320796776, 8007.559584222866, 7736.303732664059, 7951.244631760002, 7967.561784101872, 7969.681212751483, 7981.401394895377, 7769.883451748228, 8060.476069055522, 8069.475484093515, 8132.471389359673, 8138.633761480747, 7897.368210543143, 7937.44437889348, 7985.800354991114, 7999.920000799976, 8003.399745019147, 30219.395612087636, 30584.0, 30789.076327710205, 30988.84505577458, 30993.0, 3155.085025342648, 3276.2792185719104, 3310.6854848789326, 3615.2407994321225, 3787.9242415151543, 17102.401415950382, 17673.469795906145, 18007.72988405175, 18370.540736481697, 18876.433706988813, 2231.955360892773, 2253.752087270399, 2280.8289378296527, 2300.6549017647485, 2305.896234669427, 85497.0, 87244.56377718135, 104467.0, 120298.39850800777, 122870.38564807209, 20771.376858694264, 21150.576988460143, 21204.681929771064, 21340.573188536142, 21616.487795612018, 42685.78657106694, 42838.357424638656, 42860.57139428566, 43019.784901075924, 43139.35290970638, 8957.417767845069, 9154.528277365074, 9382.155605995493, 9464.1009104135, 9622.615095396246, 9037.367384283038, 9052.140046695553, 9055.275577953747, 9212.493312867722, 9274.536273186448, 5201.817936372209, 5245.947540524546, 5292.92060619091, 5294.676330917271, 5675.233843431167, 2223.110755697734, 2227.7438094619, 2268.2061278552374, 2271.2511366247895, 2342.6603142544236, 945.1965829045394, 974.0746291023556, 978.3542861711236, 987.7777500062429, 993.1607791416242, 20809.271675491284, 21016.684749728767, 21017.68473472899, 21238.78761212399, 21343.0, 967.5597603090577, 969.699393188114, 974.3228456222998, 975.8682577852042, 977.7653363192783, 11062.335381914043, 11709.297442153498, 11757.176997610257, 11758.823617645741, 11823.113266505046, 481274.0, 520062.0, 720306.0, 790363.0, 802264.0, 83051.58474207591, 89253.55373223222, 122951.0, 124586.0, 125976.0, 1176.7881781279282, 1180.451090243041, 1214.319980810731, 1218.2812140837125, 1226.625879106881, 19026.42920712381, 19123.90438047801, 19384.8061519383, 19398.806011940265, 19556.608867822848, 48956.2656560159, 49452.0, 49520.0, 49610.0, 50525.74737126291, 70814.64592677004, 71126.64436677784, 71591.64204178946, 71683.28316716765, 71738.64130679313, 9166.08339166078, 9198.310126740387, 9301.302402319989, 9415.85876211871, 9556.56995435221, 9968.850467242852, 13805.309734513436, 14343.713125737635, 14498.420063197354, 14728.484503042342, 12195.878041219474, 12515.311657858905, 12555.560555380518, 12738.172018818746, 12801.167924084904, 11759.353235572125, 11813.468393922467, 12217.633470995885, 12240.510379585074, 12255.080868935043, 12585.811212831997, 12992.350382481027, 13028.739425211632, 13046.478140874258, 13073.215607063607, 9110.134537218953, 9117.133872282122, 9269.646160272017, 9275.72172834816, 9291.535423228675, 10653.057969858875, 12565.120441569003, 12664.493420263454, 12886.42011109521, 12950.417231224807], "value": 11280.492346703188, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1451.114819959825, 1505.2248092232503, 1505.284989629926, 1512.6672132130934, 1529.090191336155, 8667.479951202933, 9044.8643270351, 9249.907500924988, 9252.12104850039, 9260.444373337605, 9016.819663606724, 9116.042815504376, 9149.085091490848, 9164.633414663405, 9187.678431254908, 2379.0840526397333, 2407.963880541793, 2410.915617953372, 2414.95170096598, 2416.178499310234, 2392.5932591459496, 2436.756324367567, 2442.670239517669, 2445.2297526279253, 2448.069733501267, 2316.976830231693, 2372.7152741671025, 2414.2033129067454, 2431.3799981004818, 2431.878406079698, 2264.62633665445, 2276.829237807163, 2294.8852557372065, 2297.4715815362392, 2301.2866011536476, 2359.056377449017, 2379.7263314718857, 2402.4114092047384, 2413.2880800163994, 2415.7705018023435, 9073.954630226872, 9169.037251088674, 9196.862047069299, 9199.356045076847, 9254.398464099811, 5356.38401583819, 5435.864103397446, 5463.2078348639225, 5475.534579560742, 5476.26070480484, 3535.522704434894, 3573.4639804029603, 3597.244578638489, 3675.3568125578186, 3715.5727091384565, 1341.597520743773, 1347.71697943432, 1371.4856928651755, 1407.2682205253313, 1415.3206460898723, 12178.939105304506, 12201.877981220252, 12295.69260768488, 12321.876781232162, 12338.198017128858, 4745.406824146981, 4745.678274298768, 4844.32179494864, 4863.197572400585, 4867.342908707279, 10090.2432317575, 10094.293399462114, 10105.0, 10119.291649584458, 10162.0, 5504.697241651747, 5569.10894256917, 5572.275604171432, 5595.776168953196, 5603.467670571289, 5065.56942659878, 5206.661566998133, 5247.344081989751, 5263.236830659533, 5309.946900531023, 3842.2507611016144, 3929.096307849211, 3950.4074388841327, 4010.939835902464, 4017.517897852218, 1185.247367921376, 1188.441432526711, 1191.5293459083787, 1197.2517176764522, 1200.4657927222477, 830.8670612701939, 834.7996480844554, 839.7774589733725, 858.1375717404094, 862.4351050062219, 5813.970930145407, 5941.55438342126, 6129.601575897553, 6186.10301506279, 6251.187345645128, 1022.5194158745378, 1037.180627304436, 1075.231209685079, 1075.7471994081384, 1078.8219943709357, 4092.4066010428323, 4117.135401565645, 4237.809298581571, 4247.256730072225, 4268.0, 10406.11548018427, 10723.624673136403, 10728.892711072946, 10832.512536935857, 10843.945780271048, 10520.736981575368, 10625.46872656364, 10664.573417063231, 10676.733081672865, 10707.411092389993, 8390.412671112963, 8507.659693612186, 8559.871601925975, 8631.093735157843, 8639.568021598894, 5987.461128498456, 6025.0, 6105.328413874381, 6215.098810672517, 6241.063840423973, 9984.850227246743, 10099.192064634959, 10135.7466063349, 10163.28856980034, 10230.181585473294, 9433.481158536346, 9669.564869581027, 9793.314467987457, 9860.950695246478, 10091.949540252252, 7594.392448603988, 7769.378449723896, 7843.372530197456, 7862.882056769038, 8098.3116435103675, 8548.273396761346, 8569.10024447424, 8572.957135214285, 8589.699360522602, 8596.699115531177, 7720.845583088195, 7750.6899724012665, 7783.961080194563, 7788.143304236416, 7828.882566761389, 7648.50284731513, 7715.8071048222, 7718.3053525183, 7731.536107833548, 7735.033120859893, 6936.7572134975035, 6957.686904089429, 6966.860662786818, 6976.337247961435, 7037.612931288623, 5094.337736094284, 5204.869878253074, 5259.789608415621, 5298.1258092415865, 5341.919871201857, 5156.767945442539, 5156.97421512905, 5192.273081768631, 5235.057689615754, 5251.579873610179], "value": 4731.5686526833915, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.1660173494889, 374.7489182247892, 375.1465416178196, 376.6365457333673, 380.8514679275082, 5395.379531353886, 5508.338999320077, 5603.495685388314, 5652.406497317784, 5660.433956604337, 5353.982743278774, 5476.288082549273, 5509.146082357231, 5537.197106419567, 5573.498385145336, 4326.30779075348, 4362.585554372329, 4364.781760911949, 4382.846600368987, 4407.074514351973, 4295.806688699, 4330.826766929319, 4370.453693288339, 4374.803133858984, 4386.210482113234, 4321.9783901080455, 4326.113146804897, 4333.956660433402, 4337.154254920292, 4341.305391137419, 4337.913241735163, 4341.891452713676, 4343.413639158704, 4362.847300344489, 4381.518033016366, 3838.3858483151075, 3964.5133075096837, 3965.275105329191, 3965.7620542767236, 3966.7619942803526, 5369.516743493065, 5426.75579598919, 5445.346558413015, 5455.454454554552, 5484.91772623411, 5077.771500282496, 5080.466551012164, 5090.414602320743, 5103.157978933472, 5105.974470127663, 5658.801941932013, 5791.362950075489, 5812.709364531799, 5851.912221316641, 5876.941230587682, 4345.174416860818, 4357.324614684729, 4365.148795984785, 4370.8907277318, 4372.1255748850035, 6034.275886893557, 6036.0, 6051.757929682807, 6054.273487181523, 6073.574849760518, 4379.868603941887, 4469.748470428285, 4482.574155455227, 4486.170058539181, 4487.0, 4541.704789188692, 4545.136424079415, 4551.249043907718, 4552.248878934939, 4560.814188311063, 5046.217836235316, 5086.77109530072, 5091.3126727892, 5110.061714514095, 5145.614078944094, 5693.4875861172695, 5886.6173698709445, 5903.468687818117, 5922.585419020714, 5934.910976335358, 1405.676694360303, 1425.950091746784, 1439.7768345906402, 1440.3734375546671, 1444.714204358122, 957.861110139026, 988.4415305352453, 993.513178542509, 996.5963784667222, 1002.8144793213279, 5473.233747275384, 5523.530499907472, 5545.584081193927, 5546.77812887488, 5588.6646801192055, 5756.712164391847, 5798.26052184343, 5814.76740930358, 5826.73779679907, 5841.328247251536, 5494.230807686927, 5546.362168350692, 5598.0, 5744.396838331915, 5748.885022299531, 3060.219643990768, 3066.8006579572257, 3090.2892334763133, 3091.8917837876015, 3092.196029032468, 5977.701114944235, 5992.04525013489, 6030.638161710312, 6055.757769689163, 6057.273127224673, 6050.638606313632, 6070.6357618543025, 6073.51411887048, 6093.969530152321, 6122.877542449215, 6222.377762223741, 6235.441139715072, 6239.78160764371, 6263.4362907337645, 6298.968505157445, 5779.884402312015, 5952.404759524186, 5971.4327138921735, 5986.521078313812, 6016.819495415145, 5951.553633477593, 5959.195508606456, 5963.522918166623, 5966.164736936919, 5972.223610930551, 6001.609895356788, 6107.938920610737, 6169.660668663267, 6222.906656400067, 6278.748850045947, 4178.770167640688, 4191.916161676689, 4241.0, 4261.595148460891, 4267.0, 5834.562407819346, 6019.939800601938, 6029.57792954489, 6030.125631783455, 6089.269287685506, 5806.229100124503, 5825.854353641193, 5826.271716035496, 5831.591788574759, 5833.008388573868, 5875.882482350415, 5876.559258055749, 5884.617499862496, 5895.41045895407, 5906.793262235801, 5670.9432905672065, 5789.884202316014, 5838.211841401357, 5844.240248767633, 5864.413558644272, 5844.298684157929, 5856.9121463178935, 5865.824025279248, 5877.794277200449, 5920.467157955804, 5498.917516237339, 5676.602637815313, 5748.511376533042, 5752.28096487939, 5787.565932554991], "value": 4478.31914602563, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [831.1812864328639, 834.3950635789057, 858.8969323681159, 907.8728977943088, 926.6478738079529, 16252.18739063048, 16999.57501062474, 17127.914360428196, 17927.193276302565, 18232.635347293046, 16392.590185245375, 16508.504744857644, 16673.749893751603, 16686.58283542909, 16894.915525422355, 827.9751607451786, 842.9367797415188, 843.3843294395095, 845.1041895590663, 845.1379592815325, 805.3436449293807, 839.6095815445816, 844.1937949258474, 844.3414136973171, 844.6959094725894, 875.0374587953232, 877.2806298834957, 886.1271647427279, 887.2591386192505, 887.6759982606335, 876.6449587916904, 876.7808047988003, 878.2929741558044, 879.4898958604026, 881.3654168998311, 641.6631268583984, 642.5726891617069, 642.9549931504797, 647.757091090841, 648.6918713611044, 17197.91401042999, 17590.736138957927, 17686.0, 17814.287428502976, 18012.00933948632, 15153.621159470991, 15191.0, 15347.07917524941, 15436.53690389279, 15733.449329273535, 13460.663483412993, 13605.183688978694, 13617.659558511017, 13671.794923076162, 13773.173609583457, 3903.6486716195395, 3904.746191497572, 3960.108975480494, 4003.15933653933, 4015.337469317559, 81350.59324703398, 83612.58193709054, 84712.0, 84866.57566712188, 86467.56766216192, 11934.820977685342, 12074.87925120755, 12173.147879648339, 12214.694632634255, 12288.754224915452, 24037.639435408484, 24063.157789477285, 24069.0, 24131.155409560582, 24362.147324843547, 8280.213379729037, 8343.290820280345, 8445.1977062179, 8632.093630168867, 8702.564871756387, 4525.886852828639, 4665.5567721066445, 4681.227597446451, 4712.552307530779, 4740.1230772307235, 3823.713221508398, 3903.2974064668065, 3927.136030073379, 3931.331673615492, 3937.3897045957924, 679.3546131175403, 681.5059082165391, 683.4122654517112, 686.4474098350876, 686.8694947959872, 786.9173736757673, 789.1595450844947, 801.7193982106216, 807.188775280839, 809.9433039687283, 11478.583689273955, 11607.709807254887, 11737.647870563897, 12047.27716337005, 12146.149769516049, 849.0660273698882, 860.3289434241302, 875.92992560595, 881.9470831750116, 883.9116088391238, 5736.598438109292, 5758.712064396764, 5793.362730099686, 5814.447627475383, 5848.239728835224, 81132.0, 84289.0, 86562.0, 88719.55640221758, 89777.55111224533, 71103.64448177726, 76891.61554192193, 76893.23106768973, 76945.0, 78929.60535197402, 68720.6563967187, 69690.30309696838, 70012.64993675101, 70434.88695339148, 71445.28554714387, 11505.42472876336, 11845.23006004607, 11902.0, 11921.46353414081, 12091.274523528617, 43618.34572481479, 44011.0, 44073.55926440823, 44309.77845110754, 45170.774146130374, 55696.44303556912, 56386.718066409405, 57256.42743572678, 57932.71033644805, 58804.0, 14348.210848403438, 14669.779953300922, 14697.706045879237, 15145.0, 15285.388584456497, 16126.0, 16434.835651643807, 16564.0, 16652.831557965965, 16817.579560511083, 15520.844791552392, 15545.68908621844, 15551.222438878238, 15800.288986995844, 15979.760303595223, 15431.691366172838, 15790.0, 15803.604909877346, 15948.0, 16127.516174514783, 15372.769408458658, 15420.614484637974, 15446.84553154454, 15453.845461545241, 15516.37934482608, 12389.0, 12416.813747793609, 12707.87292127067, 12762.0, 12913.548025819051, 12212.450439730412, 12704.872951270369, 13006.479740810262, 13082.28047457399, 13143.53997610079], "value": 8008.946283295405, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1486.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 112.0, 112.0, 111.0, 113.0, 112.0, 112.0, 113.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 121.0, 125.0, 154.0, 125.0, 120.0, 123.0, 126.0, 134.0, 124.0], "value": 129.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 162.0, 161.0, 162.0, 163.0, 163.0, 161.0, 162.0, 163.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 128.0, 78.0, 76.0, 79.0, 76.0, 93.0, 75.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 101.0, 82.0, 82.0, 83.0, 90.0, 85.0, 84.0, 105.0], "value": 88.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 121.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 148.0, 148.0, 149.0, 149.0, 148.0, 148.0, 152.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 57.0, 56.0, 57.0, 56.0, 57.0, 57.0, 61.0, 57.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 86.0, 75.0, 75.0, 76.0, 80.0, 75.0, 76.0, 75.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 130.0, 122.0, 122.0, 132.0, 120.0, 126.0, 132.0, 157.0, 127.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 158.0, 161.0, 161.0, 158.0, 167.0, 162.0, 156.0, 155.0, 159.0], "value": 159.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 60.0, 63.0, 61.0, 61.0, 59.0, 60.0, 63.0], "value": 61.4, "unit": "score"}]}]} 20:17:33 INFO - Return code: 0 20:17:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:17:33 ERROR - # TBPL SUCCESS # 20:17:33 INFO - Running post-action listener: _resource_record_post_action 20:17:33 INFO - [mozharness: 2017-02-06 04:17:33.724941Z] Finished run-tests step (success) 20:17:33 INFO - Running post-run listener: _resource_record_post_run 20:17:33 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 362340352; Read time: 0; Write time: 195860 20:17:33 INFO - TinderboxPrint: CPU usage
13.3% 20:17:33 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 20:17:33 INFO - TinderboxPrint: I/O write bytes / time
362,340,352 / 195,860 20:17:33 INFO - TinderboxPrint: CPU idle
8,231.1 (86.7%) 20:17:33 INFO - TinderboxPrint: CPU user
1,206.6 (12.7%) 20:17:33 INFO - TinderboxPrint: Swap in / out
0 / 0 20:17:33 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109944832; Read time: 0; Write time: 83340 20:17:33 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 252395520; Read time: 0; Write time: 112520 20:17:34 INFO - Running post-run listener: _upload_blobber_files 20:17:34 INFO - Blob upload gear active. 20:17:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:17:34 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 20:17:34 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'] 20:17:34 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 20:17:34 INFO - (blobuploader) - INFO - Open directory for files ... 20:17:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:17:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:17:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:17:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:17:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:17:37 INFO - (blobuploader) - INFO - Done attempting. 20:17:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:17:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:17:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:17:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:17:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:17:38 INFO - (blobuploader) - INFO - Done attempting. 20:17:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:17:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:17:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:17:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:17:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:17:39 INFO - (blobuploader) - INFO - Done attempting. 20:17:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:17:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:17:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:17:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:17:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:17:40 INFO - (blobuploader) - INFO - Done attempting. 20:17:40 INFO - (blobuploader) - INFO - Iteration through files over. 20:17:40 INFO - Return code: 0 20:17:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:17:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:17:40 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b79f6aa86368b0099abd5ce4142a43ee2498826442f21bfa3923964bc72657a270cb629d1eaf041f1a9ef056675ee2e9a72161e6c90c36f0f056b1fd5a897c1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/5c451f6e5e84fc47aec9b5c99478945a6d5121cfe0c26af7f880a6bd2052ee2f0d0e44eb9f19a54b561c3c2cc9e9ddca9a17cdf570786a45af86a11da2abc863", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/838a50efa6d667c7c3d488f453777fe4ecb0bb7abd196daa7ed3a7bb7c2d903c8752e054e932d7fdf602aea13c53af4182c830ec424d097859bc86157a1a03d8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f682f393ab16e798852712b0c6f0a7fef7838075dced00d42ca8012c4846bec3a481a0b10bf3233399a39b5ae13ccaa7be5b20618abcdfd1a8412d4f83fbc9bd"} 20:17:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:17:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:17:40 INFO - Contents: 20:17:40 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b79f6aa86368b0099abd5ce4142a43ee2498826442f21bfa3923964bc72657a270cb629d1eaf041f1a9ef056675ee2e9a72161e6c90c36f0f056b1fd5a897c1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/5c451f6e5e84fc47aec9b5c99478945a6d5121cfe0c26af7f880a6bd2052ee2f0d0e44eb9f19a54b561c3c2cc9e9ddca9a17cdf570786a45af86a11da2abc863", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/838a50efa6d667c7c3d488f453777fe4ecb0bb7abd196daa7ed3a7bb7c2d903c8752e054e932d7fdf602aea13c53af4182c830ec424d097859bc86157a1a03d8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f682f393ab16e798852712b0c6f0a7fef7838075dced00d42ca8012c4846bec3a481a0b10bf3233399a39b5ae13ccaa7be5b20618abcdfd1a8412d4f83fbc9bd"} 20:17:40 INFO - Running post-run listener: copy_logs_to_upload_dir 20:17:40 INFO - Copying logs to upload dir... 20:17:40 INFO - mkdir: /builds/slave/test/build/upload/logs 20:17:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.598982 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-02-05 20:17:40.205492) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-05 20:17:40.209285) ========= 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=8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b79f6aa86368b0099abd5ce4142a43ee2498826442f21bfa3923964bc72657a270cb629d1eaf041f1a9ef056675ee2e9a72161e6c90c36f0f056b1fd5a897c1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/5c451f6e5e84fc47aec9b5c99478945a6d5121cfe0c26af7f880a6bd2052ee2f0d0e44eb9f19a54b561c3c2cc9e9ddca9a17cdf570786a45af86a11da2abc863", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/838a50efa6d667c7c3d488f453777fe4ecb0bb7abd196daa7ed3a7bb7c2d903c8752e054e932d7fdf602aea13c53af4182c830ec424d097859bc86157a1a03d8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f682f393ab16e798852712b0c6f0a7fef7838075dced00d42ca8012c4846bec3a481a0b10bf3233399a39b5ae13ccaa7be5b20618abcdfd1a8412d4f83fbc9bd"} build_url:https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011288 build_url: 'https://queue.taskcluster.net/v1/task/IBIBD-rIQkmnSQbT_PewuA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b79f6aa86368b0099abd5ce4142a43ee2498826442f21bfa3923964bc72657a270cb629d1eaf041f1a9ef056675ee2e9a72161e6c90c36f0f056b1fd5a897c1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/5c451f6e5e84fc47aec9b5c99478945a6d5121cfe0c26af7f880a6bd2052ee2f0d0e44eb9f19a54b561c3c2cc9e9ddca9a17cdf570786a45af86a11da2abc863", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/838a50efa6d667c7c3d488f453777fe4ecb0bb7abd196daa7ed3a7bb7c2d903c8752e054e932d7fdf602aea13c53af4182c830ec424d097859bc86157a1a03d8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f682f393ab16e798852712b0c6f0a7fef7838075dced00d42ca8012c4846bec3a481a0b10bf3233399a39b5ae13ccaa7be5b20618abcdfd1a8412d4f83fbc9bd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-05 20:17:40.235046) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 20:17:40.235364) ========= 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=8887e36bb8e381bfd44124ac000001a8-1486353422.422479-1364926299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004404 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 20:17:40.321636) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-05 20:17:40.321989) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-05 20:17:40.322315) ========= ========= Total master_lag: 0.18 =========