builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-004 starttime: 1494443931.68 results: success (0) revision: ce2218406119c36a551e3faea4e192186ee46cc5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:51.677370) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:51.677793) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:51.678064) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:51.692601) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:51.692870) ========= 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=c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-10 12:18:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.7M=0s 2017-05-10 12:18:51 (45.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.101051 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:51.808258) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:51.808563) ========= 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=c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018177 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:51.861556) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:51.864908) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ce2218406119c36a551e3faea4e192186ee46cc5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev ce2218406119c36a551e3faea4e192186ee46cc5 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-10 12:18:52,062 truncating revision to first 12 chars 2017-05-10 12:18:52,062 Setting DEBUG logging. 2017-05-10 12:18:52,062 attempt 1/10 2017-05-10 12:18:52,062 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ce2218406119?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-10 12:18:52,379 unpacking tar archive at: mozilla-central-ce2218406119/testing/mozharness/ program finished with exit code 0 elapsedTime=0.678839 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:52.557048) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:52.557365) ========= script_repo_revision: ce2218406119c36a551e3faea4e192186ee46cc5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:52.560744) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:52.561019) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 12:18:52.571663) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-05-10 12:18:52.572008) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:18:52 INFO - MultiFileLogger online at 20170510 12:18:52 in /builds/slave/test 12:18:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 12:18:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:18:52 INFO - {'append_to_log': False, 12:18:52 INFO - 'base_work_dir': '/builds/slave/test', 12:18:52 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 12:18:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:18:52 INFO - 'branch': 'Firefox-Non-PGO', 12:18:52 INFO - 'buildbot_json_path': 'buildprops.json', 12:18:52 INFO - 'config_files': ('talos/linux_config.py',), 12:18:52 INFO - 'default_actions': ('clobber', 12:18:52 INFO - 'read-buildbot-config', 12:18:52 INFO - 'download-and-extract', 12:18:52 INFO - 'populate-webroot', 12:18:52 INFO - 'create-virtualenv', 12:18:52 INFO - 'install', 12:18:52 INFO - 'run-tests'), 12:18:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:18:52 INFO - 'download_minidump_stackwalk': True, 12:18:52 INFO - 'download_symbols': 'ondemand', 12:18:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:18:52 INFO - 'tooltool.py': '/tools/tooltool.py', 12:18:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:18:52 INFO - '/tools/misc-python/virtualenv.py')}, 12:18:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:18:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:18:52 INFO - 'gecko_profile': False, 12:18:52 INFO - 'gecko_profile_interval': 0, 12:18:52 INFO - 'installer_path': 'installer.exe', 12:18:52 INFO - 'log_level': 'info', 12:18:52 INFO - 'log_name': 'talos', 12:18:52 INFO - 'log_to_console': True, 12:18:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:18:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:18:52 INFO - 'opt_config_files': (), 12:18:52 INFO - 'pip_index': False, 12:18:52 INFO - 'suite': 'dromaeojs-e10s', 12:18:52 INFO - 'system_bits': '32', 12:18:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:18:52 INFO - 'title': 'talos-linux64-ix-004', 12:18:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:18:52 INFO - 'use_talos_json': True, 12:18:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:18:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:18:52 INFO - 'work_dir': 'build'} 12:18:52 INFO - [mozharness: 2017-05-10 19:18:52.861985Z] Running clobber step. 12:18:52 INFO - Running pre-action listener: _resource_record_pre_action 12:18:52 INFO - Running main action method: clobber 12:18:52 INFO - rmtree: /builds/slave/test/build 12:18:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:18:53 INFO - Running post-action listener: _resource_record_post_action 12:18:53 INFO - [mozharness: 2017-05-10 19:18:53.776695Z] Finished clobber step (success) 12:18:53 INFO - [mozharness: 2017-05-10 19:18:53.776795Z] Running read-buildbot-config step. 12:18:53 INFO - Running pre-action listener: _resource_record_pre_action 12:18:53 INFO - Running main action method: read_buildbot_config 12:18:53 INFO - Using buildbot properties: 12:18:53 INFO - { 12:18:53 INFO - "project": "", 12:18:53 INFO - "product": "firefox", 12:18:53 INFO - "who": "kwierso@gmail.com", 12:18:53 INFO - "installer_path": "public/build/target.tar.bz2", 12:18:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 12:18:53 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 12:18:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 12:18:53 INFO - "stage_platform": "linux64", 12:18:53 INFO - "basedir": "/builds/slave/test", 12:18:53 INFO - "buildnumber": 593, 12:18:53 INFO - "platform": "ubuntu64_hw", 12:18:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:18:53 INFO - "slavebuilddir": "test", 12:18:53 INFO - "taskId": "KX-r6fEtRMi7o_jAznXKmA", 12:18:53 INFO - "branch": "mozilla-central", 12:18:53 INFO - "script_repo_revision": "production", 12:18:53 INFO - "revision": "ce2218406119c36a551e3faea4e192186ee46cc5", 12:18:53 INFO - "slavename": "talos-linux64-ix-004", 12:18:53 INFO - "repo_path": "mozilla-central" 12:18:53 INFO - } 12:18:53 INFO - Finding installer, test and symbols from parent task. 12:18:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KX-r6fEtRMi7o_jAznXKmA'}, attempt #1 12:18:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KX-r6fEtRMi7o_jAznXKmA'}, attempt #1 12:18:54 INFO - Task dependencies: MkqwQkpZR8Sw_-bjO_mh7Q 12:18:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q'}, attempt #1 12:18:55 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/target.tar.bz2 12:18:55 INFO - Set test_url: https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/test_packages.json 12:18:55 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/target.crashreporter-symbols.zip 12:18:55 INFO - Running post-action listener: _resource_record_post_action 12:18:55 INFO - [mozharness: 2017-05-10 19:18:55.160602Z] Finished read-buildbot-config step (success) 12:18:55 INFO - [mozharness: 2017-05-10 19:18:55.160819Z] Running download-and-extract step. 12:18:55 INFO - Running pre-action listener: _resource_record_pre_action 12:18:55 INFO - Running main action method: download_and_extract 12:18:55 INFO - mkdir: /builds/slave/test/build/tests 12:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:55 INFO - trying https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/target.test_packages.json 12:18:55 INFO - Downloading https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:18:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:18:55 INFO - Downloaded 986 bytes. 12:18:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:18:55 INFO - Using the following test package requirements: 12:18:55 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:18:55 INFO - u'common': [u'target.common.tests.zip'], 12:18:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:18:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:18:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:18:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:18:55 INFO - u'mozbase': [u'target.common.tests.zip'], 12:18:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:18:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:18:55 INFO - u'web-platform': [u'target.common.tests.zip', 12:18:55 INFO - u'target.web-platform.tests.zip'], 12:18:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:18:55 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:18:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/target.common.tests.zip 12:18:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:18:55 INFO - Fetch https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/target.common.tests.zip into memory 12:18:56 INFO - Content-Length response header: 58594828 12:18:56 INFO - Bytes received: 58594828 12:19:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:19:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/target.common.tests.zip 12:19:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:19:06 INFO - Fetch https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/target.common.tests.zip into memory 12:19:07 INFO - Content-Length response header: 58594828 12:19:07 INFO - Bytes received: 58594828 12:19:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/target.talos.tests.zip 12:19:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:19:18 INFO - Fetch https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/target.talos.tests.zip into memory 12:19:19 INFO - Content-Length response header: 14409362 12:19:19 INFO - Bytes received: 14409362 12:19: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')]} 12:19:19 INFO - trying https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/target.tar.bz2 12:19:19 INFO - Downloading https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:19:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:19:21 INFO - Downloaded 63025015 bytes. 12:19:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/target.tar.bz2 12:19:21 INFO - mkdir: /builds/slave/test/properties 12:19:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:19:21 INFO - Writing to file /builds/slave/test/properties/build_url 12:19:21 INFO - Contents: 12:19:21 INFO - build_url:https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/target.tar.bz2 12:19:21 INFO - Running post-action listener: _resource_record_post_action 12:19:21 INFO - Running post-action listener: set_extra_try_arguments 12:19:21 INFO - [mozharness: 2017-05-10 19:19:21.263451Z] Finished download-and-extract step (success) 12:19:21 INFO - [mozharness: 2017-05-10 19:19:21.263594Z] Running populate-webroot step. 12:19:21 INFO - Running pre-action listener: _resource_record_pre_action 12:19:21 INFO - Running main action method: populate_webroot 12:19:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:19:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:19:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:19:21 INFO - '--tppagecycles', 12:19:21 INFO - '7'], 12:19:21 INFO - 'tests': ['tsvgm']}}, 12:19:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:19:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:19:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:19:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:19:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:19:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:19:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:19:21 INFO - 'talos_options': ['--disable-e10s'], 12:19:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:19:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:19:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:19:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:19:21 INFO - 'talos_options': ['--disable-e10s'], 12:19:21 INFO - 'tests': ['damp', 'tps']}, 12:19:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:19:21 INFO - 'tests': ['damp', 'tps']}, 12:19:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:19:21 INFO - 'tests': ['dromaeo_dom']}, 12:19:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:19:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:19:21 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 12:19:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:19:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:19:21 INFO - 'tests': ['a11yr', 12:19:21 INFO - 'ts_paint', 12:19:21 INFO - 'tpaint', 12:19:21 INFO - 'sessionrestore', 12:19:21 INFO - 'sessionrestore_no_auto_restore', 12:19:21 INFO - 'tabpaint']}, 12:19:21 INFO - 'other-e10s': {'tests': ['a11yr', 12:19:21 INFO - 'ts_paint', 12:19:21 INFO - 'tpaint', 12:19:21 INFO - 'sessionrestore', 12:19:21 INFO - 'sessionrestore_no_auto_restore', 12:19:21 INFO - 'tabpaint']}, 12:19:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:19:21 INFO - 'ts_paint', 12:19:21 INFO - 'tpaint', 12:19:21 INFO - 'sessionrestore', 12:19:21 INFO - 'sessionrestore_no_auto_restore', 12:19:21 INFO - 'tabpaint']}, 12:19:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:19:21 INFO - 'ts_paint', 12:19:21 INFO - 'tpaint', 12:19:21 INFO - 'sessionrestore', 12:19:21 INFO - 'sessionrestore_no_auto_restore', 12:19:21 INFO - 'tabpaint']}, 12:19:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:19:21 INFO - 'tests': ['a11yr', 12:19:21 INFO - 'ts_paint', 12:19:21 INFO - 'tpaint', 12:19:21 INFO - 'sessionrestore', 12:19:21 INFO - 'sessionrestore_no_auto_restore', 12:19:21 INFO - 'tabpaint']}, 12:19:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:19:21 INFO - 'tests': ['a11yr', 12:19:21 INFO - 'ts_paint', 12:19:21 INFO - 'tpaint', 12:19:21 INFO - 'sessionrestore', 12:19:21 INFO - 'sessionrestore_no_auto_restore', 12:19:21 INFO - 'tabpaint']}, 12:19:21 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 12:19:21 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 12:19:21 INFO - 'bloom_basic_ref']}, 12:19:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:19:21 INFO - 'tests': ['tsvgx', 12:19:21 INFO - 'tsvgr_opacity', 12:19:21 INFO - 'tart', 12:19:21 INFO - 'tscrollx', 12:19:21 INFO - 'cart', 12:19:21 INFO - 'tsvg_static']}, 12:19:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:19:21 INFO - 'tsvgr_opacity', 12:19:21 INFO - 'tart', 12:19:21 INFO - 'tscrollx', 12:19:21 INFO - 'cart', 12:19:21 INFO - 'tsvg_static']}, 12:19:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:19:21 INFO - 'talos_options': ['--disable-e10s'], 12:19:21 INFO - 'tests': ['tp5o']}, 12:19:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:19:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:19:21 INFO - 'talos_options': ['--disable-e10s', 12:19:21 INFO - '--xperf_path', 12:19:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:19:21 INFO - 'tests': ['tp5n']}, 12:19:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:19:21 INFO - 'talos_options': ['--xperf_path', 12:19:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:19:21 INFO - 'tests': ['tp5n']}}, 12:19:21 INFO - 'talos.zip': {'path': '', 12:19:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:19:21 INFO - Running post-action listener: _resource_record_post_action 12:19:21 INFO - [mozharness: 2017-05-10 19:19:21.280905Z] Finished populate-webroot step (success) 12:19:21 INFO - [mozharness: 2017-05-10 19:19:21.280994Z] Running create-virtualenv step. 12:19:21 INFO - Running pre-action listener: _resource_record_pre_action 12:19:21 INFO - Running main action method: create_virtualenv 12:19:21 INFO - Creating virtualenv /builds/slave/test/build/venv 12:19:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:19:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:19:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:19:21 INFO - Using real prefix '/usr' 12:19:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:19:21 INFO - Installing distribute.............................................................................................................................................................................................done. 12:19:23 INFO - Installing pip.................done. 12:19:23 INFO - Return code: 0 12:19:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:19:24 INFO - Reading from file tmpfile_stdout 12:19:24 INFO - Output received: 12:19:24 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 12:19:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:24 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 0x19a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d17a30>, '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 0x1d187f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d18ca0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:19:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:19:24 INFO - Using env: {'DISPLAY': ':0', 12:19:24 INFO - 'HOME': '/home/cltbld', 12:19:24 INFO - 'LANG': 'en_US.UTF-8', 12:19:24 INFO - 'LANGUAGE': 'en_US:en', 12:19:24 INFO - 'LOGNAME': 'cltbld', 12:19:24 INFO - 'MAIL': '/var/mail/cltbld', 12:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:24 INFO - 'MOZ_NO_REMOTE': '1', 12:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:24 INFO - 'NO_EM_RESTART': '1', 12:19:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:24 INFO - 'PWD': '/builds/slave/test', 12:19:24 INFO - 'SHELL': '/bin/bash', 12:19:24 INFO - 'SHLVL': '1', 12:19:24 INFO - 'TERM': 'linux', 12:19:24 INFO - 'TMOUT': '86400', 12:19:24 INFO - 'USER': 'cltbld', 12:19:24 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755', 12:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:24 INFO - '_': '/tools/buildbot/bin/python'} 12:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:19:24 INFO - Cleaning up... 12:19:24 INFO - Return code: 0 12:19:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:24 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 0x19a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d17a30>, '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 0x1d187f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d18ca0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:19:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:19:24 INFO - Using env: {'DISPLAY': ':0', 12:19:24 INFO - 'HOME': '/home/cltbld', 12:19:24 INFO - 'LANG': 'en_US.UTF-8', 12:19:24 INFO - 'LANGUAGE': 'en_US:en', 12:19:24 INFO - 'LOGNAME': 'cltbld', 12:19:24 INFO - 'MAIL': '/var/mail/cltbld', 12:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:24 INFO - 'MOZ_NO_REMOTE': '1', 12:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:24 INFO - 'NO_EM_RESTART': '1', 12:19:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:24 INFO - 'PWD': '/builds/slave/test', 12:19:24 INFO - 'SHELL': '/bin/bash', 12:19:24 INFO - 'SHLVL': '1', 12:19:24 INFO - 'TERM': 'linux', 12:19:24 INFO - 'TMOUT': '86400', 12:19:24 INFO - 'USER': 'cltbld', 12:19:24 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755', 12:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:24 INFO - '_': '/tools/buildbot/bin/python'} 12:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:24 INFO - Downloading/unpacking psutil>=3.1.1 12:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:19:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:19:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:19:25 INFO - Installing collected packages: psutil 12:19:25 INFO - Running setup.py install for psutil 12:19:25 INFO - building 'psutil._psutil_linux' extension 12:19:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:19:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:19:25 INFO - building 'psutil._psutil_posix' extension 12:19:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:19: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 12:19:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:19:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:19:26 INFO - Successfully installed psutil 12:19:26 INFO - Cleaning up... 12:19:26 INFO - Return code: 0 12:19:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:19: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')]} 12:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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')]} 12:19:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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 0x19a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d17a30>, '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 0x1d187f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d18ca0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:19: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 12:19: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 12:19:26 INFO - Using env: {'DISPLAY': ':0', 12:19:26 INFO - 'HOME': '/home/cltbld', 12:19:26 INFO - 'LANG': 'en_US.UTF-8', 12:19:26 INFO - 'LANGUAGE': 'en_US:en', 12:19:26 INFO - 'LOGNAME': 'cltbld', 12:19:26 INFO - 'MAIL': '/var/mail/cltbld', 12:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:26 INFO - 'MOZ_NO_REMOTE': '1', 12:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:26 INFO - 'NO_EM_RESTART': '1', 12:19:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:26 INFO - 'PWD': '/builds/slave/test', 12:19:26 INFO - 'SHELL': '/bin/bash', 12:19:26 INFO - 'SHLVL': '1', 12:19:26 INFO - 'TERM': 'linux', 12:19:26 INFO - 'TMOUT': '86400', 12:19:26 INFO - 'USER': 'cltbld', 12:19:26 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755', 12:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:26 INFO - '_': '/tools/buildbot/bin/python'} 12:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:19:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:19:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:19:27 INFO - Installing collected packages: mozsystemmonitor 12:19:27 INFO - Running setup.py install for mozsystemmonitor 12:19:27 INFO - Successfully installed mozsystemmonitor 12:19:27 INFO - Cleaning up... 12:19:27 INFO - Return code: 0 12:19:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x19a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d17a30>, '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 0x1d187f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d18ca0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:19:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:19:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:19:27 INFO - Using env: {'DISPLAY': ':0', 12:19:27 INFO - 'HOME': '/home/cltbld', 12:19:27 INFO - 'LANG': 'en_US.UTF-8', 12:19:27 INFO - 'LANGUAGE': 'en_US:en', 12:19:27 INFO - 'LOGNAME': 'cltbld', 12:19:27 INFO - 'MAIL': '/var/mail/cltbld', 12:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:27 INFO - 'MOZ_NO_REMOTE': '1', 12:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:27 INFO - 'NO_EM_RESTART': '1', 12:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:27 INFO - 'PWD': '/builds/slave/test', 12:19:27 INFO - 'SHELL': '/bin/bash', 12:19:27 INFO - 'SHLVL': '1', 12:19:27 INFO - 'TERM': 'linux', 12:19:27 INFO - 'TMOUT': '86400', 12:19:27 INFO - 'USER': 'cltbld', 12:19:27 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755', 12:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:27 INFO - '_': '/tools/buildbot/bin/python'} 12:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:27 INFO - Downloading/unpacking jsonschema==2.5.1 12:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:19:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19:29 INFO - Downloading functools32-3.2.3-2.tar.gz 12:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:19:29 INFO - warning: no files found matching '*.txt' 12:19:29 INFO - no previously-included directories found matching 'build' 12:19:29 INFO - no previously-included directories found matching 'dist' 12:19:29 INFO - no previously-included directories found matching '.git*' 12:19:29 INFO - Installing collected packages: jsonschema, functools32 12:19:29 INFO - Running setup.py install for functools32 12:19:29 INFO - warning: no files found matching '*.txt' 12:19:29 INFO - no previously-included directories found matching 'build' 12:19:29 INFO - no previously-included directories found matching 'dist' 12:19:29 INFO - no previously-included directories found matching '.git*' 12:19:29 INFO - Successfully installed jsonschema functools32 12:19:29 INFO - Cleaning up... 12:19:29 INFO - Return code: 0 12:19:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:29 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 0x19a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d17a30>, '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 0x1d187f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d18ca0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:19:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:19:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:19:29 INFO - Using env: {'DISPLAY': ':0', 12:19:29 INFO - 'HOME': '/home/cltbld', 12:19:29 INFO - 'LANG': 'en_US.UTF-8', 12:19:29 INFO - 'LANGUAGE': 'en_US:en', 12:19:29 INFO - 'LOGNAME': 'cltbld', 12:19:29 INFO - 'MAIL': '/var/mail/cltbld', 12:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:29 INFO - 'MOZ_NO_REMOTE': '1', 12:19:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:29 INFO - 'NO_EM_RESTART': '1', 12:19:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:29 INFO - 'PWD': '/builds/slave/test', 12:19:29 INFO - 'SHELL': '/bin/bash', 12:19:29 INFO - 'SHLVL': '1', 12:19:29 INFO - 'TERM': 'linux', 12:19:29 INFO - 'TMOUT': '86400', 12:19:29 INFO - 'USER': 'cltbld', 12:19:29 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755', 12:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:29 INFO - '_': '/tools/buildbot/bin/python'} 12:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:19:29 INFO - Cleaning up... 12:19:29 INFO - Return code: 0 12:19:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:29 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 0x19a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d17a30>, '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 0x1d187f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d18ca0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:19:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:19:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:19:29 INFO - Using env: {'DISPLAY': ':0', 12:19:29 INFO - 'HOME': '/home/cltbld', 12:19:29 INFO - 'LANG': 'en_US.UTF-8', 12:19:29 INFO - 'LANGUAGE': 'en_US:en', 12:19:29 INFO - 'LOGNAME': 'cltbld', 12:19:29 INFO - 'MAIL': '/var/mail/cltbld', 12:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:29 INFO - 'MOZ_NO_REMOTE': '1', 12:19:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:29 INFO - 'NO_EM_RESTART': '1', 12:19:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:29 INFO - 'PWD': '/builds/slave/test', 12:19:29 INFO - 'SHELL': '/bin/bash', 12:19:29 INFO - 'SHLVL': '1', 12:19:29 INFO - 'TERM': 'linux', 12:19:29 INFO - 'TMOUT': '86400', 12:19:29 INFO - 'USER': 'cltbld', 12:19:29 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755', 12:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:29 INFO - '_': '/tools/buildbot/bin/python'} 12:19:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:30 INFO - Downloading/unpacking blobuploader==1.2.4 12:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:31 INFO - Downloading blobuploader-1.2.4.tar.gz 12:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:19:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:19:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19:31 INFO - Downloading docopt-0.6.1.tar.gz 12:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:19:31 INFO - Installing collected packages: blobuploader, requests, docopt 12:19:31 INFO - Running setup.py install for blobuploader 12:19:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:19:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:19:31 INFO - Running setup.py install for requests 12:19:32 INFO - Running setup.py install for docopt 12:19:32 INFO - Successfully installed blobuploader requests docopt 12:19:32 INFO - Cleaning up... 12:19:32 INFO - Return code: 0 12:19:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:32 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 0x19a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d17a30>, '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 0x1d187f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d18ca0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:19:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:19:32 INFO - Using env: {'DISPLAY': ':0', 12:19:32 INFO - 'HOME': '/home/cltbld', 12:19:32 INFO - 'LANG': 'en_US.UTF-8', 12:19:32 INFO - 'LANGUAGE': 'en_US:en', 12:19:32 INFO - 'LOGNAME': 'cltbld', 12:19:32 INFO - 'MAIL': '/var/mail/cltbld', 12:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:32 INFO - 'MOZ_NO_REMOTE': '1', 12:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:32 INFO - 'NO_EM_RESTART': '1', 12:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:32 INFO - 'PWD': '/builds/slave/test', 12:19:32 INFO - 'SHELL': '/bin/bash', 12:19:32 INFO - 'SHLVL': '1', 12:19:32 INFO - 'TERM': 'linux', 12:19:32 INFO - 'TMOUT': '86400', 12:19:32 INFO - 'USER': 'cltbld', 12:19:32 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755', 12:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:32 INFO - '_': '/tools/buildbot/bin/python'} 12:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:19:32 INFO - Running setup.py (path:/tmp/pip-fyq6PO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:19:32 INFO - Running setup.py (path:/tmp/pip-mYxevc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:19:32 INFO - Running setup.py (path:/tmp/pip-9EcM0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:19:32 INFO - Running setup.py (path:/tmp/pip-9UlhzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:19:32 INFO - Running setup.py (path:/tmp/pip-0nHQHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:19:32 INFO - Running setup.py (path:/tmp/pip-295nRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:19:32 INFO - Running setup.py (path:/tmp/pip-rPgaWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:19:33 INFO - Running setup.py (path:/tmp/pip-mruXQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:19:33 INFO - Running setup.py (path:/tmp/pip-fBhC2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:19:33 INFO - Running setup.py (path:/tmp/pip-zXAPaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:19:33 INFO - Running setup.py (path:/tmp/pip-_vTqnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:19:33 INFO - Running setup.py (path:/tmp/pip-FAigAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:19:33 INFO - Running setup.py (path:/tmp/pip-Y9hYYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:19:33 INFO - Running setup.py (path:/tmp/pip-VpRzUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:33 INFO - Running setup.py (path:/tmp/pip-v2kiIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:19:33 INFO - Running setup.py (path:/tmp/pip-RXY9_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:19:33 INFO - Running setup.py (path:/tmp/pip-Hsx8Gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:19:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:19:33 INFO - Running setup.py install for manifestparser 12:19:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:19:33 INFO - Running setup.py install for mozcrash 12:19:33 INFO - Running setup.py install for mozdebug 12:19:34 INFO - Running setup.py install for mozdevice 12:19:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:19:34 INFO - Running setup.py install for mozfile 12:19:34 INFO - Running setup.py install for mozhttpd 12:19:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:19:34 INFO - Running setup.py install for mozinfo 12:19:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:19:34 INFO - Running setup.py install for mozInstall 12:19:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:19:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:19:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:19:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:19:34 INFO - Running setup.py install for mozleak 12:19:34 INFO - Running setup.py install for mozlog 12:19:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:19:34 INFO - Running setup.py install for moznetwork 12:19:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:19:34 INFO - Running setup.py install for mozprocess 12:19:35 INFO - Running setup.py install for mozprofile 12:19:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:19:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:19:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:19:35 INFO - Running setup.py install for mozrunner 12:19:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:19:35 INFO - Running setup.py install for mozscreenshot 12:19:35 INFO - Running setup.py install for moztest 12:19:35 INFO - Running setup.py install for mozversion 12:19:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:19:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:19:35 INFO - Cleaning up... 12:19:35 INFO - Return code: 0 12:19:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19: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')]} 12:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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')]} 12:19:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:35 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 0x19a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d17a30>, '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 0x1d187f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d18ca0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:19:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:19:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:19:35 INFO - Using env: {'DISPLAY': ':0', 12:19:35 INFO - 'HOME': '/home/cltbld', 12:19:35 INFO - 'LANG': 'en_US.UTF-8', 12:19:35 INFO - 'LANGUAGE': 'en_US:en', 12:19:35 INFO - 'LOGNAME': 'cltbld', 12:19:35 INFO - 'MAIL': '/var/mail/cltbld', 12:19:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:35 INFO - 'MOZ_NO_REMOTE': '1', 12:19:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:35 INFO - 'NO_EM_RESTART': '1', 12:19:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:35 INFO - 'PWD': '/builds/slave/test', 12:19:35 INFO - 'SHELL': '/bin/bash', 12:19:35 INFO - 'SHLVL': '1', 12:19:35 INFO - 'TERM': 'linux', 12:19:35 INFO - 'TMOUT': '86400', 12:19:35 INFO - 'USER': 'cltbld', 12:19:35 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755', 12:19:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:35 INFO - '_': '/tools/buildbot/bin/python'} 12:19:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:19:35 INFO - Running setup.py (path:/tmp/pip-VqVLHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:19:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:19:35 INFO - Running setup.py (path:/tmp/pip-2sKUqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:19:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:19:35 INFO - Running setup.py (path:/tmp/pip-gzVChJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:19:36 INFO - Running setup.py (path:/tmp/pip-XZTN8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:19:36 INFO - Running setup.py (path:/tmp/pip-_T9wt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:19:36 INFO - Running setup.py (path:/tmp/pip-hzsiYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:19:36 INFO - Running setup.py (path:/tmp/pip-iKUQFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:19:36 INFO - Running setup.py (path:/tmp/pip-XiWX0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:19:36 INFO - Running setup.py (path:/tmp/pip-rjxshG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:19:36 INFO - Running setup.py (path:/tmp/pip-TJvI5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:19:36 INFO - Running setup.py (path:/tmp/pip-IfQglI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:19:36 INFO - Running setup.py (path:/tmp/pip-04mESk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:19:36 INFO - Running setup.py (path:/tmp/pip-3ki523-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:19:36 INFO - Running setup.py (path:/tmp/pip-nztPiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:36 INFO - Running setup.py (path:/tmp/pip-YOvjD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:19:36 INFO - Running setup.py (path:/tmp/pip-Tmc0UL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:19:36 INFO - Running setup.py (path:/tmp/pip-qyYJy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:19:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:38 INFO - Downloading blessings-1.6.tar.gz 12:19:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:19:38 INFO - Installing collected packages: blessings 12:19:38 INFO - Running setup.py install for blessings 12:19:38 INFO - Successfully installed blessings 12:19:38 INFO - Cleaning up... 12:19:38 INFO - Return code: 0 12:19:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:19:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:19:38 INFO - Reading from file tmpfile_stdout 12:19:38 INFO - Current package versions: 12:19:38 INFO - argparse == 1.2.1 12:19:38 INFO - blessings == 1.6 12:19:38 INFO - blobuploader == 1.2.4 12:19:38 INFO - docopt == 0.6.1 12:19:38 INFO - functools32 == 3.2.3-2 12:19:38 INFO - jsonschema == 2.5.1 12:19:38 INFO - manifestparser == 1.1 12:19:38 INFO - mozInstall == 1.12 12:19:38 INFO - mozcrash == 1.0 12:19:38 INFO - mozdebug == 0.1 12:19:38 INFO - mozdevice == 0.50 12:19:38 INFO - mozfile == 1.2 12:19:38 INFO - mozhttpd == 0.7 12:19:38 INFO - mozinfo == 0.9 12:19:38 INFO - mozleak == 0.1 12:19:38 INFO - mozlog == 3.4 12:19:38 INFO - moznetwork == 0.27 12:19:38 INFO - mozprocess == 0.25 12:19:38 INFO - mozprofile == 0.28 12:19:38 INFO - mozrunner == 6.13 12:19:38 INFO - mozscreenshot == 0.1 12:19:38 INFO - mozsystemmonitor == 0.3 12:19:38 INFO - moztest == 0.8 12:19:38 INFO - mozversion == 1.4 12:19:38 INFO - psutil == 3.1.1 12:19:38 INFO - requests == 1.2.3 12:19:38 INFO - wsgiref == 0.1.2 12:19:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19: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')]} 12:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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')]} 12:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:38 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 0x19a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d17a30>, '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 0x1d187f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d18ca0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:19:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:19:38 INFO - Using env: {'DISPLAY': ':0', 12:19:38 INFO - 'HOME': '/home/cltbld', 12:19:38 INFO - 'LANG': 'en_US.UTF-8', 12:19:38 INFO - 'LANGUAGE': 'en_US:en', 12:19:38 INFO - 'LOGNAME': 'cltbld', 12:19:38 INFO - 'MAIL': '/var/mail/cltbld', 12:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:38 INFO - 'MOZ_NO_REMOTE': '1', 12:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:38 INFO - 'NO_EM_RESTART': '1', 12:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:38 INFO - 'PWD': '/builds/slave/test', 12:19:38 INFO - 'SHELL': '/bin/bash', 12:19:38 INFO - 'SHLVL': '1', 12:19:38 INFO - 'TERM': 'linux', 12:19:38 INFO - 'TMOUT': '86400', 12:19:38 INFO - 'USER': 'cltbld', 12:19:38 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755', 12:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:38 INFO - '_': '/tools/buildbot/bin/python'} 12:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:19:38 INFO - Cleaning up... 12:19:38 INFO - Return code: 0 12:19:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:19: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')]} 12:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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')]} 12:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:38 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 0x19a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d17a30>, '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 0x1d187f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d18ca0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:19:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:19:38 INFO - Using env: {'DISPLAY': ':0', 12:19:38 INFO - 'HOME': '/home/cltbld', 12:19:38 INFO - 'LANG': 'en_US.UTF-8', 12:19:38 INFO - 'LANGUAGE': 'en_US:en', 12:19:38 INFO - 'LOGNAME': 'cltbld', 12:19:38 INFO - 'MAIL': '/var/mail/cltbld', 12:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:38 INFO - 'MOZ_NO_REMOTE': '1', 12:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:38 INFO - 'NO_EM_RESTART': '1', 12:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:38 INFO - 'PWD': '/builds/slave/test', 12:19:38 INFO - 'SHELL': '/bin/bash', 12:19:38 INFO - 'SHLVL': '1', 12:19:38 INFO - 'TERM': 'linux', 12:19:38 INFO - 'TMOUT': '86400', 12:19:38 INFO - 'USER': 'cltbld', 12:19:38 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755', 12:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:38 INFO - '_': '/tools/buildbot/bin/python'} 12:19:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:19:39 INFO - Cleaning up... 12:19:39 INFO - Return code: 0 12:19:39 INFO - Running post-action listener: _resource_record_post_action 12:19:39 INFO - Running post-action listener: _start_resource_monitoring 12:19:39 INFO - Starting resource monitoring. 12:19:39 INFO - [mozharness: 2017-05-10 19:19:39.120841Z] Finished create-virtualenv step (success) 12:19:39 INFO - [mozharness: 2017-05-10 19:19:39.121308Z] Running install step. 12:19:39 INFO - Running pre-action listener: _resource_record_pre_action 12:19:39 INFO - Running main action method: install 12:19:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:19:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:19:39 INFO - Reading from file tmpfile_stdout 12:19:39 INFO - Detecting whether we're running mozinstall >=1.0... 12:19:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:19:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:19:39 INFO - Reading from file tmpfile_stdout 12:19:39 INFO - Output received: 12:19:39 INFO - Usage: mozinstall [options] installer 12:19:39 INFO - Options: 12:19:39 INFO - -h, --help show this help message and exit 12:19:39 INFO - -d DEST, --destination=DEST 12:19:39 INFO - Directory to install application into. [default: 12:19:39 INFO - "/builds/slave/test"] 12:19:39 INFO - --app=APP Application being installed. [default: firefox] 12:19:39 INFO - mkdir: /builds/slave/test/build/application 12:19:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:19:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:19:55 INFO - Reading from file tmpfile_stdout 12:19:55 INFO - Output received: 12:19:55 INFO - /builds/slave/test/build/application/firefox/firefox 12:19:55 INFO - Running post-action listener: _resource_record_post_action 12:19:55 INFO - [mozharness: 2017-05-10 19:19:55.235667Z] Finished install step (success) 12:19:55 INFO - [mozharness: 2017-05-10 19:19:55.235918Z] Running run-tests step. 12:19:55 INFO - Running pre-action listener: _resource_record_pre_action 12:19:55 INFO - Running main action method: run_tests 12:19:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:19:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:19:55 INFO - Python 2.7.3 12:19:55 INFO - Return code: 0 12:19:55 INFO - grabbing minidump binary from tooltool 12:19:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:55 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 0x1d17a30>, '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 0x1d187f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d18ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:19:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:19:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:19:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:19:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:19:55 INFO - Return code: 0 12:19:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:19:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:19:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:19:55 INFO - ENV: RUST_BACKTRACE is now 1 12:19:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:19:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:19:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:19:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:19:55 INFO - Using env: {'DISPLAY': ':0', 12:19:55 INFO - 'HOME': '/home/cltbld', 12:19:55 INFO - 'LANG': 'en_US.UTF-8', 12:19:55 INFO - 'LANGUAGE': 'en_US:en', 12:19:55 INFO - 'LOGNAME': 'cltbld', 12:19:55 INFO - 'MAIL': '/var/mail/cltbld', 12:19:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:19:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:55 INFO - 'MOZ_NO_REMOTE': '1', 12:19:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:55 INFO - 'NO_EM_RESTART': '1', 12:19:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:55 INFO - 'PWD': '/builds/slave/test', 12:19:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:19:55 INFO - 'RUST_BACKTRACE': '1', 12:19:55 INFO - 'SHELL': '/bin/bash', 12:19:55 INFO - 'SHLVL': '1', 12:19:55 INFO - 'TERM': 'linux', 12:19:55 INFO - 'TMOUT': '86400', 12:19:55 INFO - 'USER': 'cltbld', 12:19:55 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755', 12:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:55 INFO - '_': '/tools/buildbot/bin/python'} 12:19:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:19:55 INFO - mozversion application_buildid: 20170510183120 12:19:55 INFO - mozversion application_changeset: ce2218406119c36a551e3faea4e192186ee46cc5 12:19:55 INFO - mozversion application_display_name: Nightly 12:19:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:19:55 INFO - mozversion application_name: Firefox 12:19:55 INFO - mozversion application_remotingname: firefox 12:19:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:19:55 INFO - mozversion application_vendor: Mozilla 12:19:55 INFO - mozversion application_version: 55.0a1 12:19:55 INFO - mozversion platform_buildid: 20170510183120 12:19:55 INFO - mozversion platform_changeset: ce2218406119c36a551e3faea4e192186ee46cc5 12:19:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:19:55 INFO - mozversion platform_version: 55.0a1 12:19:55 INFO - using testdate: 1494443995 12:19:55 INFO - actual date: 1494443995 12:19:55 INFO - starting webserver on 'localhost:47273' 12:19:55 INFO - SUITE-START | Running 2 tests 12:19:55 INFO - TEST-START | dromaeo_css 12:19:55 INFO - operating with platform_type : linux_ 12:19:55 INFO - Initialising browser for dromaeo_css test... 12:19:55 INFO - TEST-INFO | started process 9815 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprsWrxa/profile http://localhost:47273/getInfo.html) 12:19:59 INFO - PID 9815 | __metrics Screen width/height:1600/1200 12:19:59 INFO - PID 9815 | colorDepth:24 12:19:59 INFO - PID 9815 | Browser inner width/height: 1024/695 12:19:59 INFO - PID 9815 | __metrics 12:20:01 INFO - TEST-INFO | 9815: exit 0 12:20:01 INFO - Browser initialized. 12:20:01 INFO - Running cycle 1/1 for dromaeo_css test... 12:20:01 INFO - TEST-INFO | started process 9985 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprsWrxa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:20:13 INFO - PID 9985 | RSS: Main: 154816512 12:20:13 INFO - PID 9985 | 12:23:17 INFO - PID 9985 | Cycle 1(1): loaded http://localhost:47273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47273/tests/dromaeo/cssquery-ext.html) 12:23:20 INFO - PID 9985 | RSS: Main: 166715392 12:23:20 INFO - PID 9985 | 12:26:22 INFO - PID 9985 | Cycle 1(1): loaded http://localhost:47273/tests/dromaeo/cssquery-ext.html (next: http://localhost:47273/tests/dromaeo/cssquery-jquery.html) 12:26:23 INFO - PID 9985 | RSS: Main: 159952896 12:26:23 INFO - PID 9985 | 12:29:24 INFO - PID 9985 | Cycle 1(1): loaded http://localhost:47273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47273/tests/dromaeo/cssquery-mootools.html) 12:29:25 INFO - PID 9985 | RSS: Main: 168841216 12:29:25 INFO - PID 9985 | 12:32:27 INFO - PID 9985 | Cycle 1(1): loaded http://localhost:47273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47273/tests/dromaeo/cssquery-prototype.html) 12:32:27 INFO - PID 9985 | RSS: Main: 160145408 12:32:27 INFO - PID 9985 | 12:35:30 INFO - PID 9985 | Cycle 1(1): loaded http://localhost:47273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47273/tests/dromaeo/cssquery-yui.html) 12:35:31 INFO - PID 9985 | RSS: Main: 166150144 12:35:31 INFO - PID 9985 | 12:38:33 INFO - PID 9985 | Cycle 1(1): loaded http://localhost:47273/tests/dromaeo/cssquery-yui.html (next: http://localhost:47273/tests/dromaeo/cssquery-dojo.html) 12:38:33 INFO - PID 9985 | RSS: Main: 168419328 12:38:33 INFO - PID 9985 | 12:38:33 INFO - PID 9985 | __start_tp_report 12:38:33 INFO - PID 9985 | _x_x_mozilla_page_load 12:38:33 INFO - PID 9985 | _x_x_mozilla_page_load_details 12:38:33 INFO - PID 9985 | |i|pagename|runs| 12:38:33 INFO - PID 9985 | |0;dojo.html;2706.066407089554;2715.8370497770147;2736.425350676358;2752.8898844046234;2754.7107553706846;5222.112240919043;5304.893902121955;5350.384705758834;5351.812686555972;5354.973225133874;5286.603504737141;5294.947050529494;5322.095243808552;5370.382406023308;5403.486668766471;4454.198244316021;4704.764761761915;4745.288206768986;4771.141194584973;4820.517948205169;4774.427068751737;4812.663113582051;4830.806767729287;4852.053849499332;4870.025994801036;4683.133620280225;4689.366935463703;4753.595944344735;4781.2350023996;4790.664653474259;4756.595689366408;4774.641901857374;4779.80880764769;4818.71087734737;4844.927326090112;4446.666500012512;4707.058588282323;4707.411573553306;4739.289106634033;4767.61859051275;5222.373315202162;5293.788248470095;5316.548093412064;5338.466153384669;5358.4373640767935;5685;5731.828045158652;5776.989026920314;5780.826575202751;5798.478136967693;5735.254416925814;5760.107183386582;5760.798372056958;5767.423257674241;5777.306723193202;5272.420033796279;5318.414974352818;5325.573954083703;5326.760295786699;5336.733163341895;5887.970560147171;5901.734421951022;5956.85107872298;5959.433853783884;5984.970075149597;5576.525995290364;5588.524975377139;5631.070873305941;5636.633618814764;5642.153676948491;5680.005998950167;5699.857503562444;5702.600817942787;5738.024535828836;5738.713064346766;5661.348944871393;5668.688222147822;5673.205751194836;5673.744681489343;5675.120356344691;5655.236543066716;5661.122526008393;5665.461781130786;5688.317401911797;5694.345150307685;4761.928571071437;4767.547083027107;4769.880752981134;4786.114568804713;4788.832390866372;4137.751734895915;4153.792310384469;4165.937510937339;4172.207280616673;4226.661867050629;4741.644376671695;4863.7324947128245;4872.634552408584;4876.829310974099;4911.091448082117;5575.776968921197;5600.831975040755;5627.887442251132;5633.718314084279;5652.095664693629;4715;4727.62179025684;4757.8096876125255;4774.474807771142;4779.211430113992;4977.278294647328;5095.184770436712;5170.793168273302;5176.456472070378;5192;5328.200769884548;5333.173358129418;5336.012837625051;5350.678959262456;5359.732013399314;5725.685087320071;5726.713664316684;5727.226824378822;5735.569832262514;5776.971115144397;5219.425863155126;5313.229581710553;5321.920171197357;5346.679199248058;5354.892902142014;5692.629979051514;5717.799877004285;5724.771009159587;5738.397468265939;5742.799002034909;5792.942070579409;5803.564732645153;5839.532837373085;5865.384134665798;5876.647401155944;5570.275864137636;5583.804566840141;5587.3015873015875;5589.860253493695;5591.720413979366;5470.234167216672;5586.106223004463;5588.413216612197;5599.412061733622;5622;5321.760520776652;5462.672239665632;5465.152901300305;5473.917891231715;5489.094299440707;5452.863678407913;5573.498385145356;5576.442355764391;5579.163125531203;5579.69311687861;5365.248865158959;5431.864203394789;5435.809746658848;5439.5920305976415;5443.101888188563 12:38:33 INFO - PID 9985 | |1;ext.html;705.4427002667893;725.2240103089692;1040.4277647293986;1047.8637777088977;1057.8148823955805;28015.299617509547;31037.534436983464;31094.378112437767;31122.688773112262;31271.68728312716;31383.21541961452;31415.371692566136;31787.523187152154;31792.841035794787;31823.36353272933;6265.216847894013;6832.48756343275;6936.826579335532;6938.306169383071;6990.965045174767;6915.585064896122;6972.721091156348;7019.578825270474;7053.118360204974;7058.2588828173075;6951.2701166377565;7030;7034.191068027191;7051.964740176318;7069.187043490013;6986.09180806497;6988.301169883021;7007.719691212345;7017.2631873653045;7044.964775176142;6832.248452670202;6850.109485766869;6909.516333856582;6914.377706006484;6917.584944903322;29917.70082299171;30190.698093019008;30204.54693179604;30234.092977210497;30243.697563024307;2967.9703202967908;2992.1771512833925;3011.0966709987133;3018.6981301869637;3034.499307614241;23546.411339716473;23578.17476388318;23669.171578994825;23677.526449471086;23766.28701138951;3109.191610181369;3110.0203435917615;3132.060381885448;3138.6547479777205;3167.683231676837;135619;136706.31646841703;136717;136805;136936.31531842376;37286.44070338947;39257.41113883294;39414.40878386827;39601;39627.80186099051;40450.19099617991;40603;40664.18671626551;40722.79638601788;40869.79565102215;11694.941525292319;11836.70408239801;11851.229670071418;11908.523659053713;11931.463084161234;9386.249100071978;9397;9436.622535098657;9464.053594640618;9502.857457138149;12461.501539938301;12573.937130314473;12582;12623.980163174032;12695.936520317524;5133.537981581676;5276.894462110737;5283.788648454019;5286.07493688603;5311.309529761106;860.242986172177;904.6434039327457;911.1116661255223;918.1186061381148;940.6613619097119;20258.18967241294;20854.687179692315;21368.679469807965;21732.782672173074;21781.782182178293;974.9658761943298;977.2621670638622;986.911177993984;988.421773262635;1006.6527048168371;10922.344659320308;11383;11383.487743051583;11455.885441145649;11558.190926635054;173466;174720;175117.12441437712;175302;175626;40111.39832902509;40158.196836063114;40279.59720402758;40320.59679403227;40565.18869622591;1167.0080528397918;1225.5710501324465;1239.1264158768047;1242.3477674221106;1244.0669497876593;19276.8072319275;19670.180805702123;19979.500512486724;20538.07578658934;20691.793082069587;29182.416351673273;29280.56079158857;29322.56016159717;29367.706322937353;29379.85310073436;145915;146183;146594;146731.26634367186;147204.2639786837;27591.724082758916;28037.299067523476;28625.570616440353;30150.944716934802;30180.24549386283;35396.64603354037;36126.09684757797;36176.095597609215;36241.45637815382;36251.81874090613;25934.35164120912;26889.865550672122;26940.436145168183;27931.581026284217;28390.85804570964;26947.326316842235;27229.86385068062;27919.162425127277;28249.805400874266;28715.425691485634;29317;29992.550111747903;30213.97860213961;30251;30740;26252.27459057388;26252.8687356562;26581.33546661349;26896.865515672296;28221.294467638472;20648.48378790542;22259.77740222577;22284.77715222827;22456;22459.550808984055 12:38:33 INFO - PID 9985 | |2;jquery.html;407.45604617835187;407.8164825828374;417.2947718355978;434.9195398851212;442.13121216808963;13568.93215533921;16629.501114966555;17340.56648583786;17380.91309543454;17515.2118154683;17448.651026979485;17878.642427151448;17962.461126166203;18426.631467370644;18624.068796560186;5314.840554783344;5335.33308336458;5361.81233656823;5387.811426600069;5540.86147846303;5364.704941228231;5420.972895135538;5427.891442171154;5434.103372943459;5450;5174.586033117342;5302.2841916341185;5304.549113325372;5420.972895135538;5435.619506634537;5324.307839980816;5374.91937620936;5389.83830485086;5396.379416367129;5424.430434804348;4822.879428014293;4871.537203965618;4875.536824001714;4936.679115857458;4995.050940321327;21971.121155153774;22305.665415018786;22378.32865014052;22466.88766556173;22568.77431225683;1637.2141372141439;1644.9753253701203;1654.7186978213613;1656.180190805547;1657.8093519245322;14735.55793326202;14815.555533334018;15079.698406031928;15276.465323713728;15338.769918451233;2017.485541186988;2031.867928584652;2080.375887233824;2092.309537852505;2099.4226587688354;83238.34093272523;87214;88503.55748221283;88820;90238;10723.195760318007;10939.617113400993;11123.388213648326;11347.37589432589;11348.09215262777;15387.846121538865;15406.229688515754;15408;15420.92289538545;15513;7494.077309849164;7565.319121279002;7616.7334143305825;7813.374930005586;7881.921180788233;6902.585844849325;6991.930080699128;7206.711731530785;7218.3503484686635;7235.963820180866;7098.290170982964;7098.3256590623805;7115.928840711526;7146.142462904485;7227.710891564278;2020.7069974853564;2075.3500966731485;2077.563711620546;2105.136893873535;2263.841531092841;846.7883029242689;865.6840253307623;882.2236431939851;889.8487257166297;909.7316291693966;17045.573860653334;17061.40285090016;17254.654906902044;17532.298708051534;17970.910145449452;866.9739907802776;873.5195642396784;881.532787622561;881.8985816631169;892.3218354050967;9237.584308706124;9699.6120155193;9722.756931076638;9748.171405430476;9875.753106172404;335849;341459;341972;343400;345587;73492;75526.62236688781;76101.6194919033;76626.61686691642;77015;1027.9023492768026;1050.0916707048348;1086.5327908999047;1087.3367245979946;1087.782443511301;14654;14786.186759727889;14908.62728431798;15027.6994460108;15544.611384715472;37544;37549.4367584481;37620.247595048495;38336.616633833306;39083.413748793224;44855.32717009313;44999;45438;45614.08771824611;47264.763676182774;8170.10128885834;8213.95893020531;8354;8367.079621241537;8474.152584741476;12640.43118059708;12690.428930697955;12866.549670761478;12874.935625321814;13116.278604676452;10795.318367021002;11059.50232239535;11093.722656933318;11139.053180479426;11437;10580.89419105799;11008.614698485835;11056;11117.22179447431;11637.592684256011;11182.832257516306;11298.378589177673;11503.827442588536;11868.169228153947;12290.385480725748;8534.103919088406;8621.69824056155;8730.301575874042;8811.911880881109;8813;10806.973337532922;10884.346939183357;10902.618408355987;10989.505472253928;11385.658430247106 12:38:33 INFO - PID 9985 | |3;mootools.html;1242.1429213842448;1282.2050328796147;1282.9935850320753;1290.8644592317812;1300.1224173682765;9887.901120988789;10350.37897726135;10370.844437333446;10372.896271037287;10528.684139475808;10342.120919721814;10515.211359148056;10526.105281051101;10546.841797373027;10553.102986246178;2253.1550668499312;2307.1809507624803;2307.5500277445904;2312.1560630369963;2312.19073324336;2153.095699806085;2230.0633733831746;2230.944226394337;2232.5200081982453;2237.8209743220505;2205.106931692667;2211.3587059752654;2247.6965609642734;2249.268987579035;2258.254775923941;2154.676798480225;2167.1656412281304;2201.328594778592;2203.3059586230447;2207.1612787140866;2142.742870855507;2220.3006053093222;2235.083615717564;2275.2832857649787;2280.942976425586;10248.641297554625;10284;10319.329243599217;10320.79358412835;10353.689389318257;5441.401445840955;5630.859228519279;5633.774649014075;5648.576356773217;5651.4913657770585;3173.619165700131;3296.719778818803;3511.2801875615437;3561.28774245152;3602.819859007039;1108.4568561404853;1108.5288752280248;1132.3545579019963;1146.3007565385192;1150.6030419505257;15458.304376303093;15566.22168891551;15581.532554023397;15606.219689015617;15683.529494115195;4698.177818881751;4866.099771542205;4966.850994470172;4989.600831933437;4992.450830408652;11027.558897644005;11038.392888391056;11072.114230861513;11077.058450031838;11085.445727713583;5372.355317361941;5392.352917649829;5410.91883621746;5423.945760542423;5436.728163591804;5060.5698515625845;5069.290299358093;5080.415752188545;5170.715610641376;5237.083510385667;3814.7329686922203;3932.311845427039;3937.350337194388;4000.1999600079516;4028.5568587455355;1159.588346137126;1164;1178.6581891251612;1187.5131196209686;1193.8268951002055;678.772611175252;713.9821504462326;714.7355478472895;730.1858427852906;734.0604026845646;5469.15228139639;5537.169424586345;5597.832065038056;5598;5698.116791897262;522.6080439670247;525.6399366434005;530.1517571884954;537.159345624097;548.1886807524885;3436.055084851636;3443.1908501502126;3466.8613255470004;3485;3549.6627820357025;13375.53185638498;13597.660058498419;13788.448462061606;13861.514846980308;13881.375338109809;13191.934040329928;13487.393067311994;13625.795613065811;13749.037567370187;13806.309684515734;7274.636268186569;7344.559326440431;7354.485186037033;7433.331000209899;7498.737544185928;5864.384239654775;5881.9705901470215;5961.254843144607;5984;6002.369751176064;11699.88300117022;11943;12123;12306.261624302571;12470.68823279389;12200.267983920992;12395.380230988594;12513.687157821127;12610.18033827835;12651.557195498113;7474.103107627119;7637.350825179699;7649.158592554926;7657.234276572298;7674.424418168772;9549;9666.371685840399;9716.368436051634;9820.852687209841;9834.065763752433;8287.585620718819;8297.08732039463;8342.83314333722;8452.830943380975;8526.616302266537;7515.661795219337;7536.434767392577;7547.622618868925;7591.4685971981435;8090.797730056795;6880.69036893351;6994.720211191496;7013.579185248901;7034.788956331318;7044.753433629799;4920.384951881015;4937.506249375034;4992.126377883928;5077.994192294097;5199.71401572902;4846.903061938812;4915.4592994771265;4944.554990050912;4967.776450059829;4995.075910956485 12:38:33 INFO - PID 9985 | |4;prototype.html;373.64130434782606;391.89027072419714;392.19795518165347;395.3496498260361;397.39000634026775;5431.619786614929;5647.604667673265;5676.460736230051;5676.559079595782;5681.687507187103;5399.1091469907515;5478.479544443281;5479.232907392969;5483.561315094793;5516.4072885743735;4133.441985331971;4153.086321009373;4153.107081977374;4153.6677065834665;4160.479940007499;4103.815328310233;4137.6482998944975;4153.709240353177;4158.355454904479;4170.124273902484;4089.591040895916;4092.9795351023354;4099.426080348753;4110.897227569305;4124.020470174318;4079.224947260011;4093.4678491796026;4095.303798354272;4121.340585506305;4136.482939632546;3599.3521166190076;3610.5667319921513;3613.963860361389;3615.2407994321225;3623.9456408153897;5224.973875130638;5400.972995135038;5406.162044883049;5432;5452.754626041838;4791.760411979387;4796.544328288842;4797.784099715521;4797.920467894695;4800;5676.574256930747;5855.824325270206;5861.648301101947;5867.735951882176;5888.146218798251;3933.8426462941447;3939.8227079781477;3951.209758048402;3953.881383558498;3966.9008274793073;5966.373530779249;6135;6148.200733904564;6151.63090214593;6218.906716399258;4075.7554546727292;4091.365838295069;4100.302948498763;4114.9095489695255;4131.091159944807;4164.729292595972;4179.1432756284885;4182.1844740275965;4188.434561334242;4192.756875071822;4703.482616912137;4774.3793306870575;4776;4812.807487700523;4816.579109162805;5810.360860305363;5816.854578635483;5821.446962538552;5832.329282132524;5839.503642190376;1422.8506006869336;1443.5885772554982;1444.1335198880588;1447.9710405792036;1452.891033172495;935.8502639577771;937.5687183895349;940.7742141885898;959.9520023998772;978.9167920726818;4981.153203955337;4998.725070121178;5002.59979201663;5008.424031236382;5026.271190677331;5965.343812180657;6045.304789949124;6051.122587224828;6076.088586712029;6086.6652334122045;4806.423229212517;4988.55103040728;4995.650304478651;5003.099442100384;5032.018756342478;3191.1064901827526;3217.501287300472;3219.5653586765957;3221.597300337458;3232.8383580820864;5460.208269800856;5564.749586268627;5585.832425027255;5606.495415412551;5615.494605485526;6180.47465965398;6181.072839074175;6192.969035154885;6207.399708169251;6241.251049874044;5542.501174894279;5548.167774833807;5576.525995290446;5578.832635020955;5588.832335029955;5921.259842519685;6039.48664363534;6048.425399587032;6053.152558641706;6053.273607167168;5948.851278718067;5950.166976623363;5967.91048134287;5984.551158663205;6022.307434645072;5426.348838139291;5552.167174923794;5590.413006634408;5604.299462567179;5620.241267429008;4086.5709100544013;4117.053077792185;4128.112455822013;4132.876013719593;4137.13120244752;5933.525317974465;6097.817065488042;6111.755529778759;6120.908186377297;6132.313613756252;5869.559783016205;5872.647641141374;5881.735531820194;5885.529157667462;5904.940950590611;5855.2095467113095;5878.147668588116;5890.293164820249;5898.203742494708;5906.2026626406605;5701.771929122789;5773.480386765212;5783.508401785727;5785.450382213683;5812.476877081083;5897.7935772247765;5901.3213480450295;5922.378150294329;5942.6731529766275;5944.732487038007;5635;5681.346645135863;5727.284089488814;5757.596968212185;5762.366139724543 12:38:33 INFO - PID 9985 | |5;yui.html;732.5458215906139;745.3403737692141;751.5978951261073;767.0718430698854;771.7067514344549;11596.942015289911;12092.576759813408;12739.363031848405;13283.800742988862;13375.197488150718;14866.702665946674;15427;15442.845571544281;15458.227088645579;15494.84505154948;851.2168804699676;883.0639522106555;883.1786438612088;884.0496466298722;889.7597648634865;856.1096459681924;886.7162507997411;890.6838072484272;893.1738142218454;894.4543828264754;920.6363486422858;938.3853575907791;942.156769691126;942.7171848445473;945.8533927241289;903.6566104880136;931.0503286647615;935.2004036548789;936.7939053408239;936.8313703533362;671.7178784910301;683.1870074611246;688.0676683094385;690.0373978300294;693.1058933975166;13011.804822927663;13161.86838131616;13326.133801302884;13520.526781562598;13662.863371366258;15279.388824447009;15436.459723909722;15680.529584112495;16182.676346473005;16337.26482308299;12466.189697669623;12477.625671229787;12642.810357844639;12699.492020319176;12815.359232038454;2895.4932886744737;2907.912762617125;2922.0941508132546;2942.249726319796;2945.675975642699;69322.30677693209;69639;69739.65130174368;70136.298637014;71008;12403.813942790865;12510.124291299522;12577.245365278113;12597.244165350108;12657.050721195947;22342.66486002711;22441.887790560944;22465.32604021882;22530.887345563166;22553.210637627606;6006.099085137177;6014.7594096236535;6172.444479996821;6197.070439434121;6253.906191407133;2801.7898657600763;2866.484032874061;2877.9712202878122;2883.5818806272973;2888.176869592156;3375.4430518964587;3468.2023134679166;3474.42671959129;3475.0269924421204;3563.94654080189;735.981600459982;750.0362034785275;750.523417629809;750.7635094945075;752.5409500204871;586.8034208540101;598.6886818854172;611.8317462697794;618.4279541424164;635.640862912453;8919.286457083417;9059.81880362389;9083.727488175366;9123.17891389765;9720.854187187198;591.2993103172754;616.4205646692095;617.7899514165116;623.1338439569003;634.0330995232215;4232.936505952413;4245.724027938174;4371.30059190528;4455.443069616298;4505.684602077823;62305.688471557354;62478.37521624816;62773;64355.35644643493;65040;55476;56834.431655683744;57551.424485755444;57728;58342.7082864583;50736;51145.488545114815;51586.74206628943;51929;53577;8929.285657147282;8989.775255618662;8993.28053755711;9250.074992500966;9313.068693130905;26669.46661066729;26988;27397.45205095847;27833.02584409536;28199.15402537927;32341.35317293688;32384;32508.18729531686;32525.837370812995;33304.66695333113;11225.775484490101;11401.372924489233;11492.36791976416;11495.137864660352;11630.302181869114;13431.86568134306;14676.853231467549;14749.18879461597;14876;16311;12915.935420322838;13130.474781008652;13130.737385252432;13287.269200194081;13333.333333333489;14567.92716036413;15001.77497337519;15453.84546154569;15494.380224790882;15586.610334741723;13417.262050586922;13808.654783630489;14185.929070354583;14762.63093422673;15027.248637568297;11525.193236473366;11591.536338546364;11734.765304694029;11893.583724569598;12111.273323600612;10610.681679549625;10955.50700218476;11251.831222531504;11330.150238731963;12308.323042232763 12:38:33 INFO - PID 9985 | __end_tp_report 12:38:33 INFO - PID 9985 | __start_cc_report 12:38:33 INFO - PID 9985 | _x_x_mozilla_cycle_collect,383 12:38:33 INFO - PID 9985 | __end_cc_report 12:38:33 INFO - PID 9985 | __startTimestamp1494445113344__endTimestamp 12:38:33 INFO - PID 9985 | 12:38:33 INFO - PID 9985 | ------- Summary: start ------- 12:38:33 INFO - PID 9985 | Number of tests: 6 12:38:33 INFO - PID 9985 | 12:38:33 INFO - PID 9985 | [#0] dojo.html Cycles:165 Average:5232.80 Median:5358.44 stddev:618.04 (11.5%) stddev-sans-first:587.30 12:38:33 INFO - PID 9985 | Values: 2706.1 2715.8 2736.4 2752.9 2754.7 5222.1 5304.9 5350.4 5351.8 5355.0 5286.6 5294.9 5322.1 5370.4 5403.5 4454.2 4704.8 4745.3 4771.1 4820.5 4774.4 4812.7 4830.8 4852.1 4870.0 4683.1 4689.4 4753.6 4781.2 4790.7 4756.6 4774.6 4779.8 4818.7 4844.9 4446.7 4707.1 4707.4 4739.3 4767.6 5222.4 5293.8 5316.5 5338.5 5358.4 5685.0 5731.8 5777.0 5780.8 5798.5 5735.3 5760.1 5760.8 5767.4 5777.3 5272.4 5318.4 5325.6 5326.8 5336.7 5888.0 5901.7 5956.9 5959.4 5985.0 5576.5 5588.5 5631.1 5636.6 5642.2 5680.0 5699.9 5702.6 5738.0 5738.7 5661.3 5668.7 5673.2 5673.7 5675.1 5655.2 5661.1 5665.5 5688.3 5694.3 4761.9 4767.5 4769.9 4786.1 4788.8 4137.8 4153.8 4165.9 4172.2 4226.7 4741.6 4863.7 4872.6 4876.8 4911.1 5575.8 5600.8 5627.9 5633.7 5652.1 4715.0 4727.6 4757.8 4774.5 4779.2 4977.3 5095.2 5170.8 5176.5 5192.0 5328.2 5333.2 5336.0 5350.7 5359.7 5725.7 5726.7 5727.2 5735.6 5777.0 5219.4 5313.2 5321.9 5346.7 5354.9 5692.6 5717.8 5724.8 5738.4 5742.8 5792.9 5803.6 5839.5 5865.4 5876.6 5570.3 5583.8 5587.3 5589.9 5591.7 5470.2 5586.1 5588.4 5599.4 5622.0 5321.8 5462.7 5465.2 5473.9 5489.1 5452.9 5573.5 5576.4 5579.2 5579.7 5365.2 5431.9 5435.8 5439.6 5443.1 12:38:33 INFO - PID 9985 | 12:38:33 INFO - PID 9985 | [#1] ext.html Cycles:180 Average:29408.68 Median:16599.47 stddev:39564.91 (238.4%) stddev-sans-first:39617.20 12:38:33 INFO - PID 9985 | Values: 705.4 725.2 1040.4 1047.9 1057.8 28015.3 31037.5 31094.4 31122.7 31271.7 31383.2 31415.4 31787.5 31792.8 31823.4 6265.2 6832.5 6936.8 6938.3 6991.0 6915.6 6972.7 7019.6 7053.1 7058.3 6951.3 7030.0 7034.2 7052.0 7069.2 6986.1 6988.3 7007.7 7017.3 7045.0 6832.2 6850.1 6909.5 6914.4 6917.6 29917.7 30190.7 30204.5 30234.1 30243.7 2968.0 2992.2 3011.1 3018.7 3034.5 23546.4 23578.2 23669.2 23677.5 23766.3 3109.2 3110.0 3132.1 3138.7 3167.7 135619.0 136706.3 136717.0 136805.0 136936.3 37286.4 39257.4 39414.4 39601.0 39627.8 40450.2 40603.0 40664.2 40722.8 40869.8 11694.9 11836.7 11851.2 11908.5 11931.5 9386.2 9397.0 9436.6 9464.1 9502.9 12461.5 12573.9 12582.0 12624.0 12695.9 5133.5 5276.9 5283.8 5286.1 5311.3 860.2 904.6 911.1 918.1 940.7 20258.2 20854.7 21368.7 21732.8 21781.8 975.0 977.3 986.9 988.4 1006.7 10922.3 11383.0 11383.5 11455.9 11558.2 173466.0 174720.0 175117.1 175302.0 175626.0 40111.4 40158.2 40279.6 40320.6 40565.2 1167.0 1225.6 1239.1 1242.3 1244.1 19276.8 19670.2 19979.5 20538.1 20691.8 29182.4 29280.6 29322.6 29367.7 29379.9 145915.0 146183.0 146594.0 146731.3 147204.3 27591.7 28037.3 28625.6 30150.9 30180.2 35396.6 36126.1 36176.1 36241.5 36251.8 25934.4 26889.9 26940.4 27931.6 28390.9 26947.3 27229.9 27919.2 28249.8 28715.4 29317.0 29992.6 30214.0 30251.0 30740.0 26252.3 26252.9 26581.3 26896.9 28221.3 20648.5 22259.8 22284.8 22456.0 22459.6 12:38:33 INFO - PID 9985 | 12:38:33 INFO - PID 9985 | [#2] jquery.html Cycles:180 Average:23922.89 Median:37546.72 stddev:57049.96 (151.9%) stddev-sans-first:57182.68 12:38:33 INFO - PID 9985 | Values: 407.5 407.8 417.3 434.9 442.1 13568.9 16629.5 17340.6 17380.9 17515.2 17448.7 17878.6 17962.5 18426.6 18624.1 5314.8 5335.3 5361.8 5387.8 5540.9 5364.7 5421.0 5427.9 5434.1 5450.0 5174.6 5302.3 5304.5 5421.0 5435.6 5324.3 5374.9 5389.8 5396.4 5424.4 4822.9 4871.5 4875.5 4936.7 4995.1 21971.1 22305.7 22378.3 22466.9 22568.8 1637.2 1645.0 1654.7 1656.2 1657.8 14735.6 14815.6 15079.7 15276.5 15338.8 2017.5 2031.9 2080.4 2092.3 2099.4 83238.3 87214.0 88503.6 88820.0 90238.0 10723.2 10939.6 11123.4 11347.4 11348.1 15387.8 15406.2 15408.0 15420.9 15513.0 7494.1 7565.3 7616.7 7813.4 7881.9 6902.6 6991.9 7206.7 7218.4 7236.0 7098.3 7098.3 7115.9 7146.1 7227.7 2020.7 2075.4 2077.6 2105.1 2263.8 846.8 865.7 882.2 889.8 909.7 17045.6 17061.4 17254.7 17532.3 17970.9 867.0 873.5 881.5 881.9 892.3 9237.6 9699.6 9722.8 9748.2 9875.8 335849.0 341459.0 341972.0 343400.0 345587.0 73492.0 75526.6 76101.6 76626.6 77015.0 1027.9 1050.1 1086.5 1087.3 1087.8 14654.0 14786.2 14908.6 15027.7 15544.6 37544.0 37549.4 37620.2 38336.6 39083.4 44855.3 44999.0 45438.0 45614.1 47264.8 8170.1 8214.0 8354.0 8367.1 8474.2 12640.4 12690.4 12866.5 12874.9 13116.3 10795.3 11059.5 11093.7 11139.1 11437.0 10580.9 11008.6 11056.0 11117.2 11637.6 11182.8 11298.4 11503.8 11868.2 12290.4 8534.1 8621.7 8730.3 8811.9 8813.0 10807.0 10884.3 10902.6 10989.5 11385.7 12:38:33 INFO - PID 9985 | 12:38:33 INFO - PID 9985 | [#3] mootools.html Cycles:180 Average:6297.46 Median:3530.47 stddev:4146.33 (117.4%) stddev-sans-first:4140.57 12:38:33 INFO - PID 9985 | Values: 1242.1 1282.2 1283.0 1290.9 1300.1 9887.9 10350.4 10370.8 10372.9 10528.7 10342.1 10515.2 10526.1 10546.8 10553.1 2253.2 2307.2 2307.6 2312.2 2312.2 2153.1 2230.1 2230.9 2232.5 2237.8 2205.1 2211.4 2247.7 2249.3 2258.3 2154.7 2167.2 2201.3 2203.3 2207.2 2142.7 2220.3 2235.1 2275.3 2280.9 10248.6 10284.0 10319.3 10320.8 10353.7 5441.4 5630.9 5633.8 5648.6 5651.5 3173.6 3296.7 3511.3 3561.3 3602.8 1108.5 1108.5 1132.4 1146.3 1150.6 15458.3 15566.2 15581.5 15606.2 15683.5 4698.2 4866.1 4966.9 4989.6 4992.5 11027.6 11038.4 11072.1 11077.1 11085.4 5372.4 5392.4 5410.9 5423.9 5436.7 5060.6 5069.3 5080.4 5170.7 5237.1 3814.7 3932.3 3937.4 4000.2 4028.6 1159.6 1164.0 1178.7 1187.5 1193.8 678.8 714.0 714.7 730.2 734.1 5469.2 5537.2 5597.8 5598.0 5698.1 522.6 525.6 530.2 537.2 548.2 3436.1 3443.2 3466.9 3485.0 3549.7 13375.5 13597.7 13788.4 13861.5 13881.4 13191.9 13487.4 13625.8 13749.0 13806.3 7274.6 7344.6 7354.5 7433.3 7498.7 5864.4 5882.0 5961.3 5984.0 6002.4 11699.9 11943.0 12123.0 12306.3 12470.7 12200.3 12395.4 12513.7 12610.2 12651.6 7474.1 7637.4 7649.2 7657.2 7674.4 9549.0 9666.4 9716.4 9820.9 9834.1 8287.6 8297.1 8342.8 8452.8 8526.6 7515.7 7536.4 7547.6 7591.5 8090.8 6880.7 6994.7 7013.6 7034.8 7044.8 4920.4 4937.5 4992.1 5078.0 5199.7 4846.9 4915.5 4944.6 4967.8 4995.1 12:38:33 INFO - PID 9985 | 12:38:33 INFO - PID 9985 | [#4] prototype.html Cycles:180 Average:4790.46 Median:5481.40 stddev:1437.28 (26.2%) stddev-sans-first:1402.56 12:38:33 INFO - PID 9985 | Values: 373.6 391.9 392.2 395.3 397.4 5431.6 5647.6 5676.5 5676.6 5681.7 5399.1 5478.5 5479.2 5483.6 5516.4 4133.4 4153.1 4153.1 4153.7 4160.5 4103.8 4137.6 4153.7 4158.4 4170.1 4089.6 4093.0 4099.4 4110.9 4124.0 4079.2 4093.5 4095.3 4121.3 4136.5 3599.4 3610.6 3614.0 3615.2 3623.9 5225.0 5401.0 5406.2 5432.0 5452.8 4791.8 4796.5 4797.8 4797.9 4800.0 5676.6 5855.8 5861.6 5867.7 5888.1 3933.8 3939.8 3951.2 3953.9 3966.9 5966.4 6135.0 6148.2 6151.6 6218.9 4075.8 4091.4 4100.3 4114.9 4131.1 4164.7 4179.1 4182.2 4188.4 4192.8 4703.5 4774.4 4776.0 4812.8 4816.6 5810.4 5816.9 5821.4 5832.3 5839.5 1422.9 1443.6 1444.1 1448.0 1452.9 935.9 937.6 940.8 960.0 978.9 4981.2 4998.7 5002.6 5008.4 5026.3 5965.3 6045.3 6051.1 6076.1 6086.7 4806.4 4988.6 4995.7 5003.1 5032.0 3191.1 3217.5 3219.6 3221.6 3232.8 5460.2 5564.7 5585.8 5606.5 5615.5 6180.5 6181.1 6193.0 6207.4 6241.3 5542.5 5548.2 5576.5 5578.8 5588.8 5921.3 6039.5 6048.4 6053.2 6053.3 5948.9 5950.2 5967.9 5984.6 6022.3 5426.3 5552.2 5590.4 5604.3 5620.2 4086.6 4117.1 4128.1 4132.9 4137.1 5933.5 6097.8 6111.8 6120.9 6132.3 5869.6 5872.6 5881.7 5885.5 5904.9 5855.2 5878.1 5890.3 5898.2 5906.2 5701.8 5773.5 5783.5 5785.5 5812.5 5897.8 5901.3 5922.4 5942.7 5944.7 5635.0 5681.3 5727.3 5757.6 5762.4 12:38:33 INFO - PID 9985 | 12:38:33 INFO - PID 9985 | [#5] yui.html Cycles:180 Average:15113.67 Median:3421.82 stddev:17993.42 (525.8%) stddev-sans-first:18011.49 12:38:33 INFO - PID 9985 | Values: 732.5 745.3 751.6 767.1 771.7 11596.9 12092.6 12739.4 13283.8 13375.2 14866.7 15427.0 15442.8 15458.2 15494.8 851.2 883.1 883.2 884.0 889.8 856.1 886.7 890.7 893.2 894.5 920.6 938.4 942.2 942.7 945.9 903.7 931.1 935.2 936.8 936.8 671.7 683.2 688.1 690.0 693.1 13011.8 13161.9 13326.1 13520.5 13662.9 15279.4 15436.5 15680.5 16182.7 16337.3 12466.2 12477.6 12642.8 12699.5 12815.4 2895.5 2907.9 2922.1 2942.2 2945.7 69322.3 69639.0 69739.7 70136.3 71008.0 12403.8 12510.1 12577.2 12597.2 12657.1 22342.7 22441.9 22465.3 22530.9 22553.2 6006.1 6014.8 6172.4 6197.1 6253.9 2801.8 2866.5 2878.0 2883.6 2888.2 3375.4 3468.2 3474.4 3475.0 3563.9 736.0 750.0 750.5 750.8 752.5 586.8 598.7 611.8 618.4 635.6 8919.3 9059.8 9083.7 9123.2 9720.9 591.3 616.4 617.8 623.1 634.0 4232.9 4245.7 4371.3 4455.4 4505.7 62305.7 62478.4 62773.0 64355.4 65040.0 55476.0 56834.4 57551.4 57728.0 58342.7 50736.0 51145.5 51586.7 51929.0 53577.0 8929.3 8989.8 8993.3 9250.1 9313.1 26669.5 26988.0 27397.5 27833.0 28199.2 32341.4 32384.0 32508.2 32525.8 33304.7 11225.8 11401.4 11492.4 11495.1 11630.3 13431.9 14676.9 14749.2 14876.0 16311.0 12915.9 13130.5 13130.7 13287.3 13333.3 14567.9 15001.8 15453.8 15494.4 15586.6 13417.3 13808.7 14185.9 14762.6 15027.2 11525.2 11591.5 11734.8 11893.6 12111.3 10610.7 10955.5 11251.8 11330.2 12308.3 12:38:33 INFO - PID 9985 | -------- Summary: end -------- 12:38:33 INFO - PID 9985 | 12:38:34 INFO - TEST-INFO | 9985: exit 0 12:38:34 INFO - TEST-OK | dromaeo_css | took 1118698ms 12:38:34 INFO - TEST-START | kraken 12:38:34 INFO - operating with platform_type : linux_ 12:38:34 INFO - Initialising browser for kraken test... 12:38:34 INFO - TEST-INFO | started process 10406 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAcTAel/profile http://localhost:47273/getInfo.html) 12:38:38 INFO - PID 10406 | __metrics Screen width/height:1600/1200 12:38:38 INFO - PID 10406 | colorDepth:24 12:38:38 INFO - PID 10406 | Browser inner width/height: 1024/695 12:38:38 INFO - PID 10406 | __metrics 12:38:39 INFO - TEST-INFO | 10406: exit 0 12:38:39 INFO - Browser initialized. 12:38:39 INFO - Running cycle 1/1 for kraken test... 12:38:39 INFO - TEST-INFO | started process 10579 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAcTAel/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:38:51 INFO - PID 10579 | RSS: Main: 155488256 12:38:51 INFO - PID 10579 | 12:38:54 INFO - PID 10579 | Cycle 1(1): loaded http://localhost:47273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47273/tests/kraken/driver.html?testName=audio-beat-detection) 12:38:55 INFO - PID 10579 | RSS: Main: 161705984 12:38:55 INFO - PID 10579 | 12:38:58 INFO - PID 10579 | Cycle 1(1): loaded http://localhost:47273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47273/tests/kraken/driver.html?testName=audio-dft) 12:38:58 INFO - PID 10579 | RSS: Main: 160030720 12:38:58 INFO - PID 10579 | 12:39:01 INFO - PID 10579 | Cycle 1(1): loaded http://localhost:47273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47273/tests/kraken/driver.html?testName=audio-fft) 12:39:02 INFO - PID 10579 | RSS: Main: 156225536 12:39:02 INFO - PID 10579 | 12:39:04 INFO - PID 10579 | Cycle 1(1): loaded http://localhost:47273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47273/tests/kraken/driver.html?testName=audio-oscillator) 12:39:05 INFO - PID 10579 | RSS: Main: 157147136 12:39:05 INFO - PID 10579 | 12:39:07 INFO - PID 10579 | Cycle 1(1): loaded http://localhost:47273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:39:07 INFO - PID 10579 | RSS: Main: 157515776 12:39:07 INFO - PID 10579 | 12:39:10 INFO - PID 10579 | Cycle 1(1): loaded http://localhost:47273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47273/tests/kraken/driver.html?testName=imaging-darkroom) 12:39:11 INFO - PID 10579 | RSS: Main: 162758656 12:39:11 INFO - PID 10579 | 12:39:15 INFO - PID 10579 | Cycle 1(1): loaded http://localhost:47273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47273/tests/kraken/driver.html?testName=imaging-desaturate) 12:39:15 INFO - PID 10579 | RSS: Main: 160772096 12:39:15 INFO - PID 10579 | 12:39:18 INFO - PID 10579 | Cycle 1(1): loaded http://localhost:47273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47273/tests/kraken/driver.html?testName=json-parse-financial) 12:39:19 INFO - PID 10579 | RSS: Main: 161484800 12:39:19 INFO - PID 10579 | 12:39:20 INFO - PID 10579 | Cycle 1(1): loaded http://localhost:47273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:39:21 INFO - PID 10579 | RSS: Main: 161746944 12:39:21 INFO - PID 10579 | 12:39:23 INFO - PID 10579 | Cycle 1(1): loaded http://localhost:47273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47273/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:39:23 INFO - PID 10579 | RSS: Main: 161996800 12:39:23 INFO - PID 10579 | 12:39:26 INFO - PID 10579 | Cycle 1(1): loaded http://localhost:47273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:39:26 INFO - PID 10579 | RSS: Main: 161697792 12:39:26 INFO - PID 10579 | 12:39:29 INFO - PID 10579 | Cycle 1(1): loaded http://localhost:47273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:39:30 INFO - PID 10579 | RSS: Main: 162082816 12:39:30 INFO - PID 10579 | 12:39:33 INFO - PID 10579 | Cycle 1(1): loaded http://localhost:47273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:39:34 INFO - PID 10579 | RSS: Main: 162455552 12:39:34 INFO - PID 10579 | 12:39:35 INFO - PID 10579 | Cycle 1(1): loaded http://localhost:47273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47273/tests/kraken/driver.html?testName=ai-astar) 12:39:36 INFO - PID 10579 | RSS: Main: 163823616 12:39:36 INFO - PID 10579 | 12:39:36 INFO - PID 10579 | __start_tp_report 12:39:36 INFO - PID 10579 | _x_x_mozilla_page_load 12:39:36 INFO - PID 10579 | _x_x_mozilla_page_load_details 12:39:36 INFO - PID 10579 | |i|pagename|runs| 12:39:36 INFO - PID 10579 | |0;ai-astar;102;111;113;111;111;113;112;113;113;114 12:39:36 INFO - PID 10579 | |1;audio-beat-detection;153;128;124;168;128;125;122;124;151;133 12:39:36 INFO - PID 10579 | |2;audio-dft;163;164;163;161;165;166;173;164;163;164 12:39:36 INFO - PID 10579 | |3;audio-fft;75;77;74;111;77;76;78;78;96;77 12:39:36 INFO - PID 10579 | |4;audio-oscillator;84;86;109;87;86;85;95;84;84;105 12:39:36 INFO - PID 10579 | |5;imaging-gaussian-blur;114;115;114;114;114;114;114;114;114;113 12:39:36 INFO - PID 10579 | |6;imaging-darkroom;150;150;150;152;150;151;151;151;150;150 12:39:36 INFO - PID 10579 | |7;imaging-desaturate;95;94;95;100;99;95;95;94;95;94 12:39:36 INFO - PID 10579 | |8;json-parse-financial;55;54;54;54;58;58;55;54;55;54 12:39:36 INFO - PID 10579 | |9;json-stringify-tinderbox;55;56;55;56;56;55;56;56;56;55 12:39:36 INFO - PID 10579 | |10;stanford-crypto-aes;85;83;82;83;81;81;82;81;81;80 12:39:36 INFO - PID 10579 | |11;stanford-crypto-ccm;135;134;140;132;141;133;132;133;184;137 12:39:36 INFO - PID 10579 | |12;stanford-crypto-pbkdf2;181;205;190;191;190;196;195;196;190;189 12:39:36 INFO - PID 10579 | |13;stanford-crypto-sha256-iterative;75;76;72;73;74;73;74;72;71;70 12:39:36 INFO - PID 10579 | __end_tp_report 12:39:36 INFO - PID 10579 | __start_cc_report 12:39:36 INFO - PID 10579 | _x_x_mozilla_cycle_collect,851 12:39:36 INFO - PID 10579 | __end_cc_report 12:39:36 INFO - PID 10579 | __startTimestamp1494445176076__endTimestamp 12:39:36 INFO - PID 10579 | 12:39:36 INFO - PID 10579 | ------- Summary: start ------- 12:39:36 INFO - PID 10579 | Number of tests: 14 12:39:36 INFO - PID 10579 | 12:39:36 INFO - PID 10579 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.00 stddev:3.43 (3.0%) stddev-sans-first:1.12 12:39:36 INFO - PID 10579 | Values: 102.0 111.0 113.0 111.0 111.0 113.0 112.0 113.0 113.0 114.0 12:39:36 INFO - PID 10579 | 12:39:36 INFO - PID 10579 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:130.50 stddev:15.91 (12.2%) stddev-sans-first:15.58 12:39:36 INFO - PID 10579 | Values: 153.0 128.0 124.0 168.0 128.0 125.0 122.0 124.0 151.0 133.0 12:39:36 INFO - PID 10579 | 12:39:36 INFO - PID 10579 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:3.24 (2.0%) stddev-sans-first:3.38 12:39:36 INFO - PID 10579 | Values: 163.0 164.0 163.0 161.0 165.0 166.0 173.0 164.0 163.0 164.0 12:39:36 INFO - PID 10579 | 12:39:36 INFO - PID 10579 | [#3] audio-fft Cycles:10 Average:81.90 Median:77.00 stddev:11.99 (15.6%) stddev-sans-first:12.45 12:39:36 INFO - PID 10579 | Values: 75.0 77.0 74.0 111.0 77.0 76.0 78.0 78.0 96.0 77.0 12:39:36 INFO - PID 10579 | 12:39:36 INFO - PID 10579 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:85.50 stddev:9.32 (10.9%) stddev-sans-first:9.59 12:39:36 INFO - PID 10579 | Values: 84.0 86.0 109.0 87.0 86.0 85.0 95.0 84.0 84.0 105.0 12:39:36 INFO - PID 10579 | 12:39:36 INFO - PID 10579 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 12:39:36 INFO - PID 10579 | Values: 114.0 115.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 113.0 12:39:36 INFO - PID 10579 | 12:39:36 INFO - PID 10579 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 12:39:36 INFO - PID 10579 | Values: 150.0 150.0 150.0 152.0 150.0 151.0 151.0 151.0 150.0 150.0 12:39:36 INFO - PID 10579 | 12:39:36 INFO - PID 10579 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.00 stddev:2.12 (2.2%) stddev-sans-first:2.24 12:39:36 INFO - PID 10579 | Values: 95.0 94.0 95.0 100.0 99.0 95.0 95.0 94.0 95.0 94.0 12:39:36 INFO - PID 10579 | 12:39:36 INFO - PID 10579 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:1.60 (2.9%) stddev-sans-first:1.69 12:39:36 INFO - PID 10579 | Values: 55.0 54.0 54.0 54.0 58.0 58.0 55.0 54.0 55.0 54.0 12:39:36 INFO - PID 10579 | 12:39:36 INFO - PID 10579 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:56.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 12:39:36 INFO - PID 10579 | Values: 55.0 56.0 55.0 56.0 56.0 55.0 56.0 56.0 56.0 55.0 12:39:36 INFO - PID 10579 | 12:39:36 INFO - PID 10579 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:1.45 (1.8%) stddev-sans-first:1.01 12:39:36 INFO - PID 10579 | Values: 85.0 83.0 82.0 83.0 81.0 81.0 82.0 81.0 81.0 80.0 12:39:36 INFO - PID 10579 | 12:39:36 INFO - PID 10579 | [#11] stanford-crypto-ccm Cycles:10 Average:140.10 Median:136.00 stddev:15.75 (11.6%) stddev-sans-first:16.60 12:39:36 INFO - PID 10579 | Values: 135.0 134.0 140.0 132.0 141.0 133.0 132.0 133.0 184.0 137.0 12:39:36 INFO - PID 10579 | 12:39:36 INFO - PID 10579 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.30 Median:193.00 stddev:6.25 (3.2%) stddev-sans-first:5.13 12:39:36 INFO - PID 10579 | Values: 181.0 205.0 190.0 191.0 190.0 196.0 195.0 196.0 190.0 189.0 12:39:36 INFO - PID 10579 | 12:39:36 INFO - PID 10579 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:73.50 stddev:1.83 (2.5%) stddev-sans-first:1.79 12:39:36 INFO - PID 10579 | Values: 75.0 76.0 72.0 73.0 74.0 73.0 74.0 72.0 71.0 70.0 12:39:36 INFO - PID 10579 | -------- Summary: end -------- 12:39:36 INFO - PID 10579 | 12:39:37 INFO - TEST-INFO | 10579: exit 0 12:39:37 INFO - TEST-OK | kraken | took 63034ms 12:39:37 INFO - SUITE-END | took 1181s 12:39:37 INFO - Completed test suite (00:19:42) 12:39:37 INFO - javascript benchmark 12:39:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6686.648668570675, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2706.066407089554, 2715.8370497770147, 2736.425350676358, 2752.8898844046234, 2754.7107553706846, 5222.112240919043, 5304.893902121955, 5350.384705758834, 5351.812686555972, 5354.973225133874, 5286.603504737141, 5294.947050529494, 5322.095243808552, 5370.382406023308, 5403.486668766471, 4454.198244316021, 4704.764761761915, 4745.288206768986, 4771.141194584973, 4820.517948205169, 4774.427068751737, 4812.663113582051, 4830.806767729287, 4852.053849499332, 4870.025994801036, 4683.133620280225, 4689.366935463703, 4753.595944344735, 4781.2350023996, 4790.664653474259, 4756.595689366408, 4774.641901857374, 4779.80880764769, 4818.71087734737, 4844.927326090112, 4446.666500012512, 4707.058588282323, 4707.411573553306, 4739.289106634033, 4767.61859051275, 5222.373315202162, 5293.788248470095, 5316.548093412064, 5338.466153384669, 5358.4373640767935, 5685.0, 5731.828045158652, 5776.989026920314, 5780.826575202751, 5798.478136967693, 5735.254416925814, 5760.107183386582, 5760.798372056958, 5767.423257674241, 5777.306723193202, 5272.420033796279, 5318.414974352818, 5325.573954083703, 5326.760295786699, 5336.733163341895, 5887.970560147171, 5901.734421951022, 5956.85107872298, 5959.433853783884, 5984.970075149597, 5576.525995290364, 5588.524975377139, 5631.070873305941, 5636.633618814764, 5642.153676948491, 5680.005998950167, 5699.857503562444, 5702.600817942787, 5738.024535828836, 5738.713064346766, 5661.348944871393, 5668.688222147822, 5673.205751194836, 5673.744681489343, 5675.120356344691, 5655.236543066716, 5661.122526008393, 5665.461781130786, 5688.317401911797, 5694.345150307685, 4761.928571071437, 4767.547083027107, 4769.880752981134, 4786.114568804713, 4788.832390866372, 4137.751734895915, 4153.792310384469, 4165.937510937339, 4172.207280616673, 4226.661867050629, 4741.644376671695, 4863.7324947128245, 4872.634552408584, 4876.829310974099, 4911.091448082117, 5575.776968921197, 5600.831975040755, 5627.887442251132, 5633.718314084279, 5652.095664693629, 4715.0, 4727.62179025684, 4757.8096876125255, 4774.474807771142, 4779.211430113992, 4977.278294647328, 5095.184770436712, 5170.793168273302, 5176.456472070378, 5192.0, 5328.200769884548, 5333.173358129418, 5336.012837625051, 5350.678959262456, 5359.732013399314, 5725.685087320071, 5726.713664316684, 5727.226824378822, 5735.569832262514, 5776.971115144397, 5219.425863155126, 5313.229581710553, 5321.920171197357, 5346.679199248058, 5354.892902142014, 5692.629979051514, 5717.799877004285, 5724.771009159587, 5738.397468265939, 5742.799002034909, 5792.942070579409, 5803.564732645153, 5839.532837373085, 5865.384134665798, 5876.647401155944, 5570.275864137636, 5583.804566840141, 5587.3015873015875, 5589.860253493695, 5591.720413979366, 5470.234167216672, 5586.106223004463, 5588.413216612197, 5599.412061733622, 5622.0, 5321.760520776652, 5462.672239665632, 5465.152901300305, 5473.917891231715, 5489.094299440707, 5452.863678407913, 5573.498385145356, 5576.442355764391, 5579.163125531203, 5579.69311687861, 5365.248865158959, 5431.864203394789, 5435.809746658848, 5439.5920305976415, 5443.101888188563], "value": 5187.4875322689995, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.4427002667893, 725.2240103089692, 1040.4277647293986, 1047.8637777088977, 1057.8148823955805, 28015.299617509547, 31037.534436983464, 31094.378112437767, 31122.688773112262, 31271.68728312716, 31383.21541961452, 31415.371692566136, 31787.523187152154, 31792.841035794787, 31823.36353272933, 6265.216847894013, 6832.48756343275, 6936.826579335532, 6938.306169383071, 6990.965045174767, 6915.585064896122, 6972.721091156348, 7019.578825270474, 7053.118360204974, 7058.2588828173075, 6951.2701166377565, 7030.0, 7034.191068027191, 7051.964740176318, 7069.187043490013, 6986.09180806497, 6988.301169883021, 7007.719691212345, 7017.2631873653045, 7044.964775176142, 6832.248452670202, 6850.109485766869, 6909.516333856582, 6914.377706006484, 6917.584944903322, 29917.70082299171, 30190.698093019008, 30204.54693179604, 30234.092977210497, 30243.697563024307, 2967.9703202967908, 2992.1771512833925, 3011.0966709987133, 3018.6981301869637, 3034.499307614241, 23546.411339716473, 23578.17476388318, 23669.171578994825, 23677.526449471086, 23766.28701138951, 3109.191610181369, 3110.0203435917615, 3132.060381885448, 3138.6547479777205, 3167.683231676837, 135619.0, 136706.31646841703, 136717.0, 136805.0, 136936.31531842376, 37286.44070338947, 39257.41113883294, 39414.40878386827, 39601.0, 39627.80186099051, 40450.19099617991, 40603.0, 40664.18671626551, 40722.79638601788, 40869.79565102215, 11694.941525292319, 11836.70408239801, 11851.229670071418, 11908.523659053713, 11931.463084161234, 9386.249100071978, 9397.0, 9436.622535098657, 9464.053594640618, 9502.857457138149, 12461.501539938301, 12573.937130314473, 12582.0, 12623.980163174032, 12695.936520317524, 5133.537981581676, 5276.894462110737, 5283.788648454019, 5286.07493688603, 5311.309529761106, 860.242986172177, 904.6434039327457, 911.1116661255223, 918.1186061381148, 940.6613619097119, 20258.18967241294, 20854.687179692315, 21368.679469807965, 21732.782672173074, 21781.782182178293, 974.9658761943298, 977.2621670638622, 986.911177993984, 988.421773262635, 1006.6527048168371, 10922.344659320308, 11383.0, 11383.487743051583, 11455.885441145649, 11558.190926635054, 173466.0, 174720.0, 175117.12441437712, 175302.0, 175626.0, 40111.39832902509, 40158.196836063114, 40279.59720402758, 40320.59679403227, 40565.18869622591, 1167.0080528397918, 1225.5710501324465, 1239.1264158768047, 1242.3477674221106, 1244.0669497876593, 19276.8072319275, 19670.180805702123, 19979.500512486724, 20538.07578658934, 20691.793082069587, 29182.416351673273, 29280.56079158857, 29322.56016159717, 29367.706322937353, 29379.85310073436, 145915.0, 146183.0, 146594.0, 146731.26634367186, 147204.2639786837, 27591.724082758916, 28037.299067523476, 28625.570616440353, 30150.944716934802, 30180.24549386283, 35396.64603354037, 36126.09684757797, 36176.095597609215, 36241.45637815382, 36251.81874090613, 25934.35164120912, 26889.865550672122, 26940.436145168183, 27931.581026284217, 28390.85804570964, 26947.326316842235, 27229.86385068062, 27919.162425127277, 28249.805400874266, 28715.425691485634, 29317.0, 29992.550111747903, 30213.97860213961, 30251.0, 30740.0, 26252.27459057388, 26252.8687356562, 26581.33546661349, 26896.865515672296, 28221.294467638472, 20648.48378790542, 22259.77740222577, 22284.77715222827, 22456.0, 22459.550808984055], "value": 14250.363203626532, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.45604617835187, 407.8164825828374, 417.2947718355978, 434.9195398851212, 442.13121216808963, 13568.93215533921, 16629.501114966555, 17340.56648583786, 17380.91309543454, 17515.2118154683, 17448.651026979485, 17878.642427151448, 17962.461126166203, 18426.631467370644, 18624.068796560186, 5314.840554783344, 5335.33308336458, 5361.81233656823, 5387.811426600069, 5540.86147846303, 5364.704941228231, 5420.972895135538, 5427.891442171154, 5434.103372943459, 5450.0, 5174.586033117342, 5302.2841916341185, 5304.549113325372, 5420.972895135538, 5435.619506634537, 5324.307839980816, 5374.91937620936, 5389.83830485086, 5396.379416367129, 5424.430434804348, 4822.879428014293, 4871.537203965618, 4875.536824001714, 4936.679115857458, 4995.050940321327, 21971.121155153774, 22305.665415018786, 22378.32865014052, 22466.88766556173, 22568.77431225683, 1637.2141372141439, 1644.9753253701203, 1654.7186978213613, 1656.180190805547, 1657.8093519245322, 14735.55793326202, 14815.555533334018, 15079.698406031928, 15276.465323713728, 15338.769918451233, 2017.485541186988, 2031.867928584652, 2080.375887233824, 2092.309537852505, 2099.4226587688354, 83238.34093272523, 87214.0, 88503.55748221283, 88820.0, 90238.0, 10723.195760318007, 10939.617113400993, 11123.388213648326, 11347.37589432589, 11348.09215262777, 15387.846121538865, 15406.229688515754, 15408.0, 15420.92289538545, 15513.0, 7494.077309849164, 7565.319121279002, 7616.7334143305825, 7813.374930005586, 7881.921180788233, 6902.585844849325, 6991.930080699128, 7206.711731530785, 7218.3503484686635, 7235.963820180866, 7098.290170982964, 7098.3256590623805, 7115.928840711526, 7146.142462904485, 7227.710891564278, 2020.7069974853564, 2075.3500966731485, 2077.563711620546, 2105.136893873535, 2263.841531092841, 846.7883029242689, 865.6840253307623, 882.2236431939851, 889.8487257166297, 909.7316291693966, 17045.573860653334, 17061.40285090016, 17254.654906902044, 17532.298708051534, 17970.910145449452, 866.9739907802776, 873.5195642396784, 881.532787622561, 881.8985816631169, 892.3218354050967, 9237.584308706124, 9699.6120155193, 9722.756931076638, 9748.171405430476, 9875.753106172404, 335849.0, 341459.0, 341972.0, 343400.0, 345587.0, 73492.0, 75526.62236688781, 76101.6194919033, 76626.61686691642, 77015.0, 1027.9023492768026, 1050.0916707048348, 1086.5327908999047, 1087.3367245979946, 1087.782443511301, 14654.0, 14786.186759727889, 14908.62728431798, 15027.6994460108, 15544.611384715472, 37544.0, 37549.4367584481, 37620.247595048495, 38336.616633833306, 39083.413748793224, 44855.32717009313, 44999.0, 45438.0, 45614.08771824611, 47264.763676182774, 8170.10128885834, 8213.95893020531, 8354.0, 8367.079621241537, 8474.152584741476, 12640.43118059708, 12690.428930697955, 12866.549670761478, 12874.935625321814, 13116.278604676452, 10795.318367021002, 11059.50232239535, 11093.722656933318, 11139.053180479426, 11437.0, 10580.89419105799, 11008.614698485835, 11056.0, 11117.22179447431, 11637.592684256011, 11182.832257516306, 11298.378589177673, 11503.827442588536, 11868.169228153947, 12290.385480725748, 8534.103919088406, 8621.69824056155, 8730.301575874042, 8811.911880881109, 8813.0, 10806.973337532922, 10884.346939183357, 10902.618408355987, 10989.505472253928, 11385.658430247106], "value": 8798.24723189599, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1242.1429213842448, 1282.2050328796147, 1282.9935850320753, 1290.8644592317812, 1300.1224173682765, 9887.901120988789, 10350.37897726135, 10370.844437333446, 10372.896271037287, 10528.684139475808, 10342.120919721814, 10515.211359148056, 10526.105281051101, 10546.841797373027, 10553.102986246178, 2253.1550668499312, 2307.1809507624803, 2307.5500277445904, 2312.1560630369963, 2312.19073324336, 2153.095699806085, 2230.0633733831746, 2230.944226394337, 2232.5200081982453, 2237.8209743220505, 2205.106931692667, 2211.3587059752654, 2247.6965609642734, 2249.268987579035, 2258.254775923941, 2154.676798480225, 2167.1656412281304, 2201.328594778592, 2203.3059586230447, 2207.1612787140866, 2142.742870855507, 2220.3006053093222, 2235.083615717564, 2275.2832857649787, 2280.942976425586, 10248.641297554625, 10284.0, 10319.329243599217, 10320.79358412835, 10353.689389318257, 5441.401445840955, 5630.859228519279, 5633.774649014075, 5648.576356773217, 5651.4913657770585, 3173.619165700131, 3296.719778818803, 3511.2801875615437, 3561.28774245152, 3602.819859007039, 1108.4568561404853, 1108.5288752280248, 1132.3545579019963, 1146.3007565385192, 1150.6030419505257, 15458.304376303093, 15566.22168891551, 15581.532554023397, 15606.219689015617, 15683.529494115195, 4698.177818881751, 4866.099771542205, 4966.850994470172, 4989.600831933437, 4992.450830408652, 11027.558897644005, 11038.392888391056, 11072.114230861513, 11077.058450031838, 11085.445727713583, 5372.355317361941, 5392.352917649829, 5410.91883621746, 5423.945760542423, 5436.728163591804, 5060.5698515625845, 5069.290299358093, 5080.415752188545, 5170.715610641376, 5237.083510385667, 3814.7329686922203, 3932.311845427039, 3937.350337194388, 4000.1999600079516, 4028.5568587455355, 1159.588346137126, 1164.0, 1178.6581891251612, 1187.5131196209686, 1193.8268951002055, 678.772611175252, 713.9821504462326, 714.7355478472895, 730.1858427852906, 734.0604026845646, 5469.15228139639, 5537.169424586345, 5597.832065038056, 5598.0, 5698.116791897262, 522.6080439670247, 525.6399366434005, 530.1517571884954, 537.159345624097, 548.1886807524885, 3436.055084851636, 3443.1908501502126, 3466.8613255470004, 3485.0, 3549.6627820357025, 13375.53185638498, 13597.660058498419, 13788.448462061606, 13861.514846980308, 13881.375338109809, 13191.934040329928, 13487.393067311994, 13625.795613065811, 13749.037567370187, 13806.309684515734, 7274.636268186569, 7344.559326440431, 7354.485186037033, 7433.331000209899, 7498.737544185928, 5864.384239654775, 5881.9705901470215, 5961.254843144607, 5984.0, 6002.369751176064, 11699.88300117022, 11943.0, 12123.0, 12306.261624302571, 12470.68823279389, 12200.267983920992, 12395.380230988594, 12513.687157821127, 12610.18033827835, 12651.557195498113, 7474.103107627119, 7637.350825179699, 7649.158592554926, 7657.234276572298, 7674.424418168772, 9549.0, 9666.371685840399, 9716.368436051634, 9820.852687209841, 9834.065763752433, 8287.585620718819, 8297.08732039463, 8342.83314333722, 8452.830943380975, 8526.616302266537, 7515.661795219337, 7536.434767392577, 7547.622618868925, 7591.4685971981435, 8090.797730056795, 6880.69036893351, 6994.720211191496, 7013.579185248901, 7034.788956331318, 7044.753433629799, 4920.384951881015, 4937.506249375034, 4992.126377883928, 5077.994192294097, 5199.71401572902, 4846.903061938812, 4915.4592994771265, 4944.554990050912, 4967.776450059829, 4995.075910956485], "value": 4685.405067254508, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.64130434782606, 391.89027072419714, 392.19795518165347, 395.3496498260361, 397.39000634026775, 5431.619786614929, 5647.604667673265, 5676.460736230051, 5676.559079595782, 5681.687507187103, 5399.1091469907515, 5478.479544443281, 5479.232907392969, 5483.561315094793, 5516.4072885743735, 4133.441985331971, 4153.086321009373, 4153.107081977374, 4153.6677065834665, 4160.479940007499, 4103.815328310233, 4137.6482998944975, 4153.709240353177, 4158.355454904479, 4170.124273902484, 4089.591040895916, 4092.9795351023354, 4099.426080348753, 4110.897227569305, 4124.020470174318, 4079.224947260011, 4093.4678491796026, 4095.303798354272, 4121.340585506305, 4136.482939632546, 3599.3521166190076, 3610.5667319921513, 3613.963860361389, 3615.2407994321225, 3623.9456408153897, 5224.973875130638, 5400.972995135038, 5406.162044883049, 5432.0, 5452.754626041838, 4791.760411979387, 4796.544328288842, 4797.784099715521, 4797.920467894695, 4800.0, 5676.574256930747, 5855.824325270206, 5861.648301101947, 5867.735951882176, 5888.146218798251, 3933.8426462941447, 3939.8227079781477, 3951.209758048402, 3953.881383558498, 3966.9008274793073, 5966.373530779249, 6135.0, 6148.200733904564, 6151.63090214593, 6218.906716399258, 4075.7554546727292, 4091.365838295069, 4100.302948498763, 4114.9095489695255, 4131.091159944807, 4164.729292595972, 4179.1432756284885, 4182.1844740275965, 4188.434561334242, 4192.756875071822, 4703.482616912137, 4774.3793306870575, 4776.0, 4812.807487700523, 4816.579109162805, 5810.360860305363, 5816.854578635483, 5821.446962538552, 5832.329282132524, 5839.503642190376, 1422.8506006869336, 1443.5885772554982, 1444.1335198880588, 1447.9710405792036, 1452.891033172495, 935.8502639577771, 937.5687183895349, 940.7742141885898, 959.9520023998772, 978.9167920726818, 4981.153203955337, 4998.725070121178, 5002.59979201663, 5008.424031236382, 5026.271190677331, 5965.343812180657, 6045.304789949124, 6051.122587224828, 6076.088586712029, 6086.6652334122045, 4806.423229212517, 4988.55103040728, 4995.650304478651, 5003.099442100384, 5032.018756342478, 3191.1064901827526, 3217.501287300472, 3219.5653586765957, 3221.597300337458, 3232.8383580820864, 5460.208269800856, 5564.749586268627, 5585.832425027255, 5606.495415412551, 5615.494605485526, 6180.47465965398, 6181.072839074175, 6192.969035154885, 6207.399708169251, 6241.251049874044, 5542.501174894279, 5548.167774833807, 5576.525995290446, 5578.832635020955, 5588.832335029955, 5921.259842519685, 6039.48664363534, 6048.425399587032, 6053.152558641706, 6053.273607167168, 5948.851278718067, 5950.166976623363, 5967.91048134287, 5984.551158663205, 6022.307434645072, 5426.348838139291, 5552.167174923794, 5590.413006634408, 5604.299462567179, 5620.241267429008, 4086.5709100544013, 4117.053077792185, 4128.112455822013, 4132.876013719593, 4137.13120244752, 5933.525317974465, 6097.817065488042, 6111.755529778759, 6120.908186377297, 6132.313613756252, 5869.559783016205, 5872.647641141374, 5881.735531820194, 5885.529157667462, 5904.940950590611, 5855.2095467113095, 5878.147668588116, 5890.293164820249, 5898.203742494708, 5906.2026626406605, 5701.771929122789, 5773.480386765212, 5783.508401785727, 5785.450382213683, 5812.476877081083, 5897.7935772247765, 5901.3213480450295, 5922.378150294329, 5942.6731529766275, 5944.732487038007, 5635.0, 5681.346645135863, 5727.284089488814, 5757.596968212185, 5762.366139724543], "value": 4346.98433786107, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.5458215906139, 745.3403737692141, 751.5978951261073, 767.0718430698854, 771.7067514344549, 11596.942015289911, 12092.576759813408, 12739.363031848405, 13283.800742988862, 13375.197488150718, 14866.702665946674, 15427.0, 15442.845571544281, 15458.227088645579, 15494.84505154948, 851.2168804699676, 883.0639522106555, 883.1786438612088, 884.0496466298722, 889.7597648634865, 856.1096459681924, 886.7162507997411, 890.6838072484272, 893.1738142218454, 894.4543828264754, 920.6363486422858, 938.3853575907791, 942.156769691126, 942.7171848445473, 945.8533927241289, 903.6566104880136, 931.0503286647615, 935.2004036548789, 936.7939053408239, 936.8313703533362, 671.7178784910301, 683.1870074611246, 688.0676683094385, 690.0373978300294, 693.1058933975166, 13011.804822927663, 13161.86838131616, 13326.133801302884, 13520.526781562598, 13662.863371366258, 15279.388824447009, 15436.459723909722, 15680.529584112495, 16182.676346473005, 16337.26482308299, 12466.189697669623, 12477.625671229787, 12642.810357844639, 12699.492020319176, 12815.359232038454, 2895.4932886744737, 2907.912762617125, 2922.0941508132546, 2942.249726319796, 2945.675975642699, 69322.30677693209, 69639.0, 69739.65130174368, 70136.298637014, 71008.0, 12403.813942790865, 12510.124291299522, 12577.245365278113, 12597.244165350108, 12657.050721195947, 22342.66486002711, 22441.887790560944, 22465.32604021882, 22530.887345563166, 22553.210637627606, 6006.099085137177, 6014.7594096236535, 6172.444479996821, 6197.070439434121, 6253.906191407133, 2801.7898657600763, 2866.484032874061, 2877.9712202878122, 2883.5818806272973, 2888.176869592156, 3375.4430518964587, 3468.2023134679166, 3474.42671959129, 3475.0269924421204, 3563.94654080189, 735.981600459982, 750.0362034785275, 750.523417629809, 750.7635094945075, 752.5409500204871, 586.8034208540101, 598.6886818854172, 611.8317462697794, 618.4279541424164, 635.640862912453, 8919.286457083417, 9059.81880362389, 9083.727488175366, 9123.17891389765, 9720.854187187198, 591.2993103172754, 616.4205646692095, 617.7899514165116, 623.1338439569003, 634.0330995232215, 4232.936505952413, 4245.724027938174, 4371.30059190528, 4455.443069616298, 4505.684602077823, 62305.688471557354, 62478.37521624816, 62773.0, 64355.35644643493, 65040.0, 55476.0, 56834.431655683744, 57551.424485755444, 57728.0, 58342.7082864583, 50736.0, 51145.488545114815, 51586.74206628943, 51929.0, 53577.0, 8929.285657147282, 8989.775255618662, 8993.28053755711, 9250.074992500966, 9313.068693130905, 26669.46661066729, 26988.0, 27397.45205095847, 27833.02584409536, 28199.15402537927, 32341.35317293688, 32384.0, 32508.18729531686, 32525.837370812995, 33304.66695333113, 11225.775484490101, 11401.372924489233, 11492.36791976416, 11495.137864660352, 11630.302181869114, 13431.86568134306, 14676.853231467549, 14749.18879461597, 14876.0, 16311.0, 12915.935420322838, 13130.474781008652, 13130.737385252432, 13287.269200194081, 13333.333333333489, 14567.92716036413, 15001.77497337519, 15453.84546154569, 15494.380224790882, 15586.610334741723, 13417.262050586922, 13808.654783630489, 14185.929070354583, 14762.63093422673, 15027.248637568297, 11525.193236473366, 11591.536338546364, 11734.765304694029, 11893.583724569598, 12111.273323600612, 10610.681679549625, 10955.50700218476, 11251.831222531504, 11330.150238731963, 12308.323042232763], "value": 6746.924219957194, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 113.0, 111.0, 111.0, 113.0, 112.0, 113.0, 113.0, 114.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 128.0, 124.0, 168.0, 128.0, 125.0, 122.0, 124.0, 151.0, 133.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 161.0, 165.0, 166.0, 173.0, 164.0, 163.0, 164.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 74.0, 111.0, 77.0, 76.0, 78.0, 78.0, 96.0, 77.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 109.0, 87.0, 86.0, 85.0, 95.0, 84.0, 84.0, 105.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 152.0, 150.0, 151.0, 151.0, 151.0, 150.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 100.0, 99.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 58.0, 58.0, 55.0, 54.0, 55.0, 54.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 56.0, 56.0, 55.0, 56.0, 56.0, 56.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 82.0, 83.0, 81.0, 81.0, 82.0, 81.0, 81.0, 80.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 134.0, 140.0, 132.0, 141.0, 133.0, 132.0, 133.0, 184.0, 137.0], "value": 140.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 205.0, 190.0, 191.0, 190.0, 196.0, 195.0, 196.0, 190.0, 189.0], "value": 192.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 72.0, 73.0, 74.0, 73.0, 74.0, 72.0, 71.0, 70.0], "value": 73.0, "unit": "score"}]}]} 12:39:37 INFO - Return code: 0 12:39:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:39:37 INFO - # TBPL SUCCESS # 12:39:37 INFO - Running post-action listener: _resource_record_post_action 12:39:37 INFO - [mozharness: 2017-05-10 19:39:37.878280Z] Finished run-tests step (success) 12:39:37 INFO - Running post-run listener: _resource_record_post_run 12:39:37 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 12288; Write bytes: 370647040; Read time: 376; Write time: 245360 12:39:37 INFO - TinderboxPrint: CPU usage
13.3% 12:39:37 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 376 12:39:37 INFO - TinderboxPrint: I/O write bytes / time
370,647,040 / 245,360 12:39:37 INFO - TinderboxPrint: CPU idle
8,290.8 (86.7%) 12:39:37 INFO - TinderboxPrint: CPU user
1,213.8 (12.7%) 12:39:37 INFO - TinderboxPrint: Swap in / out
0 / 0 12:39:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 106139648; Read time: 192; Write time: 105560 12:39:37 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 263237632; Read time: 168; Write time: 139772 12:39:38 INFO - Running post-run listener: _upload_blobber_files 12:39:38 INFO - Blob upload gear active. 12:39:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:39:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:39:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:39:38 INFO - (blobuploader) - INFO - Open directory for files ... 12:39:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:39:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:39:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:39 INFO - (blobuploader) - INFO - Done attempting. 12:39:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:39:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:39:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:40 INFO - (blobuploader) - INFO - Done attempting. 12:39:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:39:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:39:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:41 INFO - (blobuploader) - INFO - Done attempting. 12:39:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:39:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:39:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:45 INFO - (blobuploader) - INFO - Done attempting. 12:39:45 INFO - (blobuploader) - INFO - Iteration through files over. 12:39:45 INFO - Return code: 0 12:39:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:39:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:39:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02fb16afcf46db9747fe9995a3474a254cfebdf77cdf5f62c5980882fc9e852cc922f5545d4c679a399cc5a9034e3faafa2bac6e4a63e336c89dafef2cb539ce", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e128de4e56d75c3c0019b64384d4896a4cf9ba5d83f3d96d1b4f62e9948072e04016ac0353f058dc8d74d13cc91173013b51fac8a16c25b910484a3a1db0a227", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2528ae48e28cd7b188b54c35a1c3dd7651683e0add9843b363cedfc4619750d012ce9c04fbe38dfe7385fad0ffaa634c2f4f3bff6a17063fa31f426c54464cc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/84f89723bc466cd866b4dd52229c409d47d5360e16338ae6bf81c5e81eb6779db3474b9c3151abe39a8dfe0918e0ffd49fdd74ed925f09512a1aa61ed57fdd57"} 12:39:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:39:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:39:45 INFO - Contents: 12:39:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02fb16afcf46db9747fe9995a3474a254cfebdf77cdf5f62c5980882fc9e852cc922f5545d4c679a399cc5a9034e3faafa2bac6e4a63e336c89dafef2cb539ce", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e128de4e56d75c3c0019b64384d4896a4cf9ba5d83f3d96d1b4f62e9948072e04016ac0353f058dc8d74d13cc91173013b51fac8a16c25b910484a3a1db0a227", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2528ae48e28cd7b188b54c35a1c3dd7651683e0add9843b363cedfc4619750d012ce9c04fbe38dfe7385fad0ffaa634c2f4f3bff6a17063fa31f426c54464cc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/84f89723bc466cd866b4dd52229c409d47d5360e16338ae6bf81c5e81eb6779db3474b9c3151abe39a8dfe0918e0ffd49fdd74ed925f09512a1aa61ed57fdd57"} 12:39:45 INFO - Running post-run listener: copy_logs_to_upload_dir 12:39:45 INFO - Copying logs to upload dir... 12:39:45 INFO - mkdir: /builds/slave/test/build/upload/logs 12:39:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.528741 ========= master_lag: -0.30 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-05-10 12:39:44.801977) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 12:39:44.806075) ========= 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=c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02fb16afcf46db9747fe9995a3474a254cfebdf77cdf5f62c5980882fc9e852cc922f5545d4c679a399cc5a9034e3faafa2bac6e4a63e336c89dafef2cb539ce", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e128de4e56d75c3c0019b64384d4896a4cf9ba5d83f3d96d1b4f62e9948072e04016ac0353f058dc8d74d13cc91173013b51fac8a16c25b910484a3a1db0a227", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2528ae48e28cd7b188b54c35a1c3dd7651683e0add9843b363cedfc4619750d012ce9c04fbe38dfe7385fad0ffaa634c2f4f3bff6a17063fa31f426c54464cc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/84f89723bc466cd866b4dd52229c409d47d5360e16338ae6bf81c5e81eb6779db3474b9c3151abe39a8dfe0918e0ffd49fdd74ed925f09512a1aa61ed57fdd57"} build_url:https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011127 build_url: 'https://queue.taskcluster.net/v1/task/MkqwQkpZR8Sw_-bjO_mh7Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/02fb16afcf46db9747fe9995a3474a254cfebdf77cdf5f62c5980882fc9e852cc922f5545d4c679a399cc5a9034e3faafa2bac6e4a63e336c89dafef2cb539ce", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e128de4e56d75c3c0019b64384d4896a4cf9ba5d83f3d96d1b4f62e9948072e04016ac0353f058dc8d74d13cc91173013b51fac8a16c25b910484a3a1db0a227", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2528ae48e28cd7b188b54c35a1c3dd7651683e0add9843b363cedfc4619750d012ce9c04fbe38dfe7385fad0ffaa634c2f4f3bff6a17063fa31f426c54464cc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/84f89723bc466cd866b4dd52229c409d47d5360e16338ae6bf81c5e81eb6779db3474b9c3151abe39a8dfe0918e0ffd49fdd74ed925f09512a1aa61ed57fdd57"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 12:39:44.833759) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:39:44.834050) ========= 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=c6927cf182745ad25b1d38b9000001fe-1494443930.890347-2107483755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004395 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 12:39:44.914073) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 12:39:44.914340) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 12:39:44.914600) ========= ========= Total master_lag: -0.14 =========