builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-031 starttime: 1494216094.51 results: success (0) revision: c3e5497cff1c995821b1c9320fa71f1ef9a8c30e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-07 21:01:34.509436) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-07 21:01:34.509939) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-07 21:01:34.510227) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-07 21:01:34.807453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 21:01:34.807820) ========= 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=db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-07 21:01:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2017-05-07 21:01:34 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106458 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 21:01:34.958143) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 21:01:34.958541) ========= 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=db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017283 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 21:01:35.095921) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-07 21:01:35.096291) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c3e5497cff1c995821b1c9320fa71f1ef9a8c30e --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 c3e5497cff1c995821b1c9320fa71f1ef9a8c30e --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=db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-07 21:01:35,226 truncating revision to first 12 chars 2017-05-07 21:01:35,227 Setting DEBUG logging. 2017-05-07 21:01:35,227 attempt 1/10 2017-05-07 21:01:35,227 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c3e5497cff1c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-07 21:01:36,113 unpacking tar archive at: mozilla-central-c3e5497cff1c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.186054 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-07 21:01:36.380742) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-07 21:01:36.381081) ========= script_repo_revision: c3e5497cff1c995821b1c9320fa71f1ef9a8c30e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-07 21:01:36.385590) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-07 21:01:36.385913) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-07 21:01:36.409878) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-05-07 21:01:36.410288) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:01:36 INFO - MultiFileLogger online at 20170507 21:01:36 in /builds/slave/test 21:01:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:01:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:01:36 INFO - {'append_to_log': False, 21:01:36 INFO - 'base_work_dir': '/builds/slave/test', 21:01:36 INFO - 'blob_upload_branch': 'Firefox', 21:01:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:01:36 INFO - 'branch': 'Firefox', 21:01:36 INFO - 'buildbot_json_path': 'buildprops.json', 21:01:36 INFO - 'config_files': ('talos/linux_config.py',), 21:01:36 INFO - 'default_actions': ('clobber', 21:01:36 INFO - 'read-buildbot-config', 21:01:36 INFO - 'download-and-extract', 21:01:36 INFO - 'populate-webroot', 21:01:36 INFO - 'create-virtualenv', 21:01:36 INFO - 'install', 21:01:36 INFO - 'run-tests'), 21:01:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:01:36 INFO - 'download_minidump_stackwalk': True, 21:01:36 INFO - 'download_symbols': 'ondemand', 21:01:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:01:36 INFO - 'tooltool.py': '/tools/tooltool.py', 21:01:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:01:36 INFO - '/tools/misc-python/virtualenv.py')}, 21:01:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:01:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:01:36 INFO - 'gecko_profile': False, 21:01:36 INFO - 'gecko_profile_interval': 0, 21:01:36 INFO - 'installer_path': 'installer.exe', 21:01:36 INFO - 'log_level': 'info', 21:01:36 INFO - 'log_name': 'talos', 21:01:36 INFO - 'log_to_console': True, 21:01:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:01:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:01:36 INFO - 'opt_config_files': (), 21:01:36 INFO - 'pip_index': False, 21:01:36 INFO - 'suite': 'dromaeojs-e10s', 21:01:36 INFO - 'system_bits': '32', 21:01:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:01:36 INFO - 'title': 'talos-linux64-ix-031', 21:01:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:01:36 INFO - 'use_talos_json': True, 21:01:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:01:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:01:36 INFO - 'work_dir': 'build'} 21:01:36 INFO - [mozharness: 2017-05-08 04:01:36.560594Z] Running clobber step. 21:01:36 INFO - Running pre-action listener: _resource_record_pre_action 21:01:36 INFO - Running main action method: clobber 21:01:36 INFO - rmtree: /builds/slave/test/build 21:01:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:01:37 INFO - Running post-action listener: _resource_record_post_action 21:01:37 INFO - [mozharness: 2017-05-08 04:01:37.491395Z] Finished clobber step (success) 21:01:37 INFO - [mozharness: 2017-05-08 04:01:37.491495Z] Running read-buildbot-config step. 21:01:37 INFO - Running pre-action listener: _resource_record_pre_action 21:01:37 INFO - Running main action method: read_buildbot_config 21:01:37 INFO - Using buildbot properties: 21:01:37 INFO - { 21:01:37 INFO - "project": "", 21:01:37 INFO - "product": "firefox", 21:01:37 INFO - "who": "ihsiao@mozilla.com", 21:01:37 INFO - "installer_path": "public/build/target.tar.bz2", 21:01:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 21:01:37 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 21:01:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 21:01:37 INFO - "stage_platform": "linux64-pgo", 21:01:37 INFO - "basedir": "/builds/slave/test", 21:01:37 INFO - "buildnumber": 198, 21:01:37 INFO - "platform": "ubuntu64_hw", 21:01:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:01:37 INFO - "slavebuilddir": "test", 21:01:37 INFO - "taskId": "KAZ3gxebRdC4HRPm5wJQSA", 21:01:37 INFO - "branch": "mozilla-central", 21:01:37 INFO - "script_repo_revision": "production", 21:01:37 INFO - "revision": "c3e5497cff1c995821b1c9320fa71f1ef9a8c30e", 21:01:37 INFO - "slavename": "talos-linux64-ix-031", 21:01:37 INFO - "repo_path": "mozilla-central" 21:01:37 INFO - } 21:01:37 INFO - Finding installer, test and symbols from parent task. 21:01:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KAZ3gxebRdC4HRPm5wJQSA'}, attempt #1 21:01:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KAZ3gxebRdC4HRPm5wJQSA'}, attempt #1 21:01:38 INFO - Task dependencies: MNk_T-iaSS-OqEB13I9tpg 21:01:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg'}, attempt #1 21:01:38 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/target.tar.bz2 21:01:38 INFO - Set test_url: https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/test_packages.json 21:01:38 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/target.crashreporter-symbols.zip 21:01:38 INFO - Running post-action listener: _resource_record_post_action 21:01:38 INFO - [mozharness: 2017-05-08 04:01:38.911076Z] Finished read-buildbot-config step (success) 21:01:38 INFO - [mozharness: 2017-05-08 04:01:38.911294Z] Running download-and-extract step. 21:01:38 INFO - Running pre-action listener: _resource_record_pre_action 21:01:38 INFO - Running main action method: download_and_extract 21:01:38 INFO - mkdir: /builds/slave/test/build/tests 21:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:01:38 INFO - trying https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/target.test_packages.json 21:01:38 INFO - Downloading https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:01:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:01:39 INFO - Downloaded 986 bytes. 21:01:39 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:01:39 INFO - Using the following test package requirements: 21:01:39 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:01:39 INFO - u'common': [u'target.common.tests.zip'], 21:01:39 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:01:39 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:01:39 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:01:39 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:01:39 INFO - u'mozbase': [u'target.common.tests.zip'], 21:01:39 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:01:39 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:01:39 INFO - u'web-platform': [u'target.common.tests.zip', 21:01:39 INFO - u'target.web-platform.tests.zip'], 21:01:39 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:01:39 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 21:01:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/target.common.tests.zip 21:01:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:01:39 INFO - Fetch https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/target.common.tests.zip into memory 21:01:40 INFO - Content-Length response header: 60568910 21:01:40 INFO - Bytes received: 60568910 21:01:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 21:01:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/target.common.tests.zip 21:01:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:01:50 INFO - Fetch https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/target.common.tests.zip into memory 21:01:53 INFO - Content-Length response header: 60568910 21:01:53 INFO - Bytes received: 60568910 21:02:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/target.talos.tests.zip 21:02:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:02:05 INFO - Fetch https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/target.talos.tests.zip into memory 21:02:05 INFO - Content-Length response header: 14409362 21:02:05 INFO - Bytes received: 14409362 21:02:06 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')]} 21:02:06 INFO - trying https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/target.tar.bz2 21:02:06 INFO - Downloading https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:02:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:02:07 INFO - Downloaded 63972559 bytes. 21:02:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/target.tar.bz2 21:02:07 INFO - mkdir: /builds/slave/test/properties 21:02:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:02:07 INFO - Writing to file /builds/slave/test/properties/build_url 21:02:07 INFO - Contents: 21:02:07 INFO - build_url:https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/target.tar.bz2 21:02:07 INFO - Running post-action listener: _resource_record_post_action 21:02:07 INFO - Running post-action listener: set_extra_try_arguments 21:02:07 INFO - [mozharness: 2017-05-08 04:02:07.268508Z] Finished download-and-extract step (success) 21:02:07 INFO - [mozharness: 2017-05-08 04:02:07.268604Z] Running populate-webroot step. 21:02:07 INFO - Running pre-action listener: _resource_record_pre_action 21:02:07 INFO - Running main action method: populate_webroot 21:02:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:02:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:02:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:02:07 INFO - '--tppagecycles', 21:02:07 INFO - '7'], 21:02:07 INFO - 'tests': ['tsvgm']}}, 21:02:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:02:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:02:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:02:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:02:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:02:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:02:07 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:02:07 INFO - 'talos_options': ['--disable-e10s'], 21:02:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:02:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:02:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:02:07 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:02:07 INFO - 'talos_options': ['--disable-e10s'], 21:02:07 INFO - 'tests': ['damp', 'tps']}, 21:02:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:02:07 INFO - 'tests': ['damp', 'tps']}, 21:02:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:02:07 INFO - 'tests': ['dromaeo_dom']}, 21:02:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:02:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:02:07 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 21:02:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:02:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:02:07 INFO - 'tests': ['a11yr', 21:02:07 INFO - 'ts_paint', 21:02:07 INFO - 'tpaint', 21:02:07 INFO - 'sessionrestore', 21:02:07 INFO - 'sessionrestore_no_auto_restore', 21:02:07 INFO - 'tabpaint']}, 21:02:07 INFO - 'other-e10s': {'tests': ['a11yr', 21:02:07 INFO - 'ts_paint', 21:02:07 INFO - 'tpaint', 21:02:07 INFO - 'sessionrestore', 21:02:07 INFO - 'sessionrestore_no_auto_restore', 21:02:07 INFO - 'tabpaint']}, 21:02:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:02:07 INFO - 'ts_paint', 21:02:07 INFO - 'tpaint', 21:02:07 INFO - 'sessionrestore', 21:02:07 INFO - 'sessionrestore_no_auto_restore', 21:02:07 INFO - 'tabpaint']}, 21:02:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:02:07 INFO - 'ts_paint', 21:02:07 INFO - 'tpaint', 21:02:07 INFO - 'sessionrestore', 21:02:07 INFO - 'sessionrestore_no_auto_restore', 21:02:07 INFO - 'tabpaint']}, 21:02:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:02:07 INFO - 'tests': ['a11yr', 21:02:07 INFO - 'ts_paint', 21:02:07 INFO - 'tpaint', 21:02:07 INFO - 'sessionrestore', 21:02:07 INFO - 'sessionrestore_no_auto_restore', 21:02:07 INFO - 'tabpaint']}, 21:02:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:02:07 INFO - 'tests': ['a11yr', 21:02:07 INFO - 'ts_paint', 21:02:07 INFO - 'tpaint', 21:02:07 INFO - 'sessionrestore', 21:02:07 INFO - 'sessionrestore_no_auto_restore', 21:02:07 INFO - 'tabpaint']}, 21:02:07 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 21:02:07 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 21:02:07 INFO - 'bloom_basic_ref']}, 21:02:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:02:07 INFO - 'tests': ['tsvgx', 21:02:07 INFO - 'tsvgr_opacity', 21:02:07 INFO - 'tart', 21:02:07 INFO - 'tscrollx', 21:02:07 INFO - 'cart', 21:02:07 INFO - 'tsvg_static']}, 21:02:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:02:07 INFO - 'tsvgr_opacity', 21:02:07 INFO - 'tart', 21:02:07 INFO - 'tscrollx', 21:02:07 INFO - 'cart', 21:02:07 INFO - 'tsvg_static']}, 21:02:07 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:02:07 INFO - 'talos_options': ['--disable-e10s'], 21:02:07 INFO - 'tests': ['tp5o']}, 21:02:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:02:07 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:02:07 INFO - 'talos_options': ['--disable-e10s', 21:02:07 INFO - '--xperf_path', 21:02:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:02:07 INFO - 'tests': ['tp5n']}, 21:02:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:02:07 INFO - 'talos_options': ['--xperf_path', 21:02:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:02:07 INFO - 'tests': ['tp5n']}}, 21:02:07 INFO - 'talos.zip': {'path': '', 21:02:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:02:07 INFO - Running post-action listener: _resource_record_post_action 21:02:07 INFO - [mozharness: 2017-05-08 04:02:07.282227Z] Finished populate-webroot step (success) 21:02:07 INFO - [mozharness: 2017-05-08 04:02:07.282315Z] Running create-virtualenv step. 21:02:07 INFO - Running pre-action listener: _resource_record_pre_action 21:02:07 INFO - Running main action method: create_virtualenv 21:02:07 INFO - Creating virtualenv /builds/slave/test/build/venv 21:02:07 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 21:02:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:02:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:02:07 INFO - Using real prefix '/usr' 21:02:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:02:07 INFO - Installing distribute.............................................................................................................................................................................................done. 21:02:09 INFO - Installing pip.................done. 21:02:09 INFO - Return code: 0 21:02:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:02:10 INFO - Reading from file tmpfile_stdout 21:02:10 INFO - Output received: 21:02:10 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) 21:02:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2000a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a3a30>, '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 0x21a47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a4ca0>, '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': 'db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716', '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 21:02:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:02:10 INFO - Using env: {'DISPLAY': ':0', 21:02:10 INFO - 'HOME': '/home/cltbld', 21:02:10 INFO - 'LANG': 'en_US.UTF-8', 21:02:10 INFO - 'LANGUAGE': 'en_US:en', 21:02:10 INFO - 'LOGNAME': 'cltbld', 21:02:10 INFO - 'MAIL': '/var/mail/cltbld', 21:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:10 INFO - 'MOZ_NO_REMOTE': '1', 21:02:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:10 INFO - 'NO_EM_RESTART': '1', 21:02:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:10 INFO - 'PWD': '/builds/slave/test', 21:02:10 INFO - 'SHELL': '/bin/bash', 21:02:10 INFO - 'SHLVL': '1', 21:02:10 INFO - 'TERM': 'linux', 21:02:10 INFO - 'TMOUT': '86400', 21:02:10 INFO - 'USER': 'cltbld', 21:02:10 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716', 21:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:10 INFO - '_': '/tools/buildbot/bin/python'} 21:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:10 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 21:02:10 INFO - Cleaning up... 21:02:10 INFO - Return code: 0 21:02:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2000a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a3a30>, '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 0x21a47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a4ca0>, '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': 'db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716', '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 21:02:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:02:10 INFO - Using env: {'DISPLAY': ':0', 21:02:10 INFO - 'HOME': '/home/cltbld', 21:02:10 INFO - 'LANG': 'en_US.UTF-8', 21:02:10 INFO - 'LANGUAGE': 'en_US:en', 21:02:10 INFO - 'LOGNAME': 'cltbld', 21:02:10 INFO - 'MAIL': '/var/mail/cltbld', 21:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:10 INFO - 'MOZ_NO_REMOTE': '1', 21:02:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:10 INFO - 'NO_EM_RESTART': '1', 21:02:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:10 INFO - 'PWD': '/builds/slave/test', 21:02:10 INFO - 'SHELL': '/bin/bash', 21:02:10 INFO - 'SHLVL': '1', 21:02:10 INFO - 'TERM': 'linux', 21:02:10 INFO - 'TMOUT': '86400', 21:02:10 INFO - 'USER': 'cltbld', 21:02:10 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716', 21:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:10 INFO - '_': '/tools/buildbot/bin/python'} 21:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:10 INFO - Downloading/unpacking psutil>=3.1.1 21:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:02:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:02:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:02:11 INFO - Installing collected packages: psutil 21:02:11 INFO - Running setup.py install for psutil 21:02:11 INFO - building 'psutil._psutil_linux' extension 21:02:11 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 21:02:11 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 21:02:11 INFO - building 'psutil._psutil_posix' extension 21:02:11 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 21:02:12 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 21:02:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:02:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:02:12 INFO - Successfully installed psutil 21:02:12 INFO - Cleaning up... 21:02:12 INFO - Return code: 0 21:02:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:02:12 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')]} 21:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:12 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')]} 21:02:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:12 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 0x1e341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2000a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a3a30>, '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 0x21a47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a4ca0>, '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': 'db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716', '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 21:02:12 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 21:02:12 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 21:02:12 INFO - Using env: {'DISPLAY': ':0', 21:02:12 INFO - 'HOME': '/home/cltbld', 21:02:12 INFO - 'LANG': 'en_US.UTF-8', 21:02:12 INFO - 'LANGUAGE': 'en_US:en', 21:02:12 INFO - 'LOGNAME': 'cltbld', 21:02:12 INFO - 'MAIL': '/var/mail/cltbld', 21:02:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:12 INFO - 'MOZ_NO_REMOTE': '1', 21:02:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:12 INFO - 'NO_EM_RESTART': '1', 21:02:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:12 INFO - 'PWD': '/builds/slave/test', 21:02:12 INFO - 'SHELL': '/bin/bash', 21:02:12 INFO - 'SHLVL': '1', 21:02:12 INFO - 'TERM': 'linux', 21:02:12 INFO - 'TMOUT': '86400', 21:02:12 INFO - 'USER': 'cltbld', 21:02:12 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716', 21:02:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:12 INFO - '_': '/tools/buildbot/bin/python'} 21:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:02:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:02:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:02:13 INFO - Installing collected packages: mozsystemmonitor 21:02:13 INFO - Running setup.py install for mozsystemmonitor 21:02:13 INFO - Successfully installed mozsystemmonitor 21:02:13 INFO - Cleaning up... 21:02:13 INFO - Return code: 0 21:02:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:13 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 0x1e341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2000a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a3a30>, '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 0x21a47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a4ca0>, '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': 'db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716', '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 21:02:13 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 21:02:13 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 21:02:13 INFO - Using env: {'DISPLAY': ':0', 21:02:13 INFO - 'HOME': '/home/cltbld', 21:02:13 INFO - 'LANG': 'en_US.UTF-8', 21:02:13 INFO - 'LANGUAGE': 'en_US:en', 21:02:13 INFO - 'LOGNAME': 'cltbld', 21:02:13 INFO - 'MAIL': '/var/mail/cltbld', 21:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:13 INFO - 'MOZ_NO_REMOTE': '1', 21:02:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:13 INFO - 'NO_EM_RESTART': '1', 21:02:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:13 INFO - 'PWD': '/builds/slave/test', 21:02:13 INFO - 'SHELL': '/bin/bash', 21:02:13 INFO - 'SHLVL': '1', 21:02:13 INFO - 'TERM': 'linux', 21:02:13 INFO - 'TMOUT': '86400', 21:02:13 INFO - 'USER': 'cltbld', 21:02:13 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716', 21:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:13 INFO - '_': '/tools/buildbot/bin/python'} 21:02:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:13 INFO - Downloading/unpacking jsonschema==2.5.1 21:02:13 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 21:02:13 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 21:02:13 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 21:02:13 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 21:02:13 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 21:02:13 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 21:02:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:02:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:02:14 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 21:02:14 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 21:02:14 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 21:02:14 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 21:02:14 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 21:02:14 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 21:02:15 INFO - Downloading functools32-3.2.3-2.tar.gz 21:02:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:02:15 INFO - warning: no files found matching '*.txt' 21:02:15 INFO - no previously-included directories found matching 'build' 21:02:15 INFO - no previously-included directories found matching 'dist' 21:02:15 INFO - no previously-included directories found matching '.git*' 21:02:15 INFO - Installing collected packages: jsonschema, functools32 21:02:15 INFO - Running setup.py install for functools32 21:02:15 INFO - warning: no files found matching '*.txt' 21:02:15 INFO - no previously-included directories found matching 'build' 21:02:15 INFO - no previously-included directories found matching 'dist' 21:02:15 INFO - no previously-included directories found matching '.git*' 21:02:15 INFO - Successfully installed jsonschema functools32 21:02:15 INFO - Cleaning up... 21:02:15 INFO - Return code: 0 21:02:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:02:15 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')]} 21:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:15 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')]} 21:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:15 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 0x1e341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2000a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a3a30>, '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 0x21a47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a4ca0>, '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': 'db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716', '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 21:02:15 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 21:02:15 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 21:02:15 INFO - Using env: {'DISPLAY': ':0', 21:02:15 INFO - 'HOME': '/home/cltbld', 21:02:15 INFO - 'LANG': 'en_US.UTF-8', 21:02:15 INFO - 'LANGUAGE': 'en_US:en', 21:02:15 INFO - 'LOGNAME': 'cltbld', 21:02:15 INFO - 'MAIL': '/var/mail/cltbld', 21:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:15 INFO - 'MOZ_NO_REMOTE': '1', 21:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:15 INFO - 'NO_EM_RESTART': '1', 21:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:15 INFO - 'PWD': '/builds/slave/test', 21:02:15 INFO - 'SHELL': '/bin/bash', 21:02:15 INFO - 'SHLVL': '1', 21:02:15 INFO - 'TERM': 'linux', 21:02:15 INFO - 'TMOUT': '86400', 21:02:15 INFO - 'USER': 'cltbld', 21:02:15 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716', 21:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:15 INFO - '_': '/tools/buildbot/bin/python'} 21:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:02:15 INFO - Cleaning up... 21:02:15 INFO - Return code: 0 21:02:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:02:15 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')]} 21:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:15 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')]} 21:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:15 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 0x1e341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2000a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a3a30>, '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 0x21a47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a4ca0>, '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': 'db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716', '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 21:02:15 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 21:02:15 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 21:02:15 INFO - Using env: {'DISPLAY': ':0', 21:02:15 INFO - 'HOME': '/home/cltbld', 21:02:15 INFO - 'LANG': 'en_US.UTF-8', 21:02:15 INFO - 'LANGUAGE': 'en_US:en', 21:02:15 INFO - 'LOGNAME': 'cltbld', 21:02:15 INFO - 'MAIL': '/var/mail/cltbld', 21:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:15 INFO - 'MOZ_NO_REMOTE': '1', 21:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:15 INFO - 'NO_EM_RESTART': '1', 21:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:15 INFO - 'PWD': '/builds/slave/test', 21:02:15 INFO - 'SHELL': '/bin/bash', 21:02:15 INFO - 'SHLVL': '1', 21:02:15 INFO - 'TERM': 'linux', 21:02:15 INFO - 'TMOUT': '86400', 21:02:15 INFO - 'USER': 'cltbld', 21:02:15 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716', 21:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:15 INFO - '_': '/tools/buildbot/bin/python'} 21:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:15 INFO - Downloading/unpacking blobuploader==1.2.4 21:02:15 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 21:02:15 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 21:02:15 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 21:02:15 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 21:02:15 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 21:02:15 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 21:02:16 INFO - Downloading blobuploader-1.2.4.tar.gz 21:02:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:02:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:02:16 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 21:02:16 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 21:02:16 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 21:02:16 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 21:02:16 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 21:02:16 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 21:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:02:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:02:17 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 21:02:17 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 21:02:17 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 21:02:17 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 21:02:17 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 21:02:17 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 21:02:17 INFO - Downloading docopt-0.6.1.tar.gz 21:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:02:17 INFO - Installing collected packages: blobuploader, requests, docopt 21:02:17 INFO - Running setup.py install for blobuploader 21:02:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:02:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:02:17 INFO - Running setup.py install for requests 21:02:17 INFO - Running setup.py install for docopt 21:02:18 INFO - Successfully installed blobuploader requests docopt 21:02:18 INFO - Cleaning up... 21:02:18 INFO - Return code: 0 21:02:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:02:18 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')]} 21:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:18 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')]} 21:02:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:18 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 0x1e341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2000a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a3a30>, '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 0x21a47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a4ca0>, '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': 'db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716', '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 21:02:18 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 21:02:18 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 21:02:18 INFO - Using env: {'DISPLAY': ':0', 21:02:18 INFO - 'HOME': '/home/cltbld', 21:02:18 INFO - 'LANG': 'en_US.UTF-8', 21:02:18 INFO - 'LANGUAGE': 'en_US:en', 21:02:18 INFO - 'LOGNAME': 'cltbld', 21:02:18 INFO - 'MAIL': '/var/mail/cltbld', 21:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:18 INFO - 'MOZ_NO_REMOTE': '1', 21:02:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:18 INFO - 'NO_EM_RESTART': '1', 21:02:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:18 INFO - 'PWD': '/builds/slave/test', 21:02:18 INFO - 'SHELL': '/bin/bash', 21:02:18 INFO - 'SHLVL': '1', 21:02:18 INFO - 'TERM': 'linux', 21:02:18 INFO - 'TMOUT': '86400', 21:02:18 INFO - 'USER': 'cltbld', 21:02:18 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716', 21:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:18 INFO - '_': '/tools/buildbot/bin/python'} 21:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:02:18 INFO - Running setup.py (path:/tmp/pip-G6ubKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:02:18 INFO - Running setup.py (path:/tmp/pip-s80gRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:02:18 INFO - Running setup.py (path:/tmp/pip-FtPzUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:02:18 INFO - Running setup.py (path:/tmp/pip-PLntzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:02:18 INFO - Running setup.py (path:/tmp/pip-bigBVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:02:18 INFO - Running setup.py (path:/tmp/pip-zpuMZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:02:18 INFO - Running setup.py (path:/tmp/pip-Fd3Jde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:02:18 INFO - Running setup.py (path:/tmp/pip-AZhXPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:02:18 INFO - Running setup.py (path:/tmp/pip-3Re_8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:02:18 INFO - Running setup.py (path:/tmp/pip-2glJHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:02:19 INFO - Running setup.py (path:/tmp/pip-oLUL1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:02:19 INFO - Running setup.py (path:/tmp/pip-Z5KH5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:02:19 INFO - Running setup.py (path:/tmp/pip-kDQuWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:02:19 INFO - Running setup.py (path:/tmp/pip-_r1pN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:02:19 INFO - Running setup.py (path:/tmp/pip-gebPVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:02:19 INFO - Running setup.py (path:/tmp/pip-SYrDMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:02:19 INFO - Running setup.py (path:/tmp/pip-3jCC_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:02:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:02:19 INFO - Running setup.py install for manifestparser 21:02:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:02:19 INFO - Running setup.py install for mozcrash 21:02:19 INFO - Running setup.py install for mozdebug 21:02:19 INFO - Running setup.py install for mozdevice 21:02:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:02:19 INFO - Running setup.py install for mozfile 21:02:20 INFO - Running setup.py install for mozhttpd 21:02:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:02:20 INFO - Running setup.py install for mozinfo 21:02:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:02:20 INFO - Running setup.py install for mozInstall 21:02:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:02:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:02:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:02:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:02:20 INFO - Running setup.py install for mozleak 21:02:20 INFO - Running setup.py install for mozlog 21:02:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:02:20 INFO - Running setup.py install for moznetwork 21:02:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:02:20 INFO - Running setup.py install for mozprocess 21:02:20 INFO - Running setup.py install for mozprofile 21:02:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:02:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:02:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:02:20 INFO - Running setup.py install for mozrunner 21:02:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:02:20 INFO - Running setup.py install for mozscreenshot 21:02:21 INFO - Running setup.py install for moztest 21:02:21 INFO - Running setup.py install for mozversion 21:02:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:02:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:02:21 INFO - Cleaning up... 21:02:21 INFO - Return code: 0 21:02:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:21 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 0x1e341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2000a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a3a30>, '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 0x21a47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a4ca0>, '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': 'db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716', '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 21:02:21 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 21:02:21 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 21:02:21 INFO - Using env: {'DISPLAY': ':0', 21:02:21 INFO - 'HOME': '/home/cltbld', 21:02:21 INFO - 'LANG': 'en_US.UTF-8', 21:02:21 INFO - 'LANGUAGE': 'en_US:en', 21:02:21 INFO - 'LOGNAME': 'cltbld', 21:02:21 INFO - 'MAIL': '/var/mail/cltbld', 21:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:21 INFO - 'MOZ_NO_REMOTE': '1', 21:02:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:21 INFO - 'NO_EM_RESTART': '1', 21:02:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:21 INFO - 'PWD': '/builds/slave/test', 21:02:21 INFO - 'SHELL': '/bin/bash', 21:02:21 INFO - 'SHLVL': '1', 21:02:21 INFO - 'TERM': 'linux', 21:02:21 INFO - 'TMOUT': '86400', 21:02:21 INFO - 'USER': 'cltbld', 21:02:21 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716', 21:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:21 INFO - '_': '/tools/buildbot/bin/python'} 21:02:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:02:21 INFO - Running setup.py (path:/tmp/pip-epR1CK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:02:21 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)) 21:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:02:21 INFO - Running setup.py (path:/tmp/pip-t7hsDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:02:21 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)) 21:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:02:21 INFO - Running setup.py (path:/tmp/pip-htteeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:02:21 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)) 21:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:02:21 INFO - Running setup.py (path:/tmp/pip-t3hYU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:02:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:02:21 INFO - Running setup.py (path:/tmp/pip-hZ5q4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:02:21 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)) 21:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:02:21 INFO - Running setup.py (path:/tmp/pip-b3qJ27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:02:21 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)) 21:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:02:21 INFO - Running setup.py (path:/tmp/pip-fPYEsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:02:22 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)) 21:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:02:22 INFO - Running setup.py (path:/tmp/pip-fNHKyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:02:22 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)) 21:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:02:22 INFO - Running setup.py (path:/tmp/pip-5Y5BQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:02:22 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)) 21:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:02:22 INFO - Running setup.py (path:/tmp/pip-rceQMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:02:22 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)) 21:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:02:22 INFO - Running setup.py (path:/tmp/pip-gy7Ldr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:02:22 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)) 21:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:02:22 INFO - Running setup.py (path:/tmp/pip-3D4myA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:02:22 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)) 21:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:02:22 INFO - Running setup.py (path:/tmp/pip-aRBHpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:02:22 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)) 21:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:02:22 INFO - Running setup.py (path:/tmp/pip-xIXFPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:02:22 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)) 21:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:02:22 INFO - Running setup.py (path:/tmp/pip-W0F_nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:02:22 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)) 21:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:02:22 INFO - Running setup.py (path:/tmp/pip-SGbErH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:02:22 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)) 21:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:02:22 INFO - Running setup.py (path:/tmp/pip-FAZHNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:02:22 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)) 21:02:22 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)) 21:02:22 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)) 21:02:22 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)) 21:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:02:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:02:22 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 21:02:22 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 21:02:22 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 21:02:22 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 21:02:22 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 21:02:22 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 21:02:23 INFO - Downloading blessings-1.6.tar.gz 21:02:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:02:23 INFO - Installing collected packages: blessings 21:02:23 INFO - Running setup.py install for blessings 21:02:23 INFO - Successfully installed blessings 21:02:23 INFO - Cleaning up... 21:02:24 INFO - Return code: 0 21:02:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:02:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:02:24 INFO - Reading from file tmpfile_stdout 21:02:24 INFO - Current package versions: 21:02:24 INFO - argparse == 1.2.1 21:02:24 INFO - blessings == 1.6 21:02:24 INFO - blobuploader == 1.2.4 21:02:24 INFO - docopt == 0.6.1 21:02:24 INFO - functools32 == 3.2.3-2 21:02:24 INFO - jsonschema == 2.5.1 21:02:24 INFO - manifestparser == 1.1 21:02:24 INFO - mozInstall == 1.12 21:02:24 INFO - mozcrash == 1.0 21:02:24 INFO - mozdebug == 0.1 21:02:24 INFO - mozdevice == 0.50 21:02:24 INFO - mozfile == 1.2 21:02:24 INFO - mozhttpd == 0.7 21:02:24 INFO - mozinfo == 0.9 21:02:24 INFO - mozleak == 0.1 21:02:24 INFO - mozlog == 3.4 21:02:24 INFO - moznetwork == 0.27 21:02:24 INFO - mozprocess == 0.25 21:02:24 INFO - mozprofile == 0.28 21:02:24 INFO - mozrunner == 6.13 21:02:24 INFO - mozscreenshot == 0.1 21:02:24 INFO - mozsystemmonitor == 0.3 21:02:24 INFO - moztest == 0.8 21:02:24 INFO - mozversion == 1.4 21:02:24 INFO - psutil == 3.1.1 21:02:24 INFO - requests == 1.2.3 21:02:24 INFO - wsgiref == 0.1.2 21:02:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:02: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')]} 21:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02: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')]} 21:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:24 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 0x1e341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2000a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a3a30>, '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 0x21a47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a4ca0>, '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': 'db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716', '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 21:02:24 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 21:02:24 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 21:02:24 INFO - Using env: {'DISPLAY': ':0', 21:02:24 INFO - 'HOME': '/home/cltbld', 21:02:24 INFO - 'LANG': 'en_US.UTF-8', 21:02:24 INFO - 'LANGUAGE': 'en_US:en', 21:02:24 INFO - 'LOGNAME': 'cltbld', 21:02:24 INFO - 'MAIL': '/var/mail/cltbld', 21:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:24 INFO - 'MOZ_NO_REMOTE': '1', 21:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:24 INFO - 'NO_EM_RESTART': '1', 21:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:24 INFO - 'PWD': '/builds/slave/test', 21:02:24 INFO - 'SHELL': '/bin/bash', 21:02:24 INFO - 'SHLVL': '1', 21:02:24 INFO - 'TERM': 'linux', 21:02:24 INFO - 'TMOUT': '86400', 21:02:24 INFO - 'USER': 'cltbld', 21:02:24 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716', 21:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:24 INFO - '_': '/tools/buildbot/bin/python'} 21:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:24 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)) 21:02:24 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)) 21:02:24 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)) 21:02:24 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)) 21:02:24 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)) 21:02:24 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)) 21:02:24 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)) 21:02:24 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)) 21:02:24 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)) 21:02:24 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)) 21:02:24 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)) 21:02:24 INFO - Cleaning up... 21:02:24 INFO - Return code: 0 21:02:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:02: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')]} 21:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02: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')]} 21:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2000a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a3a30>, '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 0x21a47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a4ca0>, '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': 'db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716', '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 21:02:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:02:24 INFO - Using env: {'DISPLAY': ':0', 21:02:24 INFO - 'HOME': '/home/cltbld', 21:02:24 INFO - 'LANG': 'en_US.UTF-8', 21:02:24 INFO - 'LANGUAGE': 'en_US:en', 21:02:24 INFO - 'LOGNAME': 'cltbld', 21:02:24 INFO - 'MAIL': '/var/mail/cltbld', 21:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:24 INFO - 'MOZ_NO_REMOTE': '1', 21:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:24 INFO - 'NO_EM_RESTART': '1', 21:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:24 INFO - 'PWD': '/builds/slave/test', 21:02:24 INFO - 'SHELL': '/bin/bash', 21:02:24 INFO - 'SHLVL': '1', 21:02:24 INFO - 'TERM': 'linux', 21:02:24 INFO - 'TMOUT': '86400', 21:02:24 INFO - 'USER': 'cltbld', 21:02:24 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716', 21:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:24 INFO - '_': '/tools/buildbot/bin/python'} 21:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:02:24 INFO - Cleaning up... 21:02:24 INFO - Return code: 0 21:02:24 INFO - Running post-action listener: _resource_record_post_action 21:02:24 INFO - Running post-action listener: _start_resource_monitoring 21:02:24 INFO - Starting resource monitoring. 21:02:24 INFO - [mozharness: 2017-05-08 04:02:24.747479Z] Finished create-virtualenv step (success) 21:02:24 INFO - [mozharness: 2017-05-08 04:02:24.747940Z] Running install step. 21:02:24 INFO - Running pre-action listener: _resource_record_pre_action 21:02:24 INFO - Running main action method: install 21:02:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:02:24 INFO - Reading from file tmpfile_stdout 21:02:24 INFO - Detecting whether we're running mozinstall >=1.0... 21:02:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:02:25 INFO - Reading from file tmpfile_stdout 21:02:25 INFO - Output received: 21:02:25 INFO - Usage: mozinstall [options] installer 21:02:25 INFO - Options: 21:02:25 INFO - -h, --help show this help message and exit 21:02:25 INFO - -d DEST, --destination=DEST 21:02:25 INFO - Directory to install application into. [default: 21:02:25 INFO - "/builds/slave/test"] 21:02:25 INFO - --app=APP Application being installed. [default: firefox] 21:02:25 INFO - mkdir: /builds/slave/test/build/application 21:02:25 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'] 21:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:02:41 INFO - Reading from file tmpfile_stdout 21:02:41 INFO - Output received: 21:02:41 INFO - /builds/slave/test/build/application/firefox/firefox 21:02:41 INFO - Running post-action listener: _resource_record_post_action 21:02:41 INFO - [mozharness: 2017-05-08 04:02:41.202058Z] Finished install step (success) 21:02:41 INFO - [mozharness: 2017-05-08 04:02:41.202186Z] Running run-tests step. 21:02:41 INFO - Running pre-action listener: _resource_record_pre_action 21:02:41 INFO - Running main action method: run_tests 21:02:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:02:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:02:41 INFO - Python 2.7.3 21:02:41 INFO - Return code: 0 21:02:41 INFO - grabbing minidump binary from tooltool 21:02:41 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')]} 21:02:41 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 0x21a3a30>, '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 0x21a47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a4ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:02:41 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 21:02:41 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 21:02:41 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 21:02:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:02:41 INFO - Return code: 0 21:02:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:02:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:02:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:02:41 INFO - ENV: RUST_BACKTRACE is now 1 21:02:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:02:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:02:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 21:02:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 21:02:41 INFO - Using env: {'DISPLAY': ':0', 21:02:41 INFO - 'HOME': '/home/cltbld', 21:02:41 INFO - 'LANG': 'en_US.UTF-8', 21:02:41 INFO - 'LANGUAGE': 'en_US:en', 21:02:41 INFO - 'LOGNAME': 'cltbld', 21:02:41 INFO - 'MAIL': '/var/mail/cltbld', 21:02:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:02:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:41 INFO - 'MOZ_NO_REMOTE': '1', 21:02:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:02:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:41 INFO - 'NO_EM_RESTART': '1', 21:02:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:41 INFO - 'PWD': '/builds/slave/test', 21:02:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:02:41 INFO - 'RUST_BACKTRACE': '1', 21:02:41 INFO - 'SHELL': '/bin/bash', 21:02:41 INFO - 'SHLVL': '1', 21:02:41 INFO - 'TERM': 'linux', 21:02:41 INFO - 'TMOUT': '86400', 21:02:41 INFO - 'USER': 'cltbld', 21:02:41 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716', 21:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:41 INFO - '_': '/tools/buildbot/bin/python'} 21:02:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 21:02:41 INFO - mozversion application_buildid: 20170508031158 21:02:41 INFO - mozversion application_changeset: c3e5497cff1c995821b1c9320fa71f1ef9a8c30e 21:02:41 INFO - mozversion application_display_name: Nightly 21:02:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:02:41 INFO - mozversion application_name: Firefox 21:02:41 INFO - mozversion application_remotingname: firefox 21:02:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:02:41 INFO - mozversion application_vendor: Mozilla 21:02:41 INFO - mozversion application_version: 55.0a1 21:02:41 INFO - mozversion platform_buildid: 20170508031158 21:02:41 INFO - mozversion platform_changeset: c3e5497cff1c995821b1c9320fa71f1ef9a8c30e 21:02:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:02:41 INFO - mozversion platform_version: 55.0a1 21:02:41 INFO - using testdate: 1494216161 21:02:41 INFO - actual date: 1494216161 21:02:41 INFO - starting webserver on 'localhost:48933' 21:02:41 INFO - SUITE-START | Running 2 tests 21:02:41 INFO - TEST-START | dromaeo_css 21:02:41 INFO - operating with platform_type : linux_ 21:02:41 INFO - Initialising browser for dromaeo_css test... 21:02:41 INFO - TEST-INFO | started process 4172 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWw4jeg/profile http://localhost:48933/getInfo.html) 21:02:45 INFO - PID 4172 | __metrics Screen width/height:1600/1200 21:02:45 INFO - PID 4172 | colorDepth:24 21:02:45 INFO - PID 4172 | Browser inner width/height: 1024/695 21:02:45 INFO - PID 4172 | __metrics 21:02:47 INFO - TEST-INFO | 4172: exit 0 21:02:47 INFO - Browser initialized. 21:02:47 INFO - Running cycle 1/1 for dromaeo_css test... 21:02:47 INFO - TEST-INFO | started process 4346 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWw4jeg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:02:59 INFO - PID 4346 | RSS: Main: 156438528 21:02:59 INFO - PID 4346 | 21:06:01 INFO - PID 4346 | Cycle 1(1): loaded http://localhost:48933/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48933/tests/dromaeo/cssquery-ext.html) 21:06:02 INFO - PID 4346 | RSS: Main: 161615872 21:06:02 INFO - PID 4346 | 21:09:04 INFO - PID 4346 | Cycle 1(1): loaded http://localhost:48933/tests/dromaeo/cssquery-ext.html (next: http://localhost:48933/tests/dromaeo/cssquery-jquery.html) 21:09:04 INFO - PID 4346 | RSS: Main: 156864512 21:09:04 INFO - PID 4346 | 21:12:06 INFO - PID 4346 | Cycle 1(1): loaded http://localhost:48933/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48933/tests/dromaeo/cssquery-mootools.html) 21:12:07 INFO - PID 4346 | RSS: Main: 166891520 21:12:07 INFO - PID 4346 | 21:15:08 INFO - PID 4346 | Cycle 1(1): loaded http://localhost:48933/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48933/tests/dromaeo/cssquery-prototype.html) 21:15:09 INFO - PID 4346 | RSS: Main: 157433856 21:15:09 INFO - PID 4346 | 21:18:12 INFO - PID 4346 | Cycle 1(1): loaded http://localhost:48933/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48933/tests/dromaeo/cssquery-yui.html) 21:18:12 INFO - PID 4346 | RSS: Main: 162955264 21:18:12 INFO - PID 4346 | 21:21:14 INFO - PID 4346 | Cycle 1(1): loaded http://localhost:48933/tests/dromaeo/cssquery-yui.html (next: http://localhost:48933/tests/dromaeo/cssquery-dojo.html) 21:21:14 INFO - PID 4346 | RSS: Main: 162918400 21:21:14 INFO - PID 4346 | 21:21:14 INFO - PID 4346 | __start_tp_report 21:21:14 INFO - PID 4346 | _x_x_mozilla_page_load 21:21:14 INFO - PID 4346 | _x_x_mozilla_page_load_details 21:21:14 INFO - PID 4346 | |i|pagename|runs| 21:21:14 INFO - PID 4346 | |0;dojo.html;3412.3516531858945;3431.4166591679414;3435.038189306995;3457.4813777933305;3471.1842716961523;5891.322497912742;6005;6023.036314189725;6059.060845568938;6088.208532890718;5994.550408719352;5998.370171132034;6007.57946943713;6141.6622085785375;6141.692915354237;5286.4449232830575;5323.653962492445;5351.036813373591;5358.437364076774;5370.570354371651;5354.170103633924;5364.7317634118335;5441.156620723775;5443.1835224716415;5457.836264912039;5218.13900706383;5270;5350.892982140374;5433.239346491494;5442.346918369782;5277.102892508283;5282.392524859613;5288.6826790392315;5299.125644268691;5304.310439642822;5187;5258.55302299305;5272.868178295535;5277.023750606112;5278.392984806758;5841.415858414124;5899.76400943966;5955.808838232371;6038.909416358758;6069.332373438918;6455.612663240174;6480.384363485461;6516.8696626067685;6525.184351956005;6528.183977002875;6421.357864213588;6528.706208220641;6550.115734375893;6565.835854103638;6575.671216439207;6018.759249630053;6127.20346354971;6134.049222370495;6147.047207682816;6150.231221097363;6578.638174900427;6614.437772789271;6618.768343107968;6680.866382672417;6689.163854518185;6213.751449942042;6326.873462530723;6484.286728459866;6504.219493660791;6512.674366281667;6446.484281257488;6538.901916471256;6548.934510654928;6555.278919318871;6572.244191917895;6288.9056664150075;6500.512461565401;6507.674616269168;6513.088167656532;6514.348565143448;6406.583572067801;6412.743490260431;6509.9023514647315;6514.674266286666;6587.473002159816;4925.630577706686;4944.950550494521;4945.282933974553;4950.3069570260195;4967.602591792648;4386.912261754747;4399;4399.340098985113;4409.845655402046;4437.29003359461;6011.7595296187665;6065.696715164224;6073.271207455045;6074.179985701962;6106.72519736613;6384.042393640991;6404.551681382259;6446.774362897276;6501.934980650133;6527.2167339919515;6128.233970753656;6194.4115309045565;6214.502839772807;6219.689015549205;6224.875502490016;5668.744906479218;5730.19777231188;5733.197352370671;5733.77064917407;5747.339056008613;6646.26891041985;6743.35938085881;6795.7961261162245;6920.688569014305;6926.549774264657;6628.5691430056895;6633.867322653617;6636.601803891782;6639.601623902581;6662.700178491883;6875.243723190545;6926.653667316715;6927.480438966997;6942.618156001468;6955.721771129098;6278.6546739929745;6365.809025729235;6372.235331760033;6487.513436492188;6493.902591461227;6592.373724496165;6639.136912201383;6655.068290439245;6655.134832471941;6678.198616166092;6181.721822517908;6246.3441338660605;6266.937330626635;6315;6315.715792789428;6391.936080639134;6424.935750642434;6425.871482570229;6432.614043157426;6437.5171862111465;6187.071939209155;6210.472109870531;6218.378162183745;6366.4588509977175;6413.679316034273;6403.935960640334;6474.70863811139;6482.643454610042;6499.512536559682;6500.447461965786;6219.626822390671;6277.435030847246;6297.307296197506;6305.464035557029;6308.905366419415 21:21:14 INFO - PID 4346 | |1;ext.html;746.6677328588777;815.2458975447711;834.9666013359464;1139.777743340049;1140.156284349581;36024.81987590062;37546.24907501852;37582.812085939535;37795.055123621925;37861;38966;39160.41259381112;39292.214155716865;39361.60638393615;39450;7123.89314160288;7194.460415468848;7326.597037162954;7338.77983660491;7356.374708149814;7307.634618269092;7332.30343117403;7352.117745870503;7379.298966598165;7392.482526223166;7365.926340736604;7399.556026638392;7407.592582407965;7449.515781474214;7449.553026818408;7362.006129172573;7369.152547457057;7374.483786135;7393.445491588099;7393.445491588125;7229.855402891965;7241.782746517613;7252.274772522758;7269.709211631528;7307.342339189446;36992.075198119994;37026.62973370286;37447.43828842569;37560.43659345112;37706.81146594277;3525.347810655037;3561.9643803561894;3574.4459608760685;3578.4274516077303;3586.1572530455323;29308.56037159444;29443;29466.852665736747;29512.11463656094;29572.40855182906;3808.9428658570146;3839.347310957144;3851.345271303885;3854.4025676019983;3876.573576906538;201959;204060;213017;218782.90608547014;218899;47734.28398574024;47907.520924791;47970.76014619974;48031.27953080706;48038;48785.5121448781;48981;49067.754661227176;49119.26321105186;49195;15673;15697.607559811097;15779.132147731756;15859.682806344039;15863;12746.553870614483;12948.223106613445;13017.284049377186;13020;13047.347632618332;14310;14322.57032289033;14342.498012569718;14549.490767823076;14670.779938300933;5858.794942177088;5893.764249429974;5940.108983652401;6040.788572399945;6103.84740381494;1022.0137567247642;1071.3946620159586;1094.3762055628215;1113.821788513834;1114.8104822180248;25400.618990715153;25484.49031019369;25839.61240581393;25890.87054564715;26122.86938565295;1198.7063169523522;1201.4293210724836;1204.1089593700774;1219.85361756588;1222.9633111006683;13712;13731.656708582366;13925.373358198905;13998.090124141898;14002.57992260234;270525;270786;271242;271391;273445;53359.73320133374;53962.46037539574;54026;54043.45956540463;54116.72941635345;1509.954701358961;1540.5224380442323;1564.7965764450548;1577.384819920232;1580.8182059063356;23839.76160238445;24723.381915451537;24868;25004.231592572167;25233.243002709947;48312.51687483221;49993;50006;50030.249546256106;50218.24672629987;234528;234853;235940;236198;237387;34400.139996500286;35472;35734.28531429305;36236;36274.637253628185;43387;43476.78261608672;45489;46128.769356153;46245.53754462412;33064.66935330712;33101.834490827394;33352.66647333495;34029.82985085059;34961.65038349584;32566.185845354055;33963.3207335847;34637.82681086679;34848.65151348454;34893.825530872185;37565.06087347729;39056.609433905294;39188.6081139185;39195;39245.21509569736;32465.188370290933;32512.83743581267;33468;33829.83085084657;34054;24504.50990980135;26296.34259143537;26875.071853802783;26953.326166845985;26954.460910782065 21:21:14 INFO - PID 4346 | |2;jquery.html;446.4085087259378;449.438202247191;454.7771591919959;466.7223002313626;468.08722990169167;20342.89828550857;21060.89469552654;21575.67636485454;22326.33021009368;22598.43503912403;22178.778212217872;22339.888300558476;22758.203462878802;22776.8861155694;23188.65217021746;4186.706930514865;5530.723463826813;5694.174344720013;5700.600957932926;5721.628094173865;5182.222666600002;5416.1063424534905;5526.778928842861;5573.359063707665;5576.275084239043;5514.91727624086;5540.722963851791;5542.418046105161;5553.333599968009;5555.722213889309;5477.178423236526;5499.7250137492965;5710.257666503369;5734.111212762028;5762.481376676119;5148.845534633967;5178.249153872667;5206.531412172884;5221.060209162387;5244.1871509915645;24963.750362496507;25614.23157305284;25791.226263212135;26000.609990850153;26081.60877586838;2193.7806219378094;2214.9335519934266;2236.1390864517116;2236.6197746383154;2240.2943072931976;16480.587985300463;17446;17584.736228956575;17703.203355848887;17731.73402398965;2060.2789023841538;2124.5538436928264;2198.1976578548874;2220.6668999650183;2253.3690566641367;110892.33661495084;119380;119825;120703.39648301703;121358.39320803428;12585.685357866127;12679.556215532411;12728.936355318165;13185.934070329778;13258.337083145998;18027.459176224733;18058.277668893097;18064;18112.637747245244;18168.273269069352;8546.444481108832;8712.085231050774;8741.868871966926;8848.274586455707;8862.822743545094;7737.961310193413;7738.4969976951315;7742.961285193538;7999.760007199793;8023.759287221393;7993.120756716757;8260.489292050974;8280.710175143962;8380.706675266336;8382.622781974826;2300.493891343902;2343.308723926446;2352.447174913894;2370;2527.620856871484;999.9950000250097;1052.9473526323652;1054.3989925742253;1064.8455973883742;1064.893510648929;19644.607107857762;20602.690959635616;20934.441145005385;20941.371758847257;21070;1045.3832238978887;1049.7533079726259;1057.434272664121;1059.8834128245887;1060.5068643081004;10960.56157753681;11283;11362.772744545064;11412.771744565061;11456.427178641035;511479;514639;519337.24307919864;525697;525802;99360;100317;101258;103271;105307.99148161824;1147.8002137962624;1198.3349241171234;1226.693326668333;1230.4217018001525;1231.1751126744923;17381.52706774836;17734.645307094044;17766.555836103682;17849.464516064538;17915.641687166444;46306.536934630225;46885.76557117193;47096.76451617857;48024.7598762004;48564;57536;59039.70480147572;59200.407995919486;59293;59396.406035939086;9282.257419406296;9381.014993425864;9482.715518534455;9512.191463725661;9862.605495780088;14135.15189088658;14687.779683304545;14920.104793712411;15135.924320378328;15146.545603631908;12380.257184568954;12563.560275390682;12830.935845320713;12909.741805164032;13017.088803783645;11687.532498699957;11774.705632358917;12143.574974875837;12357.196782209128;12721.8550330467;12912.031597630028;12957.546485872948;13016.544420945222;13073.607791765882;13142.080054396101;9387.577559009998;9573.904260957579;9858.950705246429;9938.602455901972;10182.389056656624;12981.805272921103;13191.934040329737;13318.334083295991;13457.192568445924;13582.117162384413 21:21:14 INFO - PID 4346 | |3;mootools.html;1344.3883033219886;1407.176801571081;1409.5912185466216;1423.1176670464313;1430.9427622895082;10412.791744165123;10913.781724365508;10918.563257469701;11535;11741.119416043788;11089.2237543372;11241.381724005198;11272;11288.322700637947;11292.661220163409;2298.092253559847;2335.1710142899283;2354.988225058872;2355.893984770681;2360.055977608953;2259.412552736284;2319.7912187903084;2340.4031971847157;2344.7303560090554;2350.9882450587806;2260.3445000949787;2262.1177740681146;2306.7577904320055;2306.9653955190684;2309.4341886237894;2185.967210491844;2216.855904366219;2254.368776742515;2261.412032871457;2268.081427022067;2148.387709502784;2225.4436390902274;2245.2366195493446;2253.9774602253933;2260.062074239189;10844.13246940243;10949.45252737368;10959;10995.835062474069;11005.339679619168;6185.8144255672405;6332.810015699536;6335.746570137189;6366.236051673829;6398.552101352907;3760.849566017356;3964.5044369453817;3986.6013398660193;4053.837846486137;4067.1662309226836;1350.5745690107585;1352.4725357110635;1374.3540535948089;1377.6624726941964;1413.1238632048196;15512.069275843372;15535.689286214212;15539.456119035893;15582.142982135978;15665.373385064584;4967.850964471072;5019.171836646912;5112.897742045138;5342.54588359986;5347.518723314843;11721.179517433698;11760.117991150526;11761.529538818351;11765.352905590275;11774.882251177378;6121.143039974407;6137.938620613737;6157.230346206724;6167.259928808572;6169.475594574422;5700.25896633435;5704.743286552115;5792.391798861059;5842.2405087338375;5847.888901108776;4188.560201178893;4259.212045771542;4313.84901528445;4366.672499562545;4382.627476664519;1172.3493461128985;1221.151299846598;1227.5764861122898;1228.3489750432286;1232.9938350308191;853.910339414365;872.8559787635096;876.6318146378409;889.1153302464089;904.1230006893303;6199.907001394983;6290.716917738621;6303.621782693053;6320.747170113144;6412.711427985659;649.9512536559777;658.723336198788;954.2080073538946;960.1454705312277;976.9706908792748;4450.198964186413;4453.3320001999955;4460.041091165415;4535.024969631545;4572.1770081385;13743.175409475463;14016.579502614937;14363.138211707332;14760.63098422548;14783.260836958108;14452.855471445362;14520.491782787552;14553.636159096108;14595.41618335276;14625.0493717908;8869.11308869108;9019.143181397756;9035.457872527539;9102.772430689154;9115.225205857576;7071.266432188339;7297.635118244173;7387.852242955219;7395.963020184865;7508.962455187689;13198.934005329911;13227;13546.187228766306;13712.451501939811;13798.448062077405;13433.596992090253;13535.08995565958;13680.589582312547;13761.655958601115;13794.86205137976;9381.437113773196;9569.521523923637;9631.662891798753;9640.373375730554;9640.75898102553;10490.370577765358;10545.52545135486;10566.260361774603;10597.25819192649;10617.469126543487;9039.322050846082;9243.584038718409;9289.117533834275;9426.95286523563;9465.432074075577;9047.140521650434;9085.273178145864;9085.636574536944;9149.63401463934;9326.580303886205;8215.301699355383;8248.381371397048;8308.501489910625;8316.126806685212;8430.40987130895;5849.473547380756;5921.85195370102;6016.939830601638;6051.636901785907;6194.101855231056;6369.299377068612;6441.967790161019;6460.289368169591;6470.611763294218;6508.8047358579315 21:21:14 INFO - PID 4346 | |4;prototype.html;395.2648074581277;396.81151453059783;413.61139419850366;425.70200859398426;428.86351169401075;5955.821325360235;6089.878202435949;6172.796304720576;6188.535859810515;6193.597416167946;5913.940860591393;6046.395360463951;6055.63830106259;6059.484943779773;6071.87856242876;4762.8333008344625;4767.094252092092;4805;4805.759712014403;4807.03859228154;4648.604868586174;4795.496472870351;4801;4809.831655892044;4824.155772739774;4776.665633405663;4779.235322348425;4801.951980480186;4806.62072274223;4818.566329030386;4824.565789079;4831.323614693928;4842.249451335048;4846.515348465161;4851.902961940777;4269.146170765859;4342.131573685276;4363.629091527224;4381.627561657263;4388.561143885618;5956.7319470623925;5965.135055416984;6007.36922623127;6037.184980027684;6038.607490513146;5612.494875461228;5687.971560142214;5731.885362292773;5735.311762588474;5739.483446489836;6414.294427612959;6523.771667991645;6523.804285871432;6533.314002029766;6561.1142495763415;4877.244027175793;4893.4617192108835;4907.435644900811;4934.25986102084;4937.950620493785;6572.474202063823;6755.695993680296;6765.9661701691175;6766.18805743314;6791.422729068036;4763.4522029967;4779.06808172403;4811.109944660249;4820.132376172322;4832.710037397697;4735.763211839394;4848.95151048485;4860.781264843091;4867.975660121748;4877.585405240523;5495.890082198333;5510.752016159283;5514.779408823682;5560.749766260528;5564.221009058735;6391.904121438182;6547.5416720830035;6563.146790917151;6576.539642225094;6612.735490580323;1746.9388571400193;1783.5273652482103;1786.2676302715824;1790.5523619095227;1791.1581556668345;1229.4221715793562;1247.6194760597923;1253.091508656217;1263.3304348695206;1276.7063575377529;6247.718852651642;6292.2134733158355;6292.30546355549;6302.149209856702;6314.62112273265;6509.44669703071;6718.227403848522;6720.7647732330115;6796.558223715443;6798.8640227196165;6116.339392364336;6169.96915015431;6204.875902482016;6212.875742485125;6248.9062664060075;3467.583889933174;3527.5766907971206;3552.2717842842158;3573.178169021088;3577.195131095483;6827.351401616937;7017.89473157903;7019.262977387403;7068.505204635729;7090.255523170096;6791.864162716718;6840.555363901331;6870.965645171842;6875.656217189121;6921.411680007155;6837.6581170942245;6964.79105626832;6969.581825090409;6999.825004374829;7011.824704382431;6629.5359324846795;6667.766628167991;6698.497612678971;6703.29615390377;6709.161354830646;6385.553011289165;6609;6618.238902526078;6639.240601240578;6677.397424618154;7072.858542829217;7084.326988936043;7124.25195354501;7132.216945763559;7153.749618763319;4475.395821564178;4557.908841823211;4583.977080114578;4591.931121033121;4603.562661547147;6539.6403197824575;6692.866142677021;6696.899546506709;6745.797626071029;6786.966065169642;6526.345246661885;6535.771248006297;6543.443807276435;6555.6066636002;6579.605223686594;6424.325445828121;6477.829926974517;6492.415682588589;6515.218173819172;6569.507286953593;6519.348065193442;6533.67331633426;6537.1501704778075;6548;6557.901631475627;6443.838904027437;6525.184351956005;6543.934560654523;6548.508861835477;6567.835804104936;6387.872242555216;6396.328385519453;6402.359764023747;6403.807885763435;6414.230292364946 21:21:14 INFO - PID 4346 | |5;yui.html;868.8262347530496;890.296665634149;891.5185799668179;894.172890076679;904.8506996345603;16047.759283610741;17119.828801711978;17132.14339283037;17419.564510887234;18885.81114188858;17227.487204094694;17399.652006959885;17623.11884405778;18489.260429582835;19009.144588493516;987.3582171588471;992.2111921022804;992.4640694025218;995.3381001633904;996.2329006664863;998.5306905754284;1031.2162756305224;1035.3425574760045;1043.306201376084;1044.0290529807276;1078.1751959750798;1094.9014588687016;1095.3263742798163;1096.17786660005;1097.7145942055083;1081.6538707613568;1086.5870969031796;1092.5192915117402;1093.3603841752583;1096.9670909872716;797.7048492057976;801.6592947997078;803.907550631679;805.7179987004561;808.9433739638168;16002.679946401007;16204.837951620451;16206.270717817726;16320.836791632051;16423.507294781175;18918.243270269173;18918.43244702661;18924.43226703201;18975.71536426955;19158.04209789505;14329;14390;14548.418063277457;14582.052166609137;14798.40806367744;3430.811305378203;3440.1915549845767;3440.3291358185165;3463.255400088993;3473.444248920186;92129.07870921271;92647.53676231575;92946.53526732323;94249.52875235579;94388.52805735928;14758;14907.254637268094;14930.850691492946;15047.097174169585;15089.698206035819;25323;26853;27067.729322706913;27510.449791004066;27708.168754937386;8442.45124066946;8559.614817333235;8569.785755356166;8614.353923455767;8669.523176225368;3972.3445631471063;3994.0813612868624;4086.468759061303;4087.448194493705;4131.462909821764;4311.461067366579;4327.199468098412;4358.237308471005;4371.650267978554;4380.255356589388;842.8946381702287;843.451756358372;848.7581039403864;854.5556310718516;859.3168431097292;726.6584705188553;729.9452541059336;742.5989965418613;756.5347311403448;768.4735955870135;11771.411429428494;12785.808212876815;12863.678408039686;13046.934765326112;13078.149920255344;707.4022451028873;719.7624783821326;722.5159143373952;733.6515155301189;734.4895297767999;5435.537979271727;5479.287692600016;5492.972535137379;5686.886262274731;5699.5155411790465;82395.52813415487;83022.58488707518;83433;84246.57876710578;87645.12354876497;75248;75517;75599.62200189073;77129;77341.61329193319;67075;67628.32371676416;68256;69113.65443172753;70156;10866.565337386415;11551.653450396501;11581.073514119018;11587.246828956428;11689.88310116888;35157.648423515435;35622.28755424825;36119.09702257464;36731.81634091812;36845.09682694775;43063;44731;44849;44926.3261051091;56032.43967560272;17430.30278788885;17551.736723949405;17653;17704.64590708153;17982.910085450014;19060;19368.128434220776;19449.31927382535;19607.019649017206;20168.89915550413;16912.74630880513;17799.377021804692;18004.279828806702;18329.3584724534;18503.444896653124;16504.092274924995;16523.256453459384;16774.580635483722;16874.831251687818;17027.91486042562;17373.652526949136;17416.390426335016;17452.912735436243;17602.207900644757;17630.294788208328;11063.170262230526;11119.83320250213;11187.384693841917;11197.440127993405;11508;13531.577822723195;13827.723445530832;13902.679245471663;13909.304534773422;13956.371963261881 21:21:14 INFO - PID 4346 | __end_tp_report 21:21:14 INFO - PID 4346 | __start_cc_report 21:21:14 INFO - PID 4346 | _x_x_mozilla_cycle_collect,323 21:21:14 INFO - PID 4346 | __end_cc_report 21:21:14 INFO - PID 4346 | __startTimestamp1494217274569__endTimestamp 21:21:14 INFO - PID 4346 | 21:21:14 INFO - PID 4346 | ------- Summary: start ------- 21:21:14 INFO - PID 4346 | Number of tests: 6 21:21:14 INFO - PID 4346 | 21:21:14 INFO - PID 4346 | [#0] dojo.html Cycles:165 Average:6021.59 Median:6266.94 stddev:737.93 (11.8%) stddev-sans-first:711.24 21:21:14 INFO - PID 4346 | Values: 3412.4 3431.4 3435.0 3457.5 3471.2 5891.3 6005.0 6023.0 6059.1 6088.2 5994.6 5998.4 6007.6 6141.7 6141.7 5286.4 5323.7 5351.0 5358.4 5370.6 5354.2 5364.7 5441.2 5443.2 5457.8 5218.1 5270.0 5350.9 5433.2 5442.3 5277.1 5282.4 5288.7 5299.1 5304.3 5187.0 5258.6 5272.9 5277.0 5278.4 5841.4 5899.8 5955.8 6038.9 6069.3 6455.6 6480.4 6516.9 6525.2 6528.2 6421.4 6528.7 6550.1 6565.8 6575.7 6018.8 6127.2 6134.0 6147.0 6150.2 6578.6 6614.4 6618.8 6680.9 6689.2 6213.8 6326.9 6484.3 6504.2 6512.7 6446.5 6538.9 6548.9 6555.3 6572.2 6288.9 6500.5 6507.7 6513.1 6514.3 6406.6 6412.7 6509.9 6514.7 6587.5 4925.6 4945.0 4945.3 4950.3 4967.6 4386.9 4399.0 4399.3 4409.8 4437.3 6011.8 6065.7 6073.3 6074.2 6106.7 6384.0 6404.6 6446.8 6501.9 6527.2 6128.2 6194.4 6214.5 6219.7 6224.9 5668.7 5730.2 5733.2 5733.8 5747.3 6646.3 6743.4 6795.8 6920.7 6926.5 6628.6 6633.9 6636.6 6639.6 6662.7 6875.2 6926.7 6927.5 6942.6 6955.7 6278.7 6365.8 6372.2 6487.5 6493.9 6592.4 6639.1 6655.1 6655.1 6678.2 6181.7 6246.3 6266.9 6315.0 6315.7 6391.9 6424.9 6425.9 6432.6 6437.5 6187.1 6210.5 6218.4 6366.5 6413.7 6403.9 6474.7 6482.6 6499.5 6500.4 6219.6 6277.4 6297.3 6305.5 6308.9 21:21:14 INFO - PID 4346 | 21:21:14 INFO - PID 4346 | [#1] ext.html Cycles:180 Average:40884.55 Median:19648.12 stddev:62636.02 (318.8%) stddev-sans-first:62739.23 21:21:14 INFO - PID 4346 | Values: 746.7 815.2 835.0 1139.8 1140.2 36024.8 37546.2 37582.8 37795.1 37861.0 38966.0 39160.4 39292.2 39361.6 39450.0 7123.9 7194.5 7326.6 7338.8 7356.4 7307.6 7332.3 7352.1 7379.3 7392.5 7365.9 7399.6 7407.6 7449.5 7449.6 7362.0 7369.2 7374.5 7393.4 7393.4 7229.9 7241.8 7252.3 7269.7 7307.3 36992.1 37026.6 37447.4 37560.4 37706.8 3525.3 3562.0 3574.4 3578.4 3586.2 29308.6 29443.0 29466.9 29512.1 29572.4 3808.9 3839.3 3851.3 3854.4 3876.6 201959.0 204060.0 213017.0 218782.9 218899.0 47734.3 47907.5 47970.8 48031.3 48038.0 48785.5 48981.0 49067.8 49119.3 49195.0 15673.0 15697.6 15779.1 15859.7 15863.0 12746.6 12948.2 13017.3 13020.0 13047.3 14310.0 14322.6 14342.5 14549.5 14670.8 5858.8 5893.8 5940.1 6040.8 6103.8 1022.0 1071.4 1094.4 1113.8 1114.8 25400.6 25484.5 25839.6 25890.9 26122.9 1198.7 1201.4 1204.1 1219.9 1223.0 13712.0 13731.7 13925.4 13998.1 14002.6 270525.0 270786.0 271242.0 271391.0 273445.0 53359.7 53962.5 54026.0 54043.5 54116.7 1510.0 1540.5 1564.8 1577.4 1580.8 23839.8 24723.4 24868.0 25004.2 25233.2 48312.5 49993.0 50006.0 50030.2 50218.2 234528.0 234853.0 235940.0 236198.0 237387.0 34400.1 35472.0 35734.3 36236.0 36274.6 43387.0 43476.8 45489.0 46128.8 46245.5 33064.7 33101.8 33352.7 34029.8 34961.7 32566.2 33963.3 34637.8 34848.7 34893.8 37565.1 39056.6 39188.6 39195.0 39245.2 32465.2 32512.8 33468.0 33829.8 34054.0 24504.5 26296.3 26875.1 26953.3 26954.5 21:21:14 INFO - PID 4346 | 21:21:14 INFO - PID 4346 | [#2] jquery.html Cycles:180 Average:32273.12 Median:12288.01 stddev:86390.59 (703.0%) stddev-sans-first:86599.89 21:21:14 INFO - PID 4346 | Values: 446.4 449.4 454.8 466.7 468.1 20342.9 21060.9 21575.7 22326.3 22598.4 22178.8 22339.9 22758.2 22776.9 23188.7 4186.7 5530.7 5694.2 5700.6 5721.6 5182.2 5416.1 5526.8 5573.4 5576.3 5514.9 5540.7 5542.4 5553.3 5555.7 5477.2 5499.7 5710.3 5734.1 5762.5 5148.8 5178.2 5206.5 5221.1 5244.2 24963.8 25614.2 25791.2 26000.6 26081.6 2193.8 2214.9 2236.1 2236.6 2240.3 16480.6 17446.0 17584.7 17703.2 17731.7 2060.3 2124.6 2198.2 2220.7 2253.4 110892.3 119380.0 119825.0 120703.4 121358.4 12585.7 12679.6 12728.9 13185.9 13258.3 18027.5 18058.3 18064.0 18112.6 18168.3 8546.4 8712.1 8741.9 8848.3 8862.8 7738.0 7738.5 7743.0 7999.8 8023.8 7993.1 8260.5 8280.7 8380.7 8382.6 2300.5 2343.3 2352.4 2370.0 2527.6 1000.0 1052.9 1054.4 1064.8 1064.9 19644.6 20602.7 20934.4 20941.4 21070.0 1045.4 1049.8 1057.4 1059.9 1060.5 10960.6 11283.0 11362.8 11412.8 11456.4 511479.0 514639.0 519337.2 525697.0 525802.0 99360.0 100317.0 101258.0 103271.0 105308.0 1147.8 1198.3 1226.7 1230.4 1231.2 17381.5 17734.6 17766.6 17849.5 17915.6 46306.5 46885.8 47096.8 48024.8 48564.0 57536.0 59039.7 59200.4 59293.0 59396.4 9282.3 9381.0 9482.7 9512.2 9862.6 14135.2 14687.8 14920.1 15135.9 15146.5 12380.3 12563.6 12830.9 12909.7 13017.1 11687.5 11774.7 12143.6 12357.2 12721.9 12912.0 12957.5 13016.5 13073.6 13142.1 9387.6 9573.9 9859.0 9938.6 10182.4 12981.8 13191.9 13318.3 13457.2 13582.1 21:21:14 INFO - PID 4346 | 21:21:14 INFO - PID 4346 | [#3] mootools.html Cycles:180 Average:6998.14 Median:3862.68 stddev:4399.50 (113.9%) stddev-sans-first:4391.33 21:21:14 INFO - PID 4346 | Values: 1344.4 1407.2 1409.6 1423.1 1430.9 10412.8 10913.8 10918.6 11535.0 11741.1 11089.2 11241.4 11272.0 11288.3 11292.7 2298.1 2335.2 2355.0 2355.9 2360.1 2259.4 2319.8 2340.4 2344.7 2351.0 2260.3 2262.1 2306.8 2307.0 2309.4 2186.0 2216.9 2254.4 2261.4 2268.1 2148.4 2225.4 2245.2 2254.0 2260.1 10844.1 10949.5 10959.0 10995.8 11005.3 6185.8 6332.8 6335.7 6366.2 6398.6 3760.8 3964.5 3986.6 4053.8 4067.2 1350.6 1352.5 1374.4 1377.7 1413.1 15512.1 15535.7 15539.5 15582.1 15665.4 4967.9 5019.2 5112.9 5342.5 5347.5 11721.2 11760.1 11761.5 11765.4 11774.9 6121.1 6137.9 6157.2 6167.3 6169.5 5700.3 5704.7 5792.4 5842.2 5847.9 4188.6 4259.2 4313.8 4366.7 4382.6 1172.3 1221.2 1227.6 1228.3 1233.0 853.9 872.9 876.6 889.1 904.1 6199.9 6290.7 6303.6 6320.7 6412.7 650.0 658.7 954.2 960.1 977.0 4450.2 4453.3 4460.0 4535.0 4572.2 13743.2 14016.6 14363.1 14760.6 14783.3 14452.9 14520.5 14553.6 14595.4 14625.0 8869.1 9019.1 9035.5 9102.8 9115.2 7071.3 7297.6 7387.9 7396.0 7509.0 13198.9 13227.0 13546.2 13712.5 13798.4 13433.6 13535.1 13680.6 13761.7 13794.9 9381.4 9569.5 9631.7 9640.4 9640.8 10490.4 10545.5 10566.3 10597.3 10617.5 9039.3 9243.6 9289.1 9427.0 9465.4 9047.1 9085.3 9085.6 9149.6 9326.6 8215.3 8248.4 8308.5 8316.1 8430.4 5849.5 5921.9 6016.9 6051.6 6194.1 6369.3 6442.0 6460.3 6470.6 6508.8 21:21:14 INFO - PID 4346 | 21:21:14 INFO - PID 4346 | [#4] prototype.html Cycles:180 Average:5511.20 Median:6191.07 stddev:1604.25 (25.9%) stddev-sans-first:1562.12 21:21:14 INFO - PID 4346 | Values: 395.3 396.8 413.6 425.7 428.9 5955.8 6089.9 6172.8 6188.5 6193.6 5913.9 6046.4 6055.6 6059.5 6071.9 4762.8 4767.1 4805.0 4805.8 4807.0 4648.6 4795.5 4801.0 4809.8 4824.2 4776.7 4779.2 4802.0 4806.6 4818.6 4824.6 4831.3 4842.2 4846.5 4851.9 4269.1 4342.1 4363.6 4381.6 4388.6 5956.7 5965.1 6007.4 6037.2 6038.6 5612.5 5688.0 5731.9 5735.3 5739.5 6414.3 6523.8 6523.8 6533.3 6561.1 4877.2 4893.5 4907.4 4934.3 4938.0 6572.5 6755.7 6766.0 6766.2 6791.4 4763.5 4779.1 4811.1 4820.1 4832.7 4735.8 4849.0 4860.8 4868.0 4877.6 5495.9 5510.8 5514.8 5560.7 5564.2 6391.9 6547.5 6563.1 6576.5 6612.7 1746.9 1783.5 1786.3 1790.6 1791.2 1229.4 1247.6 1253.1 1263.3 1276.7 6247.7 6292.2 6292.3 6302.1 6314.6 6509.4 6718.2 6720.8 6796.6 6798.9 6116.3 6170.0 6204.9 6212.9 6248.9 3467.6 3527.6 3552.3 3573.2 3577.2 6827.4 7017.9 7019.3 7068.5 7090.3 6791.9 6840.6 6871.0 6875.7 6921.4 6837.7 6964.8 6969.6 6999.8 7011.8 6629.5 6667.8 6698.5 6703.3 6709.2 6385.6 6609.0 6618.2 6639.2 6677.4 7072.9 7084.3 7124.3 7132.2 7153.7 4475.4 4557.9 4584.0 4591.9 4603.6 6539.6 6692.9 6696.9 6745.8 6787.0 6526.3 6535.8 6543.4 6555.6 6579.6 6424.3 6477.8 6492.4 6515.2 6569.5 6519.3 6533.7 6537.2 6548.0 6557.9 6443.8 6525.2 6543.9 6548.5 6567.8 6387.9 6396.3 6402.4 6403.8 6414.2 21:21:14 INFO - PID 4346 | 21:21:14 INFO - PID 4346 | [#5] yui.html Cycles:180 Average:19567.96 Median:26960.36 stddev:24088.35 (89.3%) stddev-sans-first:24114.99 21:21:14 INFO - PID 4346 | Values: 868.8 890.3 891.5 894.2 904.9 16047.8 17119.8 17132.1 17419.6 18885.8 17227.5 17399.7 17623.1 18489.3 19009.1 987.4 992.2 992.5 995.3 996.2 998.5 1031.2 1035.3 1043.3 1044.0 1078.2 1094.9 1095.3 1096.2 1097.7 1081.7 1086.6 1092.5 1093.4 1097.0 797.7 801.7 803.9 805.7 808.9 16002.7 16204.8 16206.3 16320.8 16423.5 18918.2 18918.4 18924.4 18975.7 19158.0 14329.0 14390.0 14548.4 14582.1 14798.4 3430.8 3440.2 3440.3 3463.3 3473.4 92129.1 92647.5 92946.5 94249.5 94388.5 14758.0 14907.3 14930.9 15047.1 15089.7 25323.0 26853.0 27067.7 27510.4 27708.2 8442.5 8559.6 8569.8 8614.4 8669.5 3972.3 3994.1 4086.5 4087.4 4131.5 4311.5 4327.2 4358.2 4371.7 4380.3 842.9 843.5 848.8 854.6 859.3 726.7 729.9 742.6 756.5 768.5 11771.4 12785.8 12863.7 13046.9 13078.1 707.4 719.8 722.5 733.7 734.5 5435.5 5479.3 5493.0 5686.9 5699.5 82395.5 83022.6 83433.0 84246.6 87645.1 75248.0 75517.0 75599.6 77129.0 77341.6 67075.0 67628.3 68256.0 69113.7 70156.0 10866.6 11551.7 11581.1 11587.2 11689.9 35157.6 35622.3 36119.1 36731.8 36845.1 43063.0 44731.0 44849.0 44926.3 56032.4 17430.3 17551.7 17653.0 17704.6 17982.9 19060.0 19368.1 19449.3 19607.0 20168.9 16912.7 17799.4 18004.3 18329.4 18503.4 16504.1 16523.3 16774.6 16874.8 17027.9 17373.7 17416.4 17452.9 17602.2 17630.3 11063.2 11119.8 11187.4 11197.4 11508.0 13531.6 13827.7 13902.7 13909.3 13956.4 21:21:14 INFO - PID 4346 | -------- Summary: end -------- 21:21:14 INFO - PID 4346 | 21:21:15 INFO - TEST-INFO | 4346: exit 0 21:21:15 INFO - TEST-OK | dromaeo_css | took 1113833ms 21:21:15 INFO - TEST-START | kraken 21:21:15 INFO - operating with platform_type : linux_ 21:21:15 INFO - Initialising browser for kraken test... 21:21:15 INFO - TEST-INFO | started process 4774 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU0BmNM/profile http://localhost:48933/getInfo.html) 21:21:19 INFO - PID 4774 | __metrics Screen width/height:1600/1200 21:21:19 INFO - PID 4774 | colorDepth:24 21:21:19 INFO - PID 4774 | Browser inner width/height: 1024/695 21:21:19 INFO - PID 4774 | __metrics 21:21:21 INFO - TEST-INFO | 4774: exit 0 21:21:21 INFO - Browser initialized. 21:21:21 INFO - Running cycle 1/1 for kraken test... 21:21:21 INFO - TEST-INFO | started process 4945 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU0BmNM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:21:32 INFO - PID 4945 | RSS: Main: 156676096 21:21:32 INFO - PID 4945 | 21:21:35 INFO - PID 4945 | Cycle 1(1): loaded http://localhost:48933/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48933/tests/kraken/driver.html?testName=audio-beat-detection) 21:21:36 INFO - PID 4945 | RSS: Main: 162287616 21:21:36 INFO - PID 4945 | 21:21:38 INFO - PID 4945 | Cycle 1(1): loaded http://localhost:48933/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48933/tests/kraken/driver.html?testName=audio-dft) 21:21:39 INFO - PID 4945 | RSS: Main: 161640448 21:21:39 INFO - PID 4945 | 21:21:42 INFO - PID 4945 | Cycle 1(1): loaded http://localhost:48933/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48933/tests/kraken/driver.html?testName=audio-fft) 21:21:42 INFO - PID 4945 | RSS: Main: 157573120 21:21:42 INFO - PID 4945 | 21:21:44 INFO - PID 4945 | Cycle 1(1): loaded http://localhost:48933/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48933/tests/kraken/driver.html?testName=audio-oscillator) 21:21:45 INFO - PID 4945 | RSS: Main: 158920704 21:21:45 INFO - PID 4945 | 21:21:47 INFO - PID 4945 | Cycle 1(1): loaded http://localhost:48933/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48933/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:21:48 INFO - PID 4945 | RSS: Main: 158728192 21:21:48 INFO - PID 4945 | 21:21:51 INFO - PID 4945 | Cycle 1(1): loaded http://localhost:48933/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48933/tests/kraken/driver.html?testName=imaging-darkroom) 21:21:51 INFO - PID 4945 | RSS: Main: 163733504 21:21:51 INFO - PID 4945 | 21:21:55 INFO - PID 4945 | Cycle 1(1): loaded http://localhost:48933/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48933/tests/kraken/driver.html?testName=imaging-desaturate) 21:21:55 INFO - PID 4945 | RSS: Main: 163221504 21:21:55 INFO - PID 4945 | 21:21:58 INFO - PID 4945 | Cycle 1(1): loaded http://localhost:48933/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48933/tests/kraken/driver.html?testName=json-parse-financial) 21:21:59 INFO - PID 4945 | RSS: Main: 163397632 21:21:59 INFO - PID 4945 | 21:22:00 INFO - PID 4945 | Cycle 1(1): loaded http://localhost:48933/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48933/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:22:01 INFO - PID 4945 | RSS: Main: 163573760 21:22:01 INFO - PID 4945 | 21:22:03 INFO - PID 4945 | Cycle 1(1): loaded http://localhost:48933/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48933/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:22:03 INFO - PID 4945 | RSS: Main: 163450880 21:22:03 INFO - PID 4945 | 21:22:05 INFO - PID 4945 | Cycle 1(1): loaded http://localhost:48933/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48933/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:22:06 INFO - PID 4945 | RSS: Main: 164245504 21:22:06 INFO - PID 4945 | 21:22:08 INFO - PID 4945 | Cycle 1(1): loaded http://localhost:48933/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48933/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:22:09 INFO - PID 4945 | RSS: Main: 163852288 21:22:09 INFO - PID 4945 | 21:22:12 INFO - PID 4945 | Cycle 1(1): loaded http://localhost:48933/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48933/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:22:13 INFO - PID 4945 | RSS: Main: 164184064 21:22:13 INFO - PID 4945 | 21:22:15 INFO - PID 4945 | Cycle 1(1): loaded http://localhost:48933/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48933/tests/kraken/driver.html?testName=ai-astar) 21:22:15 INFO - PID 4945 | RSS: Main: 166105088 21:22:15 INFO - PID 4945 | 21:22:15 INFO - PID 4945 | __start_tp_report 21:22:15 INFO - PID 4945 | _x_x_mozilla_page_load 21:22:15 INFO - PID 4945 | _x_x_mozilla_page_load_details 21:22:15 INFO - PID 4945 | |i|pagename|runs| 21:22:15 INFO - PID 4945 | |0;ai-astar;102;111;110;109;111;110;108;109;109;110 21:22:15 INFO - PID 4945 | |1;audio-beat-detection;139;117;122;178;117;117;116;117;136;122 21:22:15 INFO - PID 4945 | |2;audio-dft;165;162;164;161;163;164;165;167;172;162 21:22:15 INFO - PID 4945 | |3;audio-fft;76;76;76;93;73;73;74;74;91;74 21:22:15 INFO - PID 4945 | |4;audio-oscillator;81;82;101;82;82;81;93;81;86;107 21:22:15 INFO - PID 4945 | |5;imaging-gaussian-blur;113;114;114;115;114;113;114;114;113;113 21:22:15 INFO - PID 4945 | |6;imaging-darkroom;149;148;147;149;148;147;148;148;148;148 21:22:15 INFO - PID 4945 | |7;imaging-desaturate;95;101;96;94;95;95;94;95;94;95 21:22:15 INFO - PID 4945 | |8;json-parse-financial;46;48;44;46;48;48;48;48;46;46 21:22:15 INFO - PID 4945 | |9;json-stringify-tinderbox;56;55;56;55;55;56;56;56;55;56 21:22:15 INFO - PID 4945 | |10;stanford-crypto-aes;83;82;82;83;80;82;83;82;80;81 21:22:15 INFO - PID 4945 | |11;stanford-crypto-ccm;135;129;125;125;124;133;128;125;204;126 21:22:15 INFO - PID 4945 | |12;stanford-crypto-pbkdf2;176;183;186;182;182;184;183;202;190;183 21:22:15 INFO - PID 4945 | |13;stanford-crypto-sha256-iterative;67;68;66;66;66;66;67;66;65;66 21:22:15 INFO - PID 4945 | __end_tp_report 21:22:15 INFO - PID 4945 | __start_cc_report 21:22:15 INFO - PID 4945 | _x_x_mozilla_cycle_collect,755 21:22:15 INFO - PID 4945 | __end_cc_report 21:22:15 INFO - PID 4945 | __startTimestamp1494217335307__endTimestamp 21:22:15 INFO - PID 4945 | 21:22:15 INFO - PID 4945 | ------- Summary: start ------- 21:22:15 INFO - PID 4945 | Number of tests: 14 21:22:15 INFO - PID 4945 | 21:22:15 INFO - PID 4945 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:2.60 (2.4%) stddev-sans-first:1.00 21:22:15 INFO - PID 4945 | Values: 102.0 111.0 110.0 109.0 111.0 110.0 108.0 109.0 109.0 110.0 21:22:15 INFO - PID 4945 | 21:22:15 INFO - PID 4945 | [#1] audio-beat-detection Cycles:10 Average:128.10 Median:122.00 stddev:19.39 (15.9%) stddev-sans-first:20.16 21:22:15 INFO - PID 4945 | Values: 139.0 117.0 122.0 178.0 117.0 117.0 116.0 117.0 136.0 122.0 21:22:15 INFO - PID 4945 | 21:22:15 INFO - PID 4945 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:3.17 (1.9%) stddev-sans-first:3.36 21:22:15 INFO - PID 4945 | Values: 165.0 162.0 164.0 161.0 163.0 164.0 165.0 167.0 172.0 162.0 21:22:15 INFO - PID 4945 | 21:22:15 INFO - PID 4945 | [#3] audio-fft Cycles:10 Average:78.00 Median:76.00 stddev:7.48 (9.8%) stddev-sans-first:7.90 21:22:15 INFO - PID 4945 | Values: 76.0 76.0 76.0 93.0 73.0 73.0 74.0 74.0 91.0 74.0 21:22:15 INFO - PID 4945 | 21:22:15 INFO - PID 4945 | [#4] audio-oscillator Cycles:10 Average:87.60 Median:82.00 stddev:9.50 (11.6%) stddev-sans-first:9.77 21:22:15 INFO - PID 4945 | Values: 81.0 82.0 101.0 82.0 82.0 81.0 93.0 81.0 86.0 107.0 21:22:15 INFO - PID 4945 | 21:22:15 INFO - PID 4945 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 21:22:15 INFO - PID 4945 | Values: 113.0 114.0 114.0 115.0 114.0 113.0 114.0 114.0 113.0 113.0 21:22:15 INFO - PID 4945 | 21:22:15 INFO - PID 4945 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 21:22:15 INFO - PID 4945 | Values: 149.0 148.0 147.0 149.0 148.0 147.0 148.0 148.0 148.0 148.0 21:22:15 INFO - PID 4945 | 21:22:15 INFO - PID 4945 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:2.07 (2.2%) stddev-sans-first:2.19 21:22:15 INFO - PID 4945 | Values: 95.0 101.0 96.0 94.0 95.0 95.0 94.0 95.0 94.0 95.0 21:22:15 INFO - PID 4945 | 21:22:15 INFO - PID 4945 | [#8] json-parse-financial Cycles:10 Average:46.80 Median:48.00 stddev:1.40 (2.9%) stddev-sans-first:1.45 21:22:15 INFO - PID 4945 | Values: 46.0 48.0 44.0 46.0 48.0 48.0 48.0 48.0 46.0 46.0 21:22:15 INFO - PID 4945 | 21:22:15 INFO - PID 4945 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:56.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 21:22:15 INFO - PID 4945 | Values: 56.0 55.0 56.0 55.0 55.0 56.0 56.0 56.0 55.0 56.0 21:22:15 INFO - PID 4945 | 21:22:15 INFO - PID 4945 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:1.14 (1.4%) stddev-sans-first:1.12 21:22:15 INFO - PID 4945 | Values: 83.0 82.0 82.0 83.0 80.0 82.0 83.0 82.0 80.0 81.0 21:22:15 INFO - PID 4945 | 21:22:15 INFO - PID 4945 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:128.50 stddev:24.38 (19.0%) stddev-sans-first:25.86 21:22:15 INFO - PID 4945 | Values: 135.0 129.0 125.0 125.0 124.0 133.0 128.0 125.0 204.0 126.0 21:22:15 INFO - PID 4945 | 21:22:15 INFO - PID 4945 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.10 Median:183.50 stddev:6.89 (3.8%) stddev-sans-first:6.47 21:22:15 INFO - PID 4945 | Values: 176.0 183.0 186.0 182.0 182.0 184.0 183.0 202.0 190.0 183.0 21:22:15 INFO - PID 4945 | 21:22:15 INFO - PID 4945 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 21:22:15 INFO - PID 4945 | Values: 67.0 68.0 66.0 66.0 66.0 66.0 67.0 66.0 65.0 66.0 21:22:15 INFO - PID 4945 | -------- Summary: end -------- 21:22:15 INFO - PID 4945 | 21:22:16 INFO - TEST-INFO | 4945: exit 0 21:22:16 INFO - TEST-OK | kraken | took 61182ms 21:22:16 INFO - SUITE-END | took 1175s 21:22:16 INFO - Completed test suite (00:19:35) 21:22:16 INFO - javascript benchmark 21:22:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7886.541361432238, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3412.3516531858945, 3431.4166591679414, 3435.038189306995, 3457.4813777933305, 3471.1842716961523, 5891.322497912742, 6005.0, 6023.036314189725, 6059.060845568938, 6088.208532890718, 5994.550408719352, 5998.370171132034, 6007.57946943713, 6141.6622085785375, 6141.692915354237, 5286.4449232830575, 5323.653962492445, 5351.036813373591, 5358.437364076774, 5370.570354371651, 5354.170103633924, 5364.7317634118335, 5441.156620723775, 5443.1835224716415, 5457.836264912039, 5218.13900706383, 5270.0, 5350.892982140374, 5433.239346491494, 5442.346918369782, 5277.102892508283, 5282.392524859613, 5288.6826790392315, 5299.125644268691, 5304.310439642822, 5187.0, 5258.55302299305, 5272.868178295535, 5277.023750606112, 5278.392984806758, 5841.415858414124, 5899.76400943966, 5955.808838232371, 6038.909416358758, 6069.332373438918, 6455.612663240174, 6480.384363485461, 6516.8696626067685, 6525.184351956005, 6528.183977002875, 6421.357864213588, 6528.706208220641, 6550.115734375893, 6565.835854103638, 6575.671216439207, 6018.759249630053, 6127.20346354971, 6134.049222370495, 6147.047207682816, 6150.231221097363, 6578.638174900427, 6614.437772789271, 6618.768343107968, 6680.866382672417, 6689.163854518185, 6213.751449942042, 6326.873462530723, 6484.286728459866, 6504.219493660791, 6512.674366281667, 6446.484281257488, 6538.901916471256, 6548.934510654928, 6555.278919318871, 6572.244191917895, 6288.9056664150075, 6500.512461565401, 6507.674616269168, 6513.088167656532, 6514.348565143448, 6406.583572067801, 6412.743490260431, 6509.9023514647315, 6514.674266286666, 6587.473002159816, 4925.630577706686, 4944.950550494521, 4945.282933974553, 4950.3069570260195, 4967.602591792648, 4386.912261754747, 4399.0, 4399.340098985113, 4409.845655402046, 4437.29003359461, 6011.7595296187665, 6065.696715164224, 6073.271207455045, 6074.179985701962, 6106.72519736613, 6384.042393640991, 6404.551681382259, 6446.774362897276, 6501.934980650133, 6527.2167339919515, 6128.233970753656, 6194.4115309045565, 6214.502839772807, 6219.689015549205, 6224.875502490016, 5668.744906479218, 5730.19777231188, 5733.197352370671, 5733.77064917407, 5747.339056008613, 6646.26891041985, 6743.35938085881, 6795.7961261162245, 6920.688569014305, 6926.549774264657, 6628.5691430056895, 6633.867322653617, 6636.601803891782, 6639.601623902581, 6662.700178491883, 6875.243723190545, 6926.653667316715, 6927.480438966997, 6942.618156001468, 6955.721771129098, 6278.6546739929745, 6365.809025729235, 6372.235331760033, 6487.513436492188, 6493.902591461227, 6592.373724496165, 6639.136912201383, 6655.068290439245, 6655.134832471941, 6678.198616166092, 6181.721822517908, 6246.3441338660605, 6266.937330626635, 6315.0, 6315.715792789428, 6391.936080639134, 6424.935750642434, 6425.871482570229, 6432.614043157426, 6437.5171862111465, 6187.071939209155, 6210.472109870531, 6218.378162183745, 6366.4588509977175, 6413.679316034273, 6403.935960640334, 6474.70863811139, 6482.643454610042, 6499.512536559682, 6500.447461965786, 6219.626822390671, 6277.435030847246, 6297.307296197506, 6305.464035557029, 6308.905366419415], "value": 5968.358439261632, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.6677328588777, 815.2458975447711, 834.9666013359464, 1139.777743340049, 1140.156284349581, 36024.81987590062, 37546.24907501852, 37582.812085939535, 37795.055123621925, 37861.0, 38966.0, 39160.41259381112, 39292.214155716865, 39361.60638393615, 39450.0, 7123.89314160288, 7194.460415468848, 7326.597037162954, 7338.77983660491, 7356.374708149814, 7307.634618269092, 7332.30343117403, 7352.117745870503, 7379.298966598165, 7392.482526223166, 7365.926340736604, 7399.556026638392, 7407.592582407965, 7449.515781474214, 7449.553026818408, 7362.006129172573, 7369.152547457057, 7374.483786135, 7393.445491588099, 7393.445491588125, 7229.855402891965, 7241.782746517613, 7252.274772522758, 7269.709211631528, 7307.342339189446, 36992.075198119994, 37026.62973370286, 37447.43828842569, 37560.43659345112, 37706.81146594277, 3525.347810655037, 3561.9643803561894, 3574.4459608760685, 3578.4274516077303, 3586.1572530455323, 29308.56037159444, 29443.0, 29466.852665736747, 29512.11463656094, 29572.40855182906, 3808.9428658570146, 3839.347310957144, 3851.345271303885, 3854.4025676019983, 3876.573576906538, 201959.0, 204060.0, 213017.0, 218782.90608547014, 218899.0, 47734.28398574024, 47907.520924791, 47970.76014619974, 48031.27953080706, 48038.0, 48785.5121448781, 48981.0, 49067.754661227176, 49119.26321105186, 49195.0, 15673.0, 15697.607559811097, 15779.132147731756, 15859.682806344039, 15863.0, 12746.553870614483, 12948.223106613445, 13017.284049377186, 13020.0, 13047.347632618332, 14310.0, 14322.57032289033, 14342.498012569718, 14549.490767823076, 14670.779938300933, 5858.794942177088, 5893.764249429974, 5940.108983652401, 6040.788572399945, 6103.84740381494, 1022.0137567247642, 1071.3946620159586, 1094.3762055628215, 1113.821788513834, 1114.8104822180248, 25400.618990715153, 25484.49031019369, 25839.61240581393, 25890.87054564715, 26122.86938565295, 1198.7063169523522, 1201.4293210724836, 1204.1089593700774, 1219.85361756588, 1222.9633111006683, 13712.0, 13731.656708582366, 13925.373358198905, 13998.090124141898, 14002.57992260234, 270525.0, 270786.0, 271242.0, 271391.0, 273445.0, 53359.73320133374, 53962.46037539574, 54026.0, 54043.45956540463, 54116.72941635345, 1509.954701358961, 1540.5224380442323, 1564.7965764450548, 1577.384819920232, 1580.8182059063356, 23839.76160238445, 24723.381915451537, 24868.0, 25004.231592572167, 25233.243002709947, 48312.51687483221, 49993.0, 50006.0, 50030.249546256106, 50218.24672629987, 234528.0, 234853.0, 235940.0, 236198.0, 237387.0, 34400.139996500286, 35472.0, 35734.28531429305, 36236.0, 36274.637253628185, 43387.0, 43476.78261608672, 45489.0, 46128.769356153, 46245.53754462412, 33064.66935330712, 33101.834490827394, 33352.66647333495, 34029.82985085059, 34961.65038349584, 32566.185845354055, 33963.3207335847, 34637.82681086679, 34848.65151348454, 34893.825530872185, 37565.06087347729, 39056.609433905294, 39188.6081139185, 39195.0, 39245.21509569736, 32465.188370290933, 32512.83743581267, 33468.0, 33829.83085084657, 34054.0, 24504.50990980135, 26296.34259143537, 26875.071853802783, 26953.326166845985, 26954.460910782065], "value": 17639.03213803102, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [446.4085087259378, 449.438202247191, 454.7771591919959, 466.7223002313626, 468.08722990169167, 20342.89828550857, 21060.89469552654, 21575.67636485454, 22326.33021009368, 22598.43503912403, 22178.778212217872, 22339.888300558476, 22758.203462878802, 22776.8861155694, 23188.65217021746, 4186.706930514865, 5530.723463826813, 5694.174344720013, 5700.600957932926, 5721.628094173865, 5182.222666600002, 5416.1063424534905, 5526.778928842861, 5573.359063707665, 5576.275084239043, 5514.91727624086, 5540.722963851791, 5542.418046105161, 5553.333599968009, 5555.722213889309, 5477.178423236526, 5499.7250137492965, 5710.257666503369, 5734.111212762028, 5762.481376676119, 5148.845534633967, 5178.249153872667, 5206.531412172884, 5221.060209162387, 5244.1871509915645, 24963.750362496507, 25614.23157305284, 25791.226263212135, 26000.609990850153, 26081.60877586838, 2193.7806219378094, 2214.9335519934266, 2236.1390864517116, 2236.6197746383154, 2240.2943072931976, 16480.587985300463, 17446.0, 17584.736228956575, 17703.203355848887, 17731.73402398965, 2060.2789023841538, 2124.5538436928264, 2198.1976578548874, 2220.6668999650183, 2253.3690566641367, 110892.33661495084, 119380.0, 119825.0, 120703.39648301703, 121358.39320803428, 12585.685357866127, 12679.556215532411, 12728.936355318165, 13185.934070329778, 13258.337083145998, 18027.459176224733, 18058.277668893097, 18064.0, 18112.637747245244, 18168.273269069352, 8546.444481108832, 8712.085231050774, 8741.868871966926, 8848.274586455707, 8862.822743545094, 7737.961310193413, 7738.4969976951315, 7742.961285193538, 7999.760007199793, 8023.759287221393, 7993.120756716757, 8260.489292050974, 8280.710175143962, 8380.706675266336, 8382.622781974826, 2300.493891343902, 2343.308723926446, 2352.447174913894, 2370.0, 2527.620856871484, 999.9950000250097, 1052.9473526323652, 1054.3989925742253, 1064.8455973883742, 1064.893510648929, 19644.607107857762, 20602.690959635616, 20934.441145005385, 20941.371758847257, 21070.0, 1045.3832238978887, 1049.7533079726259, 1057.434272664121, 1059.8834128245887, 1060.5068643081004, 10960.56157753681, 11283.0, 11362.772744545064, 11412.771744565061, 11456.427178641035, 511479.0, 514639.0, 519337.24307919864, 525697.0, 525802.0, 99360.0, 100317.0, 101258.0, 103271.0, 105307.99148161824, 1147.8002137962624, 1198.3349241171234, 1226.693326668333, 1230.4217018001525, 1231.1751126744923, 17381.52706774836, 17734.645307094044, 17766.555836103682, 17849.464516064538, 17915.641687166444, 46306.536934630225, 46885.76557117193, 47096.76451617857, 48024.7598762004, 48564.0, 57536.0, 59039.70480147572, 59200.407995919486, 59293.0, 59396.406035939086, 9282.257419406296, 9381.014993425864, 9482.715518534455, 9512.191463725661, 9862.605495780088, 14135.15189088658, 14687.779683304545, 14920.104793712411, 15135.924320378328, 15146.545603631908, 12380.257184568954, 12563.560275390682, 12830.935845320713, 12909.741805164032, 13017.088803783645, 11687.532498699957, 11774.705632358917, 12143.574974875837, 12357.196782209128, 12721.8550330467, 12912.031597630028, 12957.546485872948, 13016.544420945222, 13073.607791765882, 13142.080054396101, 9387.577559009998, 9573.904260957579, 9858.950705246429, 9938.602455901972, 10182.389056656624, 12981.805272921103, 13191.934040329737, 13318.334083295991, 13457.192568445924, 13582.117162384413], "value": 10266.131230737483, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.3883033219886, 1407.176801571081, 1409.5912185466216, 1423.1176670464313, 1430.9427622895082, 10412.791744165123, 10913.781724365508, 10918.563257469701, 11535.0, 11741.119416043788, 11089.2237543372, 11241.381724005198, 11272.0, 11288.322700637947, 11292.661220163409, 2298.092253559847, 2335.1710142899283, 2354.988225058872, 2355.893984770681, 2360.055977608953, 2259.412552736284, 2319.7912187903084, 2340.4031971847157, 2344.7303560090554, 2350.9882450587806, 2260.3445000949787, 2262.1177740681146, 2306.7577904320055, 2306.9653955190684, 2309.4341886237894, 2185.967210491844, 2216.855904366219, 2254.368776742515, 2261.412032871457, 2268.081427022067, 2148.387709502784, 2225.4436390902274, 2245.2366195493446, 2253.9774602253933, 2260.062074239189, 10844.13246940243, 10949.45252737368, 10959.0, 10995.835062474069, 11005.339679619168, 6185.8144255672405, 6332.810015699536, 6335.746570137189, 6366.236051673829, 6398.552101352907, 3760.849566017356, 3964.5044369453817, 3986.6013398660193, 4053.837846486137, 4067.1662309226836, 1350.5745690107585, 1352.4725357110635, 1374.3540535948089, 1377.6624726941964, 1413.1238632048196, 15512.069275843372, 15535.689286214212, 15539.456119035893, 15582.142982135978, 15665.373385064584, 4967.850964471072, 5019.171836646912, 5112.897742045138, 5342.54588359986, 5347.518723314843, 11721.179517433698, 11760.117991150526, 11761.529538818351, 11765.352905590275, 11774.882251177378, 6121.143039974407, 6137.938620613737, 6157.230346206724, 6167.259928808572, 6169.475594574422, 5700.25896633435, 5704.743286552115, 5792.391798861059, 5842.2405087338375, 5847.888901108776, 4188.560201178893, 4259.212045771542, 4313.84901528445, 4366.672499562545, 4382.627476664519, 1172.3493461128985, 1221.151299846598, 1227.5764861122898, 1228.3489750432286, 1232.9938350308191, 853.910339414365, 872.8559787635096, 876.6318146378409, 889.1153302464089, 904.1230006893303, 6199.907001394983, 6290.716917738621, 6303.621782693053, 6320.747170113144, 6412.711427985659, 649.9512536559777, 658.723336198788, 954.2080073538946, 960.1454705312277, 976.9706908792748, 4450.198964186413, 4453.3320001999955, 4460.041091165415, 4535.024969631545, 4572.1770081385, 13743.175409475463, 14016.579502614937, 14363.138211707332, 14760.63098422548, 14783.260836958108, 14452.855471445362, 14520.491782787552, 14553.636159096108, 14595.41618335276, 14625.0493717908, 8869.11308869108, 9019.143181397756, 9035.457872527539, 9102.772430689154, 9115.225205857576, 7071.266432188339, 7297.635118244173, 7387.852242955219, 7395.963020184865, 7508.962455187689, 13198.934005329911, 13227.0, 13546.187228766306, 13712.451501939811, 13798.448062077405, 13433.596992090253, 13535.08995565958, 13680.589582312547, 13761.655958601115, 13794.86205137976, 9381.437113773196, 9569.521523923637, 9631.662891798753, 9640.373375730554, 9640.75898102553, 10490.370577765358, 10545.52545135486, 10566.260361774603, 10597.25819192649, 10617.469126543487, 9039.322050846082, 9243.584038718409, 9289.117533834275, 9426.95286523563, 9465.432074075577, 9047.140521650434, 9085.273178145864, 9085.636574536944, 9149.63401463934, 9326.580303886205, 8215.301699355383, 8248.381371397048, 8308.501489910625, 8316.126806685212, 8430.40987130895, 5849.473547380756, 5921.85195370102, 6016.939830601638, 6051.636901785907, 6194.101855231056, 6369.299377068612, 6441.967790161019, 6460.289368169591, 6470.611763294218, 6508.8047358579315], "value": 5283.625877321356, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.2648074581277, 396.81151453059783, 413.61139419850366, 425.70200859398426, 428.86351169401075, 5955.821325360235, 6089.878202435949, 6172.796304720576, 6188.535859810515, 6193.597416167946, 5913.940860591393, 6046.395360463951, 6055.63830106259, 6059.484943779773, 6071.87856242876, 4762.8333008344625, 4767.094252092092, 4805.0, 4805.759712014403, 4807.03859228154, 4648.604868586174, 4795.496472870351, 4801.0, 4809.831655892044, 4824.155772739774, 4776.665633405663, 4779.235322348425, 4801.951980480186, 4806.62072274223, 4818.566329030386, 4824.565789079, 4831.323614693928, 4842.249451335048, 4846.515348465161, 4851.902961940777, 4269.146170765859, 4342.131573685276, 4363.629091527224, 4381.627561657263, 4388.561143885618, 5956.7319470623925, 5965.135055416984, 6007.36922623127, 6037.184980027684, 6038.607490513146, 5612.494875461228, 5687.971560142214, 5731.885362292773, 5735.311762588474, 5739.483446489836, 6414.294427612959, 6523.771667991645, 6523.804285871432, 6533.314002029766, 6561.1142495763415, 4877.244027175793, 4893.4617192108835, 4907.435644900811, 4934.25986102084, 4937.950620493785, 6572.474202063823, 6755.695993680296, 6765.9661701691175, 6766.18805743314, 6791.422729068036, 4763.4522029967, 4779.06808172403, 4811.109944660249, 4820.132376172322, 4832.710037397697, 4735.763211839394, 4848.95151048485, 4860.781264843091, 4867.975660121748, 4877.585405240523, 5495.890082198333, 5510.752016159283, 5514.779408823682, 5560.749766260528, 5564.221009058735, 6391.904121438182, 6547.5416720830035, 6563.146790917151, 6576.539642225094, 6612.735490580323, 1746.9388571400193, 1783.5273652482103, 1786.2676302715824, 1790.5523619095227, 1791.1581556668345, 1229.4221715793562, 1247.6194760597923, 1253.091508656217, 1263.3304348695206, 1276.7063575377529, 6247.718852651642, 6292.2134733158355, 6292.30546355549, 6302.149209856702, 6314.62112273265, 6509.44669703071, 6718.227403848522, 6720.7647732330115, 6796.558223715443, 6798.8640227196165, 6116.339392364336, 6169.96915015431, 6204.875902482016, 6212.875742485125, 6248.9062664060075, 3467.583889933174, 3527.5766907971206, 3552.2717842842158, 3573.178169021088, 3577.195131095483, 6827.351401616937, 7017.89473157903, 7019.262977387403, 7068.505204635729, 7090.255523170096, 6791.864162716718, 6840.555363901331, 6870.965645171842, 6875.656217189121, 6921.411680007155, 6837.6581170942245, 6964.79105626832, 6969.581825090409, 6999.825004374829, 7011.824704382431, 6629.5359324846795, 6667.766628167991, 6698.497612678971, 6703.29615390377, 6709.161354830646, 6385.553011289165, 6609.0, 6618.238902526078, 6639.240601240578, 6677.397424618154, 7072.858542829217, 7084.326988936043, 7124.25195354501, 7132.216945763559, 7153.749618763319, 4475.395821564178, 4557.908841823211, 4583.977080114578, 4591.931121033121, 4603.562661547147, 6539.6403197824575, 6692.866142677021, 6696.899546506709, 6745.797626071029, 6786.966065169642, 6526.345246661885, 6535.771248006297, 6543.443807276435, 6555.6066636002, 6579.605223686594, 6424.325445828121, 6477.829926974517, 6492.415682588589, 6515.218173819172, 6569.507286953593, 6519.348065193442, 6533.67331633426, 6537.1501704778075, 6548.0, 6557.901631475627, 6443.838904027437, 6525.184351956005, 6543.934560654523, 6548.508861835477, 6567.835804104936, 6387.872242555216, 6396.328385519453, 6402.359764023747, 6403.807885763435, 6414.230292364946], "value": 5018.903292452954, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [868.8262347530496, 890.296665634149, 891.5185799668179, 894.172890076679, 904.8506996345603, 16047.759283610741, 17119.828801711978, 17132.14339283037, 17419.564510887234, 18885.81114188858, 17227.487204094694, 17399.652006959885, 17623.11884405778, 18489.260429582835, 19009.144588493516, 987.3582171588471, 992.2111921022804, 992.4640694025218, 995.3381001633904, 996.2329006664863, 998.5306905754284, 1031.2162756305224, 1035.3425574760045, 1043.306201376084, 1044.0290529807276, 1078.1751959750798, 1094.9014588687016, 1095.3263742798163, 1096.17786660005, 1097.7145942055083, 1081.6538707613568, 1086.5870969031796, 1092.5192915117402, 1093.3603841752583, 1096.9670909872716, 797.7048492057976, 801.6592947997078, 803.907550631679, 805.7179987004561, 808.9433739638168, 16002.679946401007, 16204.837951620451, 16206.270717817726, 16320.836791632051, 16423.507294781175, 18918.243270269173, 18918.43244702661, 18924.43226703201, 18975.71536426955, 19158.04209789505, 14329.0, 14390.0, 14548.418063277457, 14582.052166609137, 14798.40806367744, 3430.811305378203, 3440.1915549845767, 3440.3291358185165, 3463.255400088993, 3473.444248920186, 92129.07870921271, 92647.53676231575, 92946.53526732323, 94249.52875235579, 94388.52805735928, 14758.0, 14907.254637268094, 14930.850691492946, 15047.097174169585, 15089.698206035819, 25323.0, 26853.0, 27067.729322706913, 27510.449791004066, 27708.168754937386, 8442.45124066946, 8559.614817333235, 8569.785755356166, 8614.353923455767, 8669.523176225368, 3972.3445631471063, 3994.0813612868624, 4086.468759061303, 4087.448194493705, 4131.462909821764, 4311.461067366579, 4327.199468098412, 4358.237308471005, 4371.650267978554, 4380.255356589388, 842.8946381702287, 843.451756358372, 848.7581039403864, 854.5556310718516, 859.3168431097292, 726.6584705188553, 729.9452541059336, 742.5989965418613, 756.5347311403448, 768.4735955870135, 11771.411429428494, 12785.808212876815, 12863.678408039686, 13046.934765326112, 13078.149920255344, 707.4022451028873, 719.7624783821326, 722.5159143373952, 733.6515155301189, 734.4895297767999, 5435.537979271727, 5479.287692600016, 5492.972535137379, 5686.886262274731, 5699.5155411790465, 82395.52813415487, 83022.58488707518, 83433.0, 84246.57876710578, 87645.12354876497, 75248.0, 75517.0, 75599.62200189073, 77129.0, 77341.61329193319, 67075.0, 67628.32371676416, 68256.0, 69113.65443172753, 70156.0, 10866.565337386415, 11551.653450396501, 11581.073514119018, 11587.246828956428, 11689.88310116888, 35157.648423515435, 35622.28755424825, 36119.09702257464, 36731.81634091812, 36845.09682694775, 43063.0, 44731.0, 44849.0, 44926.3261051091, 56032.43967560272, 17430.30278788885, 17551.736723949405, 17653.0, 17704.64590708153, 17982.910085450014, 19060.0, 19368.128434220776, 19449.31927382535, 19607.019649017206, 20168.89915550413, 16912.74630880513, 17799.377021804692, 18004.279828806702, 18329.3584724534, 18503.444896653124, 16504.092274924995, 16523.256453459384, 16774.580635483722, 16874.831251687818, 17027.91486042562, 17373.652526949136, 17416.390426335016, 17452.912735436243, 17602.207900644757, 17630.294788208328, 11063.170262230526, 11119.83320250213, 11187.384693841917, 11197.440127993405, 11508.0, 13531.577822723195, 13827.723445530832, 13902.679245471663, 13909.304534773422, 13956.371963261881], "value": 8394.840077263621, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1495.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 110.0, 109.0, 111.0, 110.0, 108.0, 109.0, 109.0, 110.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 117.0, 122.0, 178.0, 117.0, 117.0, 116.0, 117.0, 136.0, 122.0], "value": 128.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 164.0, 161.0, 163.0, 164.0, 165.0, 167.0, 172.0, 162.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 93.0, 73.0, 73.0, 74.0, 74.0, 91.0, 74.0], "value": 78.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 101.0, 82.0, 82.0, 81.0, 93.0, 81.0, 86.0, 107.0], "value": 87.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 115.0, 114.0, 113.0, 114.0, 114.0, 113.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 149.0, 148.0, 147.0, 148.0, 148.0, 148.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 101.0, 96.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 48.0, 44.0, 46.0, 48.0, 48.0, 48.0, 48.0, 46.0, 46.0], "value": 46.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 55.0, 55.0, 56.0, 56.0, 56.0, 55.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 83.0, 80.0, 82.0, 83.0, 82.0, 80.0, 81.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 129.0, 125.0, 125.0, 124.0, 133.0, 128.0, 125.0, 204.0, 126.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 183.0, 186.0, 182.0, 182.0, 184.0, 183.0, 202.0, 190.0, 183.0], "value": 185.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 65.0, 66.0], "value": 66.3, "unit": "score"}]}]} 21:22:17 INFO - Return code: 0 21:22:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:22:17 INFO - # TBPL SUCCESS # 21:22:17 INFO - Running post-action listener: _resource_record_post_action 21:22:17 INFO - [mozharness: 2017-05-08 04:22:17.142639Z] Finished run-tests step (success) 21:22:17 INFO - Running post-run listener: _resource_record_post_run 21:22:17 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 425984; Write bytes: 380272640; Read time: 108; Write time: 241968 21:22:17 INFO - TinderboxPrint: CPU usage
13.2% 21:22:17 INFO - TinderboxPrint: I/O read bytes / time
425,984 / 108 21:22:17 INFO - TinderboxPrint: I/O write bytes / time
380,272,640 / 241,968 21:22:17 INFO - TinderboxPrint: CPU idle
8,253.4 (86.8%) 21:22:17 INFO - TinderboxPrint: CPU user
1,202.3 (12.6%) 21:22:17 INFO - TinderboxPrint: Swap in / out
0 / 0 21:22:17 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 39882752; Read time: 0; Write time: 9764 21:22:17 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 425984; Write bytes: 261353472; Read time: 108; Write time: 164944 21:22:17 INFO - Running post-run listener: _upload_blobber_files 21:22:17 INFO - Blob upload gear active. 21:22:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:22:17 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 21:22:17 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:22:17 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:22:18 INFO - (blobuploader) - INFO - Open directory for files ... 21:22:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:22:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:22:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:22:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:22:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:22:19 INFO - (blobuploader) - INFO - Done attempting. 21:22:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:22:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:22:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:22:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:22:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:22:22 INFO - (blobuploader) - INFO - Done attempting. 21:22:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:22:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:22:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:22:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:22:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:22:22 INFO - (blobuploader) - INFO - Done attempting. 21:22:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:22:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:22:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:22:24 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:22:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:22:24 INFO - (blobuploader) - INFO - Done attempting. 21:22:24 INFO - (blobuploader) - INFO - Iteration through files over. 21:22:24 INFO - Return code: 0 21:22:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:22:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:22:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d33622ef5c2b1bdc64ad414942a166bf0035e99d8dd9b487a660dae9441e28153f368c7d6a43e7ff1f724ba680749cd52d3b1192d914c30a9382a67c93cb49c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd68a88e4bfca7193aa0acc8b11f04ff5164a4869608a043e6440dc1b34df1a96fb8c9b4271bd727dcecf0c7f92b94e925c4b41267ccdc8c8cd9853cb210c4cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5f0ad7edbd1547da7834edce8b422a2eb6c4a2ce4f442c41517e75fe90c687cd88083e6819584767bd33cce43a49369d8d938e5ce007f62a372bb7806f95d1b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f064b072b6b63279dc58ad8fbe7a0d7aeb4fe9069f09ad609ed3fb1ddab4eae2e3a412735515c06056c6348c20ee4029b7b8e58cc67d6fe86f456c3cb87e723"} 21:22:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:22:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:22:24 INFO - Contents: 21:22:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d33622ef5c2b1bdc64ad414942a166bf0035e99d8dd9b487a660dae9441e28153f368c7d6a43e7ff1f724ba680749cd52d3b1192d914c30a9382a67c93cb49c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd68a88e4bfca7193aa0acc8b11f04ff5164a4869608a043e6440dc1b34df1a96fb8c9b4271bd727dcecf0c7f92b94e925c4b41267ccdc8c8cd9853cb210c4cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5f0ad7edbd1547da7834edce8b422a2eb6c4a2ce4f442c41517e75fe90c687cd88083e6819584767bd33cce43a49369d8d938e5ce007f62a372bb7806f95d1b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f064b072b6b63279dc58ad8fbe7a0d7aeb4fe9069f09ad609ed3fb1ddab4eae2e3a412735515c06056c6348c20ee4029b7b8e58cc67d6fe86f456c3cb87e723"} 21:22:24 INFO - Running post-run listener: copy_logs_to_upload_dir 21:22:24 INFO - Copying logs to upload dir... 21:22:24 INFO - mkdir: /builds/slave/test/build/upload/logs 21:22:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.626838 ========= master_lag: 0.64 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-05-07 21:22:24.675525) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-07 21:22:24.683859) ========= 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=db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d33622ef5c2b1bdc64ad414942a166bf0035e99d8dd9b487a660dae9441e28153f368c7d6a43e7ff1f724ba680749cd52d3b1192d914c30a9382a67c93cb49c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd68a88e4bfca7193aa0acc8b11f04ff5164a4869608a043e6440dc1b34df1a96fb8c9b4271bd727dcecf0c7f92b94e925c4b41267ccdc8c8cd9853cb210c4cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5f0ad7edbd1547da7834edce8b422a2eb6c4a2ce4f442c41517e75fe90c687cd88083e6819584767bd33cce43a49369d8d938e5ce007f62a372bb7806f95d1b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f064b072b6b63279dc58ad8fbe7a0d7aeb4fe9069f09ad609ed3fb1ddab4eae2e3a412735515c06056c6348c20ee4029b7b8e58cc67d6fe86f456c3cb87e723"} build_url:https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/MNk_T-iaSS-OqEB13I9tpg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d33622ef5c2b1bdc64ad414942a166bf0035e99d8dd9b487a660dae9441e28153f368c7d6a43e7ff1f724ba680749cd52d3b1192d914c30a9382a67c93cb49c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd68a88e4bfca7193aa0acc8b11f04ff5164a4869608a043e6440dc1b34df1a96fb8c9b4271bd727dcecf0c7f92b94e925c4b41267ccdc8c8cd9853cb210c4cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5f0ad7edbd1547da7834edce8b422a2eb6c4a2ce4f442c41517e75fe90c687cd88083e6819584767bd33cce43a49369d8d938e5ce007f62a372bb7806f95d1b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f064b072b6b63279dc58ad8fbe7a0d7aeb4fe9069f09ad609ed3fb1ddab4eae2e3a412735515c06056c6348c20ee4029b7b8e58cc67d6fe86f456c3cb87e723"}' ========= master_lag: 0.12 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-07 21:22:24.814172) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2017-05-07 21:22:24.814586) ========= 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=db0483c52d987ecb441a263b000001ad-1494215664.801443-1301296716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 2.21 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2017-05-07 21:22:27.025627) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-07 21:22:27.025940) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-07 21:22:27.032515) ========= ========= Total master_lag: 3.23 =========