builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-037 starttime: 1489536736.63 results: success (0) revision: cef93bf5a0a15ab7a2dc96d0cee90a599a4eae76 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-14 17:12:16.629646) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-14 17:12:16.630061) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-14 17:12:16.630338) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-14 17:12:16.646544) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 17:12:16.646896) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-14 17:12:16-- 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% 42.9M=0s 2017-03-14 17:12:16 (42.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132054 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 17:12:16.792406) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 17:12:16.792716) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015406 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 17:12:16.851783) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-14 17:12:16.855238) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cef93bf5a0a15ab7a2dc96d0cee90a599a4eae76 --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 cef93bf5a0a15ab7a2dc96d0cee90a599a4eae76 --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=56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-14 17:12:17,040 truncating revision to first 12 chars 2017-03-14 17:12:17,040 Setting DEBUG logging. 2017-03-14 17:12:17,040 attempt 1/10 2017-03-14 17:12:17,040 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cef93bf5a0a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-14 17:12:17,976 unpacking tar archive at: mozilla-central-cef93bf5a0a1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.293874 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-14 17:12:18.161832) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-14 17:12:18.165201) ========= script_repo_revision: cef93bf5a0a15ab7a2dc96d0cee90a599a4eae76 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-14 17:12:18.165571) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-14 17:12:18.165859) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-14 17:12:18.175173) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-03-14 17:12:18.175505) ========= /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=56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:12:18 INFO - MultiFileLogger online at 20170314 17:12:18 in /builds/slave/test 17:12:18 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 17:12:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:12:18 INFO - {'append_to_log': False, 17:12:18 INFO - 'base_work_dir': '/builds/slave/test', 17:12:18 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:12:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:12:18 INFO - 'branch': 'Firefox-Non-PGO', 17:12:18 INFO - 'buildbot_json_path': 'buildprops.json', 17:12:18 INFO - 'config_files': ('talos/linux_config.py',), 17:12:18 INFO - 'default_actions': ('clobber', 17:12:18 INFO - 'read-buildbot-config', 17:12:18 INFO - 'download-and-extract', 17:12:18 INFO - 'populate-webroot', 17:12:18 INFO - 'create-virtualenv', 17:12:18 INFO - 'install', 17:12:18 INFO - 'run-tests'), 17:12:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:12:18 INFO - 'download_minidump_stackwalk': True, 17:12:18 INFO - 'download_symbols': 'ondemand', 17:12:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:12:18 INFO - 'tooltool.py': '/tools/tooltool.py', 17:12:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:12:18 INFO - '/tools/misc-python/virtualenv.py')}, 17:12:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:12:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:12:18 INFO - 'gecko_profile': False, 17:12:18 INFO - 'gecko_profile_interval': 0, 17:12:18 INFO - 'installer_path': 'installer.exe', 17:12:18 INFO - 'log_level': 'info', 17:12:18 INFO - 'log_name': 'talos', 17:12:18 INFO - 'log_to_console': True, 17:12:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:12:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:12:18 INFO - 'opt_config_files': (), 17:12:18 INFO - 'pip_index': False, 17:12:18 INFO - 'suite': 'dromaeojs-e10s', 17:12:18 INFO - 'system_bits': '32', 17:12:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:12:18 INFO - 'title': 'talos-linux64-ix-037', 17:12:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:12:18 INFO - 'use_talos_json': True, 17:12:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:12:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:12:18 INFO - 'work_dir': 'build'} 17:12:18 INFO - [mozharness: 2017-03-15 00:12:18.455424Z] Running clobber step. 17:12:18 INFO - Running pre-action listener: _resource_record_pre_action 17:12:18 INFO - Running main action method: clobber 17:12:18 INFO - rmtree: /builds/slave/test/build 17:12:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:12:19 INFO - Running post-action listener: _resource_record_post_action 17:12:19 INFO - [mozharness: 2017-03-15 00:12:19.455360Z] Finished clobber step (success) 17:12:19 INFO - [mozharness: 2017-03-15 00:12:19.455459Z] Running read-buildbot-config step. 17:12:19 INFO - Running pre-action listener: _resource_record_pre_action 17:12:19 INFO - Running main action method: read_buildbot_config 17:12:19 INFO - Using buildbot properties: 17:12:19 INFO - { 17:12:19 INFO - "project": "", 17:12:19 INFO - "product": "firefox", 17:12:19 INFO - "who": "kwierso@gmail.com", 17:12:19 INFO - "installer_path": "public/build/target.tar.bz2", 17:12:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:12:19 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:12:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:12:19 INFO - "stage_platform": "linux64", 17:12:19 INFO - "basedir": "/builds/slave/test", 17:12:19 INFO - "buildnumber": 753, 17:12:19 INFO - "platform": "ubuntu64_hw", 17:12:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:12:19 INFO - "slavebuilddir": "test", 17:12:19 INFO - "taskId": "MMepWf2vT-a0t64RiyQlqA", 17:12:19 INFO - "branch": "mozilla-central", 17:12:19 INFO - "script_repo_revision": "production", 17:12:19 INFO - "revision": "cef93bf5a0a15ab7a2dc96d0cee90a599a4eae76", 17:12:19 INFO - "slavename": "talos-linux64-ix-037", 17:12:19 INFO - "repo_path": "mozilla-central" 17:12:19 INFO - } 17:12:19 INFO - Finding installer, test and symbols from parent task. 17:12:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MMepWf2vT-a0t64RiyQlqA'}, attempt #1 17:12:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MMepWf2vT-a0t64RiyQlqA'}, attempt #1 17:12:20 INFO - Task dependencies: URowWlIASi6v2QE4IU9kvw 17:12:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/URowWlIASi6v2QE4IU9kvw'}, attempt #1 17:12:20 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/target.tar.bz2 17:12:20 INFO - Set test_url: https://queue.taskcluster.net/v1/task/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/test_packages.json 17:12:20 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/target.crashreporter-symbols.zip 17:12:20 INFO - Running post-action listener: _resource_record_post_action 17:12:20 INFO - [mozharness: 2017-03-15 00:12:20.936578Z] Finished read-buildbot-config step (success) 17:12:20 INFO - [mozharness: 2017-03-15 00:12:20.936793Z] Running download-and-extract step. 17:12:20 INFO - Running pre-action listener: _resource_record_pre_action 17:12:20 INFO - Running main action method: download_and_extract 17:12:20 INFO - mkdir: /builds/slave/test/build/tests 17:12:20 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')]} 17:12:20 INFO - trying https://queue.taskcluster.net/v1/task/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/target.test_packages.json 17:12:20 INFO - Downloading https://queue.taskcluster.net/v1/task/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:12:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:12:21 INFO - Downloaded 896 bytes. 17:12:21 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:12:21 INFO - Using the following test package requirements: 17:12:21 INFO - {u'common': [u'target.common.tests.zip'], 17:12:21 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:12:21 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:12:21 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:12:21 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:12:21 INFO - u'mozbase': [u'target.common.tests.zip'], 17:12:21 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:12:21 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:12:21 INFO - u'web-platform': [u'target.common.tests.zip', 17:12:21 INFO - u'target.web-platform.tests.zip'], 17:12:21 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:12:21 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:12:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/target.common.tests.zip 17:12:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:12:21 INFO - Fetch https://queue.taskcluster.net/v1/task/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/target.common.tests.zip into memory 17:12:22 INFO - Expected file size: 58182918 17:12:22 INFO - Obtained file size: 58182918 17:12:32 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:12:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/target.common.tests.zip 17:12:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:12:32 INFO - Fetch https://queue.taskcluster.net/v1/task/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/target.common.tests.zip into memory 17:12:33 INFO - Expected file size: 58182918 17:12:33 INFO - Obtained file size: 58182918 17:12:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/target.talos.tests.zip 17:12:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:12:43 INFO - Fetch https://queue.taskcluster.net/v1/task/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/target.talos.tests.zip into memory 17:12:44 INFO - Expected file size: 14404452 17:12:44 INFO - Obtained file size: 14404452 17:12:44 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')]} 17:12:44 INFO - trying https://queue.taskcluster.net/v1/task/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/target.tar.bz2 17:12:44 INFO - Downloading https://queue.taskcluster.net/v1/task/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:12:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:12:45 INFO - Downloaded 61661852 bytes. 17:12:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/target.tar.bz2 17:12:45 INFO - mkdir: /builds/slave/test/properties 17:12:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:12:45 INFO - Writing to file /builds/slave/test/properties/build_url 17:12:45 INFO - Contents: 17:12:45 INFO - build_url:https://queue.taskcluster.net/v1/task/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/target.tar.bz2 17:12:45 INFO - Running post-action listener: _resource_record_post_action 17:12:45 INFO - Running post-action listener: set_extra_try_arguments 17:12:45 INFO - [mozharness: 2017-03-15 00:12:45.955534Z] Finished download-and-extract step (success) 17:12:45 INFO - [mozharness: 2017-03-15 00:12:45.955630Z] Running populate-webroot step. 17:12:45 INFO - Running pre-action listener: _resource_record_pre_action 17:12:45 INFO - Running main action method: populate_webroot 17:12:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:12:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:12:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:12:45 INFO - '--tppagecycles', 17:12:45 INFO - '7'], 17:12:45 INFO - 'tests': ['tsvgm']}}, 17:12:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:12:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:12:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:12:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:12:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:12:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:12:45 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:12:45 INFO - 'talos_options': ['--disable-e10s'], 17:12:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:12:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:12:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:12:45 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:12:45 INFO - 'talos_options': ['--disable-e10s'], 17:12:45 INFO - 'tests': ['damp', 'tps']}, 17:12:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:12:45 INFO - 'tests': ['damp', 'tps']}, 17:12:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:12:45 INFO - 'tests': ['dromaeo_dom']}, 17:12:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:12:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:12:45 INFO - 'tests': ['basic_compositor_video']}, 17:12:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:12:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:12:45 INFO - 'tests': ['a11yr', 17:12:45 INFO - 'ts_paint', 17:12:45 INFO - 'tpaint', 17:12:45 INFO - 'sessionrestore', 17:12:45 INFO - 'sessionrestore_no_auto_restore', 17:12:45 INFO - 'tabpaint']}, 17:12:45 INFO - 'other-e10s': {'tests': ['a11yr', 17:12:45 INFO - 'ts_paint', 17:12:45 INFO - 'tpaint', 17:12:45 INFO - 'sessionrestore', 17:12:45 INFO - 'sessionrestore_no_auto_restore', 17:12:45 INFO - 'tabpaint']}, 17:12:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:12:45 INFO - 'ts_paint', 17:12:45 INFO - 'tpaint', 17:12:45 INFO - 'sessionrestore', 17:12:45 INFO - 'sessionrestore_no_auto_restore', 17:12:45 INFO - 'tabpaint']}, 17:12:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:12:45 INFO - 'ts_paint', 17:12:45 INFO - 'tpaint', 17:12:45 INFO - 'sessionrestore', 17:12:45 INFO - 'sessionrestore_no_auto_restore', 17:12:45 INFO - 'tabpaint']}, 17:12:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:12:45 INFO - 'tests': ['a11yr', 17:12:45 INFO - 'ts_paint', 17:12:45 INFO - 'tpaint', 17:12:45 INFO - 'sessionrestore', 17:12:45 INFO - 'sessionrestore_no_auto_restore', 17:12:45 INFO - 'tabpaint']}, 17:12:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:12:45 INFO - 'tests': ['a11yr', 17:12:45 INFO - 'ts_paint', 17:12:45 INFO - 'tpaint', 17:12:45 INFO - 'sessionrestore', 17:12:45 INFO - 'sessionrestore_no_auto_restore', 17:12:45 INFO - 'tabpaint']}, 17:12:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:12:45 INFO - 'tests': ['tsvgx', 17:12:45 INFO - 'tsvgr_opacity', 17:12:45 INFO - 'tart', 17:12:45 INFO - 'tscrollx', 17:12:45 INFO - 'cart', 17:12:45 INFO - 'tsvg_static']}, 17:12:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:12:45 INFO - 'tsvgr_opacity', 17:12:45 INFO - 'tart', 17:12:45 INFO - 'tscrollx', 17:12:45 INFO - 'cart', 17:12:45 INFO - 'tsvg_static']}, 17:12:45 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:12:45 INFO - 'talos_options': ['--disable-e10s'], 17:12:45 INFO - 'tests': ['tp5o']}, 17:12:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:12:45 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:12:45 INFO - 'talos_options': ['--disable-e10s', 17:12:45 INFO - '--xperf_path', 17:12:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:12:45 INFO - 'tests': ['tp5n']}, 17:12:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:12:45 INFO - 'talos_options': ['--xperf_path', 17:12:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:12:45 INFO - 'tests': ['tp5n']}}, 17:12:45 INFO - 'talos.zip': {'path': '', 17:12:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:12:45 INFO - Running post-action listener: _resource_record_post_action 17:12:45 INFO - [mozharness: 2017-03-15 00:12:45.968680Z] Finished populate-webroot step (success) 17:12:45 INFO - [mozharness: 2017-03-15 00:12:45.968769Z] Running create-virtualenv step. 17:12:45 INFO - Running pre-action listener: _resource_record_pre_action 17:12:45 INFO - Running main action method: create_virtualenv 17:12:45 INFO - Creating virtualenv /builds/slave/test/build/venv 17:12:45 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 17:12:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:12:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:12:46 INFO - Using real prefix '/usr' 17:12:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:12:46 INFO - Installing distribute.............................................................................................................................................................................................done. 17:12:48 INFO - Installing pip.................done. 17:12:48 INFO - Return code: 0 17:12:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:12:48 INFO - Reading from file tmpfile_stdout 17:12:48 INFO - Output received: 17:12:48 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) 17:12:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:12:48 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')]} 17:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:48 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')]} 17:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:48 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 0x12d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x156db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156b290>, '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 0x156bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156c040>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119', '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 17:12:48 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 17:12:48 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 17:12:48 INFO - Using env: {'DISPLAY': ':0', 17:12:48 INFO - 'HOME': '/home/cltbld', 17:12:48 INFO - 'LANG': 'en_US.UTF-8', 17:12:48 INFO - 'LANGUAGE': 'en_US:en', 17:12:48 INFO - 'LOGNAME': 'cltbld', 17:12:48 INFO - 'MAIL': '/var/mail/cltbld', 17:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:48 INFO - 'MOZ_NO_REMOTE': '1', 17:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:48 INFO - 'NO_EM_RESTART': '1', 17:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:48 INFO - 'PWD': '/builds/slave/test', 17:12:48 INFO - 'SHELL': '/bin/bash', 17:12:48 INFO - 'SHLVL': '1', 17:12:48 INFO - 'TERM': 'linux', 17:12:48 INFO - 'TMOUT': '86400', 17:12:48 INFO - 'USER': 'cltbld', 17:12:48 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119', 17:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:48 INFO - '_': '/tools/buildbot/bin/python'} 17:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:48 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 17:12:48 INFO - Cleaning up... 17:12:48 INFO - Return code: 0 17:12:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:12:48 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')]} 17:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:48 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')]} 17:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:49 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 0x12d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x156db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156b290>, '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 0x156bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156c040>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119', '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 17:12:49 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 17:12:49 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 17:12:49 INFO - Using env: {'DISPLAY': ':0', 17:12:49 INFO - 'HOME': '/home/cltbld', 17:12:49 INFO - 'LANG': 'en_US.UTF-8', 17:12:49 INFO - 'LANGUAGE': 'en_US:en', 17:12:49 INFO - 'LOGNAME': 'cltbld', 17:12:49 INFO - 'MAIL': '/var/mail/cltbld', 17:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:49 INFO - 'MOZ_NO_REMOTE': '1', 17:12:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:49 INFO - 'NO_EM_RESTART': '1', 17:12:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:49 INFO - 'PWD': '/builds/slave/test', 17:12:49 INFO - 'SHELL': '/bin/bash', 17:12:49 INFO - 'SHLVL': '1', 17:12:49 INFO - 'TERM': 'linux', 17:12:49 INFO - 'TMOUT': '86400', 17:12:49 INFO - 'USER': 'cltbld', 17:12:49 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119', 17:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:49 INFO - '_': '/tools/buildbot/bin/python'} 17:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:49 INFO - Downloading/unpacking psutil>=3.1.1 17:12:49 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 17:12:49 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 17:12:49 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 17:12:49 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 17:12:49 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 17:12:49 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 17:12:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:12:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:12:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:12:51 INFO - Installing collected packages: psutil 17:12:51 INFO - Running setup.py install for psutil 17:12:51 INFO - building 'psutil._psutil_linux' extension 17:12:51 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 17:12:51 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 17:12:51 INFO - building 'psutil._psutil_posix' extension 17:12:51 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 17:12:51 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 17:12:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:12:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:12:51 INFO - Successfully installed psutil 17:12:51 INFO - Cleaning up... 17:12:52 INFO - Return code: 0 17:12:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:52 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 0x12d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x156db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156b290>, '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 0x156bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156c040>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119', '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 17:12:52 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 17:12:52 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 17:12:52 INFO - Using env: {'DISPLAY': ':0', 17:12:52 INFO - 'HOME': '/home/cltbld', 17:12:52 INFO - 'LANG': 'en_US.UTF-8', 17:12:52 INFO - 'LANGUAGE': 'en_US:en', 17:12:52 INFO - 'LOGNAME': 'cltbld', 17:12:52 INFO - 'MAIL': '/var/mail/cltbld', 17:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:52 INFO - 'MOZ_NO_REMOTE': '1', 17:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:52 INFO - 'NO_EM_RESTART': '1', 17:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:52 INFO - 'PWD': '/builds/slave/test', 17:12:52 INFO - 'SHELL': '/bin/bash', 17:12:52 INFO - 'SHLVL': '1', 17:12:52 INFO - 'TERM': 'linux', 17:12:52 INFO - 'TMOUT': '86400', 17:12:52 INFO - 'USER': 'cltbld', 17:12:52 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119', 17:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:52 INFO - '_': '/tools/buildbot/bin/python'} 17:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:12:52 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 17:12:52 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 17:12:52 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 17:12:52 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 17:12:52 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 17:12:52 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 17:12:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:12:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:12:54 INFO - Installing collected packages: mozsystemmonitor 17:12:54 INFO - Running setup.py install for mozsystemmonitor 17:12:54 INFO - Successfully installed mozsystemmonitor 17:12:54 INFO - Cleaning up... 17:12:54 INFO - Return code: 0 17:12:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:12:54 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')]} 17:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:54 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')]} 17:12:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:54 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 0x12d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x156db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156b290>, '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 0x156bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156c040>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119', '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 17:12:54 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 17:12:54 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 17:12:54 INFO - Using env: {'DISPLAY': ':0', 17:12:54 INFO - 'HOME': '/home/cltbld', 17:12:54 INFO - 'LANG': 'en_US.UTF-8', 17:12:54 INFO - 'LANGUAGE': 'en_US:en', 17:12:54 INFO - 'LOGNAME': 'cltbld', 17:12:54 INFO - 'MAIL': '/var/mail/cltbld', 17:12:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:54 INFO - 'MOZ_NO_REMOTE': '1', 17:12:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:54 INFO - 'NO_EM_RESTART': '1', 17:12:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:54 INFO - 'PWD': '/builds/slave/test', 17:12:54 INFO - 'SHELL': '/bin/bash', 17:12:54 INFO - 'SHLVL': '1', 17:12:54 INFO - 'TERM': 'linux', 17:12:54 INFO - 'TMOUT': '86400', 17:12:54 INFO - 'USER': 'cltbld', 17:12:54 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119', 17:12:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:54 INFO - '_': '/tools/buildbot/bin/python'} 17:12:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:54 INFO - Downloading/unpacking jsonschema==2.5.1 17:12:54 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 17:12:54 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 17:12:54 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 17:12:54 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 17:12:54 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 17:12:54 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 17:12:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:12:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:56 INFO - Downloading functools32-3.2.3-2.tar.gz 17:12:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:12:56 INFO - warning: no files found matching '*.txt' 17:12:56 INFO - no previously-included directories found matching 'build' 17:12:56 INFO - no previously-included directories found matching 'dist' 17:12:56 INFO - no previously-included directories found matching '.git*' 17:12:56 INFO - Installing collected packages: jsonschema, functools32 17:12:56 INFO - Running setup.py install for functools32 17:12:57 INFO - warning: no files found matching '*.txt' 17:12:57 INFO - no previously-included directories found matching 'build' 17:12:57 INFO - no previously-included directories found matching 'dist' 17:12:57 INFO - no previously-included directories found matching '.git*' 17:12:57 INFO - Successfully installed jsonschema functools32 17:12:57 INFO - Cleaning up... 17:12:57 INFO - Return code: 0 17:12:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:12:57 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')]} 17:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:57 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')]} 17:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:57 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 0x12d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x156db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156b290>, '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 0x156bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156c040>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119', '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 17:12:57 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 17:12:57 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 17:12:57 INFO - Using env: {'DISPLAY': ':0', 17:12:57 INFO - 'HOME': '/home/cltbld', 17:12:57 INFO - 'LANG': 'en_US.UTF-8', 17:12:57 INFO - 'LANGUAGE': 'en_US:en', 17:12:57 INFO - 'LOGNAME': 'cltbld', 17:12:57 INFO - 'MAIL': '/var/mail/cltbld', 17:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:57 INFO - 'MOZ_NO_REMOTE': '1', 17:12:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:57 INFO - 'NO_EM_RESTART': '1', 17:12:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:57 INFO - 'PWD': '/builds/slave/test', 17:12:57 INFO - 'SHELL': '/bin/bash', 17:12:57 INFO - 'SHLVL': '1', 17:12:57 INFO - 'TERM': 'linux', 17:12:57 INFO - 'TMOUT': '86400', 17:12:57 INFO - 'USER': 'cltbld', 17:12:57 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119', 17:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:57 INFO - '_': '/tools/buildbot/bin/python'} 17:12:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:12:57 INFO - Cleaning up... 17:12:57 INFO - Return code: 0 17:12:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:12:57 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')]} 17:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:57 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')]} 17:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:57 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 0x12d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x156db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156b290>, '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 0x156bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156c040>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119', '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 17:12:57 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 17:12:57 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 17:12:57 INFO - Using env: {'DISPLAY': ':0', 17:12:57 INFO - 'HOME': '/home/cltbld', 17:12:57 INFO - 'LANG': 'en_US.UTF-8', 17:12:57 INFO - 'LANGUAGE': 'en_US:en', 17:12:57 INFO - 'LOGNAME': 'cltbld', 17:12:57 INFO - 'MAIL': '/var/mail/cltbld', 17:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:57 INFO - 'MOZ_NO_REMOTE': '1', 17:12:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:57 INFO - 'NO_EM_RESTART': '1', 17:12:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:57 INFO - 'PWD': '/builds/slave/test', 17:12:57 INFO - 'SHELL': '/bin/bash', 17:12:57 INFO - 'SHLVL': '1', 17:12:57 INFO - 'TERM': 'linux', 17:12:57 INFO - 'TMOUT': '86400', 17:12:57 INFO - 'USER': 'cltbld', 17:12:57 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119', 17:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:57 INFO - '_': '/tools/buildbot/bin/python'} 17:12:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:57 INFO - Downloading/unpacking blobuploader==1.2.4 17:12:57 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 17:12:57 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 17:12:57 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 17:12:57 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 17:12:57 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 17:12:57 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 17:12:59 INFO - Downloading blobuploader-1.2.4.tar.gz 17:12:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:12:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:12:59 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 17:12:59 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 17:12:59 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 17:12:59 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 17:12:59 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 17:12:59 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 17:12:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:13:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:00 INFO - Downloading docopt-0.6.1.tar.gz 17:13:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:13:00 INFO - Installing collected packages: blobuploader, requests, docopt 17:13:00 INFO - Running setup.py install for blobuploader 17:13:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:13:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:13:00 INFO - Running setup.py install for requests 17:13:00 INFO - Running setup.py install for docopt 17:13:00 INFO - Successfully installed blobuploader requests docopt 17:13:00 INFO - Cleaning up... 17:13:01 INFO - Return code: 0 17:13:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:01 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 0x12d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x156db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156b290>, '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 0x156bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156c040>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119', '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 17:13:01 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 17:13:01 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 17:13:01 INFO - Using env: {'DISPLAY': ':0', 17:13:01 INFO - 'HOME': '/home/cltbld', 17:13:01 INFO - 'LANG': 'en_US.UTF-8', 17:13:01 INFO - 'LANGUAGE': 'en_US:en', 17:13:01 INFO - 'LOGNAME': 'cltbld', 17:13:01 INFO - 'MAIL': '/var/mail/cltbld', 17:13:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:01 INFO - 'MOZ_NO_REMOTE': '1', 17:13:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:01 INFO - 'NO_EM_RESTART': '1', 17:13:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:01 INFO - 'PWD': '/builds/slave/test', 17:13:01 INFO - 'SHELL': '/bin/bash', 17:13:01 INFO - 'SHLVL': '1', 17:13:01 INFO - 'TERM': 'linux', 17:13:01 INFO - 'TMOUT': '86400', 17:13:01 INFO - 'USER': 'cltbld', 17:13:01 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119', 17:13:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:01 INFO - '_': '/tools/buildbot/bin/python'} 17:13:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:13:01 INFO - Running setup.py (path:/tmp/pip-UfqG5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:13:01 INFO - Running setup.py (path:/tmp/pip-qahZEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:13:01 INFO - Running setup.py (path:/tmp/pip-aO9Xo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:13:01 INFO - Running setup.py (path:/tmp/pip-Q9CaqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:13:01 INFO - Running setup.py (path:/tmp/pip-cMJnYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:13:01 INFO - Running setup.py (path:/tmp/pip-tOxT3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:13:01 INFO - Running setup.py (path:/tmp/pip-4NsEmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:13:01 INFO - Running setup.py (path:/tmp/pip-dUtZri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:13:01 INFO - Running setup.py (path:/tmp/pip-p8v0fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:13:01 INFO - Running setup.py (path:/tmp/pip-MkZU3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:13:01 INFO - Running setup.py (path:/tmp/pip-jjOTAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:13:02 INFO - Running setup.py (path:/tmp/pip-ywHChj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:13:02 INFO - Running setup.py (path:/tmp/pip-uyq2h1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:13:02 INFO - Running setup.py (path:/tmp/pip-V7IG4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:02 INFO - Running setup.py (path:/tmp/pip-o30xVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:13:02 INFO - Running setup.py (path:/tmp/pip-swKHck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:13:02 INFO - Running setup.py (path:/tmp/pip-EFunJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:13:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:13:02 INFO - Running setup.py install for manifestparser 17:13:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:13:02 INFO - Running setup.py install for mozcrash 17:13:02 INFO - Running setup.py install for mozdebug 17:13:02 INFO - Running setup.py install for mozdevice 17:13:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:13:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:13:02 INFO - Running setup.py install for mozfile 17:13:02 INFO - Running setup.py install for mozhttpd 17:13:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:13:03 INFO - Running setup.py install for mozinfo 17:13:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:13:03 INFO - Running setup.py install for mozInstall 17:13:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:13:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:13:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:13:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:13:03 INFO - Running setup.py install for mozleak 17:13:03 INFO - Running setup.py install for mozlog 17:13:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:13:03 INFO - Running setup.py install for moznetwork 17:13:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:13:03 INFO - Running setup.py install for mozprocess 17:13:03 INFO - Running setup.py install for mozprofile 17:13:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:13:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:13:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:13:03 INFO - Running setup.py install for mozrunner 17:13:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:13:03 INFO - Running setup.py install for mozscreenshot 17:13:04 INFO - Running setup.py install for moztest 17:13:04 INFO - Running setup.py install for mozversion 17:13:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:13:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:13:04 INFO - Cleaning up... 17:13:04 INFO - Return code: 0 17:13:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:04 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 0x12d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x156db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156b290>, '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 0x156bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156c040>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119', '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 17:13:04 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 17:13:04 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 17:13:04 INFO - Using env: {'DISPLAY': ':0', 17:13:04 INFO - 'HOME': '/home/cltbld', 17:13:04 INFO - 'LANG': 'en_US.UTF-8', 17:13:04 INFO - 'LANGUAGE': 'en_US:en', 17:13:04 INFO - 'LOGNAME': 'cltbld', 17:13:04 INFO - 'MAIL': '/var/mail/cltbld', 17:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:04 INFO - 'MOZ_NO_REMOTE': '1', 17:13:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:04 INFO - 'NO_EM_RESTART': '1', 17:13:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:04 INFO - 'PWD': '/builds/slave/test', 17:13:04 INFO - 'SHELL': '/bin/bash', 17:13:04 INFO - 'SHLVL': '1', 17:13:04 INFO - 'TERM': 'linux', 17:13:04 INFO - 'TMOUT': '86400', 17:13:04 INFO - 'USER': 'cltbld', 17:13:04 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119', 17:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:04 INFO - '_': '/tools/buildbot/bin/python'} 17:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:13:04 INFO - Running setup.py (path:/tmp/pip-Na6Wmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:13:04 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)) 17:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:13:04 INFO - Running setup.py (path:/tmp/pip-7AZy4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:13:04 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)) 17:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:13:04 INFO - Running setup.py (path:/tmp/pip-iOCkzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:13:04 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)) 17:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:13:04 INFO - Running setup.py (path:/tmp/pip-IKsUAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:13:04 INFO - Running setup.py (path:/tmp/pip-XZILD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:13:04 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)) 17:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:13:04 INFO - Running setup.py (path:/tmp/pip-afAsF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:13:04 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)) 17:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:13:04 INFO - Running setup.py (path:/tmp/pip-Uhguu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:13:05 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)) 17:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:13:05 INFO - Running setup.py (path:/tmp/pip-zOpEWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:13:05 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)) 17:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:13:05 INFO - Running setup.py (path:/tmp/pip-9pmwQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:13:05 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)) 17:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:13:05 INFO - Running setup.py (path:/tmp/pip-6X7lQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:13:05 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)) 17:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:13:05 INFO - Running setup.py (path:/tmp/pip-Y0eEW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:13:05 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)) 17:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:13:05 INFO - Running setup.py (path:/tmp/pip-wZK93T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:13:05 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)) 17:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:13:05 INFO - Running setup.py (path:/tmp/pip-PALjoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:13:05 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)) 17:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:13:05 INFO - Running setup.py (path:/tmp/pip-gcqA0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:13:05 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)) 17:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:05 INFO - Running setup.py (path:/tmp/pip-vJXJdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:05 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)) 17:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:13:05 INFO - Running setup.py (path:/tmp/pip-ZoR4KC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:13:05 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)) 17:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:13:05 INFO - Running setup.py (path:/tmp/pip-RKIYDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:13:05 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)) 17:13:05 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)) 17:13:05 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)) 17:13:05 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)) 17:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:13:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:13:05 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 17:13:05 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 17:13:05 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 17:13:05 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 17:13:05 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 17:13:05 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 17:13:07 INFO - Downloading blessings-1.6.tar.gz 17:13:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:13:07 INFO - Installing collected packages: blessings 17:13:07 INFO - Running setup.py install for blessings 17:13:07 INFO - Successfully installed blessings 17:13:07 INFO - Cleaning up... 17:13:08 INFO - Return code: 0 17:13:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:13:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:13:08 INFO - Reading from file tmpfile_stdout 17:13:08 INFO - Current package versions: 17:13:08 INFO - argparse == 1.2.1 17:13:08 INFO - blessings == 1.6 17:13:08 INFO - blobuploader == 1.2.4 17:13:08 INFO - docopt == 0.6.1 17:13:08 INFO - functools32 == 3.2.3-2 17:13:08 INFO - jsonschema == 2.5.1 17:13:08 INFO - manifestparser == 1.1 17:13:08 INFO - mozInstall == 1.12 17:13:08 INFO - mozcrash == 1.0 17:13:08 INFO - mozdebug == 0.1 17:13:08 INFO - mozdevice == 0.49 17:13:08 INFO - mozfile == 1.2 17:13:08 INFO - mozhttpd == 0.7 17:13:08 INFO - mozinfo == 0.9 17:13:08 INFO - mozleak == 0.1 17:13:08 INFO - mozlog == 3.4 17:13:08 INFO - moznetwork == 0.27 17:13:08 INFO - mozprocess == 0.25 17:13:08 INFO - mozprofile == 0.28 17:13:08 INFO - mozrunner == 6.13 17:13:08 INFO - mozscreenshot == 0.1 17:13:08 INFO - mozsystemmonitor == 0.3 17:13:08 INFO - moztest == 0.8 17:13:08 INFO - mozversion == 1.4 17:13:08 INFO - psutil == 3.1.1 17:13:08 INFO - requests == 1.2.3 17:13:08 INFO - wsgiref == 0.1.2 17:13:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:08 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 0x12d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x156db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156b290>, '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 0x156bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156c040>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119', '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 17:13:08 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 17:13:08 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 17:13:08 INFO - Using env: {'DISPLAY': ':0', 17:13:08 INFO - 'HOME': '/home/cltbld', 17:13:08 INFO - 'LANG': 'en_US.UTF-8', 17:13:08 INFO - 'LANGUAGE': 'en_US:en', 17:13:08 INFO - 'LOGNAME': 'cltbld', 17:13:08 INFO - 'MAIL': '/var/mail/cltbld', 17:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:08 INFO - 'MOZ_NO_REMOTE': '1', 17:13:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:08 INFO - 'NO_EM_RESTART': '1', 17:13:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:08 INFO - 'PWD': '/builds/slave/test', 17:13:08 INFO - 'SHELL': '/bin/bash', 17:13:08 INFO - 'SHLVL': '1', 17:13:08 INFO - 'TERM': 'linux', 17:13:08 INFO - 'TMOUT': '86400', 17:13:08 INFO - 'USER': 'cltbld', 17:13:08 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119', 17:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:08 INFO - '_': '/tools/buildbot/bin/python'} 17:13:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:08 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)) 17:13:08 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)) 17:13:08 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)) 17:13:08 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)) 17:13:08 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)) 17:13:08 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)) 17:13:08 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)) 17:13:08 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)) 17:13:08 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)) 17:13:08 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)) 17:13:08 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)) 17:13:08 INFO - Cleaning up... 17:13:08 INFO - Return code: 0 17:13:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:08 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 0x12d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x156db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156b290>, '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 0x156bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156c040>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119', '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 17:13:08 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 17:13:08 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 17:13:08 INFO - Using env: {'DISPLAY': ':0', 17:13:08 INFO - 'HOME': '/home/cltbld', 17:13:08 INFO - 'LANG': 'en_US.UTF-8', 17:13:08 INFO - 'LANGUAGE': 'en_US:en', 17:13:08 INFO - 'LOGNAME': 'cltbld', 17:13:08 INFO - 'MAIL': '/var/mail/cltbld', 17:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:08 INFO - 'MOZ_NO_REMOTE': '1', 17:13:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:08 INFO - 'NO_EM_RESTART': '1', 17:13:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:08 INFO - 'PWD': '/builds/slave/test', 17:13:08 INFO - 'SHELL': '/bin/bash', 17:13:08 INFO - 'SHLVL': '1', 17:13:08 INFO - 'TERM': 'linux', 17:13:08 INFO - 'TMOUT': '86400', 17:13:08 INFO - 'USER': 'cltbld', 17:13:08 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119', 17:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:08 INFO - '_': '/tools/buildbot/bin/python'} 17:13:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:13:08 INFO - Cleaning up... 17:13:08 INFO - Return code: 0 17:13:08 INFO - Running post-action listener: _resource_record_post_action 17:13:08 INFO - Running post-action listener: _start_resource_monitoring 17:13:08 INFO - Starting resource monitoring. 17:13:08 INFO - [mozharness: 2017-03-15 00:13:08.738646Z] Finished create-virtualenv step (success) 17:13:08 INFO - [mozharness: 2017-03-15 00:13:08.739177Z] Running install step. 17:13:08 INFO - Running pre-action listener: _resource_record_pre_action 17:13:08 INFO - Running main action method: install 17:13:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:13:08 INFO - Reading from file tmpfile_stdout 17:13:08 INFO - Detecting whether we're running mozinstall >=1.0... 17:13:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:13:09 INFO - Reading from file tmpfile_stdout 17:13:09 INFO - Output received: 17:13:09 INFO - Usage: mozinstall [options] installer 17:13:09 INFO - Options: 17:13:09 INFO - -h, --help show this help message and exit 17:13:09 INFO - -d DEST, --destination=DEST 17:13:09 INFO - Directory to install application into. [default: 17:13:09 INFO - "/builds/slave/test"] 17:13:09 INFO - --app=APP Application being installed. [default: firefox] 17:13:09 INFO - mkdir: /builds/slave/test/build/application 17:13:09 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'] 17:13:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:13:24 INFO - Reading from file tmpfile_stdout 17:13:24 INFO - Output received: 17:13:24 INFO - /builds/slave/test/build/application/firefox/firefox 17:13:24 INFO - Running post-action listener: _resource_record_post_action 17:13:24 INFO - [mozharness: 2017-03-15 00:13:24.424961Z] Finished install step (success) 17:13:24 INFO - [mozharness: 2017-03-15 00:13:24.425105Z] Running run-tests step. 17:13:24 INFO - Running pre-action listener: _resource_record_pre_action 17:13:24 INFO - Running main action method: run_tests 17:13:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:13:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:13:24 INFO - Python 2.7.3 17:13:24 INFO - Return code: 0 17:13:24 INFO - grabbing minidump binary from tooltool 17:13: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')]} 17:13:24 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 0x156b290>, '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 0x156bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156c040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:13:24 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 17:13:24 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 17:13:24 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 17:13:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:13:24 INFO - Return code: 0 17:13:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:13:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:13:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:13:24 INFO - ENV: RUST_BACKTRACE is now 1 17:13:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:13:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:13:24 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/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 17:13:24 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/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 17:13:24 INFO - Using env: {'DISPLAY': ':0', 17:13:24 INFO - 'HOME': '/home/cltbld', 17:13:24 INFO - 'LANG': 'en_US.UTF-8', 17:13:24 INFO - 'LANGUAGE': 'en_US:en', 17:13:24 INFO - 'LOGNAME': 'cltbld', 17:13:24 INFO - 'MAIL': '/var/mail/cltbld', 17:13:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:13:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:13:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:24 INFO - 'MOZ_NO_REMOTE': '1', 17:13:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:13:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:24 INFO - 'NO_EM_RESTART': '1', 17:13:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:24 INFO - 'PWD': '/builds/slave/test', 17:13:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:13:24 INFO - 'RUST_BACKTRACE': '1', 17:13:24 INFO - 'SHELL': '/bin/bash', 17:13:24 INFO - 'SHLVL': '1', 17:13:24 INFO - 'TERM': 'linux', 17:13:24 INFO - 'TMOUT': '86400', 17:13:24 INFO - 'USER': 'cltbld', 17:13:24 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119', 17:13:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:24 INFO - '_': '/tools/buildbot/bin/python'} 17:13:24 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/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 17:13:24 INFO - mozversion application_buildid: 20170314234139 17:13:24 INFO - mozversion application_changeset: cef93bf5a0a15ab7a2dc96d0cee90a599a4eae76 17:13:24 INFO - mozversion application_display_name: Nightly 17:13:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:13:24 INFO - mozversion application_name: Firefox 17:13:24 INFO - mozversion application_remotingname: firefox 17:13:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:13:24 INFO - mozversion application_vendor: Mozilla 17:13:24 INFO - mozversion application_version: 55.0a1 17:13:24 INFO - mozversion platform_buildid: 20170314234139 17:13:24 INFO - mozversion platform_changeset: cef93bf5a0a15ab7a2dc96d0cee90a599a4eae76 17:13:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:13:24 INFO - mozversion platform_version: 55.0a1 17:13:24 INFO - using testdate: 1489536804 17:13:24 INFO - actual date: 1489536804 17:13:24 INFO - starting webserver on 'localhost:54953' 17:13:24 INFO - SUITE-START | Running 2 tests 17:13:24 INFO - TEST-START | dromaeo_css 17:13:24 INFO - operating with platform_type : linux_ 17:13:24 INFO - Initialising browser for dromaeo_css test... 17:13:24 INFO - TEST-INFO | started process 28387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZAgcTo/profile http://localhost:54953/getInfo.html) 17:13:29 INFO - PID 28387 | __metrics Screen width/height:1600/1200 17:13:29 INFO - PID 28387 | colorDepth:24 17:13:29 INFO - PID 28387 | Browser inner width/height: 1024/697 17:13:29 INFO - PID 28387 | __metrics 17:13:30 ERROR - PID 28387 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 17:13:30 INFO - TEST-INFO | 28387: exit 0 17:13:30 INFO - Browser initialized. 17:13:30 INFO - Running cycle 1/1 for dromaeo_css test... 17:13:30 INFO - TEST-INFO | started process 28519 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZAgcTo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:13:43 INFO - PID 28519 | RSS: Main: 158539776 17:13:43 INFO - PID 28519 | 17:16:47 INFO - PID 28519 | Cycle 1(1): loaded http://localhost:54953/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54953/tests/dromaeo/cssquery-ext.html) 17:16:48 INFO - PID 28519 | RSS: Main: 167448576 17:16:48 INFO - PID 28519 | 17:18:31 INFO - PID 28519 | ************************* 17:18:31 INFO - PID 28519 | A coding exception was thrown and uncaught in a Task. 17:18:31 INFO - PID 28519 | 17:18:31 ERROR - PID 28519 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:18:31 INFO - PID 28519 | Full stack: 17:18:31 INFO - PID 28519 | ************************* 17:19:51 INFO - PID 28519 | Cycle 1(1): loaded http://localhost:54953/tests/dromaeo/cssquery-ext.html (next: http://localhost:54953/tests/dromaeo/cssquery-jquery.html) 17:19:51 INFO - PID 28519 | RSS: Main: 160391168 17:19:51 INFO - PID 28519 | 17:22:53 INFO - PID 28519 | Cycle 1(1): loaded http://localhost:54953/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54953/tests/dromaeo/cssquery-mootools.html) 17:22:54 INFO - PID 28519 | RSS: Main: 169168896 17:22:54 INFO - PID 28519 | 17:25:56 INFO - PID 28519 | Cycle 1(1): loaded http://localhost:54953/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54953/tests/dromaeo/cssquery-prototype.html) 17:25:57 INFO - PID 28519 | RSS: Main: 160960512 17:25:57 INFO - PID 28519 | 17:29:00 INFO - PID 28519 | Cycle 1(1): loaded http://localhost:54953/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54953/tests/dromaeo/cssquery-yui.html) 17:29:00 INFO - PID 28519 | RSS: Main: 168206336 17:29:00 INFO - PID 28519 | 17:32:03 INFO - PID 28519 | Cycle 1(1): loaded http://localhost:54953/tests/dromaeo/cssquery-yui.html (next: http://localhost:54953/tests/dromaeo/cssquery-dojo.html) 17:32:03 INFO - PID 28519 | RSS: Main: 163082240 17:32:03 INFO - PID 28519 | 17:32:03 INFO - PID 28519 | __start_tp_report 17:32:03 INFO - PID 28519 | _x_x_mozilla_page_load 17:32:03 INFO - PID 28519 | _x_x_mozilla_page_load_details 17:32:03 INFO - PID 28519 | |i|pagename|runs| 17:32:03 INFO - PID 28519 | |0;dojo.html;2654.681438227413;2662.5739881618947;2677.2102229842194;2688.3413563676904;2698.7840972722183;4895.388076490439;4957.529034741703;4990.101781679296;5003.3245511855885;5029.39647242331;4964.32981547491;5006.324146240257;5009.2486127080865;5036.017976494585;5079.974600126994;4592.173408786425;4604.838830640928;4614.861554153364;4627.467841198255;4673.626109911199;4655.324977878223;4663.510331415204;4688.531146885318;4695.107929493385;4747.572718455338;4594.74728889911;4601.815927362902;4618.976905115486;4621.214393553104;4634.189016922025;4581.862544123648;4593.196190666654;4598.8069086238775;4624.930626040612;4641.791119399635;4526.502084770673;4552.044070745147;4568.451785785727;4569.588737013652;4618.838340658094;4873.610111191097;4897.1674815281485;4911.607071434277;4918.8770280743265;4922.876928076791;5288.973555132238;5302.257683924254;5341.599380046512;5354.973225133849;5364.731763411853;5305.73471326436;5367.114426119686;5373.811916582901;5374.543163831079;5375.301210842605;4894.877628059256;4958.851234462972;4970.453250142481;4984.451710311862;4999.275105109775;5420.457954204548;5421.376541697677;5442.700651464207;5457.754401051962;5483.040467918098;5140.948590514122;5190.844274671766;5266.368035835648;5307;5328.520433161034;5132.5893928486375;5280.419153893069;5295.152775555893;5311.097113490639;5353.330833645794;5236.502532259429;5275.235090911796;5297.655652382583;5305.36335639718;5325.520703136659;5259.263703081571;5271.919256552397;5294.41761406245;5311.2033195020285;5325.653832500875;4537.795799189044;4539.228331183641;4544.386507821402;4562.315652652062;4603.838865639686;3899.629535194152;3904.2972264992572;3916.784576848244;3963.603639636013;3970.086880017612;4555.9772201138785;4605.309203619484;4605.907881842411;4630.28230624247;4643.628509719214;5332.093544097513;5341.172118321666;5341.572674186055;5365.382980957162;5367.35591728995;4596.678232523758;4598.402207712976;4601.056783359403;4613.423322084739;4654.604358629486;4688.2733176357715;4724.220503616864;4794.976025119852;4802.855914322506;4850.466448690641;5050.974745126251;5059.848204553869;5066.189409694579;5078.365204349457;5117.4114976776655;5377.2740680009265;5384.380796208329;5384.6499977501335;5389.703566303734;5397.865053373697;4900.436449808318;4900.975495122501;4988.975055124701;5027.824026159067;5042.747862606929;5274.235235890851;5282.841514754564;5301.204819277139;5302.522772950453;5313.442088580798;5385.784568617211;5386.622936394415;5394.568434525307;5398.001369746609;5448.346198456052;5120.411152717336;5162.6386152968935;5194.091034068947;5223.112070947872;5253;5043.092243396224;5165.431802501646;5212.035773381936;5224.843254702365;5248.475152484721;5049.545540901337;5143.71709555978;5153.3558305211845;5186.688798672092;5188.299579556711;5193.039287731782;5231.895362092813;5239;5245.685258884327;5256.474352564713;5087.694738315713;5090.872728181677;5093.923591146062;5100.6429549931145;5127.41034781005 17:32:03 INFO - PID 28519 | |1;ext.html;628.1049504456151;673.4208580620667;693.3898169610742;828.7638023163393;833.7582101190651;33104.17239569012;33885.661143388556;33937.83031084844;33999;34028.829855850745;30330.54504182439;30596;30627.846860765665;30706;30765.538516922206;6128.172696685935;6247.9062814057825;8993.775155621097;9169.128932751411;9184.265258779282;8953.194212520872;9026.774330641754;9070.637174513045;9111.908880911205;9125.13311235435;9090.13643703847;9115.49864757438;9135.31485138614;9147.405418647766;9203.17171454569;9105.271578273721;9116.088391160898;9142.542872856397;9157.862632060524;9353.064693530661;9244.121808428188;9256.90743092574;9314.906850931471;9323.953380233123;9349;34525;35125.47311790325;35157.29685406278;35169;35223.471647925304;3385.9492107618407;3448.793072415663;3473.5484387029524;3476.683395547502;3506.08841701157;22800.201992930168;22861.885690571606;22873.31380058601;23462.296131115923;24350;3201.183698156978;3210.486322188462;3289.9862168154814;3304.9173770655684;3435.2442462658423;146724;147305;147484;148178;149463;42175.156496870506;42268.788656056524;42447;42483.36274955878;42542.78728606337;44256;44372;44502.77748611236;44517;44596.3310550342;11709.473073711704;11731;11796.646100616996;11835.171537992257;11849;9166.679166229284;9194.678186263449;9198.402103863227;9205.63177472907;9213.631454741735;12441.875581244072;13376.929845612327;13397.464101436028;13450;13578.660533486742;5416;5496.780128794803;5499.890002200013;5563.610547261653;5569.55443564522;832.134580036767;873.3275377958936;885.1840825642578;893.8558644934494;897.8832751742232;25371.492570148494;25612.231633051037;25650.615240771403;25863.61204581933;25939.48121037569;940.4639355567398;944.6268723854039;959.165525992391;973.532704301939;987.5062468765617;12959.898408635183;13070.738585228242;13460.125091868997;13782.174654195866;13868.861311386758;238489;239569;240798;241075;241205;40345;45283.77358113254;45591;45615.31577026347;45764.313535297;1204.873488283735;1225.7425940552585;1242.6085782978332;1245.6138597034767;1246.2647038247478;23867;24387.634185486877;27328.726712733413;27381.58927616127;27398;38660.80669596634;39017.049147543075;39111;39136.217275653755;39184.60815391924;236877;236951;237261;237580;237752;30227.697723023368;30487.237819054702;30577.54133687952;30759.384812303182;30971.225719356295;37834.24331513299;37915;38489.23021539498;38682.6131738679;38682.613173869024;31098.53352199764;31770;32050;32200;33084.33831323408;31631.52552711757;31676.841615791775;31798.682013179572;31856.362872741953;32384;31406.842965785025;31663.36673266568;31884.362312754078;32384.35231295408;32434;25543.87228063848;27340.453190935674;28750.856245718638;29009.56485652759;29100.708992910648;22456;22692.432689182904;22826.42933926665;22939.54120917539;23049.193278235853 17:32:03 INFO - PID 28519 | |2;jquery.html;386.455098311381;387.11157892636413;393.2233838169615;405.8112977465479;415.86068666996556;13226.404811783468;17401.216945237462;17902.91048544757;18601.25594976201;18606.34877779278;17246;17505.21226544805;17701.29194832205;17954.730679039792;18085.1861666225;4867.53758392953;5614.550835933115;5643.8589035274035;6527.902081468782;6820.488463365243;6753.15585551806;6789.3889549940495;6794.830129246759;6799.150106236721;6804.48966327525;6644.60132392058;6880.2775708550635;6899.37905588497;6925.549839260457;6931.480138989596;6654.866902661968;6814.863702725943;6842.315768423143;6885.242623311432;6926.099607051102;6764.797056088325;6770.255271920085;6775.356341147583;6776;6783.6269005204695;21683.783162168333;22418.439539011655;22865.77134228653;22918.770812291998;23189.072437102495;2128.212561352294;2161.1139432832465;2200.0759680934048;2254.458929856839;2289.8740569268684;14028.228447435387;14081.64795880101;14126.85873141276;14249.78625320621;15109.697806043927;1818.6817306971227;1899.9082459009849;1918.2231196365494;1918.6354592627356;1923.6248931458372;85286.5735671324;87835;87884;88430.55784721099;90122.54938725264;15025.323860426308;15697.215139242991;16065.598360040858;16118.516444506684;16716.16419179036;26211.606825897627;28970;29027.564586531218;29131.126066218047;29217.707822921922;7528.473006889465;7592.696292148252;7616.657250423744;7688.807779805437;7821.648025838851;5877.471027607536;5962.433568810956;6086.695665216722;6122.173506576644;6152.969235153795;8633;8703.606508210167;9195;9237.815243695222;9332.580033898355;3600.7839529628304;3766.3597188478025;3767.660910518012;3773.660370566662;3791.156632525606;907.5541415884129;940.741296143566;969.5685419988038;983.4738414948112;999.2206079258191;17489.475315740547;18592.44222673322;18655.90672046631;18766.81233187678;19113.90443047776;932.9224745419052;939.9859002114973;942.1144124522926;948.7248697877538;963.6675347005412;9973.501324933724;10913.290636108628;12224.449899754354;12411.317377544321;12470.189437686522;485619;495064;496042;500837;500977;90711;90950;91373.54313228391;91574;91701.54149229344;1172.1326218598347;1176.7352345722145;1215.617080619602;1224.1308670843623;1231.735176936963;17124.657506850042;17443.01288404361;18135.093245337943;18136.45590632283;18261.634767304844;41778.79110604428;42933;43127.35308970305;43548.129037419705;43562.782186088865;55162.72418637881;55193.44806551883;56909;56977;57400.71299643642;7980.680772769024;10283.845742313722;10654.680359589225;10763.677089687322;11250.212485125963;12587.118901676795;12747.681307967376;12781.552645657357;12803.167794093353;12871.806922895978;10786.244962852525;10831;10916.290441121302;11004.39475828837;11250.549978000789;10724.785504290026;10789.406582637715;10921.344719316867;11122.165837562377;11357.886421135683;10673.776537426616;10887.673369798918;10905.945470272598;10930.403369658012;11526.193166478266;10525.210609204187;10615.513828064231;10705.518251678848;10719.410432426292;10979.945100274448;11211.831822522505;11214.88785112171;11238.438078096226;11383.365447646967;11518.596849110241 17:32:03 INFO - PID 28519 | |3;mootools.html;1456.359201951142;1459.8394176640568;1481.3630139040215;1491.1873029199085;1558.5168597734703;8485.363597730164;8737.868931966026;9130.680426185085;9491.857622135674;9516.85724714129;8982.281417486602;9273.443593384385;9279.53602319883;9290.72127836166;9310.394824336414;2056.7840376760487;2110.5145816462223;2112.112912576714;2114.048678094856;2114.8942552872295;2075.6471399861985;2097.9055942482623;2119.395972147938;2120.332095389955;2120.9893950530227;2030.93907182784;2038.062491254025;2045.8772473651554;2050.764162121353;2057.084597354178;1969.862109652325;1971.5607606447302;1976.6145601607693;1979.0797279265066;1982.7224188613607;1976.3675623800389;1989.6617575012137;2037.8064083912004;2039.418765651797;2049.9692504612444;9558.378705384128;9622.422654640673;9641.758956026086;9644.03559644037;9644.373115747525;4673.672842900998;4860.927086093711;4861.951380486221;4869.342638743759;4880.902381952376;2462.372095115752;2632.197179860142;2650.840949543014;2664.8667566621593;2734.09774774324;859.1666083898608;878.6002368922188;895.8163576466809;899.6761165980242;930.1210356213381;13864.792028119586;13905.79141312881;13960.232187229698;14035.50875719345;14060.226687532182;4118.135191609736;4172.72877262983;4218.1985422770185;4260.531341552427;4282.550332215135;11643.476043578059;11736.941315293368;11767.88232117668;11778.587749428729;11779.411029448493;4959.479254678206;4985.576226020757;4986.850394488171;4993.500649934977;4996.175631020841;3772.5472943246987;4127.380892866034;4376;4477.686561940633;4482.170798402306;3518.8592456301462;3582.462630605378;3634.127809325743;3675.448682697563;3685;968.5883499512679;980.5097451274363;982.832918403873;983.1201075037801;994.7115336552464;776.1152286393516;781.1290411191594;787.22851605427;788.9368850491946;789.7078081109911;5439.184122381675;5471.452854714496;5493.093639549509;5552.000639884859;5630.71846407678;895.9731208063769;897.8653202019749;901.0718959471754;901.2114399900088;921.5254144115786;3608.2061946371755;3630.6006339302658;3630.636936306348;3657.634236576321;3790.962090379061;11766.705832354088;11970.58102966392;12011.099167562468;12075.215111017756;12148.392580370946;12134.878651213552;12157.270563766202;12179.147459677915;12183.086268529896;12191;8121.269085782308;8417.242448179693;8474.830503389898;8490.386826502945;8512.659493620185;5460.15367618004;5475.863103422287;5544.362398324244;5625.46558076982;5691.430856914276;9893.950530247303;9918.05778451046;9941.801163976535;9995.500224988868;10110.140638045848;10135.64525241613;10255.435951022468;10278.074973252444;10468.842967355344;10490.94754526253;6915.446764258948;7993.72021979228;8116.634751436081;8134.430589858653;8208.917910821054;8961.059088795582;8991.910080899108;9076.774635424134;9109.362344635812;9335.766605834908;7702.229777022253;7856.096548896721;7923.643436045277;7998.920010799818;8112.59437028158;7701.576413297323;7773.727919522789;7838.960805195938;7937;8215.219554142346;6488.967555162194;6501.1548498694865;6503.447206987459;6569.113169722026;6601.570897891622;4734.881627959328;4826.889815342421;4866.586340161126;4876.830060460729;4957.776900039435;4964.578010869117;4974.452810190948;4976.527229913152;5046.268291097844;5058.2918391425965 17:32:03 INFO - PID 28519 | |4;prototype.html;364.30236097872574;366.78726338723527;372.9906752331193;376.9849206031758;383.06914198497657;5023.472535383787;5234.895302093956;5242.55438287746;5322.441143679911;5324.5740340772745;5071.340725705653;5179.611529135311;5205.973970130144;5240.44975277596;5246.842594722155;4536.183486972343;4548.863534093983;4550.886227844314;4552.658550608701;4562.156001139783;4174.958250417502;4347.5652434756585;4550.2264615015365;4551.362809206714;4559.430071241095;4330.935035974463;4333.631641310492;4345.413369195166;4351.564843515639;4371.213181627306;4345.826166953318;4347.108842687241;4351.564843515639;4360.542143074963;4373.125374924996;3960.0693836948294;4043.2722110020186;4052.5136983561865;4055.6349928506575;4058.492688413948;5069.0115427491655;5070.898582028339;5077.065274412323;5079.949200507985;5093.1087059764395;5034;5039.3448851649055;5047.596192304607;5051.595872330205;5064.848054558369;5399.163129714901;5488.9725551372385;5535.114381698949;5545.140503222007;5551.833444996657;4399.2622913949135;4443.311796363186;4450.198964186445;4452.732836029849;4470.575295346969;5509.421510741395;5672.149177623348;5711.600187986843;5784.88430231393;5842.123681447774;4566.566176213254;4568.70303430276;4578.336141259565;4589.059242855206;4593.586577208001;4648.581627653527;4663.230566956414;4668.4631267404;4669.968563674813;4671.267308624425;4831.903361932742;5007.599392048627;5027.547520723152;5030.522100400456;5048.72232027242;5526.226328314039;5526.972365138148;5542.334919809648;5545.390007099216;5583.832485025456;1613.5240104169297;1634.1012443156217;1638.5412084616326;1642.4169419856019;1647.744599587066;1205.2286536616573;1220.2434490615874;1224.1859163656247;1232.8828761267666;1233.864274929757;4846.248831431063;4858.58702010333;4859.902801943941;4863.10032643962;4886.462489126193;5722.971385143048;5733.3406658234;5737.3975732548315;5756.25168728071;5762.596618236683;4689.132510485571;4824.614030877591;4848.490908454632;4854.514548545188;4863.10032643962;3025.3949210158057;3026.500627396455;3042.2242328206166;3048.481758101084;3063.8927637533025;5247.239150323182;5345.278387417727;5346.4118946915805;5361.35663720356;5368.8389348319615;5783.595148339576;5813.6221145625395;5834.387389324144;5856.736446859902;5883.764649414061;5332.813351532678;5358.196270559525;5365.302510673588;5366.275552800322;5379.085555455504;5534.280543529316;5694.1458781183155;5710.2862142232225;5716.228309178374;5720.170575266647;5373.543248823894;5631.873625275043;5637.633553818989;5650.29371328584;5662.2639056922335;5229.50319719626;5237.685738855681;5308.6283960123965;5364;5367.584586935973;4545.749983750926;4546.795394207203;4562.425963042745;4567.223571992836;4591.127685739699;5497.697626630574;5712.5429965601825;5739.8565035874435;5741.62679425836;5746.798862039808;5558.138488534284;5572.888542229051;5578.135389014709;5587.497125258747;5591.720413979366;5553.916691249554;5558.805441809517;5567.216391804098;5576.721163941867;5576.86057848557;5187.351581052369;5397.865053373697;5462;5463.972680136733;5470.234167216672;5528.143137813645;5540.224368588481;5574;5575.386707462257;5576.804811831566;5200.895982080261;5368.919466208088;5399.2980912481125;5416.647917885325;5425.593080518898 17:32:03 INFO - PID 28519 | |5;yui.html;628.9465395441388;641.7433026789281;673.7978606418073;686.4028295383015;693.7363801755332;13017.739645207103;13216.669583260424;13623.318834058295;13643.863561364384;13659.931700341484;13211.735765284688;13274.070815042951;13280.535181268657;13428.194308341506;13970.580882573538;824.1428913929522;839.1776059461731;843.3674743942044;850.3664769746548;864.3042350907517;877.0221203358274;877.4910551879894;877.5568337989338;879.9604017819214;880.7181701855409;910.0808183734409;914.1315750037458;918.4626993208948;918.8024574716435;919.3610440743686;901.8827552418177;908.5548081440113;910.4309806371018;911.7401540560975;912.0059135542258;665.3280187011105;667.1393901866586;667.9699413526355;672.2504407585556;673.8349104469387;13711.45154193831;14172.645683857883;14403.639909002253;14627.049241799248;14632.634184145376;13711.588652340446;14605.6348591285;14622.853771462256;14631.853681463263;14709.852901470955;10387;10529.631462898838;10550.419726915017;10699.03708666216;10713.303635263761;3070.3245286037036;3162.984185079083;3177.507486339621;3199.152224660467;3296.8846090386724;49222.50777492215;51249;51503.484965150245;51629.22556161661;52145.2178217327;10365.585376585002;10769.138468922623;10873.619423320304;10999.835002474969;11071.05895998833;19952.10215540304;20000.399988000383;20007.699884501744;20031.899840500704;20084.397468075982;6830.316968303229;6926.411255043277;7134.857302853914;7216.96391518039;7227.241139680363;3503.4394496880377;3518.8592456301462;3536.487209354629;3568.589612194579;3632.3461776880417;2724.155511791351;2736.165469531812;2772.7781777457753;2773.9583906241423;2786.637737094165;475.77876287525777;486.96347773917097;487.48813745567014;493.28473713116125;496.1466278001831;638.1831255992337;651.90547370631;652.9804105876831;659.9505037122235;660.2934859700171;8766.912330876738;9054.954725226331;9202.171804537624;9311.208547273558;9455.007224241494;579.39163877928;595.6336852835475;611.8776244751068;613.0926229180749;626.132806063596;4135.656713592605;4141.130362623882;4198.706090573631;4250.277452833026;4389.978050109793;63434.68282658557;63747.88430717661;64007.67996160083;66542.66728666326;66546.66726666335;47072;51009.23486147711;54950.794927558105;54977;55350;50667.23999140016;51297;51713.741431292605;52428.73785631047;52453.47546524486;7933.8413231736195;8280.337572994267;8306.626201821053;8367.539785311623;8412.914735981463;35853;36153;36388.81805590955;36441.453378199876;36487.635123648426;41027;41489;42063;43029;43042.56957430511;10351.585936562453;10424.843627345444;10542.8418573723;10544.630937917444;10688;10744.355338679705;10879.836802448128;10950.452477376259;11060.557577696802;11079.667609971713;10387;10409.323393979366;10418.583256669952;10667.519961601902;10676.62631807883;10347;10607.469626518488;11086.279391839505;11326.490307935997;11368.829467557827;10342.896571034193;10373.481325933824;10454.42500662471;10525.9473702631;10900;8257.628406721591;8316.542590157358;8457.703980360659;8491.320694344562;8667.95666021691;8208.183194814439;10157.441340726331;10744.4090575016;10777.344645723471;10802 17:32:03 INFO - PID 28519 | __end_tp_report 17:32:03 INFO - PID 28519 | __start_cc_report 17:32:03 INFO - PID 28519 | _x_x_mozilla_cycle_collect,392 17:32:03 INFO - PID 28519 | __end_cc_report 17:32:03 INFO - PID 28519 | __startTimestamp1489537923968__endTimestamp 17:32:03 INFO - PID 28519 | 17:32:03 INFO - PID 28519 | ------- Summary: start ------- 17:32:03 INFO - PID 28519 | Number of tests: 6 17:32:03 INFO - PID 28519 | 17:32:03 INFO - PID 28519 | [#0] dojo.html Cycles:165 Average:4929.85 Median:5059.85 stddev:527.84 (10.4%) stddev-sans-first:498.37 17:32:03 INFO - PID 28519 | Values: 2654.7 2662.6 2677.2 2688.3 2698.8 4895.4 4957.5 4990.1 5003.3 5029.4 4964.3 5006.3 5009.2 5036.0 5080.0 4592.2 4604.8 4614.9 4627.5 4673.6 4655.3 4663.5 4688.5 4695.1 4747.6 4594.7 4601.8 4619.0 4621.2 4634.2 4581.9 4593.2 4598.8 4624.9 4641.8 4526.5 4552.0 4568.5 4569.6 4618.8 4873.6 4897.2 4911.6 4918.9 4922.9 5289.0 5302.3 5341.6 5355.0 5364.7 5305.7 5367.1 5373.8 5374.5 5375.3 4894.9 4958.9 4970.5 4984.5 4999.3 5420.5 5421.4 5442.7 5457.8 5483.0 5140.9 5190.8 5266.4 5307.0 5328.5 5132.6 5280.4 5295.2 5311.1 5353.3 5236.5 5275.2 5297.7 5305.4 5325.5 5259.3 5271.9 5294.4 5311.2 5325.7 4537.8 4539.2 4544.4 4562.3 4603.8 3899.6 3904.3 3916.8 3963.6 3970.1 4556.0 4605.3 4605.9 4630.3 4643.6 5332.1 5341.2 5341.6 5365.4 5367.4 4596.7 4598.4 4601.1 4613.4 4654.6 4688.3 4724.2 4795.0 4802.9 4850.5 5051.0 5059.8 5066.2 5078.4 5117.4 5377.3 5384.4 5384.6 5389.7 5397.9 4900.4 4901.0 4989.0 5027.8 5042.7 5274.2 5282.8 5301.2 5302.5 5313.4 5385.8 5386.6 5394.6 5398.0 5448.3 5120.4 5162.6 5194.1 5223.1 5253.0 5043.1 5165.4 5212.0 5224.8 5248.5 5049.5 5143.7 5153.4 5186.7 5188.3 5193.0 5231.9 5239.0 5245.7 5256.5 5087.7 5090.9 5093.9 5100.6 5127.4 17:32:03 INFO - PID 28519 | 17:32:03 INFO - PID 28519 | [#1] ext.html Cycles:180 Average:35945.62 Median:18635.81 stddev:55339.31 (297.0%) stddev-sans-first:55431.01 17:32:03 INFO - PID 28519 | Values: 628.1 673.4 693.4 828.8 833.8 33104.2 33885.7 33937.8 33999.0 34028.8 30330.5 30596.0 30627.8 30706.0 30765.5 6128.2 6247.9 8993.8 9169.1 9184.3 8953.2 9026.8 9070.6 9111.9 9125.1 9090.1 9115.5 9135.3 9147.4 9203.2 9105.3 9116.1 9142.5 9157.9 9353.1 9244.1 9256.9 9314.9 9324.0 9349.0 34525.0 35125.5 35157.3 35169.0 35223.5 3385.9 3448.8 3473.5 3476.7 3506.1 22800.2 22861.9 22873.3 23462.3 24350.0 3201.2 3210.5 3290.0 3304.9 3435.2 146724.0 147305.0 147484.0 148178.0 149463.0 42175.2 42268.8 42447.0 42483.4 42542.8 44256.0 44372.0 44502.8 44517.0 44596.3 11709.5 11731.0 11796.6 11835.2 11849.0 9166.7 9194.7 9198.4 9205.6 9213.6 12441.9 13376.9 13397.5 13450.0 13578.7 5416.0 5496.8 5499.9 5563.6 5569.6 832.1 873.3 885.2 893.9 897.9 25371.5 25612.2 25650.6 25863.6 25939.5 940.5 944.6 959.2 973.5 987.5 12959.9 13070.7 13460.1 13782.2 13868.9 238489.0 239569.0 240798.0 241075.0 241205.0 40345.0 45283.8 45591.0 45615.3 45764.3 1204.9 1225.7 1242.6 1245.6 1246.3 23867.0 24387.6 27328.7 27381.6 27398.0 38660.8 39017.0 39111.0 39136.2 39184.6 236877.0 236951.0 237261.0 237580.0 237752.0 30227.7 30487.2 30577.5 30759.4 30971.2 37834.2 37915.0 38489.2 38682.6 38682.6 31098.5 31770.0 32050.0 32200.0 33084.3 31631.5 31676.8 31798.7 31856.4 32384.0 31406.8 31663.4 31884.4 32384.4 32434.0 25543.9 27340.5 28750.9 29009.6 29100.7 22456.0 22692.4 22826.4 22939.5 23049.2 17:32:03 INFO - PID 28519 | 17:32:03 INFO - PID 28519 | [#2] jquery.html Cycles:180 Average:30095.85 Median:29079.35 stddev:81658.91 (280.8%) stddev-sans-first:81857.52 17:32:03 INFO - PID 28519 | Values: 386.5 387.1 393.2 405.8 415.9 13226.4 17401.2 17902.9 18601.3 18606.3 17246.0 17505.2 17701.3 17954.7 18085.2 4867.5 5614.6 5643.9 6527.9 6820.5 6753.2 6789.4 6794.8 6799.2 6804.5 6644.6 6880.3 6899.4 6925.5 6931.5 6654.9 6814.9 6842.3 6885.2 6926.1 6764.8 6770.3 6775.4 6776.0 6783.6 21683.8 22418.4 22865.8 22918.8 23189.1 2128.2 2161.1 2200.1 2254.5 2289.9 14028.2 14081.6 14126.9 14249.8 15109.7 1818.7 1899.9 1918.2 1918.6 1923.6 85286.6 87835.0 87884.0 88430.6 90122.5 15025.3 15697.2 16065.6 16118.5 16716.2 26211.6 28970.0 29027.6 29131.1 29217.7 7528.5 7592.7 7616.7 7688.8 7821.6 5877.5 5962.4 6086.7 6122.2 6153.0 8633.0 8703.6 9195.0 9237.8 9332.6 3600.8 3766.4 3767.7 3773.7 3791.2 907.6 940.7 969.6 983.5 999.2 17489.5 18592.4 18655.9 18766.8 19113.9 932.9 940.0 942.1 948.7 963.7 9973.5 10913.3 12224.4 12411.3 12470.2 485619.0 495064.0 496042.0 500837.0 500977.0 90711.0 90950.0 91373.5 91574.0 91701.5 1172.1 1176.7 1215.6 1224.1 1231.7 17124.7 17443.0 18135.1 18136.5 18261.6 41778.8 42933.0 43127.4 43548.1 43562.8 55162.7 55193.4 56909.0 56977.0 57400.7 7980.7 10283.8 10654.7 10763.7 11250.2 12587.1 12747.7 12781.6 12803.2 12871.8 10786.2 10831.0 10916.3 11004.4 11250.5 10724.8 10789.4 10921.3 11122.2 11357.9 10673.8 10887.7 10905.9 10930.4 11526.2 10525.2 10615.5 10705.5 10719.4 10979.9 11211.8 11214.9 11238.4 11383.4 11518.6 17:32:03 INFO - PID 28519 | 17:32:03 INFO - PID 28519 | [#3] mootools.html Cycles:180 Average:5839.52 Median:4958.63 stddev:3740.03 (75.4%) stddev-sans-first:3736.02 17:32:03 INFO - PID 28519 | Values: 1456.4 1459.8 1481.4 1491.2 1558.5 8485.4 8737.9 9130.7 9491.9 9516.9 8982.3 9273.4 9279.5 9290.7 9310.4 2056.8 2110.5 2112.1 2114.0 2114.9 2075.6 2097.9 2119.4 2120.3 2121.0 2030.9 2038.1 2045.9 2050.8 2057.1 1969.9 1971.6 1976.6 1979.1 1982.7 1976.4 1989.7 2037.8 2039.4 2050.0 9558.4 9622.4 9641.8 9644.0 9644.4 4673.7 4860.9 4862.0 4869.3 4880.9 2462.4 2632.2 2650.8 2664.9 2734.1 859.2 878.6 895.8 899.7 930.1 13864.8 13905.8 13960.2 14035.5 14060.2 4118.1 4172.7 4218.2 4260.5 4282.6 11643.5 11736.9 11767.9 11778.6 11779.4 4959.5 4985.6 4986.9 4993.5 4996.2 3772.5 4127.4 4376.0 4477.7 4482.2 3518.9 3582.5 3634.1 3675.4 3685.0 968.6 980.5 982.8 983.1 994.7 776.1 781.1 787.2 788.9 789.7 5439.2 5471.5 5493.1 5552.0 5630.7 896.0 897.9 901.1 901.2 921.5 3608.2 3630.6 3630.6 3657.6 3791.0 11766.7 11970.6 12011.1 12075.2 12148.4 12134.9 12157.3 12179.1 12183.1 12191.0 8121.3 8417.2 8474.8 8490.4 8512.7 5460.2 5475.9 5544.4 5625.5 5691.4 9894.0 9918.1 9941.8 9995.5 10110.1 10135.6 10255.4 10278.1 10468.8 10490.9 6915.4 7993.7 8116.6 8134.4 8208.9 8961.1 8991.9 9076.8 9109.4 9335.8 7702.2 7856.1 7923.6 7998.9 8112.6 7701.6 7773.7 7839.0 7937.0 8215.2 6489.0 6501.2 6503.4 6569.1 6601.6 4734.9 4826.9 4866.6 4876.8 4957.8 4964.6 4974.5 4976.5 5046.3 5058.3 17:32:03 INFO - PID 28519 | 17:32:03 INFO - PID 28519 | [#4] prototype.html Cycles:180 Average:4727.73 Median:5086.53 stddev:1258.29 (24.7%) stddev-sans-first:1218.45 17:32:03 INFO - PID 28519 | Values: 364.3 366.8 373.0 377.0 383.1 5023.5 5234.9 5242.6 5322.4 5324.6 5071.3 5179.6 5206.0 5240.4 5246.8 4536.2 4548.9 4550.9 4552.7 4562.2 4175.0 4347.6 4550.2 4551.4 4559.4 4330.9 4333.6 4345.4 4351.6 4371.2 4345.8 4347.1 4351.6 4360.5 4373.1 3960.1 4043.3 4052.5 4055.6 4058.5 5069.0 5070.9 5077.1 5079.9 5093.1 5034.0 5039.3 5047.6 5051.6 5064.8 5399.2 5489.0 5535.1 5545.1 5551.8 4399.3 4443.3 4450.2 4452.7 4470.6 5509.4 5672.1 5711.6 5784.9 5842.1 4566.6 4568.7 4578.3 4589.1 4593.6 4648.6 4663.2 4668.5 4670.0 4671.3 4831.9 5007.6 5027.5 5030.5 5048.7 5526.2 5527.0 5542.3 5545.4 5583.8 1613.5 1634.1 1638.5 1642.4 1647.7 1205.2 1220.2 1224.2 1232.9 1233.9 4846.2 4858.6 4859.9 4863.1 4886.5 5723.0 5733.3 5737.4 5756.3 5762.6 4689.1 4824.6 4848.5 4854.5 4863.1 3025.4 3026.5 3042.2 3048.5 3063.9 5247.2 5345.3 5346.4 5361.4 5368.8 5783.6 5813.6 5834.4 5856.7 5883.8 5332.8 5358.2 5365.3 5366.3 5379.1 5534.3 5694.1 5710.3 5716.2 5720.2 5373.5 5631.9 5637.6 5650.3 5662.3 5229.5 5237.7 5308.6 5364.0 5367.6 4545.7 4546.8 4562.4 4567.2 4591.1 5497.7 5712.5 5739.9 5741.6 5746.8 5558.1 5572.9 5578.1 5587.5 5591.7 5553.9 5558.8 5567.2 5576.7 5576.9 5187.4 5397.9 5462.0 5464.0 5470.2 5528.1 5540.2 5574.0 5575.4 5576.8 5200.9 5368.9 5399.3 5416.6 5425.6 17:32:03 INFO - PID 28519 | 17:32:03 INFO - PID 28519 | [#5] yui.html Cycles:180 Average:14240.53 Median:23639.64 stddev:17110.80 (72.4%) stddev-sans-first:17128.27 17:32:03 INFO - PID 28519 | Values: 628.9 641.7 673.8 686.4 693.7 13017.7 13216.7 13623.3 13643.9 13659.9 13211.7 13274.1 13280.5 13428.2 13970.6 824.1 839.2 843.4 850.4 864.3 877.0 877.5 877.6 880.0 880.7 910.1 914.1 918.5 918.8 919.4 901.9 908.6 910.4 911.7 912.0 665.3 667.1 668.0 672.3 673.8 13711.5 14172.6 14403.6 14627.0 14632.6 13711.6 14605.6 14622.9 14631.9 14709.9 10387.0 10529.6 10550.4 10699.0 10713.3 3070.3 3163.0 3177.5 3199.2 3296.9 49222.5 51249.0 51503.5 51629.2 52145.2 10365.6 10769.1 10873.6 10999.8 11071.1 19952.1 20000.4 20007.7 20031.9 20084.4 6830.3 6926.4 7134.9 7217.0 7227.2 3503.4 3518.9 3536.5 3568.6 3632.3 2724.2 2736.2 2772.8 2774.0 2786.6 475.8 487.0 487.5 493.3 496.1 638.2 651.9 653.0 660.0 660.3 8766.9 9055.0 9202.2 9311.2 9455.0 579.4 595.6 611.9 613.1 626.1 4135.7 4141.1 4198.7 4250.3 4390.0 63434.7 63747.9 64007.7 66542.7 66546.7 47072.0 51009.2 54950.8 54977.0 55350.0 50667.2 51297.0 51713.7 52428.7 52453.5 7933.8 8280.3 8306.6 8367.5 8412.9 35853.0 36153.0 36388.8 36441.5 36487.6 41027.0 41489.0 42063.0 43029.0 43042.6 10351.6 10424.8 10542.8 10544.6 10688.0 10744.4 10879.8 10950.5 11060.6 11079.7 10387.0 10409.3 10418.6 10667.5 10676.6 10347.0 10607.5 11086.3 11326.5 11368.8 10342.9 10373.5 10454.4 10525.9 10900.0 8257.6 8316.5 8457.7 8491.3 8668.0 8208.2 10157.4 10744.4 10777.3 10802.0 17:32:03 INFO - PID 28519 | -------- Summary: end -------- 17:32:03 INFO - PID 28519 | 17:32:04 INFO - TEST-INFO | 28519: exit 0 17:32:04 INFO - TEST-OK | dromaeo_css | took 1120142ms 17:32:04 INFO - TEST-START | kraken 17:32:04 INFO - operating with platform_type : linux_ 17:32:04 INFO - Initialising browser for kraken test... 17:32:04 INFO - TEST-INFO | started process 28904 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPwQcsh/profile http://localhost:54953/getInfo.html) 17:32:09 INFO - PID 28904 | __metrics Screen width/height:1600/1200 17:32:09 INFO - PID 28904 | colorDepth:24 17:32:09 INFO - PID 28904 | Browser inner width/height: 1024/697 17:32:09 INFO - PID 28904 | __metrics 17:32:09 ERROR - PID 28904 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 17:32:10 INFO - TEST-INFO | 28904: exit 0 17:32:10 INFO - Browser initialized. 17:32:10 INFO - Running cycle 1/1 for kraken test... 17:32:10 INFO - TEST-INFO | started process 29032 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPwQcsh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:32:22 INFO - PID 29032 | RSS: Main: 155299840 17:32:22 INFO - PID 29032 | 17:32:25 INFO - PID 29032 | Cycle 1(1): loaded http://localhost:54953/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54953/tests/kraken/driver.html?testName=audio-beat-detection) 17:32:26 INFO - PID 29032 | RSS: Main: 161603584 17:32:26 INFO - PID 29032 | 17:32:29 INFO - PID 29032 | Cycle 1(1): loaded http://localhost:54953/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54953/tests/kraken/driver.html?testName=audio-dft) 17:32:29 INFO - PID 29032 | RSS: Main: 160776192 17:32:29 INFO - PID 29032 | 17:32:32 INFO - PID 29032 | Cycle 1(1): loaded http://localhost:54953/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54953/tests/kraken/driver.html?testName=audio-fft) 17:32:33 INFO - PID 29032 | RSS: Main: 157106176 17:32:33 INFO - PID 29032 | 17:32:35 INFO - PID 29032 | Cycle 1(1): loaded http://localhost:54953/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54953/tests/kraken/driver.html?testName=audio-oscillator) 17:32:36 INFO - PID 29032 | RSS: Main: 158302208 17:32:36 INFO - PID 29032 | 17:32:38 INFO - PID 29032 | Cycle 1(1): loaded http://localhost:54953/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54953/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:32:39 INFO - PID 29032 | RSS: Main: 158461952 17:32:39 INFO - PID 29032 | 17:32:42 INFO - PID 29032 | Cycle 1(1): loaded http://localhost:54953/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54953/tests/kraken/driver.html?testName=imaging-darkroom) 17:32:42 INFO - PID 29032 | RSS: Main: 162967552 17:32:42 INFO - PID 29032 | 17:32:46 INFO - PID 29032 | Cycle 1(1): loaded http://localhost:54953/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54953/tests/kraken/driver.html?testName=imaging-desaturate) 17:32:47 INFO - PID 29032 | RSS: Main: 161091584 17:32:47 INFO - PID 29032 | 17:32:50 INFO - PID 29032 | Cycle 1(1): loaded http://localhost:54953/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54953/tests/kraken/driver.html?testName=json-parse-financial) 17:32:50 INFO - PID 29032 | RSS: Main: 162148352 17:32:50 INFO - PID 29032 | 17:32:52 INFO - PID 29032 | Cycle 1(1): loaded http://localhost:54953/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54953/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:32:53 INFO - PID 29032 | RSS: Main: 162791424 17:32:53 INFO - PID 29032 | 17:32:55 INFO - PID 29032 | Cycle 1(1): loaded http://localhost:54953/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54953/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:32:55 INFO - PID 29032 | RSS: Main: 162439168 17:32:55 INFO - PID 29032 | 17:32:57 INFO - PID 29032 | Cycle 1(1): loaded http://localhost:54953/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54953/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:32:58 INFO - PID 29032 | RSS: Main: 163196928 17:32:58 INFO - PID 29032 | 17:33:01 INFO - PID 29032 | Cycle 1(1): loaded http://localhost:54953/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54953/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:33:02 INFO - PID 29032 | RSS: Main: 163950592 17:33:02 INFO - PID 29032 | 17:33:05 INFO - PID 29032 | Cycle 1(1): loaded http://localhost:54953/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54953/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:33:06 INFO - PID 29032 | RSS: Main: 163758080 17:33:06 INFO - PID 29032 | 17:33:07 INFO - PID 29032 | Cycle 1(1): loaded http://localhost:54953/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54953/tests/kraken/driver.html?testName=ai-astar) 17:33:08 INFO - PID 29032 | RSS: Main: 165408768 17:33:08 INFO - PID 29032 | 17:33:08 INFO - PID 29032 | __start_tp_report 17:33:08 INFO - PID 29032 | _x_x_mozilla_page_load 17:33:08 INFO - PID 29032 | _x_x_mozilla_page_load_details 17:33:08 INFO - PID 29032 | |i|pagename|runs| 17:33:08 INFO - PID 29032 | |0;ai-astar;113;120;120;119;120;120;119;121;120;119 17:33:08 INFO - PID 29032 | |1;audio-beat-detection;157;131;126;174;128;125;126;126;147;127 17:33:08 INFO - PID 29032 | |2;audio-dft;165;168;165;168;169;168;163;164;163;165 17:33:08 INFO - PID 29032 | |3;audio-fft;75;75;76;120;77;76;75;76;94;76 17:33:08 INFO - PID 29032 | |4;audio-oscillator;85;85;108;85;85;83;108;87;85;114 17:33:08 INFO - PID 29032 | |5;imaging-gaussian-blur;114;114;114;117;114;118;114;115;113;115 17:33:08 INFO - PID 29032 | |6;imaging-darkroom;152;151;151;150;150;150;150;151;150;151 17:33:08 INFO - PID 29032 | |7;imaging-desaturate;95;95;95;96;95;95;95;96;95;94 17:33:08 INFO - PID 29032 | |8;json-parse-financial;69;68;68;70;71;69;70;70;71;70 17:33:08 INFO - PID 29032 | |9;json-stringify-tinderbox;55;55;54;54;55;57;55;55;54;56 17:33:08 INFO - PID 29032 | |10;stanford-crypto-aes;83;91;83;83;85;84;83;82;84;82 17:33:08 INFO - PID 29032 | |11;stanford-crypto-ccm;143;144;138;133;132;136;134;135;177;137 17:33:08 INFO - PID 29032 | |12;stanford-crypto-pbkdf2;188;195;200;214;188;206;193;200;203;200 17:33:08 INFO - PID 29032 | |13;stanford-crypto-sha256-iterative;76;72;71;73;72;73;72;78;70;71 17:33:08 INFO - PID 29032 | __end_tp_report 17:33:08 INFO - PID 29032 | __start_cc_report 17:33:08 INFO - PID 29032 | _x_x_mozilla_cycle_collect,881 17:33:08 INFO - PID 29032 | __end_cc_report 17:33:08 INFO - PID 29032 | __startTimestamp1489537988114__endTimestamp 17:33:08 INFO - PID 29032 | 17:33:08 INFO - PID 29032 | ------- Summary: start ------- 17:33:08 INFO - PID 29032 | Number of tests: 14 17:33:08 INFO - PID 29032 | 17:33:08 INFO - PID 29032 | [#0] ai-astar Cycles:10 Average:119.10 Median:120.00 stddev:2.23 (1.9%) stddev-sans-first:0.67 17:33:08 INFO - PID 29032 | Values: 113.0 120.0 120.0 119.0 120.0 120.0 119.0 121.0 120.0 119.0 17:33:08 INFO - PID 29032 | 17:33:08 INFO - PID 29032 | [#1] audio-beat-detection Cycles:10 Average:136.70 Median:129.50 stddev:16.97 (13.1%) stddev-sans-first:16.33 17:33:08 INFO - PID 29032 | Values: 157.0 131.0 126.0 174.0 128.0 125.0 126.0 126.0 147.0 127.0 17:33:08 INFO - PID 29032 | 17:33:08 INFO - PID 29032 | [#2] audio-dft Cycles:10 Average:165.80 Median:166.50 stddev:2.25 (1.4%) stddev-sans-first:2.37 17:33:08 INFO - PID 29032 | Values: 165.0 168.0 165.0 168.0 169.0 168.0 163.0 164.0 163.0 165.0 17:33:08 INFO - PID 29032 | 17:33:08 INFO - PID 29032 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:14.54 (19.1%) stddev-sans-first:15.21 17:33:08 INFO - PID 29032 | Values: 75.0 75.0 76.0 120.0 77.0 76.0 75.0 76.0 94.0 76.0 17:33:08 INFO - PID 29032 | 17:33:08 INFO - PID 29032 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:85.00 stddev:12.22 (14.4%) stddev-sans-first:12.66 17:33:08 INFO - PID 29032 | Values: 85.0 85.0 108.0 85.0 85.0 83.0 108.0 87.0 85.0 114.0 17:33:08 INFO - PID 29032 | 17:33:08 INFO - PID 29032 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:114.50 stddev:1.55 (1.4%) stddev-sans-first:1.62 17:33:08 INFO - PID 29032 | Values: 114.0 114.0 114.0 117.0 114.0 118.0 114.0 115.0 113.0 115.0 17:33:08 INFO - PID 29032 | 17:33:08 INFO - PID 29032 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 17:33:08 INFO - PID 29032 | Values: 152.0 151.0 151.0 150.0 150.0 150.0 150.0 151.0 150.0 151.0 17:33:08 INFO - PID 29032 | 17:33:08 INFO - PID 29032 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 17:33:08 INFO - PID 29032 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 94.0 17:33:08 INFO - PID 29032 | 17:33:08 INFO - PID 29032 | [#8] json-parse-financial Cycles:10 Average:69.60 Median:70.00 stddev:1.07 (1.5%) stddev-sans-first:1.12 17:33:08 INFO - PID 29032 | Values: 69.0 68.0 68.0 70.0 71.0 69.0 70.0 70.0 71.0 70.0 17:33:08 INFO - PID 29032 | 17:33:08 INFO - PID 29032 | [#9] json-stringify-tinderbox Cycles:10 Average:55.00 Median:55.00 stddev:0.94 (1.7%) stddev-sans-first:1.00 17:33:08 INFO - PID 29032 | Values: 55.0 55.0 54.0 54.0 55.0 57.0 55.0 55.0 54.0 56.0 17:33:08 INFO - PID 29032 | 17:33:08 INFO - PID 29032 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:83.50 stddev:2.62 (3.1%) stddev-sans-first:2.76 17:33:08 INFO - PID 29032 | Values: 83.0 91.0 83.0 83.0 85.0 84.0 83.0 82.0 84.0 82.0 17:33:08 INFO - PID 29032 | 17:33:08 INFO - PID 29032 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:137.50 stddev:13.29 (9.7%) stddev-sans-first:14.07 17:33:08 INFO - PID 29032 | Values: 143.0 144.0 138.0 133.0 132.0 136.0 134.0 135.0 177.0 137.0 17:33:08 INFO - PID 29032 | 17:33:08 INFO - PID 29032 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.70 Median:200.00 stddev:8.07 (4.0%) stddev-sans-first:7.57 17:33:08 INFO - PID 29032 | Values: 188.0 195.0 200.0 214.0 188.0 206.0 193.0 200.0 203.0 200.0 17:33:08 INFO - PID 29032 | 17:33:08 INFO - PID 29032 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:72.50 stddev:2.44 (3.4%) stddev-sans-first:2.30 17:33:08 INFO - PID 29032 | Values: 76.0 72.0 71.0 73.0 72.0 73.0 72.0 78.0 70.0 71.0 17:33:08 INFO - PID 29032 | -------- Summary: end -------- 17:33:08 INFO - PID 29032 | 17:33:09 INFO - TEST-INFO | 29032: exit 0 17:33:09 INFO - TEST-OK | kraken | took 64464ms 17:33:09 INFO - SUITE-END | took 1184s 17:33:09 INFO - Completed test suite (00:19:45) 17:33:09 INFO - javascript benchmark 17:33:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6754.681924585989, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2654.681438227413, 2662.5739881618947, 2677.2102229842194, 2688.3413563676904, 2698.7840972722183, 4895.388076490439, 4957.529034741703, 4990.101781679296, 5003.3245511855885, 5029.39647242331, 4964.32981547491, 5006.324146240257, 5009.2486127080865, 5036.017976494585, 5079.974600126994, 4592.173408786425, 4604.838830640928, 4614.861554153364, 4627.467841198255, 4673.626109911199, 4655.324977878223, 4663.510331415204, 4688.531146885318, 4695.107929493385, 4747.572718455338, 4594.74728889911, 4601.815927362902, 4618.976905115486, 4621.214393553104, 4634.189016922025, 4581.862544123648, 4593.196190666654, 4598.8069086238775, 4624.930626040612, 4641.791119399635, 4526.502084770673, 4552.044070745147, 4568.451785785727, 4569.588737013652, 4618.838340658094, 4873.610111191097, 4897.1674815281485, 4911.607071434277, 4918.8770280743265, 4922.876928076791, 5288.973555132238, 5302.257683924254, 5341.599380046512, 5354.973225133849, 5364.731763411853, 5305.73471326436, 5367.114426119686, 5373.811916582901, 5374.543163831079, 5375.301210842605, 4894.877628059256, 4958.851234462972, 4970.453250142481, 4984.451710311862, 4999.275105109775, 5420.457954204548, 5421.376541697677, 5442.700651464207, 5457.754401051962, 5483.040467918098, 5140.948590514122, 5190.844274671766, 5266.368035835648, 5307.0, 5328.520433161034, 5132.5893928486375, 5280.419153893069, 5295.152775555893, 5311.097113490639, 5353.330833645794, 5236.502532259429, 5275.235090911796, 5297.655652382583, 5305.36335639718, 5325.520703136659, 5259.263703081571, 5271.919256552397, 5294.41761406245, 5311.2033195020285, 5325.653832500875, 4537.795799189044, 4539.228331183641, 4544.386507821402, 4562.315652652062, 4603.838865639686, 3899.629535194152, 3904.2972264992572, 3916.784576848244, 3963.603639636013, 3970.086880017612, 4555.9772201138785, 4605.309203619484, 4605.907881842411, 4630.28230624247, 4643.628509719214, 5332.093544097513, 5341.172118321666, 5341.572674186055, 5365.382980957162, 5367.35591728995, 4596.678232523758, 4598.402207712976, 4601.056783359403, 4613.423322084739, 4654.604358629486, 4688.2733176357715, 4724.220503616864, 4794.976025119852, 4802.855914322506, 4850.466448690641, 5050.974745126251, 5059.848204553869, 5066.189409694579, 5078.365204349457, 5117.4114976776655, 5377.2740680009265, 5384.380796208329, 5384.6499977501335, 5389.703566303734, 5397.865053373697, 4900.436449808318, 4900.975495122501, 4988.975055124701, 5027.824026159067, 5042.747862606929, 5274.235235890851, 5282.841514754564, 5301.204819277139, 5302.522772950453, 5313.442088580798, 5385.784568617211, 5386.622936394415, 5394.568434525307, 5398.001369746609, 5448.346198456052, 5120.411152717336, 5162.6386152968935, 5194.091034068947, 5223.112070947872, 5253.0, 5043.092243396224, 5165.431802501646, 5212.035773381936, 5224.843254702365, 5248.475152484721, 5049.545540901337, 5143.71709555978, 5153.3558305211845, 5186.688798672092, 5188.299579556711, 5193.039287731782, 5231.895362092813, 5239.0, 5245.685258884327, 5256.474352564713, 5087.694738315713, 5090.872728181677, 5093.923591146062, 5100.6429549931145, 5127.41034781005], "value": 4894.400501591165, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.1049504456151, 673.4208580620667, 693.3898169610742, 828.7638023163393, 833.7582101190651, 33104.17239569012, 33885.661143388556, 33937.83031084844, 33999.0, 34028.829855850745, 30330.54504182439, 30596.0, 30627.846860765665, 30706.0, 30765.538516922206, 6128.172696685935, 6247.9062814057825, 8993.775155621097, 9169.128932751411, 9184.265258779282, 8953.194212520872, 9026.774330641754, 9070.637174513045, 9111.908880911205, 9125.13311235435, 9090.13643703847, 9115.49864757438, 9135.31485138614, 9147.405418647766, 9203.17171454569, 9105.271578273721, 9116.088391160898, 9142.542872856397, 9157.862632060524, 9353.064693530661, 9244.121808428188, 9256.90743092574, 9314.906850931471, 9323.953380233123, 9349.0, 34525.0, 35125.47311790325, 35157.29685406278, 35169.0, 35223.471647925304, 3385.9492107618407, 3448.793072415663, 3473.5484387029524, 3476.683395547502, 3506.08841701157, 22800.201992930168, 22861.885690571606, 22873.31380058601, 23462.296131115923, 24350.0, 3201.183698156978, 3210.486322188462, 3289.9862168154814, 3304.9173770655684, 3435.2442462658423, 146724.0, 147305.0, 147484.0, 148178.0, 149463.0, 42175.156496870506, 42268.788656056524, 42447.0, 42483.36274955878, 42542.78728606337, 44256.0, 44372.0, 44502.77748611236, 44517.0, 44596.3310550342, 11709.473073711704, 11731.0, 11796.646100616996, 11835.171537992257, 11849.0, 9166.679166229284, 9194.678186263449, 9198.402103863227, 9205.63177472907, 9213.631454741735, 12441.875581244072, 13376.929845612327, 13397.464101436028, 13450.0, 13578.660533486742, 5416.0, 5496.780128794803, 5499.890002200013, 5563.610547261653, 5569.55443564522, 832.134580036767, 873.3275377958936, 885.1840825642578, 893.8558644934494, 897.8832751742232, 25371.492570148494, 25612.231633051037, 25650.615240771403, 25863.61204581933, 25939.48121037569, 940.4639355567398, 944.6268723854039, 959.165525992391, 973.532704301939, 987.5062468765617, 12959.898408635183, 13070.738585228242, 13460.125091868997, 13782.174654195866, 13868.861311386758, 238489.0, 239569.0, 240798.0, 241075.0, 241205.0, 40345.0, 45283.77358113254, 45591.0, 45615.31577026347, 45764.313535297, 1204.873488283735, 1225.7425940552585, 1242.6085782978332, 1245.6138597034767, 1246.2647038247478, 23867.0, 24387.634185486877, 27328.726712733413, 27381.58927616127, 27398.0, 38660.80669596634, 39017.049147543075, 39111.0, 39136.217275653755, 39184.60815391924, 236877.0, 236951.0, 237261.0, 237580.0, 237752.0, 30227.697723023368, 30487.237819054702, 30577.54133687952, 30759.384812303182, 30971.225719356295, 37834.24331513299, 37915.0, 38489.23021539498, 38682.6131738679, 38682.613173869024, 31098.53352199764, 31770.0, 32050.0, 32200.0, 33084.33831323408, 31631.52552711757, 31676.841615791775, 31798.682013179572, 31856.362872741953, 32384.0, 31406.842965785025, 31663.36673266568, 31884.362312754078, 32384.35231295408, 32434.0, 25543.87228063848, 27340.453190935674, 28750.856245718638, 29009.56485652759, 29100.708992910648, 22456.0, 22692.432689182904, 22826.42933926665, 22939.54120917539, 23049.193278235853], "value": 15943.408222338576, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.455098311381, 387.11157892636413, 393.2233838169615, 405.8112977465479, 415.86068666996556, 13226.404811783468, 17401.216945237462, 17902.91048544757, 18601.25594976201, 18606.34877779278, 17246.0, 17505.21226544805, 17701.29194832205, 17954.730679039792, 18085.1861666225, 4867.53758392953, 5614.550835933115, 5643.8589035274035, 6527.902081468782, 6820.488463365243, 6753.15585551806, 6789.3889549940495, 6794.830129246759, 6799.150106236721, 6804.48966327525, 6644.60132392058, 6880.2775708550635, 6899.37905588497, 6925.549839260457, 6931.480138989596, 6654.866902661968, 6814.863702725943, 6842.315768423143, 6885.242623311432, 6926.099607051102, 6764.797056088325, 6770.255271920085, 6775.356341147583, 6776.0, 6783.6269005204695, 21683.783162168333, 22418.439539011655, 22865.77134228653, 22918.770812291998, 23189.072437102495, 2128.212561352294, 2161.1139432832465, 2200.0759680934048, 2254.458929856839, 2289.8740569268684, 14028.228447435387, 14081.64795880101, 14126.85873141276, 14249.78625320621, 15109.697806043927, 1818.6817306971227, 1899.9082459009849, 1918.2231196365494, 1918.6354592627356, 1923.6248931458372, 85286.5735671324, 87835.0, 87884.0, 88430.55784721099, 90122.54938725264, 15025.323860426308, 15697.215139242991, 16065.598360040858, 16118.516444506684, 16716.16419179036, 26211.606825897627, 28970.0, 29027.564586531218, 29131.126066218047, 29217.707822921922, 7528.473006889465, 7592.696292148252, 7616.657250423744, 7688.807779805437, 7821.648025838851, 5877.471027607536, 5962.433568810956, 6086.695665216722, 6122.173506576644, 6152.969235153795, 8633.0, 8703.606508210167, 9195.0, 9237.815243695222, 9332.580033898355, 3600.7839529628304, 3766.3597188478025, 3767.660910518012, 3773.660370566662, 3791.156632525606, 907.5541415884129, 940.741296143566, 969.5685419988038, 983.4738414948112, 999.2206079258191, 17489.475315740547, 18592.44222673322, 18655.90672046631, 18766.81233187678, 19113.90443047776, 932.9224745419052, 939.9859002114973, 942.1144124522926, 948.7248697877538, 963.6675347005412, 9973.501324933724, 10913.290636108628, 12224.449899754354, 12411.317377544321, 12470.189437686522, 485619.0, 495064.0, 496042.0, 500837.0, 500977.0, 90711.0, 90950.0, 91373.54313228391, 91574.0, 91701.54149229344, 1172.1326218598347, 1176.7352345722145, 1215.617080619602, 1224.1308670843623, 1231.735176936963, 17124.657506850042, 17443.01288404361, 18135.093245337943, 18136.45590632283, 18261.634767304844, 41778.79110604428, 42933.0, 43127.35308970305, 43548.129037419705, 43562.782186088865, 55162.72418637881, 55193.44806551883, 56909.0, 56977.0, 57400.71299643642, 7980.680772769024, 10283.845742313722, 10654.680359589225, 10763.677089687322, 11250.212485125963, 12587.118901676795, 12747.681307967376, 12781.552645657357, 12803.167794093353, 12871.806922895978, 10786.244962852525, 10831.0, 10916.290441121302, 11004.39475828837, 11250.549978000789, 10724.785504290026, 10789.406582637715, 10921.344719316867, 11122.165837562377, 11357.886421135683, 10673.776537426616, 10887.673369798918, 10905.945470272598, 10930.403369658012, 11526.193166478266, 10525.210609204187, 10615.513828064231, 10705.518251678848, 10719.410432426292, 10979.945100274448, 11211.831822522505, 11214.88785112171, 11238.438078096226, 11383.365447646967, 11518.596849110241], "value": 10059.534033658108, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1456.359201951142, 1459.8394176640568, 1481.3630139040215, 1491.1873029199085, 1558.5168597734703, 8485.363597730164, 8737.868931966026, 9130.680426185085, 9491.857622135674, 9516.85724714129, 8982.281417486602, 9273.443593384385, 9279.53602319883, 9290.72127836166, 9310.394824336414, 2056.7840376760487, 2110.5145816462223, 2112.112912576714, 2114.048678094856, 2114.8942552872295, 2075.6471399861985, 2097.9055942482623, 2119.395972147938, 2120.332095389955, 2120.9893950530227, 2030.93907182784, 2038.062491254025, 2045.8772473651554, 2050.764162121353, 2057.084597354178, 1969.862109652325, 1971.5607606447302, 1976.6145601607693, 1979.0797279265066, 1982.7224188613607, 1976.3675623800389, 1989.6617575012137, 2037.8064083912004, 2039.418765651797, 2049.9692504612444, 9558.378705384128, 9622.422654640673, 9641.758956026086, 9644.03559644037, 9644.373115747525, 4673.672842900998, 4860.927086093711, 4861.951380486221, 4869.342638743759, 4880.902381952376, 2462.372095115752, 2632.197179860142, 2650.840949543014, 2664.8667566621593, 2734.09774774324, 859.1666083898608, 878.6002368922188, 895.8163576466809, 899.6761165980242, 930.1210356213381, 13864.792028119586, 13905.79141312881, 13960.232187229698, 14035.50875719345, 14060.226687532182, 4118.135191609736, 4172.72877262983, 4218.1985422770185, 4260.531341552427, 4282.550332215135, 11643.476043578059, 11736.941315293368, 11767.88232117668, 11778.587749428729, 11779.411029448493, 4959.479254678206, 4985.576226020757, 4986.850394488171, 4993.500649934977, 4996.175631020841, 3772.5472943246987, 4127.380892866034, 4376.0, 4477.686561940633, 4482.170798402306, 3518.8592456301462, 3582.462630605378, 3634.127809325743, 3675.448682697563, 3685.0, 968.5883499512679, 980.5097451274363, 982.832918403873, 983.1201075037801, 994.7115336552464, 776.1152286393516, 781.1290411191594, 787.22851605427, 788.9368850491946, 789.7078081109911, 5439.184122381675, 5471.452854714496, 5493.093639549509, 5552.000639884859, 5630.71846407678, 895.9731208063769, 897.8653202019749, 901.0718959471754, 901.2114399900088, 921.5254144115786, 3608.2061946371755, 3630.6006339302658, 3630.636936306348, 3657.634236576321, 3790.962090379061, 11766.705832354088, 11970.58102966392, 12011.099167562468, 12075.215111017756, 12148.392580370946, 12134.878651213552, 12157.270563766202, 12179.147459677915, 12183.086268529896, 12191.0, 8121.269085782308, 8417.242448179693, 8474.830503389898, 8490.386826502945, 8512.659493620185, 5460.15367618004, 5475.863103422287, 5544.362398324244, 5625.46558076982, 5691.430856914276, 9893.950530247303, 9918.05778451046, 9941.801163976535, 9995.500224988868, 10110.140638045848, 10135.64525241613, 10255.435951022468, 10278.074973252444, 10468.842967355344, 10490.94754526253, 6915.446764258948, 7993.72021979228, 8116.634751436081, 8134.430589858653, 8208.917910821054, 8961.059088795582, 8991.910080899108, 9076.774635424134, 9109.362344635812, 9335.766605834908, 7702.229777022253, 7856.096548896721, 7923.643436045277, 7998.920010799818, 8112.59437028158, 7701.576413297323, 7773.727919522789, 7838.960805195938, 7937.0, 8215.219554142346, 6488.967555162194, 6501.1548498694865, 6503.447206987459, 6569.113169722026, 6601.570897891622, 4734.881627959328, 4826.889815342421, 4866.586340161126, 4876.830060460729, 4957.776900039435, 4964.578010869117, 4974.452810190948, 4976.527229913152, 5046.268291097844, 5058.2918391425965], "value": 4427.621599846113, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.30236097872574, 366.78726338723527, 372.9906752331193, 376.9849206031758, 383.06914198497657, 5023.472535383787, 5234.895302093956, 5242.55438287746, 5322.441143679911, 5324.5740340772745, 5071.340725705653, 5179.611529135311, 5205.973970130144, 5240.44975277596, 5246.842594722155, 4536.183486972343, 4548.863534093983, 4550.886227844314, 4552.658550608701, 4562.156001139783, 4174.958250417502, 4347.5652434756585, 4550.2264615015365, 4551.362809206714, 4559.430071241095, 4330.935035974463, 4333.631641310492, 4345.413369195166, 4351.564843515639, 4371.213181627306, 4345.826166953318, 4347.108842687241, 4351.564843515639, 4360.542143074963, 4373.125374924996, 3960.0693836948294, 4043.2722110020186, 4052.5136983561865, 4055.6349928506575, 4058.492688413948, 5069.0115427491655, 5070.898582028339, 5077.065274412323, 5079.949200507985, 5093.1087059764395, 5034.0, 5039.3448851649055, 5047.596192304607, 5051.595872330205, 5064.848054558369, 5399.163129714901, 5488.9725551372385, 5535.114381698949, 5545.140503222007, 5551.833444996657, 4399.2622913949135, 4443.311796363186, 4450.198964186445, 4452.732836029849, 4470.575295346969, 5509.421510741395, 5672.149177623348, 5711.600187986843, 5784.88430231393, 5842.123681447774, 4566.566176213254, 4568.70303430276, 4578.336141259565, 4589.059242855206, 4593.586577208001, 4648.581627653527, 4663.230566956414, 4668.4631267404, 4669.968563674813, 4671.267308624425, 4831.903361932742, 5007.599392048627, 5027.547520723152, 5030.522100400456, 5048.72232027242, 5526.226328314039, 5526.972365138148, 5542.334919809648, 5545.390007099216, 5583.832485025456, 1613.5240104169297, 1634.1012443156217, 1638.5412084616326, 1642.4169419856019, 1647.744599587066, 1205.2286536616573, 1220.2434490615874, 1224.1859163656247, 1232.8828761267666, 1233.864274929757, 4846.248831431063, 4858.58702010333, 4859.902801943941, 4863.10032643962, 4886.462489126193, 5722.971385143048, 5733.3406658234, 5737.3975732548315, 5756.25168728071, 5762.596618236683, 4689.132510485571, 4824.614030877591, 4848.490908454632, 4854.514548545188, 4863.10032643962, 3025.3949210158057, 3026.500627396455, 3042.2242328206166, 3048.481758101084, 3063.8927637533025, 5247.239150323182, 5345.278387417727, 5346.4118946915805, 5361.35663720356, 5368.8389348319615, 5783.595148339576, 5813.6221145625395, 5834.387389324144, 5856.736446859902, 5883.764649414061, 5332.813351532678, 5358.196270559525, 5365.302510673588, 5366.275552800322, 5379.085555455504, 5534.280543529316, 5694.1458781183155, 5710.2862142232225, 5716.228309178374, 5720.170575266647, 5373.543248823894, 5631.873625275043, 5637.633553818989, 5650.29371328584, 5662.2639056922335, 5229.50319719626, 5237.685738855681, 5308.6283960123965, 5364.0, 5367.584586935973, 4545.749983750926, 4546.795394207203, 4562.425963042745, 4567.223571992836, 4591.127685739699, 5497.697626630574, 5712.5429965601825, 5739.8565035874435, 5741.62679425836, 5746.798862039808, 5558.138488534284, 5572.888542229051, 5578.135389014709, 5587.497125258747, 5591.720413979366, 5553.916691249554, 5558.805441809517, 5567.216391804098, 5576.721163941867, 5576.86057848557, 5187.351581052369, 5397.865053373697, 5462.0, 5463.972680136733, 5470.234167216672, 5528.143137813645, 5540.224368588481, 5574.0, 5575.386707462257, 5576.804811831566, 5200.895982080261, 5368.919466208088, 5399.2980912481125, 5416.647917885325, 5425.593080518898], "value": 4351.934724858694, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.9465395441388, 641.7433026789281, 673.7978606418073, 686.4028295383015, 693.7363801755332, 13017.739645207103, 13216.669583260424, 13623.318834058295, 13643.863561364384, 13659.931700341484, 13211.735765284688, 13274.070815042951, 13280.535181268657, 13428.194308341506, 13970.580882573538, 824.1428913929522, 839.1776059461731, 843.3674743942044, 850.3664769746548, 864.3042350907517, 877.0221203358274, 877.4910551879894, 877.5568337989338, 879.9604017819214, 880.7181701855409, 910.0808183734409, 914.1315750037458, 918.4626993208948, 918.8024574716435, 919.3610440743686, 901.8827552418177, 908.5548081440113, 910.4309806371018, 911.7401540560975, 912.0059135542258, 665.3280187011105, 667.1393901866586, 667.9699413526355, 672.2504407585556, 673.8349104469387, 13711.45154193831, 14172.645683857883, 14403.639909002253, 14627.049241799248, 14632.634184145376, 13711.588652340446, 14605.6348591285, 14622.853771462256, 14631.853681463263, 14709.852901470955, 10387.0, 10529.631462898838, 10550.419726915017, 10699.03708666216, 10713.303635263761, 3070.3245286037036, 3162.984185079083, 3177.507486339621, 3199.152224660467, 3296.8846090386724, 49222.50777492215, 51249.0, 51503.484965150245, 51629.22556161661, 52145.2178217327, 10365.585376585002, 10769.138468922623, 10873.619423320304, 10999.835002474969, 11071.05895998833, 19952.10215540304, 20000.399988000383, 20007.699884501744, 20031.899840500704, 20084.397468075982, 6830.316968303229, 6926.411255043277, 7134.857302853914, 7216.96391518039, 7227.241139680363, 3503.4394496880377, 3518.8592456301462, 3536.487209354629, 3568.589612194579, 3632.3461776880417, 2724.155511791351, 2736.165469531812, 2772.7781777457753, 2773.9583906241423, 2786.637737094165, 475.77876287525777, 486.96347773917097, 487.48813745567014, 493.28473713116125, 496.1466278001831, 638.1831255992337, 651.90547370631, 652.9804105876831, 659.9505037122235, 660.2934859700171, 8766.912330876738, 9054.954725226331, 9202.171804537624, 9311.208547273558, 9455.007224241494, 579.39163877928, 595.6336852835475, 611.8776244751068, 613.0926229180749, 626.132806063596, 4135.656713592605, 4141.130362623882, 4198.706090573631, 4250.277452833026, 4389.978050109793, 63434.68282658557, 63747.88430717661, 64007.67996160083, 66542.66728666326, 66546.66726666335, 47072.0, 51009.23486147711, 54950.794927558105, 54977.0, 55350.0, 50667.23999140016, 51297.0, 51713.741431292605, 52428.73785631047, 52453.47546524486, 7933.8413231736195, 8280.337572994267, 8306.626201821053, 8367.539785311623, 8412.914735981463, 35853.0, 36153.0, 36388.81805590955, 36441.453378199876, 36487.635123648426, 41027.0, 41489.0, 42063.0, 43029.0, 43042.56957430511, 10351.585936562453, 10424.843627345444, 10542.8418573723, 10544.630937917444, 10688.0, 10744.355338679705, 10879.836802448128, 10950.452477376259, 11060.557577696802, 11079.667609971713, 10387.0, 10409.323393979366, 10418.583256669952, 10667.519961601902, 10676.62631807883, 10347.0, 10607.469626518488, 11086.279391839505, 11326.490307935997, 11368.829467557827, 10342.896571034193, 10373.481325933824, 10454.42500662471, 10525.9473702631, 10900.0, 8257.628406721591, 8316.542590157358, 8457.703980360659, 8491.320694344562, 8667.95666021691, 8208.183194814439, 10157.441340726331, 10744.4090575016, 10777.344645723471, 10802.0], "value": 6278.813783188042, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1577.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 120.0, 120.0, 119.0, 120.0, 120.0, 119.0, 121.0, 120.0, 119.0], "value": 119.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 131.0, 126.0, 174.0, 128.0, 125.0, 126.0, 126.0, 147.0, 127.0], "value": 136.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 168.0, 165.0, 168.0, 169.0, 168.0, 163.0, 164.0, 163.0, 165.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 120.0, 77.0, 76.0, 75.0, 76.0, 94.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 108.0, 85.0, 85.0, 83.0, 108.0, 87.0, 85.0, 114.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 117.0, 114.0, 118.0, 114.0, 115.0, 113.0, 115.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 151.0, 150.0, 150.0, 150.0, 150.0, 151.0, 150.0, 151.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 70.0, 71.0, 69.0, 70.0, 70.0, 71.0, 70.0], "value": 69.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 54.0, 55.0, 57.0, 55.0, 55.0, 54.0, 56.0], "value": 55.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 91.0, 83.0, 83.0, 85.0, 84.0, 83.0, 82.0, 84.0, 82.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 144.0, 138.0, 133.0, 132.0, 136.0, 134.0, 135.0, 177.0, 137.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 195.0, 200.0, 214.0, 188.0, 206.0, 193.0, 200.0, 203.0, 200.0], "value": 198.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 71.0, 73.0, 72.0, 73.0, 72.0, 78.0, 70.0, 71.0], "value": 72.8, "unit": "score"}]}]} 17:33:09 INFO - Return code: 0 17:33:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:33:09 ERROR - # TBPL SUCCESS # 17:33:09 INFO - Running post-action listener: _resource_record_post_action 17:33:09 INFO - [mozharness: 2017-03-15 00:33:09.912609Z] Finished run-tests step (success) 17:33:09 INFO - Running post-run listener: _resource_record_post_run 17:33:09 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 364199936; Read time: 20; Write time: 230396 17:33:09 INFO - TinderboxPrint: CPU usage
13.3% 17:33:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 17:33:09 INFO - TinderboxPrint: I/O write bytes / time
364,199,936 / 230,396 17:33:09 INFO - TinderboxPrint: CPU idle
8,308.2 (86.7%) 17:33:09 INFO - TinderboxPrint: CPU user
1,219.5 (12.7%) 17:33:09 INFO - TinderboxPrint: Swap in / out
0 / 0 17:33:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105193472; Read time: 0; Write time: 85460 17:33:10 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 259006464; Read time: 20; Write time: 144936 17:33:10 INFO - Running post-run listener: _upload_blobber_files 17:33:10 INFO - Blob upload gear active. 17:33:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:33:10 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 17:33:10 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'] 17:33:10 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 17:33:10 INFO - (blobuploader) - INFO - Open directory for files ... 17:33:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:33:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:33:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:11 INFO - (blobuploader) - INFO - Done attempting. 17:33:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:33:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:33:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:14 INFO - (blobuploader) - INFO - Done attempting. 17:33:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:33:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:33:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:15 INFO - (blobuploader) - INFO - Done attempting. 17:33:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:33:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:33:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:16 INFO - (blobuploader) - INFO - Done attempting. 17:33:16 INFO - (blobuploader) - INFO - Iteration through files over. 17:33:16 INFO - Return code: 0 17:33:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:33:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:33:16 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4504380967c5a8281e6baa79ddfb6d3cc4e4d9f309d474bfd270669539ffa3ab9656d3d35cf2e450a2bd791a48b44d179b0b9ae2da32a37319914bee4f1d7a3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ffda57a3d2978284df0c6ec136838e1a4ad887c45981cc0f9056105f89a62502339f4dfd4f78bbc86c8aaa939dac0caba66c711dade2261641fc7714ebcb57ca", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d76cefc7e1c651e9411000f0aa002b413e011e303c12b829a9e3e024ee6774fd1ea5d720e388c7a6fcf87dbabed4c2a3d6bdff6c1df1c9a1e299d1289f7c1a8e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/91ccb190def7bcfd05bc2b4ee4a8c5ba1d7a255be9a5b6fc17cf05624a18d819a60f62dc692a02ef5d7cb4c4fd2a17f2a4384961f20219bff722a56d3b3a95d7"} 17:33:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:33:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:33:16 INFO - Contents: 17:33:16 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4504380967c5a8281e6baa79ddfb6d3cc4e4d9f309d474bfd270669539ffa3ab9656d3d35cf2e450a2bd791a48b44d179b0b9ae2da32a37319914bee4f1d7a3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ffda57a3d2978284df0c6ec136838e1a4ad887c45981cc0f9056105f89a62502339f4dfd4f78bbc86c8aaa939dac0caba66c711dade2261641fc7714ebcb57ca", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d76cefc7e1c651e9411000f0aa002b413e011e303c12b829a9e3e024ee6774fd1ea5d720e388c7a6fcf87dbabed4c2a3d6bdff6c1df1c9a1e299d1289f7c1a8e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/91ccb190def7bcfd05bc2b4ee4a8c5ba1d7a255be9a5b6fc17cf05624a18d819a60f62dc692a02ef5d7cb4c4fd2a17f2a4384961f20219bff722a56d3b3a95d7"} 17:33:16 INFO - Running post-run listener: copy_logs_to_upload_dir 17:33:16 INFO - Copying logs to upload dir... 17:33:16 INFO - mkdir: /builds/slave/test/build/upload/logs 17:33:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.933015 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-03-14 17:33:16.126266) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-14 17:33:16.129419) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4504380967c5a8281e6baa79ddfb6d3cc4e4d9f309d474bfd270669539ffa3ab9656d3d35cf2e450a2bd791a48b44d179b0b9ae2da32a37319914bee4f1d7a3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ffda57a3d2978284df0c6ec136838e1a4ad887c45981cc0f9056105f89a62502339f4dfd4f78bbc86c8aaa939dac0caba66c711dade2261641fc7714ebcb57ca", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d76cefc7e1c651e9411000f0aa002b413e011e303c12b829a9e3e024ee6774fd1ea5d720e388c7a6fcf87dbabed4c2a3d6bdff6c1df1c9a1e299d1289f7c1a8e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/91ccb190def7bcfd05bc2b4ee4a8c5ba1d7a255be9a5b6fc17cf05624a18d819a60f62dc692a02ef5d7cb4c4fd2a17f2a4384961f20219bff722a56d3b3a95d7"} build_url:https://queue.taskcluster.net/v1/task/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011334 build_url: 'https://queue.taskcluster.net/v1/task/URowWlIASi6v2QE4IU9kvw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4504380967c5a8281e6baa79ddfb6d3cc4e4d9f309d474bfd270669539ffa3ab9656d3d35cf2e450a2bd791a48b44d179b0b9ae2da32a37319914bee4f1d7a3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ffda57a3d2978284df0c6ec136838e1a4ad887c45981cc0f9056105f89a62502339f4dfd4f78bbc86c8aaa939dac0caba66c711dade2261641fc7714ebcb57ca", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d76cefc7e1c651e9411000f0aa002b413e011e303c12b829a9e3e024ee6774fd1ea5d720e388c7a6fcf87dbabed4c2a3d6bdff6c1df1c9a1e299d1289f7c1a8e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/91ccb190def7bcfd05bc2b4ee4a8c5ba1d7a255be9a5b6fc17cf05624a18d819a60f62dc692a02ef5d7cb4c4fd2a17f2a4384961f20219bff722a56d3b3a95d7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-14 17:33:16.154202) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 17:33:16.154531) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1489536735.952888-1267201119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004388 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 17:33:16.239905) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-14 17:33:16.240237) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-14 17:33:16.240556) ========= ========= Total master_lag: 0.18 =========