builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-047 starttime: 1490137369.12 results: success (0) revision: 18bb0299dd9b3516597e5c68cd49d8b894745a93 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 16:02:49.120712) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 16:02:49.121713) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 16:02:49.122445) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 16:02:49.138768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 16:02:49.139457) ========= 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=03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-21 16:02:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2017-03-21 16:02:49 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134691 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 16:02:49.293338) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 16:02:49.294127) ========= 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=03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016645 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 16:02:49.344811) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 16:02:49.345189) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 18bb0299dd9b3516597e5c68cd49d8b894745a93 --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 18bb0299dd9b3516597e5c68cd49d8b894745a93 --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=03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-21 16:02:49,423 truncating revision to first 12 chars 2017-03-21 16:02:49,423 Setting DEBUG logging. 2017-03-21 16:02:49,423 attempt 1/10 2017-03-21 16:02:49,423 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/18bb0299dd9b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-21 16:02:49,900 unpacking tar archive at: mozilla-central-18bb0299dd9b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.785153 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 16:02:50.147828) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 16:02:50.148715) ========= script_repo_revision: 18bb0299dd9b3516597e5c68cd49d8b894745a93 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 16:02:50.149659) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 16:02:50.150375) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 16:02:50.162914) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-21 16:02:50.163228) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:02:50 INFO - MultiFileLogger online at 20170321 16:02:50 in /builds/slave/test 16:02:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:02:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:02:50 INFO - {'append_to_log': False, 16:02:50 INFO - 'base_work_dir': '/builds/slave/test', 16:02:50 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:02:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:02:50 INFO - 'branch': 'Firefox-Non-PGO', 16:02:50 INFO - 'buildbot_json_path': 'buildprops.json', 16:02:50 INFO - 'config_files': ('talos/linux_config.py',), 16:02:50 INFO - 'default_actions': ('clobber', 16:02:50 INFO - 'read-buildbot-config', 16:02:50 INFO - 'download-and-extract', 16:02:50 INFO - 'populate-webroot', 16:02:50 INFO - 'create-virtualenv', 16:02:50 INFO - 'install', 16:02:50 INFO - 'run-tests'), 16:02:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:02:50 INFO - 'download_minidump_stackwalk': True, 16:02:50 INFO - 'download_symbols': 'ondemand', 16:02:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:02:50 INFO - 'tooltool.py': '/tools/tooltool.py', 16:02:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:02:50 INFO - '/tools/misc-python/virtualenv.py')}, 16:02:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:02:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:02:50 INFO - 'gecko_profile': False, 16:02:50 INFO - 'gecko_profile_interval': 0, 16:02:50 INFO - 'installer_path': 'installer.exe', 16:02:50 INFO - 'log_level': 'info', 16:02:50 INFO - 'log_name': 'talos', 16:02:50 INFO - 'log_to_console': True, 16:02:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:02:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:02:50 INFO - 'opt_config_files': (), 16:02:50 INFO - 'pip_index': False, 16:02:50 INFO - 'suite': 'dromaeojs-e10s', 16:02:50 INFO - 'system_bits': '32', 16:02:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:02:50 INFO - 'title': 'talos-linux64-ix-047', 16:02:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:02:50 INFO - 'use_talos_json': True, 16:02:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:02:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:02:50 INFO - 'work_dir': 'build'} 16:02:50 INFO - [mozharness: 2017-03-21 23:02:50.345895Z] Running clobber step. 16:02:50 INFO - Running pre-action listener: _resource_record_pre_action 16:02:50 INFO - Running main action method: clobber 16:02:50 INFO - rmtree: /builds/slave/test/build 16:02:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:02:51 INFO - Running post-action listener: _resource_record_post_action 16:02:51 INFO - [mozharness: 2017-03-21 23:02:51.939997Z] Finished clobber step (success) 16:02:51 INFO - [mozharness: 2017-03-21 23:02:51.940105Z] Running read-buildbot-config step. 16:02:51 INFO - Running pre-action listener: _resource_record_pre_action 16:02:51 INFO - Running main action method: read_buildbot_config 16:02:51 INFO - Using buildbot properties: 16:02:51 INFO - { 16:02:51 INFO - "project": "", 16:02:51 INFO - "product": "firefox", 16:02:51 INFO - "who": "kwierso@gmail.com", 16:02:51 INFO - "installer_path": "public/build/target.tar.bz2", 16:02:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:02:51 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:02:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:02:51 INFO - "stage_platform": "linux64", 16:02:51 INFO - "basedir": "/builds/slave/test", 16:02:51 INFO - "buildnumber": 764, 16:02:51 INFO - "platform": "ubuntu64_hw", 16:02:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:02:51 INFO - "slavebuilddir": "test", 16:02:51 INFO - "taskId": "NGfi55RnREuHJpwZlIAKrQ", 16:02:51 INFO - "branch": "mozilla-central", 16:02:51 INFO - "script_repo_revision": "production", 16:02:51 INFO - "revision": "18bb0299dd9b3516597e5c68cd49d8b894745a93", 16:02:51 INFO - "slavename": "talos-linux64-ix-047", 16:02:51 INFO - "repo_path": "mozilla-central" 16:02:51 INFO - } 16:02:51 INFO - Finding installer, test and symbols from parent task. 16:02:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NGfi55RnREuHJpwZlIAKrQ'}, attempt #1 16:02:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NGfi55RnREuHJpwZlIAKrQ'}, attempt #1 16:02:52 INFO - Task dependencies: TI_xUoXLTK20Ss081k32OA 16:02:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA'}, attempt #1 16:02:53 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/target.tar.bz2 16:02:53 INFO - Set test_url: https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/test_packages.json 16:02:53 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/target.crashreporter-symbols.zip 16:02:53 INFO - Running post-action listener: _resource_record_post_action 16:02:53 INFO - [mozharness: 2017-03-21 23:02:53.300656Z] Finished read-buildbot-config step (success) 16:02:53 INFO - [mozharness: 2017-03-21 23:02:53.300873Z] Running download-and-extract step. 16:02:53 INFO - Running pre-action listener: _resource_record_pre_action 16:02:53 INFO - Running main action method: download_and_extract 16:02:53 INFO - mkdir: /builds/slave/test/build/tests 16:02:53 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')]} 16:02:53 INFO - trying https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/target.test_packages.json 16:02:53 INFO - Downloading https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:02:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:02:53 INFO - Downloaded 986 bytes. 16:02:53 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:02:53 INFO - Using the following test package requirements: 16:02:53 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:02:53 INFO - u'common': [u'target.common.tests.zip'], 16:02:53 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:02:53 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:02:53 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:02:53 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:02:53 INFO - u'mozbase': [u'target.common.tests.zip'], 16:02:53 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:02:53 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:02:53 INFO - u'web-platform': [u'target.common.tests.zip', 16:02:53 INFO - u'target.web-platform.tests.zip'], 16:02:53 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:02:53 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:02:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/target.common.tests.zip 16:02:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:02:53 INFO - Fetch https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/target.common.tests.zip into memory 16:02:55 INFO - Expected file size: 58196686 16:02:55 INFO - Obtained file size: 58196686 16:03:04 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:03:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/target.common.tests.zip 16:03:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:03:04 INFO - Fetch https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/target.common.tests.zip into memory 16:03:05 INFO - Expected file size: 58196686 16:03:05 INFO - Obtained file size: 58196686 16:03:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/target.talos.tests.zip 16:03:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:03:16 INFO - Fetch https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/target.talos.tests.zip into memory 16:03:17 INFO - Expected file size: 14404171 16:03:17 INFO - Obtained file size: 14404171 16:03:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:03:17 INFO - trying https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/target.tar.bz2 16:03:17 INFO - Downloading https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:03:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:03:19 INFO - Downloaded 61880008 bytes. 16:03:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/target.tar.bz2 16:03:19 INFO - mkdir: /builds/slave/test/properties 16:03:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:03:19 INFO - Writing to file /builds/slave/test/properties/build_url 16:03:19 INFO - Contents: 16:03:19 INFO - build_url:https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/target.tar.bz2 16:03:19 INFO - Running post-action listener: _resource_record_post_action 16:03:19 INFO - Running post-action listener: set_extra_try_arguments 16:03:19 INFO - [mozharness: 2017-03-21 23:03:19.283791Z] Finished download-and-extract step (success) 16:03:19 INFO - [mozharness: 2017-03-21 23:03:19.283887Z] Running populate-webroot step. 16:03:19 INFO - Running pre-action listener: _resource_record_pre_action 16:03:19 INFO - Running main action method: populate_webroot 16:03:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:03:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:03:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:03:19 INFO - '--tppagecycles', 16:03:19 INFO - '7'], 16:03:19 INFO - 'tests': ['tsvgm']}}, 16:03:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:03:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:03:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:03:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:03:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:03:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:03:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:03:19 INFO - 'talos_options': ['--disable-e10s'], 16:03:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:03:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:03:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:03:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:03:19 INFO - 'talos_options': ['--disable-e10s'], 16:03:19 INFO - 'tests': ['damp', 'tps']}, 16:03:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:03:19 INFO - 'tests': ['damp', 'tps']}, 16:03:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:03:19 INFO - 'tests': ['dromaeo_dom']}, 16:03:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:03:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:03:19 INFO - 'tests': ['basic_compositor_video']}, 16:03:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:03:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:03:19 INFO - 'tests': ['a11yr', 16:03:19 INFO - 'ts_paint', 16:03:19 INFO - 'tpaint', 16:03:19 INFO - 'sessionrestore', 16:03:19 INFO - 'sessionrestore_no_auto_restore', 16:03:19 INFO - 'tabpaint']}, 16:03:19 INFO - 'other-e10s': {'tests': ['a11yr', 16:03:19 INFO - 'ts_paint', 16:03:19 INFO - 'tpaint', 16:03:19 INFO - 'sessionrestore', 16:03:19 INFO - 'sessionrestore_no_auto_restore', 16:03:19 INFO - 'tabpaint']}, 16:03:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:03:19 INFO - 'ts_paint', 16:03:19 INFO - 'tpaint', 16:03:19 INFO - 'sessionrestore', 16:03:19 INFO - 'sessionrestore_no_auto_restore', 16:03:19 INFO - 'tabpaint']}, 16:03:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:03:19 INFO - 'ts_paint', 16:03:19 INFO - 'tpaint', 16:03:19 INFO - 'sessionrestore', 16:03:19 INFO - 'sessionrestore_no_auto_restore', 16:03:19 INFO - 'tabpaint']}, 16:03:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:03:19 INFO - 'tests': ['a11yr', 16:03:19 INFO - 'ts_paint', 16:03:19 INFO - 'tpaint', 16:03:19 INFO - 'sessionrestore', 16:03:19 INFO - 'sessionrestore_no_auto_restore', 16:03:19 INFO - 'tabpaint']}, 16:03:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:03:19 INFO - 'tests': ['a11yr', 16:03:19 INFO - 'ts_paint', 16:03:19 INFO - 'tpaint', 16:03:19 INFO - 'sessionrestore', 16:03:19 INFO - 'sessionrestore_no_auto_restore', 16:03:19 INFO - 'tabpaint']}, 16:03:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:03:19 INFO - 'tests': ['tsvgx', 16:03:19 INFO - 'tsvgr_opacity', 16:03:19 INFO - 'tart', 16:03:19 INFO - 'tscrollx', 16:03:19 INFO - 'cart', 16:03:19 INFO - 'tsvg_static']}, 16:03:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:03:19 INFO - 'tsvgr_opacity', 16:03:19 INFO - 'tart', 16:03:19 INFO - 'tscrollx', 16:03:19 INFO - 'cart', 16:03:19 INFO - 'tsvg_static']}, 16:03:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:03:19 INFO - 'talos_options': ['--disable-e10s'], 16:03:19 INFO - 'tests': ['tp5o']}, 16:03:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:03:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:03:19 INFO - 'talos_options': ['--disable-e10s', 16:03:19 INFO - '--xperf_path', 16:03:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:03:19 INFO - 'tests': ['tp5n']}, 16:03:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:03:19 INFO - 'talos_options': ['--xperf_path', 16:03:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:03:19 INFO - 'tests': ['tp5n']}}, 16:03:19 INFO - 'talos.zip': {'path': '', 16:03:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:03:19 INFO - Running post-action listener: _resource_record_post_action 16:03:19 INFO - [mozharness: 2017-03-21 23:03:19.296907Z] Finished populate-webroot step (success) 16:03:19 INFO - [mozharness: 2017-03-21 23:03:19.296996Z] Running create-virtualenv step. 16:03:19 INFO - Running pre-action listener: _resource_record_pre_action 16:03:19 INFO - Running main action method: create_virtualenv 16:03:19 INFO - Creating virtualenv /builds/slave/test/build/venv 16:03:19 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 16:03:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:03:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:03:19 INFO - Using real prefix '/usr' 16:03:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:03:19 INFO - Installing distribute.............................................................................................................................................................................................done. 16:03:21 INFO - Installing pip.................done. 16:03:21 INFO - Return code: 0 16:03:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:03:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:03:22 INFO - Reading from file tmpfile_stdout 16:03:22 INFO - Output received: 16:03:22 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) 16:03:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:03:22 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')]} 16:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:22 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')]} 16:03:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:22 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 0xe9e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf96a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1139290>, '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 0x1139b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113a040>, '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': '03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322', '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 16:03:22 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 16:03:22 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 16:03:22 INFO - Using env: {'DISPLAY': ':0', 16:03:22 INFO - 'HOME': '/home/cltbld', 16:03:22 INFO - 'LANG': 'en_US.UTF-8', 16:03:22 INFO - 'LANGUAGE': 'en_US:en', 16:03:22 INFO - 'LOGNAME': 'cltbld', 16:03:22 INFO - 'MAIL': '/var/mail/cltbld', 16:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:22 INFO - 'MOZ_NO_REMOTE': '1', 16:03:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:22 INFO - 'NO_EM_RESTART': '1', 16:03:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:22 INFO - 'PWD': '/builds/slave/test', 16:03:22 INFO - 'SHELL': '/bin/bash', 16:03:22 INFO - 'SHLVL': '1', 16:03:22 INFO - 'TERM': 'linux', 16:03:22 INFO - 'TMOUT': '86400', 16:03:22 INFO - 'USER': 'cltbld', 16:03:22 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322', 16:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:22 INFO - '_': '/tools/buildbot/bin/python'} 16:03:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:22 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 16:03:22 INFO - Cleaning up... 16:03:22 INFO - Return code: 0 16:03:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:03:22 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')]} 16:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:22 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')]} 16:03:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:22 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 0xe9e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf96a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1139290>, '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 0x1139b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113a040>, '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': '03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322', '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 16:03:22 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 16:03:22 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 16:03:22 INFO - Using env: {'DISPLAY': ':0', 16:03:22 INFO - 'HOME': '/home/cltbld', 16:03:22 INFO - 'LANG': 'en_US.UTF-8', 16:03:22 INFO - 'LANGUAGE': 'en_US:en', 16:03:22 INFO - 'LOGNAME': 'cltbld', 16:03:22 INFO - 'MAIL': '/var/mail/cltbld', 16:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:22 INFO - 'MOZ_NO_REMOTE': '1', 16:03:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:22 INFO - 'NO_EM_RESTART': '1', 16:03:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:22 INFO - 'PWD': '/builds/slave/test', 16:03:22 INFO - 'SHELL': '/bin/bash', 16:03:22 INFO - 'SHLVL': '1', 16:03:22 INFO - 'TERM': 'linux', 16:03:22 INFO - 'TMOUT': '86400', 16:03:22 INFO - 'USER': 'cltbld', 16:03:22 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322', 16:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:22 INFO - '_': '/tools/buildbot/bin/python'} 16:03:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:22 INFO - Downloading/unpacking psutil>=3.1.1 16:03: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 16:03: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 16:03: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 16:03: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 16:03: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 16:03: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 16:03:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:03:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:03:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:03:24 INFO - Installing collected packages: psutil 16:03:24 INFO - Running setup.py install for psutil 16:03:24 INFO - building 'psutil._psutil_linux' extension 16:03:24 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 16:03:24 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 16:03:24 INFO - building 'psutil._psutil_posix' extension 16:03:24 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 16:03:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:03:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:03:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:03:25 INFO - Successfully installed psutil 16:03:25 INFO - Cleaning up... 16:03:25 INFO - Return code: 0 16:03:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:03:25 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')]} 16:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:25 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')]} 16:03:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:25 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 0xe9e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf96a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1139290>, '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 0x1139b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113a040>, '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': '03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322', '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 16:03:25 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 16:03:25 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 16:03:25 INFO - Using env: {'DISPLAY': ':0', 16:03:25 INFO - 'HOME': '/home/cltbld', 16:03:25 INFO - 'LANG': 'en_US.UTF-8', 16:03:25 INFO - 'LANGUAGE': 'en_US:en', 16:03:25 INFO - 'LOGNAME': 'cltbld', 16:03:25 INFO - 'MAIL': '/var/mail/cltbld', 16:03:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:25 INFO - 'MOZ_NO_REMOTE': '1', 16:03:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:25 INFO - 'NO_EM_RESTART': '1', 16:03:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:25 INFO - 'PWD': '/builds/slave/test', 16:03:25 INFO - 'SHELL': '/bin/bash', 16:03:25 INFO - 'SHLVL': '1', 16:03:25 INFO - 'TERM': 'linux', 16:03:25 INFO - 'TMOUT': '86400', 16:03:25 INFO - 'USER': 'cltbld', 16:03:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322', 16:03:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:25 INFO - '_': '/tools/buildbot/bin/python'} 16:03:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:03:25 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 16:03:25 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 16:03:25 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 16:03:25 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 16:03:25 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 16:03:25 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 16:03:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:03:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:03:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:03:27 INFO - Installing collected packages: mozsystemmonitor 16:03:27 INFO - Running setup.py install for mozsystemmonitor 16:03:27 INFO - Successfully installed mozsystemmonitor 16:03:27 INFO - Cleaning up... 16:03:27 INFO - Return code: 0 16:03:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:03:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:03:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf96a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1139290>, '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 0x1139b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113a040>, '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': '03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322', '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 16:03:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:03:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:03:27 INFO - Using env: {'DISPLAY': ':0', 16:03:27 INFO - 'HOME': '/home/cltbld', 16:03:27 INFO - 'LANG': 'en_US.UTF-8', 16:03:27 INFO - 'LANGUAGE': 'en_US:en', 16:03:27 INFO - 'LOGNAME': 'cltbld', 16:03:27 INFO - 'MAIL': '/var/mail/cltbld', 16:03:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:27 INFO - 'MOZ_NO_REMOTE': '1', 16:03:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:27 INFO - 'NO_EM_RESTART': '1', 16:03:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:27 INFO - 'PWD': '/builds/slave/test', 16:03:27 INFO - 'SHELL': '/bin/bash', 16:03:27 INFO - 'SHLVL': '1', 16:03:27 INFO - 'TERM': 'linux', 16:03:27 INFO - 'TMOUT': '86400', 16:03:27 INFO - 'USER': 'cltbld', 16:03:27 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322', 16:03:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:27 INFO - '_': '/tools/buildbot/bin/python'} 16:03:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:27 INFO - Downloading/unpacking jsonschema==2.5.1 16:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:03:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:03:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:03:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:03:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:03:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:03:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:03:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:03:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:03:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:03:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:03:30 INFO - Downloading functools32-3.2.3-2.tar.gz 16:03:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:03:30 INFO - warning: no files found matching '*.txt' 16:03:30 INFO - no previously-included directories found matching 'build' 16:03:30 INFO - no previously-included directories found matching 'dist' 16:03:30 INFO - no previously-included directories found matching '.git*' 16:03:30 INFO - Installing collected packages: jsonschema, functools32 16:03:30 INFO - Running setup.py install for functools32 16:03:30 INFO - warning: no files found matching '*.txt' 16:03:30 INFO - no previously-included directories found matching 'build' 16:03:30 INFO - no previously-included directories found matching 'dist' 16:03:30 INFO - no previously-included directories found matching '.git*' 16:03:30 INFO - Successfully installed jsonschema functools32 16:03:30 INFO - Cleaning up... 16:03:30 INFO - Return code: 0 16:03:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:03:30 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')]} 16:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:30 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')]} 16:03:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:30 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 0xe9e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf96a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1139290>, '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 0x1139b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113a040>, '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': '03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322', '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 16:03:30 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 16:03:30 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 16:03:30 INFO - Using env: {'DISPLAY': ':0', 16:03:30 INFO - 'HOME': '/home/cltbld', 16:03:30 INFO - 'LANG': 'en_US.UTF-8', 16:03:30 INFO - 'LANGUAGE': 'en_US:en', 16:03:30 INFO - 'LOGNAME': 'cltbld', 16:03:30 INFO - 'MAIL': '/var/mail/cltbld', 16:03:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:30 INFO - 'MOZ_NO_REMOTE': '1', 16:03:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:30 INFO - 'NO_EM_RESTART': '1', 16:03:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:30 INFO - 'PWD': '/builds/slave/test', 16:03:30 INFO - 'SHELL': '/bin/bash', 16:03:30 INFO - 'SHLVL': '1', 16:03:30 INFO - 'TERM': 'linux', 16:03:30 INFO - 'TMOUT': '86400', 16:03:30 INFO - 'USER': 'cltbld', 16:03:30 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322', 16:03:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:30 INFO - '_': '/tools/buildbot/bin/python'} 16:03:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:03:30 INFO - Cleaning up... 16:03:30 INFO - Return code: 0 16:03:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:03:30 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')]} 16:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:30 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')]} 16:03:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:30 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 0xe9e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf96a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1139290>, '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 0x1139b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113a040>, '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': '03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322', '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 16:03:30 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 16:03:30 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 16:03:30 INFO - Using env: {'DISPLAY': ':0', 16:03:30 INFO - 'HOME': '/home/cltbld', 16:03:30 INFO - 'LANG': 'en_US.UTF-8', 16:03:30 INFO - 'LANGUAGE': 'en_US:en', 16:03:30 INFO - 'LOGNAME': 'cltbld', 16:03:30 INFO - 'MAIL': '/var/mail/cltbld', 16:03:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:30 INFO - 'MOZ_NO_REMOTE': '1', 16:03:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:30 INFO - 'NO_EM_RESTART': '1', 16:03:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:30 INFO - 'PWD': '/builds/slave/test', 16:03:30 INFO - 'SHELL': '/bin/bash', 16:03:30 INFO - 'SHLVL': '1', 16:03:30 INFO - 'TERM': 'linux', 16:03:30 INFO - 'TMOUT': '86400', 16:03:30 INFO - 'USER': 'cltbld', 16:03:30 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322', 16:03:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:30 INFO - '_': '/tools/buildbot/bin/python'} 16:03:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:30 INFO - Downloading/unpacking blobuploader==1.2.4 16:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:03:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:03:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:03:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:03:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:03:32 INFO - Downloading blobuploader-1.2.4.tar.gz 16:03:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:03:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:03:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:03:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:03:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:03:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:03:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:03:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:03:33 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 16:03:33 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 16:03:33 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 16:03:33 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 16:03:33 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 16:03:33 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 16:03:33 INFO - Downloading docopt-0.6.1.tar.gz 16:03:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:03:33 INFO - Installing collected packages: blobuploader, requests, docopt 16:03:33 INFO - Running setup.py install for blobuploader 16:03:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:03:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:03:33 INFO - Running setup.py install for requests 16:03:34 INFO - Running setup.py install for docopt 16:03:34 INFO - Successfully installed blobuploader requests docopt 16:03:34 INFO - Cleaning up... 16:03:34 INFO - Return code: 0 16:03:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:03:34 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')]} 16:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:34 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')]} 16:03:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:34 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 0xe9e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf96a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1139290>, '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 0x1139b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113a040>, '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': '03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322', '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 16:03:34 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 16:03:34 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 16:03:34 INFO - Using env: {'DISPLAY': ':0', 16:03:34 INFO - 'HOME': '/home/cltbld', 16:03:34 INFO - 'LANG': 'en_US.UTF-8', 16:03:34 INFO - 'LANGUAGE': 'en_US:en', 16:03:34 INFO - 'LOGNAME': 'cltbld', 16:03:34 INFO - 'MAIL': '/var/mail/cltbld', 16:03:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:34 INFO - 'MOZ_NO_REMOTE': '1', 16:03:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:34 INFO - 'NO_EM_RESTART': '1', 16:03:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:34 INFO - 'PWD': '/builds/slave/test', 16:03:34 INFO - 'SHELL': '/bin/bash', 16:03:34 INFO - 'SHLVL': '1', 16:03:34 INFO - 'TERM': 'linux', 16:03:34 INFO - 'TMOUT': '86400', 16:03:34 INFO - 'USER': 'cltbld', 16:03:34 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322', 16:03:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:34 INFO - '_': '/tools/buildbot/bin/python'} 16:03:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:03:34 INFO - Running setup.py (path:/tmp/pip-hihYl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:03:34 INFO - Running setup.py (path:/tmp/pip-d_IZdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:03:34 INFO - Running setup.py (path:/tmp/pip-r4nNGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:03:34 INFO - Running setup.py (path:/tmp/pip-vbqUYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:03:34 INFO - Running setup.py (path:/tmp/pip-iw02TV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:03:34 INFO - Running setup.py (path:/tmp/pip-Dm8yYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:03:34 INFO - Running setup.py (path:/tmp/pip-18eY4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:03:34 INFO - Running setup.py (path:/tmp/pip-NzTELh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:03:35 INFO - Running setup.py (path:/tmp/pip-hYvpe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:03:35 INFO - Running setup.py (path:/tmp/pip-pFjDEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:03:35 INFO - Running setup.py (path:/tmp/pip-8Hl0Sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:03:35 INFO - Running setup.py (path:/tmp/pip-vS_wu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:03:35 INFO - Running setup.py (path:/tmp/pip-RZoiqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:03:35 INFO - Running setup.py (path:/tmp/pip-jBnk_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:03:35 INFO - Running setup.py (path:/tmp/pip-uIvwzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:03:35 INFO - Running setup.py (path:/tmp/pip-5HRugl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:03:35 INFO - Running setup.py (path:/tmp/pip-6PTM2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:03:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:03:35 INFO - Running setup.py install for manifestparser 16:03:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:03:35 INFO - Running setup.py install for mozcrash 16:03:35 INFO - Running setup.py install for mozdebug 16:03:35 INFO - Running setup.py install for mozdevice 16:03:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:03:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:03:36 INFO - Running setup.py install for mozfile 16:03:36 INFO - Running setup.py install for mozhttpd 16:03:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:03:36 INFO - Running setup.py install for mozinfo 16:03:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:03:36 INFO - Running setup.py install for mozInstall 16:03:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:03:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:03:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:03:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:03:36 INFO - Running setup.py install for mozleak 16:03:36 INFO - Running setup.py install for mozlog 16:03:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:03:36 INFO - Running setup.py install for moznetwork 16:03:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:03:36 INFO - Running setup.py install for mozprocess 16:03:36 INFO - Running setup.py install for mozprofile 16:03:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:03:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:03:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:03:37 INFO - Running setup.py install for mozrunner 16:03:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:03:37 INFO - Running setup.py install for mozscreenshot 16:03:37 INFO - Running setup.py install for moztest 16:03:37 INFO - Running setup.py install for mozversion 16:03:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:03:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:03:37 INFO - Cleaning up... 16:03:37 INFO - Return code: 0 16:03:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:03:37 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')]} 16:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:37 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')]} 16:03:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:37 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 0xe9e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf96a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1139290>, '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 0x1139b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113a040>, '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': '03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322', '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 16:03:37 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 16:03:37 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 16:03:37 INFO - Using env: {'DISPLAY': ':0', 16:03:37 INFO - 'HOME': '/home/cltbld', 16:03:37 INFO - 'LANG': 'en_US.UTF-8', 16:03:37 INFO - 'LANGUAGE': 'en_US:en', 16:03:37 INFO - 'LOGNAME': 'cltbld', 16:03:37 INFO - 'MAIL': '/var/mail/cltbld', 16:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:37 INFO - 'MOZ_NO_REMOTE': '1', 16:03:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:37 INFO - 'NO_EM_RESTART': '1', 16:03:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:37 INFO - 'PWD': '/builds/slave/test', 16:03:37 INFO - 'SHELL': '/bin/bash', 16:03:37 INFO - 'SHLVL': '1', 16:03:37 INFO - 'TERM': 'linux', 16:03:37 INFO - 'TMOUT': '86400', 16:03:37 INFO - 'USER': 'cltbld', 16:03:37 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322', 16:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:37 INFO - '_': '/tools/buildbot/bin/python'} 16:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:03:37 INFO - Running setup.py (path:/tmp/pip-0dCOmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:03:37 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)) 16:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:03:37 INFO - Running setup.py (path:/tmp/pip-2dD40a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:03:37 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)) 16:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:03:37 INFO - Running setup.py (path:/tmp/pip-Btbb_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:03:37 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)) 16:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:03:37 INFO - Running setup.py (path:/tmp/pip-Z2FRXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:03:37 INFO - Running setup.py (path:/tmp/pip-LwdWvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:03:38 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)) 16:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:03:38 INFO - Running setup.py (path:/tmp/pip-PcoPr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:03:38 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)) 16:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:03:38 INFO - Running setup.py (path:/tmp/pip-6NkJlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:03:38 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)) 16:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:03:38 INFO - Running setup.py (path:/tmp/pip-NNYiej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:03:38 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)) 16:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:03:38 INFO - Running setup.py (path:/tmp/pip-Fmu9VQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:03:38 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)) 16:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:03:38 INFO - Running setup.py (path:/tmp/pip-2b0Hqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:03:38 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)) 16:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:03:38 INFO - Running setup.py (path:/tmp/pip-sqqnrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:03:38 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)) 16:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:03:38 INFO - Running setup.py (path:/tmp/pip-R3TTmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:03:38 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)) 16:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:03:38 INFO - Running setup.py (path:/tmp/pip-8WiZ68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:03:38 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)) 16:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:03:38 INFO - Running setup.py (path:/tmp/pip-pKL3Si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:03:38 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)) 16:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:03:38 INFO - Running setup.py (path:/tmp/pip-SZ5qlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:03:38 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)) 16:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:03:38 INFO - Running setup.py (path:/tmp/pip-cvjSpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:03:38 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)) 16:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:03:38 INFO - Running setup.py (path:/tmp/pip-gxtZSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:03:38 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)) 16:03:38 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)) 16:03:38 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)) 16:03:38 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)) 16:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:03:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:03:38 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 16:03:38 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 16:03:38 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 16:03:38 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 16:03:38 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 16:03:38 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 16:03:40 INFO - Downloading blessings-1.6.tar.gz 16:03:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:03:41 INFO - Installing collected packages: blessings 16:03:41 INFO - Running setup.py install for blessings 16:03:41 INFO - Successfully installed blessings 16:03:41 INFO - Cleaning up... 16:03:41 INFO - Return code: 0 16:03:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:03:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:03:41 INFO - Reading from file tmpfile_stdout 16:03:41 INFO - Current package versions: 16:03:41 INFO - argparse == 1.2.1 16:03:41 INFO - blessings == 1.6 16:03:41 INFO - blobuploader == 1.2.4 16:03:41 INFO - docopt == 0.6.1 16:03:41 INFO - functools32 == 3.2.3-2 16:03:41 INFO - jsonschema == 2.5.1 16:03:41 INFO - manifestparser == 1.1 16:03:41 INFO - mozInstall == 1.12 16:03:41 INFO - mozcrash == 1.0 16:03:41 INFO - mozdebug == 0.1 16:03:41 INFO - mozdevice == 0.49 16:03:41 INFO - mozfile == 1.2 16:03:41 INFO - mozhttpd == 0.7 16:03:41 INFO - mozinfo == 0.9 16:03:41 INFO - mozleak == 0.1 16:03:41 INFO - mozlog == 3.4 16:03:41 INFO - moznetwork == 0.27 16:03:41 INFO - mozprocess == 0.25 16:03:41 INFO - mozprofile == 0.28 16:03:41 INFO - mozrunner == 6.13 16:03:41 INFO - mozscreenshot == 0.1 16:03:41 INFO - mozsystemmonitor == 0.3 16:03:41 INFO - moztest == 0.8 16:03:41 INFO - mozversion == 1.4 16:03:41 INFO - psutil == 3.1.1 16:03:41 INFO - requests == 1.2.3 16:03:41 INFO - wsgiref == 0.1.2 16:03:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:03: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')]} 16:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03: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')]} 16:03:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:41 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 0xe9e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf96a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1139290>, '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 0x1139b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113a040>, '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': '03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322', '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 16:03:41 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 16:03:41 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 16:03:41 INFO - Using env: {'DISPLAY': ':0', 16:03:41 INFO - 'HOME': '/home/cltbld', 16:03:41 INFO - 'LANG': 'en_US.UTF-8', 16:03:41 INFO - 'LANGUAGE': 'en_US:en', 16:03:41 INFO - 'LOGNAME': 'cltbld', 16:03:41 INFO - 'MAIL': '/var/mail/cltbld', 16:03:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:41 INFO - 'MOZ_NO_REMOTE': '1', 16:03:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:41 INFO - 'NO_EM_RESTART': '1', 16:03:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:41 INFO - 'PWD': '/builds/slave/test', 16:03:41 INFO - 'SHELL': '/bin/bash', 16:03:41 INFO - 'SHLVL': '1', 16:03:41 INFO - 'TERM': 'linux', 16:03:41 INFO - 'TMOUT': '86400', 16:03:41 INFO - 'USER': 'cltbld', 16:03:41 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322', 16:03:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:41 INFO - '_': '/tools/buildbot/bin/python'} 16:03:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:41 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)) 16:03:41 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)) 16:03:41 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)) 16:03:41 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)) 16:03:41 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)) 16:03:41 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)) 16:03:41 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)) 16:03:41 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)) 16:03:41 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)) 16:03:41 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)) 16:03:41 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)) 16:03:41 INFO - Cleaning up... 16:03:41 INFO - Return code: 0 16:03:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:03: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')]} 16:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03: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')]} 16:03:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:41 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 0xe9e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf96a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1139290>, '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 0x1139b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113a040>, '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': '03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322', '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 16:03:41 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 16:03:41 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 16:03:41 INFO - Using env: {'DISPLAY': ':0', 16:03:41 INFO - 'HOME': '/home/cltbld', 16:03:41 INFO - 'LANG': 'en_US.UTF-8', 16:03:41 INFO - 'LANGUAGE': 'en_US:en', 16:03:41 INFO - 'LOGNAME': 'cltbld', 16:03:41 INFO - 'MAIL': '/var/mail/cltbld', 16:03:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:41 INFO - 'MOZ_NO_REMOTE': '1', 16:03:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:41 INFO - 'NO_EM_RESTART': '1', 16:03:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:41 INFO - 'PWD': '/builds/slave/test', 16:03:41 INFO - 'SHELL': '/bin/bash', 16:03:41 INFO - 'SHLVL': '1', 16:03:41 INFO - 'TERM': 'linux', 16:03:41 INFO - 'TMOUT': '86400', 16:03:41 INFO - 'USER': 'cltbld', 16:03:41 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322', 16:03:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:41 INFO - '_': '/tools/buildbot/bin/python'} 16:03:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:03:41 INFO - Cleaning up... 16:03:41 INFO - Return code: 0 16:03:41 INFO - Running post-action listener: _resource_record_post_action 16:03:41 INFO - Running post-action listener: _start_resource_monitoring 16:03:41 INFO - Starting resource monitoring. 16:03:41 INFO - [mozharness: 2017-03-21 23:03:41.893316Z] Finished create-virtualenv step (success) 16:03:41 INFO - [mozharness: 2017-03-21 23:03:41.893843Z] Running install step. 16:03:41 INFO - Running pre-action listener: _resource_record_pre_action 16:03:41 INFO - Running main action method: install 16:03:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:03:42 INFO - Reading from file tmpfile_stdout 16:03:42 INFO - Detecting whether we're running mozinstall >=1.0... 16:03:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:03:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:03:42 INFO - Reading from file tmpfile_stdout 16:03:42 INFO - Output received: 16:03:42 INFO - Usage: mozinstall [options] installer 16:03:42 INFO - Options: 16:03:42 INFO - -h, --help show this help message and exit 16:03:42 INFO - -d DEST, --destination=DEST 16:03:42 INFO - Directory to install application into. [default: 16:03:42 INFO - "/builds/slave/test"] 16:03:42 INFO - --app=APP Application being installed. [default: firefox] 16:03:42 INFO - mkdir: /builds/slave/test/build/application 16:03:42 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'] 16:03:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:03:57 INFO - Reading from file tmpfile_stdout 16:03:57 INFO - Output received: 16:03:57 INFO - /builds/slave/test/build/application/firefox/firefox 16:03:57 INFO - Running post-action listener: _resource_record_post_action 16:03:57 INFO - [mozharness: 2017-03-21 23:03:57.637770Z] Finished install step (success) 16:03:57 INFO - [mozharness: 2017-03-21 23:03:57.638043Z] Running run-tests step. 16:03:57 INFO - Running pre-action listener: _resource_record_pre_action 16:03:57 INFO - Running main action method: run_tests 16:03:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:03:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:03:57 INFO - Python 2.7.3 16:03:57 INFO - Return code: 0 16:03:57 INFO - grabbing minidump binary from tooltool 16:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:03:57 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 0x1139290>, '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 0x1139b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113a040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:03:57 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 16:03:57 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 16:03:57 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 16:03:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:03:57 INFO - Return code: 0 16:03:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:03:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:03:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:03:57 INFO - ENV: RUST_BACKTRACE is now 1 16:03:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:03:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:03:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 16:03:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 16:03:57 INFO - Using env: {'DISPLAY': ':0', 16:03:57 INFO - 'HOME': '/home/cltbld', 16:03:57 INFO - 'LANG': 'en_US.UTF-8', 16:03:57 INFO - 'LANGUAGE': 'en_US:en', 16:03:57 INFO - 'LOGNAME': 'cltbld', 16:03:57 INFO - 'MAIL': '/var/mail/cltbld', 16:03:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:03:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:57 INFO - 'MOZ_NO_REMOTE': '1', 16:03:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:03:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:57 INFO - 'NO_EM_RESTART': '1', 16:03:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:57 INFO - 'PWD': '/builds/slave/test', 16:03:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:03:57 INFO - 'RUST_BACKTRACE': '1', 16:03:57 INFO - 'SHELL': '/bin/bash', 16:03:57 INFO - 'SHLVL': '1', 16:03:57 INFO - 'TERM': 'linux', 16:03:57 INFO - 'TMOUT': '86400', 16:03:57 INFO - 'USER': 'cltbld', 16:03:57 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322', 16:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:57 INFO - '_': '/tools/buildbot/bin/python'} 16:03:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 16:03:57 INFO - mozversion application_buildid: 20170321223251 16:03:57 INFO - mozversion application_changeset: 18bb0299dd9b3516597e5c68cd49d8b894745a93 16:03:57 INFO - mozversion application_display_name: Nightly 16:03:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:03:57 INFO - mozversion application_name: Firefox 16:03:57 INFO - mozversion application_remotingname: firefox 16:03:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:03:57 INFO - mozversion application_vendor: Mozilla 16:03:57 INFO - mozversion application_version: 55.0a1 16:03:57 INFO - mozversion platform_buildid: 20170321223251 16:03:57 INFO - mozversion platform_changeset: 18bb0299dd9b3516597e5c68cd49d8b894745a93 16:03:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:03:57 INFO - mozversion platform_version: 55.0a1 16:03:57 INFO - using testdate: 1490137437 16:03:57 INFO - actual date: 1490137437 16:03:57 INFO - starting webserver on 'localhost:60298' 16:03:57 INFO - SUITE-START | Running 2 tests 16:03:57 INFO - TEST-START | dromaeo_css 16:03:57 INFO - operating with platform_type : linux_ 16:03:57 INFO - Initialising browser for dromaeo_css test... 16:03:57 INFO - TEST-INFO | started process 8197 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNh820t/profile http://localhost:60298/getInfo.html) 16:04:02 INFO - PID 8197 | __metrics Screen width/height:1600/1200 16:04:02 INFO - PID 8197 | colorDepth:24 16:04:02 INFO - PID 8197 | Browser inner width/height: 1024/697 16:04:02 INFO - PID 8197 | __metrics 16:04:03 ERROR - PID 8197 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 16:04:04 INFO - TEST-INFO | 8197: exit 0 16:04:04 INFO - Browser initialized. 16:04:04 INFO - Running cycle 1/1 for dromaeo_css test... 16:04:04 INFO - TEST-INFO | started process 8329 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNh820t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:04:16 INFO - PID 8329 | RSS: Main: 155406336 16:04:16 INFO - PID 8329 | 16:07:20 INFO - PID 8329 | Cycle 1(1): loaded http://localhost:60298/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60298/tests/dromaeo/cssquery-ext.html) 16:07:22 INFO - PID 8329 | RSS: Main: 165695488 16:07:22 INFO - PID 8329 | 16:09:04 INFO - PID 8329 | ************************* 16:09:04 INFO - PID 8329 | A coding exception was thrown and uncaught in a Task. 16:09:04 INFO - PID 8329 | 16:09:04 ERROR - PID 8329 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:09:04 INFO - PID 8329 | Full stack: 16:09:04 INFO - PID 8329 | ************************* 16:10:24 INFO - PID 8329 | Cycle 1(1): loaded http://localhost:60298/tests/dromaeo/cssquery-ext.html (next: http://localhost:60298/tests/dromaeo/cssquery-jquery.html) 16:10:25 INFO - PID 8329 | RSS: Main: 161730560 16:10:25 INFO - PID 8329 | 16:13:27 INFO - PID 8329 | Cycle 1(1): loaded http://localhost:60298/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60298/tests/dromaeo/cssquery-mootools.html) 16:13:28 INFO - PID 8329 | RSS: Main: 169332736 16:13:28 INFO - PID 8329 | 16:16:30 INFO - PID 8329 | Cycle 1(1): loaded http://localhost:60298/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60298/tests/dromaeo/cssquery-prototype.html) 16:16:30 INFO - PID 8329 | RSS: Main: 161263616 16:16:30 INFO - PID 8329 | 16:19:33 INFO - PID 8329 | Cycle 1(1): loaded http://localhost:60298/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60298/tests/dromaeo/cssquery-yui.html) 16:19:34 INFO - PID 8329 | RSS: Main: 168771584 16:19:34 INFO - PID 8329 | 16:22:37 INFO - PID 8329 | Cycle 1(1): loaded http://localhost:60298/tests/dromaeo/cssquery-yui.html (next: http://localhost:60298/tests/dromaeo/cssquery-dojo.html) 16:22:37 INFO - PID 8329 | RSS: Main: 162316288 16:22:37 INFO - PID 8329 | 16:22:37 INFO - PID 8329 | __start_tp_report 16:22:37 INFO - PID 8329 | _x_x_mozilla_page_load 16:22:37 INFO - PID 8329 | _x_x_mozilla_page_load_details 16:22:37 INFO - PID 8329 | |i|pagename|runs| 16:22:37 INFO - PID 8329 | |0;dojo.html;2716.9592456113155;2742.4926388618096;2757.338238822682;2762.4337010912755;2786.777057835373;4920.040592084536;5140.331756871601;5177.559907407875;5199;5201.817936372218;5041.143005689032;5137.460566640505;5140.614453915952;5203.739813009353;5245.265662807201;4627.398438203046;4655.813767449298;4664.4402671679445;4665.253559430492;4689.953100468986;4689.9531004690025;4694.929576056362;4717.834875779348;4730.195866702668;4770.785314660831;4662;4663.720176789369;4665.160271151191;4693.812247510095;4728.338032675429;4656.837010704609;4664.930026049612;4675.976620116878;4712.175369310357;4715.64632652549;4573.588377046081;4615.446146462446;4623.26027835548;4634.930476042862;4674.182018146811;4983.90032199354;5029.949700502984;5050.671706339076;5090.211017292326;5091.389033315989;5557.861053473655;5564.081926482126;5569.554435645179;5597.076482380402;5622.662640241558;5582.63712858667;5590.608657393944;5597.580181486364;5600.551955843523;5611.438856114397;5007.674501157413;5063.063333283354;5066.113430149783;5182.196759502283;5264.31563896691;5478;5514.641548299348;5515.338159420895;5534.723263836792;5550.4449555044985;5312.707801070901;5421;5460.071787796084;5478.726063696799;5493.258410114583;5405.162199859028;5448.9727551362785;5460.426655201226;5480.150576660624;5490.890182196414;5430.701311427831;5436.016959658777;5449.4005659377435;5454.345478542521;5484.177373393943;5319.414864364917;5381.0583147948955;5462.180672899097;5513.724313784295;5517.503424691797;4629.67592268538;4635.304704294315;4636.026434448736;4655.045715628288;4674.742889141062;3987.980060099681;3990.8004599769897;3995.700322475826;4007.1184339445276;4051.8987025324013;4649.232876575395;4702.294655801657;4753.881152971134;4800.687955282895;4836.927446088312;5601.383847776741;5602.971985140048;5618.85952851182;5622.409646987007;5645.661260324394;4766.76166191689;4808.471068182497;4819.95180048202;4822.541858523435;4844;4842.22524396102;4900.975495122501;4903.730294833747;4903.828366007173;4977.776000079933;5081.745912704276;5133.02472530233;5145.099607568735;5148.176291793295;5157.406898206604;5472.972635136958;5476.288082549243;5484;5485.835424937259;5493.7802487900035;5190.480951904779;5215.426303106579;5237.947620523746;5250.606204534599;5255.947440525546;5384.300040994645;5439.5920305976415;5446.564274857923;5449.155380915964;5449.754761035683;5345.786168553214;5622.128570071645;5632.098864181711;5632.605717599728;5682.9431705684065;5249.47505249472;5336.439673834191;5388.568914486753;5400.297961265168;5409.486098820606;5376.112941364631;5377.704226267593;5379.488948549882;5394.973025134849;5405.162199859028;5281.683099014072;5312.150055991023;5316.627836051439;5317.893642127213;5318.867028324323;5238.947610523846;5316.946830531645;5384.919226211531;5415.810446634349;5439.619226654097;5218.8956220876125;5223.608229382888;5243.528082472596;5245.003449344612;5278.2346559749385 16:22:37 INFO - PID 8329 | |1;ext.html;637.9075034120053;667.9365460281275;671.3353779758041;714.2107970692384;727.9927200727993;29580.112596622108;30536.847315763447;30562.541561876562;30592;30641.846790766016;32832.50751238733;33010.50484242733;33115.66884331156;33172.17069573256;33217.501737473896;2201.196563254409;2211.5466329402516;2236.2955668964264;2285.2001799370255;2366.1127077345996;2395.125779090628;2430.805535557151;2432.805375569959;2434.014224239177;2434.1358817619666;2417.5044115956275;2426.1751004658413;2430.6111022236446;2431.0640403444622;2436.049940523197;2404.555157295897;2412.457197130649;2429.0283886445386;2433.9391515212083;2440.19473573722;2314;2333.696619439479;2335.3577766114286;2347.272345572878;2347.7534858839917;31755.682443175505;31871;31961.680383196337;33817.830910845536;34182.6581734182;2672.425428532875;2683.932901677454;2701.2706569226393;2711.457708458316;2722.6460560127257;23288.4177895554;23376.532469350517;23389.181378651836;24009.87995060031;24312.635310470356;2900.7824413169096;2966.6291713535807;2967.540031295153;2970.85145742712;2977.8064425812254;128267;132430.33784831112;134141;153019.23490382478;154229.22885385613;37358.626413736056;37634.247315053544;37719;37724;37764.43353349702;38188.809055954545;38766.41850372247;38937;39028.80485597554;39032;12598.244105353708;12657.810132848015;12728.045396595293;12776.744465110645;12949.417276222594;10390.272680912414;10419.218558608134;10483.842742358871;10493.26547141708;10540.420276884844;12914.22514649124;12916;12916.095873288967;12981.675458113434;13166.539171128965;5424.484673956047;5450.236966824647;5475.09660905946;5482.259894914216;5562.360328562187;854.3763052971366;864.93512986525;865.852805023135;895.5566994337714;907.832051070554;19861.14096341554;20786;20967.895160524098;21006.474838128863;21091.68362474564;968.7917097824002;984.1585444444896;1004.6935684616262;1004.8191325561469;1013.9695809125737;10621.575136994588;10633.149348052137;10850.860659630625;10969.890301096886;11063.668089957315;210254;210570;210936;211801;211850;40665.796671016455;40681;40695.38956915648;41037;41142.38286425706;1190.4821402689859;1255.0461649146532;1261.433610330609;1265.9683507912375;1280.257450678604;19250.22999080021;19325.226990920204;19518.902405487883;20688;20885.16459341609;29454.558181626864;29682.554761679025;29922;30037.399252014402;30055.248618784706;210891;211004;211434;212013;212180;26798.732012679622;26929.596056059567;27270.86364568244;27339.86330068337;27393.836386812807;33318.16704582405;33942.66057339494;34615.826920865235;34765;34872.12819679528;27878.581821273103;28930.566041509814;29062;29337.266568335963;30247.092587222418;27717.72282277232;28633.856830716548;28680.282992925342;28797.28006799847;30214.395712086076;30021.099367019026;30123.54814677738;30137.547936780527;30150.96980603932;30691.693083068883;24919;26119.347016323984;27543.31141721473;27601.86199068992;28086.2978425541;21400.67898981548;21480.355589332346;21621.891890540446;21739.456513587287;21780.237691680715 16:22:37 INFO - PID 8329 | |2;jquery.html;422.0268210457332;434.37016326326824;441.9911601767965;444.5843136667214;449.4180036852276;16877.746833797486;17090.829091709078;17527.386541471053;19321.13054912529;19381.70927436086;17875.28498860044;17948;17986.280548778064;18319.17563709633;19018.334358297463;3868.3810590305557;3875.612438756123;3957.5053118360206;3967.642912137907;3988.700847436454;3911.765294082364;3940.921181576367;3980.761154330735;4003.4795476588147;4007.138465229975;3958.8812335629977;3960.1089754805225;3965.4250133730593;3971.960280397188;3972.543157536877;3797.278517081759;3910.9608903911026;3940.940885886714;3945.467361906149;3951.249262640118;3669.21111960927;3670.3576874047203;3670.46778217157;3677.3748462761396;3685.594584595692;20725.37305971464;22100.447488812748;22159.889200554055;22621.434464138365;22786.65820012701;1557.0891028748197;1583.4774524406919;1595.9760603590955;1615.4911202971143;1626.9674606507922;13764.17414955106;13824.930875345659;14008.439662413593;14115.647108822259;14464.421423143061;1795.7665503484463;1809.0272249641791;1820.1809185866414;1830.5240637434363;1852.8327153893097;75723;89758.55120724419;91078;92212;93044;11094.611688591021;11286.943565282285;11366.772664546663;11418.885811141949;11636.185467017227;16217.270222840001;16236.350545978265;16239.106849123411;16291.348346066261;16320.183990800413;7753.10839253493;7931.087924888597;8052.315553178046;8150.184981501802;8187.549684767276;7348.081489813773;7361.705531778776;7382.9630851845395;7540.660670269851;7623.9618801905635;6911.861762764716;6920.861582768316;7037.261087585832;7061.1173603299585;7105.32499412555;2136.465883529118;2143.6570148776123;2155.838312126597;2159.967600485994;2260.920867769653;849.6856163219525;871.6208449324564;875.991240087591;885.0389803242173;901.0268909577641;16296;16532.83467165337;16541.751873721903;17007.914960425118;17606.559836003948;888.813349196663;896.4531635702216;907.9546022698971;914.1224424552504;915.2129168914728;8770.868436973451;10761.798587885545;10863.239573229956;12029.75940481203;12259.693507662201;300744;304475;304722;434436;443745;69243.65378173077;81146;82870;90384.54807726051;91688.54155729312;1058.9841152382721;1072.5280876414354;1120.9831852522218;1125.2966895690195;1125.7467069909205;16968.915155424143;17192.742108868126;17514.38699645506;17876;18341.90829045846;34738.131546711535;40571.1885762289;40595.39106913458;41834;42533;52534.47465525296;53314.2002869965;55861.72069139628;57844;60107.39892601193;8445.535495547803;8589.269912057294;8776.605052772513;8848.867266990872;8904.154105359981;13158.539451119164;13407.32963351848;13457.192568445924;13706.862931370559;13709.17744935307;10330.948345258226;10385.532651030571;10410;10694.518746656264;10705.89294107049;9188;9808.803823923625;10778.622748203776;10897.073748731129;11736.413179340829;11047.226694131334;11057.668269951915;11119.666410007712;11452.541898323974;11576.88423115758;8114.391420643594;8189.79525511867;8289.709860154866;8318.667253309799;8550.529720865412;11213.439328033402;11313.71715707114;11495.310281383145;11534.250273732181;11745.177837551631 16:22:37 INFO - PID 8329 | |3;mootools.html;1272.4401263444083;1326.7744483437814;1338.4177882621054;1340.2762508245542;1344.0591585889877;9100.180983711465;9387.29595280354;9396.95301523493;9607.4715890626;9834.901650983487;9634.373765705242;9712.611495540188;9778.511074446267;9803.950980245088;9814.116729494344;2116.058354032456;2141.935741927745;2148.11927109885;2152.2251989283845;2154.1060459909118;2169.674548817682;2214.878181700006;2219.855709378893;2226.1206823304783;2241.60771864923;2129.691194776756;2159.114762947192;2175.4670105824093;2181.923632672857;2185.3007037747925;2110.8205802506805;2127.851050426463;2130.7869213078648;2136.1241890824685;2139.1015773375143;1812.8549716022687;1869.7475840761458;2045.795420457957;2138.497453098536;2239.8880055997133;9485.810283794286;9544.904550954541;9578.856317155249;9581.664641737576;9857.90142098577;5342.652727572696;5585.245991791137;5585.888282234332;5589.776408943678;5603.10350343943;3177.348643528071;3197.328561002192;3268.7711860169798;3282.901512954615;3330.483775014852;1031.1493018259966;1032.865727455426;1055.788842231549;1068.2362111090529;1111.3665210829831;13946.302684865817;14014.299285035708;14046.859531404658;14116.15303081808;14140.92929535356;4410.5368936261875;4629.837955671535;4687.179743544866;4711.3639658646325;4796.77682191046;10625.203109766799;10677.626283080055;10683.83974240387;10712.143028557697;10742.946285268523;5436.401995780461;5436.592255580847;5437.809676661298;5439.265699130646;5462.399136095027;4641.559051890133;4799.18413869643;4830.903381932412;4950.5544500994365;5035.338338348336;3648.2703459307713;3767.1523907120677;3771.396576547739;3834.2906562285507;3851.788151651686;1073.8013467508379;1078.2344535379968;1078.6979645699216;1098.5386137822134;1102.2174256278133;655.6885479397248;659.9208095028628;695.9930400695928;697.9057827193366;702.420503084957;5138.229265610188;5142.562882155059;5193.584513238932;5372.758225879845;5378.489043540857;816.1104396208161;816.9877451838228;818.5620692929255;828.1263267252986;830.4767996162379;3049.207206126379;3061.5101583746496;3068.769842261839;3128.6066159388088;3203.1351535085864;12766.680832979064;13121.147125436815;13197.53808616713;13241.80137297922;13252.20486770797;13038.282894440898;13092.607221783363;13110.082294239503;13120.540781072808;13133;9094.636214551343;9179.495127767903;9261.953690231505;9317.534123293808;9372.5313734313;5329.813456529003;5342;5391.649542779707;5433.5381492572;5564.304461942257;11380.43097845121;11511.654650360168;11574.537018519164;11661.53353865836;11665.35840528779;11913.106517011085;12035.217710848767;12108.939455302667;12165.695857603278;12229.082818788449;7613.467057305936;7756.108047574601;7871.645775940211;8074.192580742114;8182.631781569725;9068.863967040632;9126.543672816466;9128.49793261377;9202;9205.355625106178;7885.64514596833;7933.761987140395;7935.880961785462;7937.285644292041;8029.397795165502;7765.611719413893;7796.805079873048;7798.415118866221;7828.725994590162;7999.080105787909;6820.249772524919;7032.789016329519;7101.218865924848;7217.24218957002;7262.709491620276;4955.603551715782;5025.6482046256415;5031.924521132113;5092.439831618593;5117.078925793244;4979.751012449436;4990.326305948651;5010.423801262901;5102.438731739431;5145.562627176582 16:22:37 INFO - PID 8329 | |4;prototype.html;361.98190090495484;387.50205985308884;398.2870661515885;407.9938800917987;408.7506620961214;5308.256844041833;5329.626926115168;5371.731413429333;5389.622726409153;5401.621886467949;5307.601929855257;5308.416074231832;5311.24728839483;5325.227841962913;5341.759620817063;3969.30537155998;4157.896052598679;4162.354835000579;4167.958320416802;4303.655707543397;4149.7302675326155;4150.252954468195;4160.607650600901;4161.396597493362;4178.018165731066;4140.337545992642;4140.441040459529;4141.647959923395;4152.937705934413;4157.896052598679;3887.436321733333;4048.6356227939627;4133.751974881502;4146.108586653853;4154.543000269968;3581.158427769472;3582.7133829293593;3594.6045934947133;3603.4414665726854;3628.6371362863765;5119.38567371914;5120.668626157189;5159.2003239497935;5172.922406163911;5179.585633149339;4590.954090459086;4717.882052948704;4731.148393289207;4747.643926705511;4755;5582.413846546136;5591.3569939457075;5599.1041433370465;5611.7474713637985;5611.803586874481;3972.00113913996;3973.5033120859894;3975.900602484961;3981.9845939285588;3987.5414327352437;5614.887702245932;5687.260656114761;5776;5784.392638772911;5893.0276504376725;4077.429159917614;4088.9795551022053;4094.9181016379507;4099.774512401847;4105.958940410557;4128.91742165155;4145.316022856256;4161.583841615875;4171.228322760299;4173.52004519478;4504.189245935698;4664.813407463731;4753;4764.714117152982;4767.380240568704;5583.944160558423;5592.552595792326;5603.7478313475995;5605.579581531401;5614.754098360689;1426.3866537389022;1442.1779585636086;1442.3581506229627;1447.3631602095045;1448.3771978049328;954.3271993244746;984.5815528400544;988.2094324540338;991.9305648604673;1008.1481148429565;4889.731064791471;4914.852554423302;4923.655344125877;4937.851864444073;4939.160342741742;5747.1379293106365;5753.280839895013;5789.189513468118;5789.8263052108505;5790.305163380422;4766.189747742823;4811.7486284684755;4868.269759536027;4929.457759646436;4943.912339285352;3019.6829332920165;3043.6195475565555;3044.071558174778;3057.2051266670824;3065.555494453292;5385.946140538623;5392;5396.625484786681;5402.460298814819;5419.783208671688;5627.52166065889;5874.471297583238;5897.115432685132;5940.79207227745;5965.224520812353;5446.673199608036;5450.258275300514;5465.726713664301;5470.206820011076;5478.287822583039;5680.261565996394;5765.673895004089;5798;5811.767529298781;5844.94155058444;5701.942980570141;5728.427157284238;5770.769169233184;5775.364709881994;5777.620092246083;5209.6874187548865;5309.548688361532;5371.113766228528;5440.428754980829;5481.561475082063;4011.7994100294286;4042.9393559097225;4049.5140583129037;4057.490270915696;4067.3695577185586;5645.71771411436;5700.144978253295;5764.538836892954;5786.797462088975;5820.653124453372;5603.551715862803;5612.887742245214;5614.887702246014;5628.662280263197;5628.831135065954;5601.411851755507;5621.494065534122;5625.128105143709;5626.2967129108865;5627.874425114912;5386.8383948481605;5528.91706624409;5566.304211973504;5573.832785016456;5577.60163129858;5633.8591535211945;5643.971780141237;5658.434156584309;5662.320521537442;5684.63049901755;5507.228987941771;5520;5526.41972592888;5531.612787104864;5542 16:22:37 INFO - PID 8329 | |5;yui.html;684.3943110347341;686.7390391651173;687.316120460142;690.540790374401;693.847353582212;12778;13125.474981000772;13140.802887956675;13173.604791856247;13183.538576149836;12581.119321647466;12675.936620316885;12773.552925647604;12783.488660453593;12786.552470663528;814.5031530766228;847.817719190374;850.3962186847315;851.9190676885686;852.3479538153287;843.439112989861;846.2679781988597;847.516915358246;848.9363297752693;853.2320911179957;888.404768804899;889.813139240757;889.8398288308102;890.3055616619048;891.4205766251956;889.1775108025083;890.0698769785557;892.0276898180949;892.0410558649413;893.530896279452;649.136648257816;650.9609423434609;652.3085529338869;655.4592461219465;655.5804285257439;14122.36449359771;14171.220582867938;14325.49860754879;14375.856241437556;14391.78412323816;12546.560870369492;13096.279704616243;13326.133801302884;13439.395227214798;13501.122427042212;9832.901670983341;10125.746856328577;10235.232357573212;10264.94867525665;10417.479126043743;2690.5829596412586;2704.4050308932005;2716.4295497945454;2727.468143711977;2805.551111822099;64485.67757161184;65069.67465162644;66091.339086609;67580;67754.9836752454;10482;10534.36793792375;10652.686191805822;10666.306690065121;10936.179786515884;20882.79117208839;21055.578888422147;21284;21493.355199344045;21546.56906861854;6916.827079323057;6941.861162776716;6955.374016338554;6978.860422791516;7038.472114591324;3159.5892533970896;3228.0799972007867;3284.83575821208;3290.5393244945726;3290.6672797517044;3476.5828100628087;3508.649135086522;3509.94735078974;3525.4359302511475;3552.182997910495;701.9262977387301;706.4136766483806;713.0552018575305;719.5251134251369;725.7205975699394;480.7524125075589;498.68333608158355;503.8513638476658;511.26122752622103;522.4279414041619;8434.915650843535;8581.528015959057;8951.239144672776;9050.456972581665;9128.543572821465;505.6283631530822;520.8151106357265;527.5594878276682;531.5959870498372;539.134688824439;3863.9806800966376;4069.959300406958;4108.856190033334;4109.794510274474;4217.7891105444605;58769;59410;60675;61100;61395.38604613986;52176;52505.2124218137;52581.737091314295;54172;55262;45038;45158.32262516065;45231;45777.54222457799;46799.53200467952;8015.398845086758;8311;8344.666213351398;8452.070272269922;8506.404551681322;22352.441188969755;23048.539029219657;25165.496690066462;25958.870205649608;26179.34551636148;33600;35717.46423803593;36587.451188231666;36594;36720.26559468849;11017.83473247886;11028.44857757125;11065.446727663746;11143.665690029313;11365.147613928822;11890.346030968034;12128.090393220367;12279.69300767488;12333.814992774936;12687.555935542212;11399.031082358093;11562.94218528902;11614.245074070159;11817;12021.639350819489;11399.838180473302;11550.826737598774;12062.698432539257;12063.155579109378;12562.183458075197;10899.564017439214;11307.547698091985;11368.658940231806;11431.256968297033;11700.941495292469;9659.71020869375;9931.851022234529;9999.250056245955;10241.539130739284;10269.84595231087;8456.365772566958;9332.253419726541;9620.567074481525;9786.51067446639;9882.209423246266 16:22:37 INFO - PID 8329 | __end_tp_report 16:22:37 INFO - PID 8329 | __start_cc_report 16:22:37 INFO - PID 8329 | _x_x_mozilla_cycle_collect,396 16:22:37 INFO - PID 8329 | __end_cc_report 16:22:37 INFO - PID 8329 | __startTimestamp1490138557304__endTimestamp 16:22:37 INFO - PID 8329 | 16:22:37 INFO - PID 8329 | ------- Summary: start ------- 16:22:37 INFO - PID 8329 | Number of tests: 6 16:22:37 INFO - PID 8329 | 16:22:37 INFO - PID 8329 | [#0] dojo.html Cycles:165 Average:5069.87 Median:5237.95 stddev:560.50 (10.7%) stddev-sans-first:530.95 16:22:37 INFO - PID 8329 | Values: 2717.0 2742.5 2757.3 2762.4 2786.8 4920.0 5140.3 5177.6 5199.0 5201.8 5041.1 5137.5 5140.6 5203.7 5245.3 4627.4 4655.8 4664.4 4665.3 4690.0 4690.0 4694.9 4717.8 4730.2 4770.8 4662.0 4663.7 4665.2 4693.8 4728.3 4656.8 4664.9 4676.0 4712.2 4715.6 4573.6 4615.4 4623.3 4634.9 4674.2 4983.9 5029.9 5050.7 5090.2 5091.4 5557.9 5564.1 5569.6 5597.1 5622.7 5582.6 5590.6 5597.6 5600.6 5611.4 5007.7 5063.1 5066.1 5182.2 5264.3 5478.0 5514.6 5515.3 5534.7 5550.4 5312.7 5421.0 5460.1 5478.7 5493.3 5405.2 5449.0 5460.4 5480.2 5490.9 5430.7 5436.0 5449.4 5454.3 5484.2 5319.4 5381.1 5462.2 5513.7 5517.5 4629.7 4635.3 4636.0 4655.0 4674.7 3988.0 3990.8 3995.7 4007.1 4051.9 4649.2 4702.3 4753.9 4800.7 4836.9 5601.4 5603.0 5618.9 5622.4 5645.7 4766.8 4808.5 4820.0 4822.5 4844.0 4842.2 4901.0 4903.7 4903.8 4977.8 5081.7 5133.0 5145.1 5148.2 5157.4 5473.0 5476.3 5484.0 5485.8 5493.8 5190.5 5215.4 5237.9 5250.6 5255.9 5384.3 5439.6 5446.6 5449.2 5449.8 5345.8 5622.1 5632.1 5632.6 5682.9 5249.5 5336.4 5388.6 5400.3 5409.5 5376.1 5377.7 5379.5 5395.0 5405.2 5281.7 5312.2 5316.6 5317.9 5318.9 5238.9 5316.9 5384.9 5415.8 5439.6 5218.9 5223.6 5243.5 5245.0 5278.2 16:22:37 INFO - PID 8329 | 16:22:37 INFO - PID 8329 | [#1] ext.html Cycles:180 Average:31735.90 Median:14735.58 stddev:49904.07 (338.7%) stddev-sans-first:49989.43 16:22:37 INFO - PID 8329 | Values: 637.9 667.9 671.3 714.2 728.0 29580.1 30536.8 30562.5 30592.0 30641.8 32832.5 33010.5 33115.7 33172.2 33217.5 2201.2 2211.5 2236.3 2285.2 2366.1 2395.1 2430.8 2432.8 2434.0 2434.1 2417.5 2426.2 2430.6 2431.1 2436.0 2404.6 2412.5 2429.0 2433.9 2440.2 2314.0 2333.7 2335.4 2347.3 2347.8 31755.7 31871.0 31961.7 33817.8 34182.7 2672.4 2683.9 2701.3 2711.5 2722.6 23288.4 23376.5 23389.2 24009.9 24312.6 2900.8 2966.6 2967.5 2970.9 2977.8 128267.0 132430.3 134141.0 153019.2 154229.2 37358.6 37634.2 37719.0 37724.0 37764.4 38188.8 38766.4 38937.0 39028.8 39032.0 12598.2 12657.8 12728.0 12776.7 12949.4 10390.3 10419.2 10483.8 10493.3 10540.4 12914.2 12916.0 12916.1 12981.7 13166.5 5424.5 5450.2 5475.1 5482.3 5562.4 854.4 864.9 865.9 895.6 907.8 19861.1 20786.0 20967.9 21006.5 21091.7 968.8 984.2 1004.7 1004.8 1014.0 10621.6 10633.1 10850.9 10969.9 11063.7 210254.0 210570.0 210936.0 211801.0 211850.0 40665.8 40681.0 40695.4 41037.0 41142.4 1190.5 1255.0 1261.4 1266.0 1280.3 19250.2 19325.2 19518.9 20688.0 20885.2 29454.6 29682.6 29922.0 30037.4 30055.2 210891.0 211004.0 211434.0 212013.0 212180.0 26798.7 26929.6 27270.9 27339.9 27393.8 33318.2 33942.7 34615.8 34765.0 34872.1 27878.6 28930.6 29062.0 29337.3 30247.1 27717.7 28633.9 28680.3 28797.3 30214.4 30021.1 30123.5 30137.5 30151.0 30691.7 24919.0 26119.3 27543.3 27601.9 28086.3 21400.7 21480.4 21621.9 21739.5 21780.2 16:22:37 INFO - PID 8329 | 16:22:37 INFO - PID 8329 | [#2] jquery.html Cycles:180 Average:24871.75 Median:19203.67 stddev:60982.90 (317.6%) stddev-sans-first:61126.34 16:22:37 INFO - PID 8329 | Values: 422.0 434.4 442.0 444.6 449.4 16877.7 17090.8 17527.4 19321.1 19381.7 17875.3 17948.0 17986.3 18319.2 19018.3 3868.4 3875.6 3957.5 3967.6 3988.7 3911.8 3940.9 3980.8 4003.5 4007.1 3958.9 3960.1 3965.4 3972.0 3972.5 3797.3 3911.0 3940.9 3945.5 3951.2 3669.2 3670.4 3670.5 3677.4 3685.6 20725.4 22100.4 22159.9 22621.4 22786.7 1557.1 1583.5 1596.0 1615.5 1627.0 13764.2 13824.9 14008.4 14115.6 14464.4 1795.8 1809.0 1820.2 1830.5 1852.8 75723.0 89758.6 91078.0 92212.0 93044.0 11094.6 11286.9 11366.8 11418.9 11636.2 16217.3 16236.4 16239.1 16291.3 16320.2 7753.1 7931.1 8052.3 8150.2 8187.5 7348.1 7361.7 7383.0 7540.7 7624.0 6911.9 6920.9 7037.3 7061.1 7105.3 2136.5 2143.7 2155.8 2160.0 2260.9 849.7 871.6 876.0 885.0 901.0 16296.0 16532.8 16541.8 17007.9 17606.6 888.8 896.5 908.0 914.1 915.2 8770.9 10761.8 10863.2 12029.8 12259.7 300744.0 304475.0 304722.0 434436.0 443745.0 69243.7 81146.0 82870.0 90384.5 91688.5 1059.0 1072.5 1121.0 1125.3 1125.7 16968.9 17192.7 17514.4 17876.0 18341.9 34738.1 40571.2 40595.4 41834.0 42533.0 52534.5 53314.2 55861.7 57844.0 60107.4 8445.5 8589.3 8776.6 8848.9 8904.2 13158.5 13407.3 13457.2 13706.9 13709.2 10330.9 10385.5 10410.0 10694.5 10705.9 9188.0 9808.8 10778.6 10897.1 11736.4 11047.2 11057.7 11119.7 11452.5 11576.9 8114.4 8189.8 8289.7 8318.7 8550.5 11213.4 11313.7 11495.3 11534.3 11745.2 16:22:37 INFO - PID 8329 | 16:22:37 INFO - PID 8329 | [#3] mootools.html Cycles:180 Average:6099.89 Median:4797.98 stddev:3936.81 (82.1%) stddev-sans-first:3931.14 16:22:37 INFO - PID 8329 | Values: 1272.4 1326.8 1338.4 1340.3 1344.1 9100.2 9387.3 9397.0 9607.5 9834.9 9634.4 9712.6 9778.5 9804.0 9814.1 2116.1 2141.9 2148.1 2152.2 2154.1 2169.7 2214.9 2219.9 2226.1 2241.6 2129.7 2159.1 2175.5 2181.9 2185.3 2110.8 2127.9 2130.8 2136.1 2139.1 1812.9 1869.7 2045.8 2138.5 2239.9 9485.8 9544.9 9578.9 9581.7 9857.9 5342.7 5585.2 5585.9 5589.8 5603.1 3177.3 3197.3 3268.8 3282.9 3330.5 1031.1 1032.9 1055.8 1068.2 1111.4 13946.3 14014.3 14046.9 14116.2 14140.9 4410.5 4629.8 4687.2 4711.4 4796.8 10625.2 10677.6 10683.8 10712.1 10742.9 5436.4 5436.6 5437.8 5439.3 5462.4 4641.6 4799.2 4830.9 4950.6 5035.3 3648.3 3767.2 3771.4 3834.3 3851.8 1073.8 1078.2 1078.7 1098.5 1102.2 655.7 659.9 696.0 697.9 702.4 5138.2 5142.6 5193.6 5372.8 5378.5 816.1 817.0 818.6 828.1 830.5 3049.2 3061.5 3068.8 3128.6 3203.1 12766.7 13121.1 13197.5 13241.8 13252.2 13038.3 13092.6 13110.1 13120.5 13133.0 9094.6 9179.5 9262.0 9317.5 9372.5 5329.8 5342.0 5391.6 5433.5 5564.3 11380.4 11511.7 11574.5 11661.5 11665.4 11913.1 12035.2 12108.9 12165.7 12229.1 7613.5 7756.1 7871.6 8074.2 8182.6 9068.9 9126.5 9128.5 9202.0 9205.4 7885.6 7933.8 7935.9 7937.3 8029.4 7765.6 7796.8 7798.4 7828.7 7999.1 6820.2 7032.8 7101.2 7217.2 7262.7 4955.6 5025.6 5031.9 5092.4 5117.1 4979.8 4990.3 5010.4 5102.4 5145.6 16:22:37 INFO - PID 8329 | 16:22:37 INFO - PID 8329 | [#4] prototype.html Cycles:180 Average:4647.64 Median:5310.40 stddev:1347.19 (25.4%) stddev-sans-first:1312.01 16:22:37 INFO - PID 8329 | Values: 362.0 387.5 398.3 408.0 408.8 5308.3 5329.6 5371.7 5389.6 5401.6 5307.6 5308.4 5311.2 5325.2 5341.8 3969.3 4157.9 4162.4 4168.0 4303.7 4149.7 4150.3 4160.6 4161.4 4178.0 4140.3 4140.4 4141.6 4152.9 4157.9 3887.4 4048.6 4133.8 4146.1 4154.5 3581.2 3582.7 3594.6 3603.4 3628.6 5119.4 5120.7 5159.2 5172.9 5179.6 4591.0 4717.9 4731.1 4747.6 4755.0 5582.4 5591.4 5599.1 5611.7 5611.8 3972.0 3973.5 3975.9 3982.0 3987.5 5614.9 5687.3 5776.0 5784.4 5893.0 4077.4 4089.0 4094.9 4099.8 4106.0 4128.9 4145.3 4161.6 4171.2 4173.5 4504.2 4664.8 4753.0 4764.7 4767.4 5583.9 5592.6 5603.7 5605.6 5614.8 1426.4 1442.2 1442.4 1447.4 1448.4 954.3 984.6 988.2 991.9 1008.1 4889.7 4914.9 4923.7 4937.9 4939.2 5747.1 5753.3 5789.2 5789.8 5790.3 4766.2 4811.7 4868.3 4929.5 4943.9 3019.7 3043.6 3044.1 3057.2 3065.6 5385.9 5392.0 5396.6 5402.5 5419.8 5627.5 5874.5 5897.1 5940.8 5965.2 5446.7 5450.3 5465.7 5470.2 5478.3 5680.3 5765.7 5798.0 5811.8 5844.9 5701.9 5728.4 5770.8 5775.4 5777.6 5209.7 5309.5 5371.1 5440.4 5481.6 4011.8 4042.9 4049.5 4057.5 4067.4 5645.7 5700.1 5764.5 5786.8 5820.7 5603.6 5612.9 5614.9 5628.7 5628.8 5601.4 5621.5 5625.1 5626.3 5627.9 5386.8 5528.9 5566.3 5573.8 5577.6 5633.9 5644.0 5658.4 5662.3 5684.6 5507.2 5520.0 5526.4 5531.6 5542.0 16:22:37 INFO - PID 8329 | 16:22:37 INFO - PID 8329 | [#5] yui.html Cycles:180 Average:13976.52 Median:24627.89 stddev:16962.53 (68.9%) stddev-sans-first:16980.75 16:22:37 INFO - PID 8329 | Values: 684.4 686.7 687.3 690.5 693.8 12778.0 13125.5 13140.8 13173.6 13183.5 12581.1 12675.9 12773.6 12783.5 12786.6 814.5 847.8 850.4 851.9 852.3 843.4 846.3 847.5 848.9 853.2 888.4 889.8 889.8 890.3 891.4 889.2 890.1 892.0 892.0 893.5 649.1 651.0 652.3 655.5 655.6 14122.4 14171.2 14325.5 14375.9 14391.8 12546.6 13096.3 13326.1 13439.4 13501.1 9832.9 10125.7 10235.2 10264.9 10417.5 2690.6 2704.4 2716.4 2727.5 2805.6 64485.7 65069.7 66091.3 67580.0 67755.0 10482.0 10534.4 10652.7 10666.3 10936.2 20882.8 21055.6 21284.0 21493.4 21546.6 6916.8 6941.9 6955.4 6978.9 7038.5 3159.6 3228.1 3284.8 3290.5 3290.7 3476.6 3508.6 3509.9 3525.4 3552.2 701.9 706.4 713.1 719.5 725.7 480.8 498.7 503.9 511.3 522.4 8434.9 8581.5 8951.2 9050.5 9128.5 505.6 520.8 527.6 531.6 539.1 3864.0 4070.0 4108.9 4109.8 4217.8 58769.0 59410.0 60675.0 61100.0 61395.4 52176.0 52505.2 52581.7 54172.0 55262.0 45038.0 45158.3 45231.0 45777.5 46799.5 8015.4 8311.0 8344.7 8452.1 8506.4 22352.4 23048.5 25165.5 25958.9 26179.3 33600.0 35717.5 36587.5 36594.0 36720.3 11017.8 11028.4 11065.4 11143.7 11365.1 11890.3 12128.1 12279.7 12333.8 12687.6 11399.0 11562.9 11614.2 11817.0 12021.6 11399.8 11550.8 12062.7 12063.2 12562.2 10899.6 11307.5 11368.7 11431.3 11700.9 9659.7 9931.9 9999.3 10241.5 10269.8 8456.4 9332.3 9620.6 9786.5 9882.2 16:22:37 INFO - PID 8329 | -------- Summary: end -------- 16:22:37 INFO - PID 8329 | 16:22:38 INFO - TEST-INFO | 8329: exit 0 16:22:38 INFO - TEST-OK | dromaeo_css | took 1120258ms 16:22:38 INFO - TEST-START | kraken 16:22:38 INFO - operating with platform_type : linux_ 16:22:38 INFO - Initialising browser for kraken test... 16:22:38 INFO - TEST-INFO | started process 8707 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQBRBfj/profile http://localhost:60298/getInfo.html) 16:22:42 INFO - PID 8707 | __metrics Screen width/height:1600/1200 16:22:42 INFO - PID 8707 | colorDepth:24 16:22:42 INFO - PID 8707 | Browser inner width/height: 1024/697 16:22:42 INFO - PID 8707 | __metrics 16:22:43 ERROR - PID 8707 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 16:22:44 INFO - TEST-INFO | 8707: exit 0 16:22:44 INFO - Browser initialized. 16:22:44 INFO - Running cycle 1/1 for kraken test... 16:22:44 INFO - TEST-INFO | started process 8838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQBRBfj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:22:56 INFO - PID 8838 | RSS: Main: 155557888 16:22:56 INFO - PID 8838 | 16:22:59 INFO - PID 8838 | Cycle 1(1): loaded http://localhost:60298/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60298/tests/kraken/driver.html?testName=audio-beat-detection) 16:23:00 INFO - PID 8838 | RSS: Main: 161939456 16:23:00 INFO - PID 8838 | 16:23:02 INFO - PID 8838 | Cycle 1(1): loaded http://localhost:60298/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60298/tests/kraken/driver.html?testName=audio-dft) 16:23:03 INFO - PID 8838 | RSS: Main: 160808960 16:23:03 INFO - PID 8838 | 16:23:06 INFO - PID 8838 | Cycle 1(1): loaded http://localhost:60298/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60298/tests/kraken/driver.html?testName=audio-fft) 16:23:07 INFO - PID 8838 | RSS: Main: 157372416 16:23:07 INFO - PID 8838 | 16:23:09 INFO - PID 8838 | Cycle 1(1): loaded http://localhost:60298/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60298/tests/kraken/driver.html?testName=audio-oscillator) 16:23:09 INFO - PID 8838 | RSS: Main: 158175232 16:23:09 INFO - PID 8838 | 16:23:12 INFO - PID 8838 | Cycle 1(1): loaded http://localhost:60298/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60298/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:23:12 INFO - PID 8838 | RSS: Main: 158367744 16:23:12 INFO - PID 8838 | 16:23:15 INFO - PID 8838 | Cycle 1(1): loaded http://localhost:60298/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60298/tests/kraken/driver.html?testName=imaging-darkroom) 16:23:16 INFO - PID 8838 | RSS: Main: 163045376 16:23:16 INFO - PID 8838 | 16:23:20 INFO - PID 8838 | Cycle 1(1): loaded http://localhost:60298/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60298/tests/kraken/driver.html?testName=imaging-desaturate) 16:23:20 INFO - PID 8838 | RSS: Main: 160849920 16:23:20 INFO - PID 8838 | 16:23:23 INFO - PID 8838 | Cycle 1(1): loaded http://localhost:60298/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60298/tests/kraken/driver.html?testName=json-parse-financial) 16:23:24 INFO - PID 8838 | RSS: Main: 162070528 16:23:24 INFO - PID 8838 | 16:23:26 INFO - PID 8838 | Cycle 1(1): loaded http://localhost:60298/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60298/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:23:26 INFO - PID 8838 | RSS: Main: 163221504 16:23:26 INFO - PID 8838 | 16:23:28 INFO - PID 8838 | Cycle 1(1): loaded http://localhost:60298/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60298/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:23:29 INFO - PID 8838 | RSS: Main: 162861056 16:23:29 INFO - PID 8838 | 16:23:31 INFO - PID 8838 | Cycle 1(1): loaded http://localhost:60298/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60298/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:23:32 INFO - PID 8838 | RSS: Main: 163110912 16:23:32 INFO - PID 8838 | 16:23:34 INFO - PID 8838 | Cycle 1(1): loaded http://localhost:60298/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60298/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:23:35 INFO - PID 8838 | RSS: Main: 163434496 16:23:35 INFO - PID 8838 | 16:23:38 INFO - PID 8838 | Cycle 1(1): loaded http://localhost:60298/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60298/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:23:39 INFO - PID 8838 | RSS: Main: 163418112 16:23:39 INFO - PID 8838 | 16:23:41 INFO - PID 8838 | Cycle 1(1): loaded http://localhost:60298/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60298/tests/kraken/driver.html?testName=ai-astar) 16:23:41 INFO - PID 8838 | RSS: Main: 165310464 16:23:41 INFO - PID 8838 | 16:23:41 INFO - PID 8838 | __start_tp_report 16:23:41 INFO - PID 8838 | _x_x_mozilla_page_load 16:23:41 INFO - PID 8838 | _x_x_mozilla_page_load_details 16:23:41 INFO - PID 8838 | |i|pagename|runs| 16:23:41 INFO - PID 8838 | |0;ai-astar;106;111;112;114;111;111;112;111;113;112 16:23:41 INFO - PID 8838 | |1;audio-beat-detection;154;125;129;163;126;125;127;127;148;125 16:23:41 INFO - PID 8838 | |2;audio-dft;163;166;164;167;168;168;164;166;165;165 16:23:41 INFO - PID 8838 | |3;audio-fft;75;76;74;110;77;75;75;76;101;77 16:23:41 INFO - PID 8838 | |4;audio-oscillator;85;84;103;84;84;84;104;85;85;99 16:23:41 INFO - PID 8838 | |5;imaging-gaussian-blur;113;114;113;114;114;116;121;115;114;113 16:23:41 INFO - PID 8838 | |6;imaging-darkroom;150;151;150;152;150;151;150;151;152;152 16:23:41 INFO - PID 8838 | |7;imaging-desaturate;94;95;94;95;95;95;95;100;95;95 16:23:41 INFO - PID 8838 | |8;json-parse-financial;68;68;68;69;69;69;68;70;69;70 16:23:41 INFO - PID 8838 | |9;json-stringify-tinderbox;56;55;56;56;56;55;56;56;57;55 16:23:41 INFO - PID 8838 | |10;stanford-crypto-aes;84;84;85;83;83;82;83;87;84;85 16:23:41 INFO - PID 8838 | |11;stanford-crypto-ccm;136;138;132;136;146;141;135;137;186;146 16:23:41 INFO - PID 8838 | |12;stanford-crypto-pbkdf2;188;200;200;205;186;209;189;198;204;200 16:23:41 INFO - PID 8838 | |13;stanford-crypto-sha256-iterative;77;72;72;81;72;71;74;70;72;76 16:23:41 INFO - PID 8838 | __end_tp_report 16:23:41 INFO - PID 8838 | __start_cc_report 16:23:41 INFO - PID 8838 | _x_x_mozilla_cycle_collect,891 16:23:41 INFO - PID 8838 | __end_cc_report 16:23:41 INFO - PID 8838 | __startTimestamp1490138621568__endTimestamp 16:23:41 INFO - PID 8838 | 16:23:41 INFO - PID 8838 | ------- Summary: start ------- 16:23:41 INFO - PID 8838 | Number of tests: 14 16:23:41 INFO - PID 8838 | 16:23:41 INFO - PID 8838 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.11 (1.9%) stddev-sans-first:1.05 16:23:41 INFO - PID 8838 | Values: 106.0 111.0 112.0 114.0 111.0 111.0 112.0 111.0 113.0 112.0 16:23:41 INFO - PID 8838 | 16:23:41 INFO - PID 8838 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:128.00 stddev:14.37 (11.2%) stddev-sans-first:13.48 16:23:41 INFO - PID 8838 | Values: 154.0 125.0 129.0 163.0 126.0 125.0 127.0 127.0 148.0 125.0 16:23:41 INFO - PID 8838 | 16:23:41 INFO - PID 8838 | [#2] audio-dft Cycles:10 Average:165.60 Median:166.00 stddev:1.71 (1.0%) stddev-sans-first:1.54 16:23:41 INFO - PID 8838 | Values: 163.0 166.0 164.0 167.0 168.0 168.0 164.0 166.0 165.0 165.0 16:23:41 INFO - PID 8838 | 16:23:41 INFO - PID 8838 | [#3] audio-fft Cycles:10 Average:81.60 Median:75.50 stddev:12.81 (17.0%) stddev-sans-first:13.36 16:23:41 INFO - PID 8838 | Values: 75.0 76.0 74.0 110.0 77.0 75.0 75.0 76.0 101.0 77.0 16:23:41 INFO - PID 8838 | 16:23:41 INFO - PID 8838 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:84.50 stddev:8.59 (10.2%) stddev-sans-first:8.94 16:23:41 INFO - PID 8838 | Values: 85.0 84.0 103.0 84.0 84.0 84.0 104.0 85.0 85.0 99.0 16:23:41 INFO - PID 8838 | 16:23:41 INFO - PID 8838 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.00 stddev:2.41 (2.1%) stddev-sans-first:2.47 16:23:41 INFO - PID 8838 | Values: 113.0 114.0 113.0 114.0 114.0 116.0 121.0 115.0 114.0 113.0 16:23:41 INFO - PID 8838 | 16:23:41 INFO - PID 8838 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 16:23:41 INFO - PID 8838 | Values: 150.0 151.0 150.0 152.0 150.0 151.0 150.0 151.0 152.0 152.0 16:23:41 INFO - PID 8838 | 16:23:41 INFO - PID 8838 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:1.70 (1.8%) stddev-sans-first:1.74 16:23:41 INFO - PID 8838 | Values: 94.0 95.0 94.0 95.0 95.0 95.0 95.0 100.0 95.0 95.0 16:23:41 INFO - PID 8838 | 16:23:41 INFO - PID 8838 | [#8] json-parse-financial Cycles:10 Average:68.80 Median:69.00 stddev:0.79 (1.1%) stddev-sans-first:0.78 16:23:41 INFO - PID 8838 | Values: 68.0 68.0 68.0 69.0 69.0 69.0 68.0 70.0 69.0 70.0 16:23:41 INFO - PID 8838 | 16:23:41 INFO - PID 8838 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:56.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 16:23:41 INFO - PID 8838 | Values: 56.0 55.0 56.0 56.0 56.0 55.0 56.0 56.0 57.0 55.0 16:23:41 INFO - PID 8838 | 16:23:41 INFO - PID 8838 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:1.41 (1.7%) stddev-sans-first:1.50 16:23:41 INFO - PID 8838 | Values: 84.0 84.0 85.0 83.0 83.0 82.0 83.0 87.0 84.0 85.0 16:23:41 INFO - PID 8838 | 16:23:41 INFO - PID 8838 | [#11] stanford-crypto-ccm Cycles:10 Average:143.30 Median:139.50 stddev:15.68 (11.2%) stddev-sans-first:16.41 16:23:41 INFO - PID 8838 | Values: 136.0 138.0 132.0 136.0 146.0 141.0 135.0 137.0 186.0 146.0 16:23:41 INFO - PID 8838 | 16:23:41 INFO - PID 8838 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.90 Median:200.00 stddev:7.77 (3.9%) stddev-sans-first:7.37 16:23:41 INFO - PID 8838 | Values: 188.0 200.0 200.0 205.0 186.0 209.0 189.0 198.0 204.0 200.0 16:23:41 INFO - PID 8838 | 16:23:41 INFO - PID 8838 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.70 Median:73.00 stddev:3.37 (4.6%) stddev-sans-first:3.35 16:23:41 INFO - PID 8838 | Values: 77.0 72.0 72.0 81.0 72.0 71.0 74.0 70.0 72.0 76.0 16:23:41 INFO - PID 8838 | -------- Summary: end -------- 16:23:41 INFO - PID 8838 | 16:23:42 INFO - TEST-INFO | 8838: exit 0 16:23:42 INFO - TEST-OK | kraken | took 64535ms 16:23:42 INFO - SUITE-END | took 1184s 16:23:43 INFO - Completed test suite (00:19:45) 16:23:43 INFO - javascript benchmark 16:23:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6341.64795802246, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2716.9592456113155, 2742.4926388618096, 2757.338238822682, 2762.4337010912755, 2786.777057835373, 4920.040592084536, 5140.331756871601, 5177.559907407875, 5199.0, 5201.817936372218, 5041.143005689032, 5137.460566640505, 5140.614453915952, 5203.739813009353, 5245.265662807201, 4627.398438203046, 4655.813767449298, 4664.4402671679445, 4665.253559430492, 4689.953100468986, 4689.9531004690025, 4694.929576056362, 4717.834875779348, 4730.195866702668, 4770.785314660831, 4662.0, 4663.720176789369, 4665.160271151191, 4693.812247510095, 4728.338032675429, 4656.837010704609, 4664.930026049612, 4675.976620116878, 4712.175369310357, 4715.64632652549, 4573.588377046081, 4615.446146462446, 4623.26027835548, 4634.930476042862, 4674.182018146811, 4983.90032199354, 5029.949700502984, 5050.671706339076, 5090.211017292326, 5091.389033315989, 5557.861053473655, 5564.081926482126, 5569.554435645179, 5597.076482380402, 5622.662640241558, 5582.63712858667, 5590.608657393944, 5597.580181486364, 5600.551955843523, 5611.438856114397, 5007.674501157413, 5063.063333283354, 5066.113430149783, 5182.196759502283, 5264.31563896691, 5478.0, 5514.641548299348, 5515.338159420895, 5534.723263836792, 5550.4449555044985, 5312.707801070901, 5421.0, 5460.071787796084, 5478.726063696799, 5493.258410114583, 5405.162199859028, 5448.9727551362785, 5460.426655201226, 5480.150576660624, 5490.890182196414, 5430.701311427831, 5436.016959658777, 5449.4005659377435, 5454.345478542521, 5484.177373393943, 5319.414864364917, 5381.0583147948955, 5462.180672899097, 5513.724313784295, 5517.503424691797, 4629.67592268538, 4635.304704294315, 4636.026434448736, 4655.045715628288, 4674.742889141062, 3987.980060099681, 3990.8004599769897, 3995.700322475826, 4007.1184339445276, 4051.8987025324013, 4649.232876575395, 4702.294655801657, 4753.881152971134, 4800.687955282895, 4836.927446088312, 5601.383847776741, 5602.971985140048, 5618.85952851182, 5622.409646987007, 5645.661260324394, 4766.76166191689, 4808.471068182497, 4819.95180048202, 4822.541858523435, 4844.0, 4842.22524396102, 4900.975495122501, 4903.730294833747, 4903.828366007173, 4977.776000079933, 5081.745912704276, 5133.02472530233, 5145.099607568735, 5148.176291793295, 5157.406898206604, 5472.972635136958, 5476.288082549243, 5484.0, 5485.835424937259, 5493.7802487900035, 5190.480951904779, 5215.426303106579, 5237.947620523746, 5250.606204534599, 5255.947440525546, 5384.300040994645, 5439.5920305976415, 5446.564274857923, 5449.155380915964, 5449.754761035683, 5345.786168553214, 5622.128570071645, 5632.098864181711, 5632.605717599728, 5682.9431705684065, 5249.47505249472, 5336.439673834191, 5388.568914486753, 5400.297961265168, 5409.486098820606, 5376.112941364631, 5377.704226267593, 5379.488948549882, 5394.973025134849, 5405.162199859028, 5281.683099014072, 5312.150055991023, 5316.627836051439, 5317.893642127213, 5318.867028324323, 5238.947610523846, 5316.946830531645, 5384.919226211531, 5415.810446634349, 5439.619226654097, 5218.8956220876125, 5223.608229382888, 5243.528082472596, 5245.003449344612, 5278.2346559749385], "value": 5031.5657754124595, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.9075034120053, 667.9365460281275, 671.3353779758041, 714.2107970692384, 727.9927200727993, 29580.112596622108, 30536.847315763447, 30562.541561876562, 30592.0, 30641.846790766016, 32832.50751238733, 33010.50484242733, 33115.66884331156, 33172.17069573256, 33217.501737473896, 2201.196563254409, 2211.5466329402516, 2236.2955668964264, 2285.2001799370255, 2366.1127077345996, 2395.125779090628, 2430.805535557151, 2432.805375569959, 2434.014224239177, 2434.1358817619666, 2417.5044115956275, 2426.1751004658413, 2430.6111022236446, 2431.0640403444622, 2436.049940523197, 2404.555157295897, 2412.457197130649, 2429.0283886445386, 2433.9391515212083, 2440.19473573722, 2314.0, 2333.696619439479, 2335.3577766114286, 2347.272345572878, 2347.7534858839917, 31755.682443175505, 31871.0, 31961.680383196337, 33817.830910845536, 34182.6581734182, 2672.425428532875, 2683.932901677454, 2701.2706569226393, 2711.457708458316, 2722.6460560127257, 23288.4177895554, 23376.532469350517, 23389.181378651836, 24009.87995060031, 24312.635310470356, 2900.7824413169096, 2966.6291713535807, 2967.540031295153, 2970.85145742712, 2977.8064425812254, 128267.0, 132430.33784831112, 134141.0, 153019.23490382478, 154229.22885385613, 37358.626413736056, 37634.247315053544, 37719.0, 37724.0, 37764.43353349702, 38188.809055954545, 38766.41850372247, 38937.0, 39028.80485597554, 39032.0, 12598.244105353708, 12657.810132848015, 12728.045396595293, 12776.744465110645, 12949.417276222594, 10390.272680912414, 10419.218558608134, 10483.842742358871, 10493.26547141708, 10540.420276884844, 12914.22514649124, 12916.0, 12916.095873288967, 12981.675458113434, 13166.539171128965, 5424.484673956047, 5450.236966824647, 5475.09660905946, 5482.259894914216, 5562.360328562187, 854.3763052971366, 864.93512986525, 865.852805023135, 895.5566994337714, 907.832051070554, 19861.14096341554, 20786.0, 20967.895160524098, 21006.474838128863, 21091.68362474564, 968.7917097824002, 984.1585444444896, 1004.6935684616262, 1004.8191325561469, 1013.9695809125737, 10621.575136994588, 10633.149348052137, 10850.860659630625, 10969.890301096886, 11063.668089957315, 210254.0, 210570.0, 210936.0, 211801.0, 211850.0, 40665.796671016455, 40681.0, 40695.38956915648, 41037.0, 41142.38286425706, 1190.4821402689859, 1255.0461649146532, 1261.433610330609, 1265.9683507912375, 1280.257450678604, 19250.22999080021, 19325.226990920204, 19518.902405487883, 20688.0, 20885.16459341609, 29454.558181626864, 29682.554761679025, 29922.0, 30037.399252014402, 30055.248618784706, 210891.0, 211004.0, 211434.0, 212013.0, 212180.0, 26798.732012679622, 26929.596056059567, 27270.86364568244, 27339.86330068337, 27393.836386812807, 33318.16704582405, 33942.66057339494, 34615.826920865235, 34765.0, 34872.12819679528, 27878.581821273103, 28930.566041509814, 29062.0, 29337.266568335963, 30247.092587222418, 27717.72282277232, 28633.856830716548, 28680.282992925342, 28797.28006799847, 30214.395712086076, 30021.099367019026, 30123.54814677738, 30137.547936780527, 30150.96980603932, 30691.693083068883, 24919.0, 26119.347016323984, 27543.31141721473, 27601.86199068992, 28086.2978425541, 21400.67898981548, 21480.355589332346, 21621.891890540446, 21739.456513587287, 21780.237691680715], "value": 12395.481214256004, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.0268210457332, 434.37016326326824, 441.9911601767965, 444.5843136667214, 449.4180036852276, 16877.746833797486, 17090.829091709078, 17527.386541471053, 19321.13054912529, 19381.70927436086, 17875.28498860044, 17948.0, 17986.280548778064, 18319.17563709633, 19018.334358297463, 3868.3810590305557, 3875.612438756123, 3957.5053118360206, 3967.642912137907, 3988.700847436454, 3911.765294082364, 3940.921181576367, 3980.761154330735, 4003.4795476588147, 4007.138465229975, 3958.8812335629977, 3960.1089754805225, 3965.4250133730593, 3971.960280397188, 3972.543157536877, 3797.278517081759, 3910.9608903911026, 3940.940885886714, 3945.467361906149, 3951.249262640118, 3669.21111960927, 3670.3576874047203, 3670.46778217157, 3677.3748462761396, 3685.594584595692, 20725.37305971464, 22100.447488812748, 22159.889200554055, 22621.434464138365, 22786.65820012701, 1557.0891028748197, 1583.4774524406919, 1595.9760603590955, 1615.4911202971143, 1626.9674606507922, 13764.17414955106, 13824.930875345659, 14008.439662413593, 14115.647108822259, 14464.421423143061, 1795.7665503484463, 1809.0272249641791, 1820.1809185866414, 1830.5240637434363, 1852.8327153893097, 75723.0, 89758.55120724419, 91078.0, 92212.0, 93044.0, 11094.611688591021, 11286.943565282285, 11366.772664546663, 11418.885811141949, 11636.185467017227, 16217.270222840001, 16236.350545978265, 16239.106849123411, 16291.348346066261, 16320.183990800413, 7753.10839253493, 7931.087924888597, 8052.315553178046, 8150.184981501802, 8187.549684767276, 7348.081489813773, 7361.705531778776, 7382.9630851845395, 7540.660670269851, 7623.9618801905635, 6911.861762764716, 6920.861582768316, 7037.261087585832, 7061.1173603299585, 7105.32499412555, 2136.465883529118, 2143.6570148776123, 2155.838312126597, 2159.967600485994, 2260.920867769653, 849.6856163219525, 871.6208449324564, 875.991240087591, 885.0389803242173, 901.0268909577641, 16296.0, 16532.83467165337, 16541.751873721903, 17007.914960425118, 17606.559836003948, 888.813349196663, 896.4531635702216, 907.9546022698971, 914.1224424552504, 915.2129168914728, 8770.868436973451, 10761.798587885545, 10863.239573229956, 12029.75940481203, 12259.693507662201, 300744.0, 304475.0, 304722.0, 434436.0, 443745.0, 69243.65378173077, 81146.0, 82870.0, 90384.54807726051, 91688.54155729312, 1058.9841152382721, 1072.5280876414354, 1120.9831852522218, 1125.2966895690195, 1125.7467069909205, 16968.915155424143, 17192.742108868126, 17514.38699645506, 17876.0, 18341.90829045846, 34738.131546711535, 40571.1885762289, 40595.39106913458, 41834.0, 42533.0, 52534.47465525296, 53314.2002869965, 55861.72069139628, 57844.0, 60107.39892601193, 8445.535495547803, 8589.269912057294, 8776.605052772513, 8848.867266990872, 8904.154105359981, 13158.539451119164, 13407.32963351848, 13457.192568445924, 13706.862931370559, 13709.17744935307, 10330.948345258226, 10385.532651030571, 10410.0, 10694.518746656264, 10705.89294107049, 9188.0, 9808.803823923625, 10778.622748203776, 10897.073748731129, 11736.413179340829, 11047.226694131334, 11057.668269951915, 11119.666410007712, 11452.541898323974, 11576.88423115758, 8114.391420643594, 8189.79525511867, 8289.709860154866, 8318.667253309799, 8550.529720865412, 11213.439328033402, 11313.71715707114, 11495.310281383145, 11534.250273732181, 11745.177837551631], "value": 8604.703126400802, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1272.4401263444083, 1326.7744483437814, 1338.4177882621054, 1340.2762508245542, 1344.0591585889877, 9100.180983711465, 9387.29595280354, 9396.95301523493, 9607.4715890626, 9834.901650983487, 9634.373765705242, 9712.611495540188, 9778.511074446267, 9803.950980245088, 9814.116729494344, 2116.058354032456, 2141.935741927745, 2148.11927109885, 2152.2251989283845, 2154.1060459909118, 2169.674548817682, 2214.878181700006, 2219.855709378893, 2226.1206823304783, 2241.60771864923, 2129.691194776756, 2159.114762947192, 2175.4670105824093, 2181.923632672857, 2185.3007037747925, 2110.8205802506805, 2127.851050426463, 2130.7869213078648, 2136.1241890824685, 2139.1015773375143, 1812.8549716022687, 1869.7475840761458, 2045.795420457957, 2138.497453098536, 2239.8880055997133, 9485.810283794286, 9544.904550954541, 9578.856317155249, 9581.664641737576, 9857.90142098577, 5342.652727572696, 5585.245991791137, 5585.888282234332, 5589.776408943678, 5603.10350343943, 3177.348643528071, 3197.328561002192, 3268.7711860169798, 3282.901512954615, 3330.483775014852, 1031.1493018259966, 1032.865727455426, 1055.788842231549, 1068.2362111090529, 1111.3665210829831, 13946.302684865817, 14014.299285035708, 14046.859531404658, 14116.15303081808, 14140.92929535356, 4410.5368936261875, 4629.837955671535, 4687.179743544866, 4711.3639658646325, 4796.77682191046, 10625.203109766799, 10677.626283080055, 10683.83974240387, 10712.143028557697, 10742.946285268523, 5436.401995780461, 5436.592255580847, 5437.809676661298, 5439.265699130646, 5462.399136095027, 4641.559051890133, 4799.18413869643, 4830.903381932412, 4950.5544500994365, 5035.338338348336, 3648.2703459307713, 3767.1523907120677, 3771.396576547739, 3834.2906562285507, 3851.788151651686, 1073.8013467508379, 1078.2344535379968, 1078.6979645699216, 1098.5386137822134, 1102.2174256278133, 655.6885479397248, 659.9208095028628, 695.9930400695928, 697.9057827193366, 702.420503084957, 5138.229265610188, 5142.562882155059, 5193.584513238932, 5372.758225879845, 5378.489043540857, 816.1104396208161, 816.9877451838228, 818.5620692929255, 828.1263267252986, 830.4767996162379, 3049.207206126379, 3061.5101583746496, 3068.769842261839, 3128.6066159388088, 3203.1351535085864, 12766.680832979064, 13121.147125436815, 13197.53808616713, 13241.80137297922, 13252.20486770797, 13038.282894440898, 13092.607221783363, 13110.082294239503, 13120.540781072808, 13133.0, 9094.636214551343, 9179.495127767903, 9261.953690231505, 9317.534123293808, 9372.5313734313, 5329.813456529003, 5342.0, 5391.649542779707, 5433.5381492572, 5564.304461942257, 11380.43097845121, 11511.654650360168, 11574.537018519164, 11661.53353865836, 11665.35840528779, 11913.106517011085, 12035.217710848767, 12108.939455302667, 12165.695857603278, 12229.082818788449, 7613.467057305936, 7756.108047574601, 7871.645775940211, 8074.192580742114, 8182.631781569725, 9068.863967040632, 9126.543672816466, 9128.49793261377, 9202.0, 9205.355625106178, 7885.64514596833, 7933.761987140395, 7935.880961785462, 7937.285644292041, 8029.397795165502, 7765.611719413893, 7796.805079873048, 7798.415118866221, 7828.725994590162, 7999.080105787909, 6820.249772524919, 7032.789016329519, 7101.218865924848, 7217.24218957002, 7262.709491620276, 4955.603551715782, 5025.6482046256415, 5031.924521132113, 5092.439831618593, 5117.078925793244, 4979.751012449436, 4990.326305948651, 5010.423801262901, 5102.438731739431, 5145.562627176582], "value": 4590.158060153608, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.98190090495484, 387.50205985308884, 398.2870661515885, 407.9938800917987, 408.7506620961214, 5308.256844041833, 5329.626926115168, 5371.731413429333, 5389.622726409153, 5401.621886467949, 5307.601929855257, 5308.416074231832, 5311.24728839483, 5325.227841962913, 5341.759620817063, 3969.30537155998, 4157.896052598679, 4162.354835000579, 4167.958320416802, 4303.655707543397, 4149.7302675326155, 4150.252954468195, 4160.607650600901, 4161.396597493362, 4178.018165731066, 4140.337545992642, 4140.441040459529, 4141.647959923395, 4152.937705934413, 4157.896052598679, 3887.436321733333, 4048.6356227939627, 4133.751974881502, 4146.108586653853, 4154.543000269968, 3581.158427769472, 3582.7133829293593, 3594.6045934947133, 3603.4414665726854, 3628.6371362863765, 5119.38567371914, 5120.668626157189, 5159.2003239497935, 5172.922406163911, 5179.585633149339, 4590.954090459086, 4717.882052948704, 4731.148393289207, 4747.643926705511, 4755.0, 5582.413846546136, 5591.3569939457075, 5599.1041433370465, 5611.7474713637985, 5611.803586874481, 3972.00113913996, 3973.5033120859894, 3975.900602484961, 3981.9845939285588, 3987.5414327352437, 5614.887702245932, 5687.260656114761, 5776.0, 5784.392638772911, 5893.0276504376725, 4077.429159917614, 4088.9795551022053, 4094.9181016379507, 4099.774512401847, 4105.958940410557, 4128.91742165155, 4145.316022856256, 4161.583841615875, 4171.228322760299, 4173.52004519478, 4504.189245935698, 4664.813407463731, 4753.0, 4764.714117152982, 4767.380240568704, 5583.944160558423, 5592.552595792326, 5603.7478313475995, 5605.579581531401, 5614.754098360689, 1426.3866537389022, 1442.1779585636086, 1442.3581506229627, 1447.3631602095045, 1448.3771978049328, 954.3271993244746, 984.5815528400544, 988.2094324540338, 991.9305648604673, 1008.1481148429565, 4889.731064791471, 4914.852554423302, 4923.655344125877, 4937.851864444073, 4939.160342741742, 5747.1379293106365, 5753.280839895013, 5789.189513468118, 5789.8263052108505, 5790.305163380422, 4766.189747742823, 4811.7486284684755, 4868.269759536027, 4929.457759646436, 4943.912339285352, 3019.6829332920165, 3043.6195475565555, 3044.071558174778, 3057.2051266670824, 3065.555494453292, 5385.946140538623, 5392.0, 5396.625484786681, 5402.460298814819, 5419.783208671688, 5627.52166065889, 5874.471297583238, 5897.115432685132, 5940.79207227745, 5965.224520812353, 5446.673199608036, 5450.258275300514, 5465.726713664301, 5470.206820011076, 5478.287822583039, 5680.261565996394, 5765.673895004089, 5798.0, 5811.767529298781, 5844.94155058444, 5701.942980570141, 5728.427157284238, 5770.769169233184, 5775.364709881994, 5777.620092246083, 5209.6874187548865, 5309.548688361532, 5371.113766228528, 5440.428754980829, 5481.561475082063, 4011.7994100294286, 4042.9393559097225, 4049.5140583129037, 4057.490270915696, 4067.3695577185586, 5645.71771411436, 5700.144978253295, 5764.538836892954, 5786.797462088975, 5820.653124453372, 5603.551715862803, 5612.887742245214, 5614.887702246014, 5628.662280263197, 5628.831135065954, 5601.411851755507, 5621.494065534122, 5625.128105143709, 5626.2967129108865, 5627.874425114912, 5386.8383948481605, 5528.91706624409, 5566.304211973504, 5573.832785016456, 5577.60163129858, 5633.8591535211945, 5643.971780141237, 5658.434156584309, 5662.320521537442, 5684.63049901755, 5507.228987941771, 5520.0, 5526.41972592888, 5531.612787104864, 5542.0], "value": 4239.2384008311765, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.3943110347341, 686.7390391651173, 687.316120460142, 690.540790374401, 693.847353582212, 12778.0, 13125.474981000772, 13140.802887956675, 13173.604791856247, 13183.538576149836, 12581.119321647466, 12675.936620316885, 12773.552925647604, 12783.488660453593, 12786.552470663528, 814.5031530766228, 847.817719190374, 850.3962186847315, 851.9190676885686, 852.3479538153287, 843.439112989861, 846.2679781988597, 847.516915358246, 848.9363297752693, 853.2320911179957, 888.404768804899, 889.813139240757, 889.8398288308102, 890.3055616619048, 891.4205766251956, 889.1775108025083, 890.0698769785557, 892.0276898180949, 892.0410558649413, 893.530896279452, 649.136648257816, 650.9609423434609, 652.3085529338869, 655.4592461219465, 655.5804285257439, 14122.36449359771, 14171.220582867938, 14325.49860754879, 14375.856241437556, 14391.78412323816, 12546.560870369492, 13096.279704616243, 13326.133801302884, 13439.395227214798, 13501.122427042212, 9832.901670983341, 10125.746856328577, 10235.232357573212, 10264.94867525665, 10417.479126043743, 2690.5829596412586, 2704.4050308932005, 2716.4295497945454, 2727.468143711977, 2805.551111822099, 64485.67757161184, 65069.67465162644, 66091.339086609, 67580.0, 67754.9836752454, 10482.0, 10534.36793792375, 10652.686191805822, 10666.306690065121, 10936.179786515884, 20882.79117208839, 21055.578888422147, 21284.0, 21493.355199344045, 21546.56906861854, 6916.827079323057, 6941.861162776716, 6955.374016338554, 6978.860422791516, 7038.472114591324, 3159.5892533970896, 3228.0799972007867, 3284.83575821208, 3290.5393244945726, 3290.6672797517044, 3476.5828100628087, 3508.649135086522, 3509.94735078974, 3525.4359302511475, 3552.182997910495, 701.9262977387301, 706.4136766483806, 713.0552018575305, 719.5251134251369, 725.7205975699394, 480.7524125075589, 498.68333608158355, 503.8513638476658, 511.26122752622103, 522.4279414041619, 8434.915650843535, 8581.528015959057, 8951.239144672776, 9050.456972581665, 9128.543572821465, 505.6283631530822, 520.8151106357265, 527.5594878276682, 531.5959870498372, 539.134688824439, 3863.9806800966376, 4069.959300406958, 4108.856190033334, 4109.794510274474, 4217.7891105444605, 58769.0, 59410.0, 60675.0, 61100.0, 61395.38604613986, 52176.0, 52505.2124218137, 52581.737091314295, 54172.0, 55262.0, 45038.0, 45158.32262516065, 45231.0, 45777.54222457799, 46799.53200467952, 8015.398845086758, 8311.0, 8344.666213351398, 8452.070272269922, 8506.404551681322, 22352.441188969755, 23048.539029219657, 25165.496690066462, 25958.870205649608, 26179.34551636148, 33600.0, 35717.46423803593, 36587.451188231666, 36594.0, 36720.26559468849, 11017.83473247886, 11028.44857757125, 11065.446727663746, 11143.665690029313, 11365.147613928822, 11890.346030968034, 12128.090393220367, 12279.69300767488, 12333.814992774936, 12687.555935542212, 11399.031082358093, 11562.94218528902, 11614.245074070159, 11817.0, 12021.639350819489, 11399.838180473302, 11550.826737598774, 12062.698432539257, 12063.155579109378, 12562.183458075197, 10899.564017439214, 11307.547698091985, 11368.658940231806, 11431.256968297033, 11700.941495292469, 9659.71020869375, 9931.851022234529, 9999.250056245955, 10241.539130739284, 10269.84595231087, 8456.365772566958, 9332.253419726541, 9620.567074481525, 9786.51067446639, 9882.209423246266], "value": 6228.265999134197, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1567.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 111.0, 112.0, 114.0, 111.0, 111.0, 112.0, 111.0, 113.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 129.0, 163.0, 126.0, 125.0, 127.0, 127.0, 148.0, 125.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 164.0, 167.0, 168.0, 168.0, 164.0, 166.0, 165.0, 165.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 110.0, 77.0, 75.0, 75.0, 76.0, 101.0, 77.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 103.0, 84.0, 84.0, 84.0, 104.0, 85.0, 85.0, 99.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 114.0, 116.0, 121.0, 115.0, 114.0, 113.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 152.0, 150.0, 151.0, 150.0, 151.0, 152.0, 152.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 100.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 68.0, 70.0, 69.0, 70.0], "value": 68.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 56.0, 56.0, 55.0, 56.0, 56.0, 57.0, 55.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 83.0, 83.0, 82.0, 83.0, 87.0, 84.0, 85.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 138.0, 132.0, 136.0, 146.0, 141.0, 135.0, 137.0, 186.0, 146.0], "value": 143.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 200.0, 200.0, 205.0, 186.0, 209.0, 189.0, 198.0, 204.0, 200.0], "value": 197.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 72.0, 72.0, 81.0, 72.0, 71.0, 74.0, 70.0, 72.0, 76.0], "value": 73.7, "unit": "score"}]}]} 16:23:43 INFO - Return code: 0 16:23:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:23:43 ERROR - # TBPL SUCCESS # 16:23:43 INFO - Running post-action listener: _resource_record_post_action 16:23:43 INFO - [mozharness: 2017-03-21 23:23:43.390671Z] Finished run-tests step (success) 16:23:43 INFO - Running post-run listener: _resource_record_post_run 16:23:43 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 364306432; Read time: 8; Write time: 254936 16:23:43 INFO - TinderboxPrint: CPU usage
13.3% 16:23:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 16:23:43 INFO - TinderboxPrint: I/O write bytes / time
364,306,432 / 254,936 16:23:43 INFO - TinderboxPrint: CPU idle
8,310.4 (86.7%) 16:23:43 INFO - TinderboxPrint: CPU user
1,217.1 (12.7%) 16:23:43 INFO - TinderboxPrint: Swap in / out
0 / 0 16:23:43 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105598976; Read time: 0; Write time: 113420 16:23:43 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 256839680; Read time: 8; Write time: 141320 16:23:44 INFO - Running post-run listener: _upload_blobber_files 16:23:44 INFO - Blob upload gear active. 16:23:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:23:44 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 16:23:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:23:44 INFO - (blobuploader) - INFO - Open directory for files ... 16:23:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:23:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:23:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:23:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:23:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:23:47 INFO - (blobuploader) - INFO - Done attempting. 16:23:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:23:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:23:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:23:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:23:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:23:48 INFO - (blobuploader) - INFO - Done attempting. 16:23:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:23:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:23:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:23:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:23:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:23:49 INFO - (blobuploader) - INFO - Done attempting. 16:23:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:23:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:23:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:23:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:23:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:23:50 INFO - (blobuploader) - INFO - Done attempting. 16:23:50 INFO - (blobuploader) - INFO - Iteration through files over. 16:23:50 INFO - Return code: 0 16:23:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:23:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:23:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c88b8ec57fdc5631ae5ee4befd69849db441bb769ec13892b415c68950ac8bc083b6b27b87671c7f5f8d67cde0fdd3facfc8cb90f587cb31f9f4f807de4c9373", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fffec59fcbbc2794461d7087250e4cd63bd8a5215dfb69c31731fa7929c037cc4c61be81cc4bff91026bda3ff6f58550773c8ad0a6ea80b0e242583c7cb06741", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8e9c18ca0f8e6c36fc94c299fd62759fc4698ee418e6de7666f4000f49ed2f58a79da66a36f635e64fc4e6317acf256da41509a12ef1ffbc87734d8817f0816", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5175bf1c75c7a8e71fbdd05764d5b72a3bfadf382a40d32ab8274b16600db911d5fe0c28d5f31105dc9449346bf08e81c1a7efc0adf26974b895fce3beb8fcdb"} 16:23:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:23:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:23:50 INFO - Contents: 16:23:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c88b8ec57fdc5631ae5ee4befd69849db441bb769ec13892b415c68950ac8bc083b6b27b87671c7f5f8d67cde0fdd3facfc8cb90f587cb31f9f4f807de4c9373", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fffec59fcbbc2794461d7087250e4cd63bd8a5215dfb69c31731fa7929c037cc4c61be81cc4bff91026bda3ff6f58550773c8ad0a6ea80b0e242583c7cb06741", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8e9c18ca0f8e6c36fc94c299fd62759fc4698ee418e6de7666f4000f49ed2f58a79da66a36f635e64fc4e6317acf256da41509a12ef1ffbc87734d8817f0816", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5175bf1c75c7a8e71fbdd05764d5b72a3bfadf382a40d32ab8274b16600db911d5fe0c28d5f31105dc9449346bf08e81c1a7efc0adf26974b895fce3beb8fcdb"} 16:23:50 INFO - Running post-run listener: copy_logs_to_upload_dir 16:23:50 INFO - Copying logs to upload dir... 16:23:50 INFO - mkdir: /builds/slave/test/build/upload/logs 16:23:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.417028 ========= master_lag: 0.41 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-21 16:23:50.991129) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 16:23:50.994301) ========= 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=03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c88b8ec57fdc5631ae5ee4befd69849db441bb769ec13892b415c68950ac8bc083b6b27b87671c7f5f8d67cde0fdd3facfc8cb90f587cb31f9f4f807de4c9373", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fffec59fcbbc2794461d7087250e4cd63bd8a5215dfb69c31731fa7929c037cc4c61be81cc4bff91026bda3ff6f58550773c8ad0a6ea80b0e242583c7cb06741", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8e9c18ca0f8e6c36fc94c299fd62759fc4698ee418e6de7666f4000f49ed2f58a79da66a36f635e64fc4e6317acf256da41509a12ef1ffbc87734d8817f0816", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5175bf1c75c7a8e71fbdd05764d5b72a3bfadf382a40d32ab8274b16600db911d5fe0c28d5f31105dc9449346bf08e81c1a7efc0adf26974b895fce3beb8fcdb"} build_url:https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011258 build_url: 'https://queue.taskcluster.net/v1/task/TI_xUoXLTK20Ss081k32OA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c88b8ec57fdc5631ae5ee4befd69849db441bb769ec13892b415c68950ac8bc083b6b27b87671c7f5f8d67cde0fdd3facfc8cb90f587cb31f9f4f807de4c9373", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fffec59fcbbc2794461d7087250e4cd63bd8a5215dfb69c31731fa7929c037cc4c61be81cc4bff91026bda3ff6f58550773c8ad0a6ea80b0e242583c7cb06741", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8e9c18ca0f8e6c36fc94c299fd62759fc4698ee418e6de7666f4000f49ed2f58a79da66a36f635e64fc4e6317acf256da41509a12ef1ffbc87734d8817f0816", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5175bf1c75c7a8e71fbdd05764d5b72a3bfadf382a40d32ab8274b16600db911d5fe0c28d5f31105dc9449346bf08e81c1a7efc0adf26974b895fce3beb8fcdb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 16:23:51.019383) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 16:23:51.019715) ========= 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=03627c79f6bb3d1578c4a402000001ba-1490137368.484470-1107672322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 16:23:51.071972) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 16:23:51.072334) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 16:23:51.072663) ========= ========= Total master_lag: 0.54 =========