builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-030 starttime: 1494516743.97 results: success (0) revision: 0259418f19ab804b126730ef1d5d03006d6aad52 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 08:32:23.973040) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 08:32:23.973566) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 08:32:23.973887) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 08:32:24.010122) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 08:32:24.010446) ========= 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=3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-11 08:32:24-- 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% 111M=0s 2017-05-11 08:32:24 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.155386 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 08:32:24.199088) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 08:32:24.199469) ========= 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=3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015865 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 08:32:24.249538) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-11 08:32:24.249920) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0259418f19ab804b126730ef1d5d03006d6aad52 --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 0259418f19ab804b126730ef1d5d03006d6aad52 --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=3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-11 08:32:24,308 truncating revision to first 12 chars 2017-05-11 08:32:24,308 Setting DEBUG logging. 2017-05-11 08:32:24,308 attempt 1/10 2017-05-11 08:32:24,308 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0259418f19ab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-11 08:32:25,456 unpacking tar archive at: mozilla-central-0259418f19ab/testing/mozharness/ program finished with exit code 0 elapsedTime=1.456797 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-11 08:32:25.720339) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 08:32:25.720729) ========= script_repo_revision: 0259418f19ab804b126730ef1d5d03006d6aad52 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 08:32:25.721154) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 08:32:25.721481) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 08:32:25.731380) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 37 mins, 46 secs) (at 2017-05-11 08:32:25.731708) ========= /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=3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:32:25 INFO - MultiFileLogger online at 20170511 08:32:25 in /builds/slave/test 08:32:25 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 08:32:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:32:25 INFO - {'append_to_log': False, 08:32:25 INFO - 'base_work_dir': '/builds/slave/test', 08:32:25 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:32:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:32:25 INFO - 'branch': 'Firefox-Non-PGO', 08:32:25 INFO - 'buildbot_json_path': 'buildprops.json', 08:32:25 INFO - 'config_files': ('talos/linux_config.py',), 08:32:25 INFO - 'default_actions': ('clobber', 08:32:25 INFO - 'read-buildbot-config', 08:32:25 INFO - 'download-and-extract', 08:32:25 INFO - 'populate-webroot', 08:32:25 INFO - 'create-virtualenv', 08:32:25 INFO - 'install', 08:32:25 INFO - 'run-tests'), 08:32:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:32:25 INFO - 'download_minidump_stackwalk': True, 08:32:25 INFO - 'download_symbols': 'ondemand', 08:32:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:32:25 INFO - 'tooltool.py': '/tools/tooltool.py', 08:32:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:32:25 INFO - '/tools/misc-python/virtualenv.py')}, 08:32:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:32:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:32:25 INFO - 'gecko_profile': False, 08:32:25 INFO - 'gecko_profile_interval': 0, 08:32:25 INFO - 'installer_path': 'installer.exe', 08:32:25 INFO - 'log_level': 'info', 08:32:25 INFO - 'log_name': 'talos', 08:32:25 INFO - 'log_to_console': True, 08:32:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:32:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:32:25 INFO - 'opt_config_files': (), 08:32:25 INFO - 'pip_index': False, 08:32:25 INFO - 'suite': 'dromaeojs-e10s', 08:32:25 INFO - 'system_bits': '32', 08:32:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:32:25 INFO - 'title': 'talos-linux64-ix-030', 08:32:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:32:25 INFO - 'use_talos_json': True, 08:32:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:32:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:32:25 INFO - 'work_dir': 'build'} 08:32:25 INFO - [mozharness: 2017-05-11 15:32:25.933809Z] Running clobber step. 08:32:25 INFO - Running pre-action listener: _resource_record_pre_action 08:32:25 INFO - Running main action method: clobber 08:32:25 INFO - rmtree: /builds/slave/test/build 08:32:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:32:26 INFO - Running post-action listener: _resource_record_post_action 08:32:26 INFO - [mozharness: 2017-05-11 15:32:26.826294Z] Finished clobber step (success) 08:32:26 INFO - [mozharness: 2017-05-11 15:32:26.826393Z] Running read-buildbot-config step. 08:32:26 INFO - Running pre-action listener: _resource_record_pre_action 08:32:26 INFO - Running main action method: read_buildbot_config 08:32:26 INFO - Using buildbot properties: 08:32:26 INFO - { 08:32:26 INFO - "project": "", 08:32:26 INFO - "product": "firefox", 08:32:26 INFO - "who": "archaeopteryx@coole-files.de", 08:32:26 INFO - "installer_path": "public/build/target.tar.bz2", 08:32:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:32:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:32:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:32:26 INFO - "stage_platform": "linux64", 08:32:26 INFO - "basedir": "/builds/slave/test", 08:32:26 INFO - "buildnumber": 868, 08:32:26 INFO - "platform": "ubuntu64_hw", 08:32:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:32:26 INFO - "slavebuilddir": "test", 08:32:26 INFO - "taskId": "DnIPperxS1OqNEEtPsdZNg", 08:32:26 INFO - "branch": "mozilla-central", 08:32:26 INFO - "script_repo_revision": "production", 08:32:26 INFO - "revision": "0259418f19ab804b126730ef1d5d03006d6aad52", 08:32:26 INFO - "slavename": "talos-linux64-ix-030", 08:32:26 INFO - "repo_path": "mozilla-central" 08:32:26 INFO - } 08:32:26 INFO - Finding installer, test and symbols from parent task. 08:32:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DnIPperxS1OqNEEtPsdZNg'}, attempt #1 08:32:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DnIPperxS1OqNEEtPsdZNg'}, attempt #1 08:32:27 INFO - Task dependencies: c_9vBZQwSGyBLaJaY1ABdg 08:32:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c_9vBZQwSGyBLaJaY1ABdg'}, attempt #1 08:32:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/target.tar.bz2 08:32:28 INFO - Set test_url: https://queue.taskcluster.net/v1/task/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/test_packages.json 08:32:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/target.crashreporter-symbols.zip 08:32:28 INFO - Running post-action listener: _resource_record_post_action 08:32:28 INFO - [mozharness: 2017-05-11 15:32:28.222984Z] Finished read-buildbot-config step (success) 08:32:28 INFO - [mozharness: 2017-05-11 15:32:28.223205Z] Running download-and-extract step. 08:32:28 INFO - Running pre-action listener: _resource_record_pre_action 08:32:28 INFO - Running main action method: download_and_extract 08:32:28 INFO - mkdir: /builds/slave/test/build/tests 08:32:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:28 INFO - trying https://queue.taskcluster.net/v1/task/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/target.test_packages.json 08:32:28 INFO - Downloading https://queue.taskcluster.net/v1/task/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:32:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:32:28 INFO - Downloaded 986 bytes. 08:32:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:32:28 INFO - Using the following test package requirements: 08:32:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:32:28 INFO - u'common': [u'target.common.tests.zip'], 08:32:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:32:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:32:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:32:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:32:28 INFO - u'mozbase': [u'target.common.tests.zip'], 08:32:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:32:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:32:28 INFO - u'web-platform': [u'target.common.tests.zip', 08:32:28 INFO - u'target.web-platform.tests.zip'], 08:32:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:32:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:32:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/target.common.tests.zip 08:32:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:32:28 INFO - Fetch https://queue.taskcluster.net/v1/task/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/target.common.tests.zip into memory 08:32:29 INFO - Content-Length response header: 58587681 08:32:29 INFO - Bytes received: 58587681 08:32:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:32:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/target.common.tests.zip 08:32:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:32:40 INFO - Fetch https://queue.taskcluster.net/v1/task/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/target.common.tests.zip into memory 08:32:41 INFO - Content-Length response header: 58587681 08:32:41 INFO - Bytes received: 58587681 08:32:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/target.talos.tests.zip 08:32:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:32:53 INFO - Fetch https://queue.taskcluster.net/v1/task/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/target.talos.tests.zip into memory 08:32:53 INFO - Content-Length response header: 14409411 08:32:53 INFO - Bytes received: 14409411 08:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:54 INFO - trying https://queue.taskcluster.net/v1/task/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/target.tar.bz2 08:32:54 INFO - Downloading https://queue.taskcluster.net/v1/task/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:32:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:32:55 INFO - Downloaded 62912250 bytes. 08:32:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/target.tar.bz2 08:32:55 INFO - mkdir: /builds/slave/test/properties 08:32:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:32:55 INFO - Writing to file /builds/slave/test/properties/build_url 08:32:55 INFO - Contents: 08:32:55 INFO - build_url:https://queue.taskcluster.net/v1/task/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/target.tar.bz2 08:32:55 INFO - Running post-action listener: _resource_record_post_action 08:32:55 INFO - Running post-action listener: set_extra_try_arguments 08:32:55 INFO - [mozharness: 2017-05-11 15:32:55.176614Z] Finished download-and-extract step (success) 08:32:55 INFO - [mozharness: 2017-05-11 15:32:55.176711Z] Running populate-webroot step. 08:32:55 INFO - Running pre-action listener: _resource_record_pre_action 08:32:55 INFO - Running main action method: populate_webroot 08:32:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:32:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:32:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:32:55 INFO - '--tppagecycles', 08:32:55 INFO - '7'], 08:32:55 INFO - 'tests': ['tsvgm']}}, 08:32:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:32:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:32:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:32:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:32:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:32:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:32:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:32:55 INFO - 'talos_options': ['--disable-e10s'], 08:32:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:32:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:32:55 INFO - 'talos_options': ['--disable-e10s'], 08:32:55 INFO - 'tests': ['damp', 'tps']}, 08:32:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:32:55 INFO - 'tests': ['damp', 'tps']}, 08:32:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:32:55 INFO - 'tests': ['dromaeo_dom']}, 08:32:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:32:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:32:55 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:32:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:32:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:32:55 INFO - 'tests': ['a11yr', 08:32:55 INFO - 'ts_paint', 08:32:55 INFO - 'tpaint', 08:32:55 INFO - 'sessionrestore', 08:32:55 INFO - 'sessionrestore_no_auto_restore', 08:32:55 INFO - 'tabpaint']}, 08:32:55 INFO - 'other-e10s': {'tests': ['a11yr', 08:32:55 INFO - 'ts_paint', 08:32:55 INFO - 'tpaint', 08:32:55 INFO - 'sessionrestore', 08:32:55 INFO - 'sessionrestore_no_auto_restore', 08:32:55 INFO - 'tabpaint']}, 08:32:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:32:55 INFO - 'ts_paint', 08:32:55 INFO - 'tpaint', 08:32:55 INFO - 'sessionrestore', 08:32:55 INFO - 'sessionrestore_no_auto_restore', 08:32:55 INFO - 'tabpaint']}, 08:32:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:32:55 INFO - 'ts_paint', 08:32:55 INFO - 'tpaint', 08:32:55 INFO - 'sessionrestore', 08:32:55 INFO - 'sessionrestore_no_auto_restore', 08:32:55 INFO - 'tabpaint']}, 08:32:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:32:55 INFO - 'tests': ['a11yr', 08:32:55 INFO - 'ts_paint', 08:32:55 INFO - 'tpaint', 08:32:55 INFO - 'sessionrestore', 08:32:55 INFO - 'sessionrestore_no_auto_restore', 08:32:55 INFO - 'tabpaint']}, 08:32:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:32:55 INFO - 'tests': ['a11yr', 08:32:55 INFO - 'ts_paint', 08:32:55 INFO - 'tpaint', 08:32:55 INFO - 'sessionrestore', 08:32:55 INFO - 'sessionrestore_no_auto_restore', 08:32:55 INFO - 'tabpaint']}, 08:32:55 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:32:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:32:55 INFO - 'bloom_basic_ref']}, 08:32:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:32:55 INFO - 'tests': ['tsvgx', 08:32:55 INFO - 'tsvgr_opacity', 08:32:55 INFO - 'tart', 08:32:55 INFO - 'tscrollx', 08:32:55 INFO - 'cart', 08:32:55 INFO - 'tsvg_static']}, 08:32:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:32:55 INFO - 'tsvgr_opacity', 08:32:55 INFO - 'tart', 08:32:55 INFO - 'tscrollx', 08:32:55 INFO - 'cart', 08:32:55 INFO - 'tsvg_static']}, 08:32:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:32:55 INFO - 'talos_options': ['--disable-e10s'], 08:32:55 INFO - 'tests': ['tp5o']}, 08:32:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:32:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:32:55 INFO - 'talos_options': ['--disable-e10s', 08:32:55 INFO - '--xperf_path', 08:32:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:55 INFO - 'tests': ['tp5n']}, 08:32:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:32:55 INFO - 'talos_options': ['--xperf_path', 08:32:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:55 INFO - 'tests': ['tp5n']}}, 08:32:55 INFO - 'talos.zip': {'path': '', 08:32:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:32:55 INFO - Running post-action listener: _resource_record_post_action 08:32:55 INFO - [mozharness: 2017-05-11 15:32:55.190373Z] Finished populate-webroot step (success) 08:32:55 INFO - [mozharness: 2017-05-11 15:32:55.190462Z] Running create-virtualenv step. 08:32:55 INFO - Running pre-action listener: _resource_record_pre_action 08:32:55 INFO - Running main action method: create_virtualenv 08:32:55 INFO - Creating virtualenv /builds/slave/test/build/venv 08:32:55 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 08:32:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:32:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:32:55 INFO - Using real prefix '/usr' 08:32:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:32:55 INFO - Installing distribute.............................................................................................................................................................................................done. 08:32:59 INFO - Installing pip.................done. 08:32:59 INFO - Return code: 0 08:32:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:33:00 INFO - Reading from file tmpfile_stdout 08:33:00 INFO - Output received: 08:33:00 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) 08:33:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:33:00 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')]} 08:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:00 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')]} 08:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:00 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 0x1d111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080a30>, '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 0x20817f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081ca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442', '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 08:33:00 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 08:33:00 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 08:33:00 INFO - Using env: {'DISPLAY': ':0', 08:33:00 INFO - 'HOME': '/home/cltbld', 08:33:00 INFO - 'LANG': 'en_US.UTF-8', 08:33:00 INFO - 'LANGUAGE': 'en_US:en', 08:33:00 INFO - 'LOGNAME': 'cltbld', 08:33:00 INFO - 'MAIL': '/var/mail/cltbld', 08:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:00 INFO - 'MOZ_NO_REMOTE': '1', 08:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:00 INFO - 'NO_EM_RESTART': '1', 08:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:00 INFO - 'PWD': '/builds/slave/test', 08:33:00 INFO - 'SHELL': '/bin/bash', 08:33:00 INFO - 'SHLVL': '1', 08:33:00 INFO - 'TERM': 'linux', 08:33:00 INFO - 'TMOUT': '86400', 08:33:00 INFO - 'USER': 'cltbld', 08:33:00 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442', 08:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:00 INFO - '_': '/tools/buildbot/bin/python'} 08:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:00 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 08:33:00 INFO - Cleaning up... 08:33:00 INFO - Return code: 0 08:33:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:33:00 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')]} 08:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:00 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')]} 08:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:00 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 0x1d111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080a30>, '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 0x20817f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081ca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442', '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 08:33:00 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 08:33:00 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 08:33:00 INFO - Using env: {'DISPLAY': ':0', 08:33:00 INFO - 'HOME': '/home/cltbld', 08:33:00 INFO - 'LANG': 'en_US.UTF-8', 08:33:00 INFO - 'LANGUAGE': 'en_US:en', 08:33:00 INFO - 'LOGNAME': 'cltbld', 08:33:00 INFO - 'MAIL': '/var/mail/cltbld', 08:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:00 INFO - 'MOZ_NO_REMOTE': '1', 08:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:00 INFO - 'NO_EM_RESTART': '1', 08:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:00 INFO - 'PWD': '/builds/slave/test', 08:33:00 INFO - 'SHELL': '/bin/bash', 08:33:00 INFO - 'SHLVL': '1', 08:33:00 INFO - 'TERM': 'linux', 08:33:00 INFO - 'TMOUT': '86400', 08:33:00 INFO - 'USER': 'cltbld', 08:33:00 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442', 08:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:00 INFO - '_': '/tools/buildbot/bin/python'} 08:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:00 INFO - Downloading/unpacking psutil>=3.1.1 08:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:35:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:35:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:35:08 INFO - Installing collected packages: psutil 08:35:08 INFO - Running setup.py install for psutil 08:35:08 INFO - building 'psutil._psutil_linux' extension 08:35:08 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 08:35:09 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 08:35:09 INFO - building 'psutil._psutil_posix' extension 08:35:09 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 08:35:09 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 08:35:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:35:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:35:09 INFO - Successfully installed psutil 08:35:09 INFO - Cleaning up... 08:35:09 INFO - Return code: 0 08:35:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:35:09 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')]} 08:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:09 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')]} 08:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:09 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 0x1d111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080a30>, '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 0x20817f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081ca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442', '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 08:35:09 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 08:35:09 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 08:35:09 INFO - Using env: {'DISPLAY': ':0', 08:35:09 INFO - 'HOME': '/home/cltbld', 08:35:09 INFO - 'LANG': 'en_US.UTF-8', 08:35:09 INFO - 'LANGUAGE': 'en_US:en', 08:35:09 INFO - 'LOGNAME': 'cltbld', 08:35:09 INFO - 'MAIL': '/var/mail/cltbld', 08:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:09 INFO - 'MOZ_NO_REMOTE': '1', 08:35:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:09 INFO - 'NO_EM_RESTART': '1', 08:35:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:09 INFO - 'PWD': '/builds/slave/test', 08:35:09 INFO - 'SHELL': '/bin/bash', 08:35:09 INFO - 'SHLVL': '1', 08:35:09 INFO - 'TERM': 'linux', 08:35:09 INFO - 'TMOUT': '86400', 08:35:09 INFO - 'USER': 'cltbld', 08:35:09 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442', 08:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:09 INFO - '_': '/tools/buildbot/bin/python'} 08:35:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:35:09 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 08:35:09 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 08:35:09 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 08:35:09 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 08:35:09 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 08:35:09 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 08:37:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:37:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:37:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:37:17 INFO - Installing collected packages: mozsystemmonitor 08:37:17 INFO - Running setup.py install for mozsystemmonitor 08:37:17 INFO - Successfully installed mozsystemmonitor 08:37:17 INFO - Cleaning up... 08:37:17 INFO - Return code: 0 08:37:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:37: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')]} 08:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37: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')]} 08:37:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:17 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 0x1d111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080a30>, '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 0x20817f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081ca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442', '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 08:37:17 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 08:37:17 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 08:37:17 INFO - Using env: {'DISPLAY': ':0', 08:37:17 INFO - 'HOME': '/home/cltbld', 08:37:17 INFO - 'LANG': 'en_US.UTF-8', 08:37:17 INFO - 'LANGUAGE': 'en_US:en', 08:37:17 INFO - 'LOGNAME': 'cltbld', 08:37:17 INFO - 'MAIL': '/var/mail/cltbld', 08:37:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:17 INFO - 'MOZ_NO_REMOTE': '1', 08:37:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:17 INFO - 'NO_EM_RESTART': '1', 08:37:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:17 INFO - 'PWD': '/builds/slave/test', 08:37:17 INFO - 'SHELL': '/bin/bash', 08:37:17 INFO - 'SHLVL': '1', 08:37:17 INFO - 'TERM': 'linux', 08:37:17 INFO - 'TMOUT': '86400', 08:37:17 INFO - 'USER': 'cltbld', 08:37:17 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442', 08:37:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:17 INFO - '_': '/tools/buildbot/bin/python'} 08:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:17 INFO - Downloading/unpacking jsonschema==2.5.1 08:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:39:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:31 INFO - Downloading functools32-3.2.3-2.tar.gz 08:41:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:41:31 INFO - warning: no files found matching '*.txt' 08:41:31 INFO - no previously-included directories found matching 'build' 08:41:31 INFO - no previously-included directories found matching 'dist' 08:41:31 INFO - no previously-included directories found matching '.git*' 08:41:31 INFO - Installing collected packages: jsonschema, functools32 08:41:31 INFO - Running setup.py install for functools32 08:41:31 INFO - warning: no files found matching '*.txt' 08:41:31 INFO - no previously-included directories found matching 'build' 08:41:31 INFO - no previously-included directories found matching 'dist' 08:41:31 INFO - no previously-included directories found matching '.git*' 08:41:31 INFO - Successfully installed jsonschema functools32 08:41:31 INFO - Cleaning up... 08:41:31 INFO - Return code: 0 08:41:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080a30>, '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 0x20817f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081ca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442', '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 08:41:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:41:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:41:31 INFO - Using env: {'DISPLAY': ':0', 08:41:31 INFO - 'HOME': '/home/cltbld', 08:41:31 INFO - 'LANG': 'en_US.UTF-8', 08:41:31 INFO - 'LANGUAGE': 'en_US:en', 08:41:31 INFO - 'LOGNAME': 'cltbld', 08:41:31 INFO - 'MAIL': '/var/mail/cltbld', 08:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:31 INFO - 'MOZ_NO_REMOTE': '1', 08:41:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:31 INFO - 'NO_EM_RESTART': '1', 08:41:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:31 INFO - 'PWD': '/builds/slave/test', 08:41:31 INFO - 'SHELL': '/bin/bash', 08:41:31 INFO - 'SHLVL': '1', 08:41:31 INFO - 'TERM': 'linux', 08:41:31 INFO - 'TMOUT': '86400', 08:41:31 INFO - 'USER': 'cltbld', 08:41:31 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442', 08:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:31 INFO - '_': '/tools/buildbot/bin/python'} 08:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:41:31 INFO - Cleaning up... 08:41:31 INFO - Return code: 0 08:41:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080a30>, '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 0x20817f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081ca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442', '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 08:41:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:41:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:41:31 INFO - Using env: {'DISPLAY': ':0', 08:41:31 INFO - 'HOME': '/home/cltbld', 08:41:31 INFO - 'LANG': 'en_US.UTF-8', 08:41:31 INFO - 'LANGUAGE': 'en_US:en', 08:41:31 INFO - 'LOGNAME': 'cltbld', 08:41:31 INFO - 'MAIL': '/var/mail/cltbld', 08:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:31 INFO - 'MOZ_NO_REMOTE': '1', 08:41:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:31 INFO - 'NO_EM_RESTART': '1', 08:41:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:31 INFO - 'PWD': '/builds/slave/test', 08:41:31 INFO - 'SHELL': '/bin/bash', 08:41:31 INFO - 'SHLVL': '1', 08:41:31 INFO - 'TERM': 'linux', 08:41:31 INFO - 'TMOUT': '86400', 08:41:31 INFO - 'USER': 'cltbld', 08:41:31 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442', 08:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:31 INFO - '_': '/tools/buildbot/bin/python'} 08:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:31 INFO - Downloading/unpacking blobuploader==1.2.4 08:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41: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 08:41: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 08:41: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 08:41: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 08:43:39 INFO - Downloading blobuploader-1.2.4.tar.gz 08:43:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:43:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:43:39 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 08:43:39 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 08:43:39 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 08:43:39 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 08:43:39 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 08:43:39 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 08:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:45:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:45:45 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 08:45:45 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 08:45:45 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 08:45:45 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 08:45:45 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 08:45:45 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 08:47:52 INFO - Downloading docopt-0.6.1.tar.gz 08:47:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:47:52 INFO - Installing collected packages: blobuploader, requests, docopt 08:47:52 INFO - Running setup.py install for blobuploader 08:47:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:47:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:47:52 INFO - Running setup.py install for requests 08:47:52 INFO - Running setup.py install for docopt 08:47:52 INFO - Successfully installed blobuploader requests docopt 08:47:52 INFO - Cleaning up... 08:47:53 INFO - Return code: 0 08:47:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47: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')]} 08:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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')]} 08:47:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:53 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 0x1d111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080a30>, '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 0x20817f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081ca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442', '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 08:47:53 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 08:47:53 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 08:47:53 INFO - Using env: {'DISPLAY': ':0', 08:47:53 INFO - 'HOME': '/home/cltbld', 08:47:53 INFO - 'LANG': 'en_US.UTF-8', 08:47:53 INFO - 'LANGUAGE': 'en_US:en', 08:47:53 INFO - 'LOGNAME': 'cltbld', 08:47:53 INFO - 'MAIL': '/var/mail/cltbld', 08:47:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:53 INFO - 'MOZ_NO_REMOTE': '1', 08:47:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:53 INFO - 'NO_EM_RESTART': '1', 08:47:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:53 INFO - 'PWD': '/builds/slave/test', 08:47:53 INFO - 'SHELL': '/bin/bash', 08:47:53 INFO - 'SHLVL': '1', 08:47:53 INFO - 'TERM': 'linux', 08:47:53 INFO - 'TMOUT': '86400', 08:47:53 INFO - 'USER': 'cltbld', 08:47:53 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442', 08:47:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:53 INFO - '_': '/tools/buildbot/bin/python'} 08:47:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:47:53 INFO - Running setup.py (path:/tmp/pip-xsnWea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:47:53 INFO - Running setup.py (path:/tmp/pip-QG8_Oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:47:53 INFO - Running setup.py (path:/tmp/pip-QsXI4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:47:53 INFO - Running setup.py (path:/tmp/pip-1RvpI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:47:53 INFO - Running setup.py (path:/tmp/pip-oxSI3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:47:53 INFO - Running setup.py (path:/tmp/pip-emT63N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:47:53 INFO - Running setup.py (path:/tmp/pip-bguRxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:47:53 INFO - Running setup.py (path:/tmp/pip-ylrKLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:47:53 INFO - Running setup.py (path:/tmp/pip-7JzTft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:47:53 INFO - Running setup.py (path:/tmp/pip-mcIxqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:47:53 INFO - Running setup.py (path:/tmp/pip-5NvaoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:47:54 INFO - Running setup.py (path:/tmp/pip-NweEU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:47:54 INFO - Running setup.py (path:/tmp/pip-neLClk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:47:54 INFO - Running setup.py (path:/tmp/pip-PEGCMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:54 INFO - Running setup.py (path:/tmp/pip-B_MXOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:47:54 INFO - Running setup.py (path:/tmp/pip-fQ6muy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:47:54 INFO - Running setup.py (path:/tmp/pip-OVLmPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:47:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:47:54 INFO - Running setup.py install for manifestparser 08:47:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:47:54 INFO - Running setup.py install for mozcrash 08:47:54 INFO - Running setup.py install for mozdebug 08:47:54 INFO - Running setup.py install for mozdevice 08:47:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:47:54 INFO - Running setup.py install for mozfile 08:47:54 INFO - Running setup.py install for mozhttpd 08:47:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:47:55 INFO - Running setup.py install for mozinfo 08:47:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:47:55 INFO - Running setup.py install for mozInstall 08:47:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:47:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:47:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:47:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:47:55 INFO - Running setup.py install for mozleak 08:47:55 INFO - Running setup.py install for mozlog 08:47:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:47:55 INFO - Running setup.py install for moznetwork 08:47:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:47:55 INFO - Running setup.py install for mozprocess 08:47:55 INFO - Running setup.py install for mozprofile 08:47:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:47:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:47:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:47:55 INFO - Running setup.py install for mozrunner 08:47:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:47:55 INFO - Running setup.py install for mozscreenshot 08:47:56 INFO - Running setup.py install for moztest 08:47:56 INFO - Running setup.py install for mozversion 08:47:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:47:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:47:56 INFO - Cleaning up... 08:47:56 INFO - Return code: 0 08:47:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47:56 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')]} 08:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:56 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')]} 08:47:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:56 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 0x1d111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080a30>, '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 0x20817f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081ca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442', '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 08:47:56 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 08:47:56 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 08:47:56 INFO - Using env: {'DISPLAY': ':0', 08:47:56 INFO - 'HOME': '/home/cltbld', 08:47:56 INFO - 'LANG': 'en_US.UTF-8', 08:47:56 INFO - 'LANGUAGE': 'en_US:en', 08:47:56 INFO - 'LOGNAME': 'cltbld', 08:47:56 INFO - 'MAIL': '/var/mail/cltbld', 08:47:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:56 INFO - 'MOZ_NO_REMOTE': '1', 08:47:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:56 INFO - 'NO_EM_RESTART': '1', 08:47:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:56 INFO - 'PWD': '/builds/slave/test', 08:47:56 INFO - 'SHELL': '/bin/bash', 08:47:56 INFO - 'SHLVL': '1', 08:47:56 INFO - 'TERM': 'linux', 08:47:56 INFO - 'TMOUT': '86400', 08:47:56 INFO - 'USER': 'cltbld', 08:47:56 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442', 08:47:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:56 INFO - '_': '/tools/buildbot/bin/python'} 08:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:47:56 INFO - Running setup.py (path:/tmp/pip-wkLNi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:47:56 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)) 08:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:47:56 INFO - Running setup.py (path:/tmp/pip-hcmHqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:47:56 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)) 08:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:47:56 INFO - Running setup.py (path:/tmp/pip-eKYnhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:47:56 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)) 08:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:47:56 INFO - Running setup.py (path:/tmp/pip-LLxaAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:47:56 INFO - Running setup.py (path:/tmp/pip-ubsfGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:47:56 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)) 08:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:47:56 INFO - Running setup.py (path:/tmp/pip-npwSC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:47:56 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)) 08:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:47:56 INFO - Running setup.py (path:/tmp/pip-bL9mlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:47:56 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)) 08:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:47:56 INFO - Running setup.py (path:/tmp/pip-8q5QiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:47:57 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)) 08:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:47:57 INFO - Running setup.py (path:/tmp/pip-FTwqXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:47:57 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)) 08:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:47:57 INFO - Running setup.py (path:/tmp/pip-bdIm3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:47:57 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)) 08:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:47:57 INFO - Running setup.py (path:/tmp/pip-OTfECd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:47:57 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)) 08:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:47:57 INFO - Running setup.py (path:/tmp/pip-vNJexR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:47:57 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)) 08:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:47:57 INFO - Running setup.py (path:/tmp/pip-MJjyXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:47:57 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)) 08:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:47:57 INFO - Running setup.py (path:/tmp/pip-OS1FsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:47:57 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)) 08:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:57 INFO - Running setup.py (path:/tmp/pip-Q_rVBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:57 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)) 08:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:47:57 INFO - Running setup.py (path:/tmp/pip-YYmUdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:47:57 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)) 08:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:47:57 INFO - Running setup.py (path:/tmp/pip-xgbmu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:47:57 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)) 08:47:57 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)) 08:47:57 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)) 08:47:57 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)) 08:47:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:47:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:47:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:05 INFO - Downloading blessings-1.6.tar.gz 08:50:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:50:05 INFO - Installing collected packages: blessings 08:50:05 INFO - Running setup.py install for blessings 08:50:05 INFO - Successfully installed blessings 08:50:05 INFO - Cleaning up... 08:50:05 INFO - Return code: 0 08:50:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:50:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:05 INFO - Reading from file tmpfile_stdout 08:50:05 INFO - Current package versions: 08:50:05 INFO - argparse == 1.2.1 08:50:05 INFO - blessings == 1.6 08:50:05 INFO - blobuploader == 1.2.4 08:50:05 INFO - docopt == 0.6.1 08:50:05 INFO - functools32 == 3.2.3-2 08:50:05 INFO - jsonschema == 2.5.1 08:50:05 INFO - manifestparser == 1.1 08:50:05 INFO - mozInstall == 1.12 08:50:05 INFO - mozcrash == 1.0 08:50:05 INFO - mozdebug == 0.1 08:50:05 INFO - mozdevice == 0.50 08:50:05 INFO - mozfile == 1.2 08:50:05 INFO - mozhttpd == 0.7 08:50:05 INFO - mozinfo == 0.9 08:50:05 INFO - mozleak == 0.1 08:50:05 INFO - mozlog == 3.4 08:50:05 INFO - moznetwork == 0.27 08:50:05 INFO - mozprocess == 0.25 08:50:05 INFO - mozprofile == 0.28 08:50:05 INFO - mozrunner == 6.13 08:50:05 INFO - mozscreenshot == 0.1 08:50:05 INFO - mozsystemmonitor == 0.3 08:50:05 INFO - moztest == 0.8 08:50:05 INFO - mozversion == 1.4 08:50:05 INFO - psutil == 3.1.1 08:50:05 INFO - requests == 1.2.3 08:50:05 INFO - wsgiref == 0.1.2 08:50:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:05 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')]} 08:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:05 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')]} 08:50:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:05 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 0x1d111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080a30>, '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 0x20817f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081ca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442', '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 08:50:05 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 08:50:05 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 08:50:05 INFO - Using env: {'DISPLAY': ':0', 08:50:05 INFO - 'HOME': '/home/cltbld', 08:50:05 INFO - 'LANG': 'en_US.UTF-8', 08:50:05 INFO - 'LANGUAGE': 'en_US:en', 08:50:05 INFO - 'LOGNAME': 'cltbld', 08:50:05 INFO - 'MAIL': '/var/mail/cltbld', 08:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:05 INFO - 'MOZ_NO_REMOTE': '1', 08:50:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:05 INFO - 'NO_EM_RESTART': '1', 08:50:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:05 INFO - 'PWD': '/builds/slave/test', 08:50:05 INFO - 'SHELL': '/bin/bash', 08:50:05 INFO - 'SHLVL': '1', 08:50:05 INFO - 'TERM': 'linux', 08:50:05 INFO - 'TMOUT': '86400', 08:50:05 INFO - 'USER': 'cltbld', 08:50:05 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442', 08:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:05 INFO - '_': '/tools/buildbot/bin/python'} 08:50:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:05 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)) 08:50:05 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)) 08:50:05 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)) 08:50:05 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)) 08:50:05 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)) 08:50:05 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)) 08:50:05 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)) 08:50:05 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)) 08:50:05 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)) 08:50:05 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)) 08:50:05 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)) 08:50:05 INFO - Cleaning up... 08:50:05 INFO - Return code: 0 08:50:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:50:05 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')]} 08:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:05 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')]} 08:50:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:05 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 0x1d111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080a30>, '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 0x20817f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081ca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442', '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 08:50:05 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 08:50:05 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 08:50:05 INFO - Using env: {'DISPLAY': ':0', 08:50:05 INFO - 'HOME': '/home/cltbld', 08:50:05 INFO - 'LANG': 'en_US.UTF-8', 08:50:05 INFO - 'LANGUAGE': 'en_US:en', 08:50:05 INFO - 'LOGNAME': 'cltbld', 08:50:05 INFO - 'MAIL': '/var/mail/cltbld', 08:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:05 INFO - 'MOZ_NO_REMOTE': '1', 08:50:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:05 INFO - 'NO_EM_RESTART': '1', 08:50:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:05 INFO - 'PWD': '/builds/slave/test', 08:50:05 INFO - 'SHELL': '/bin/bash', 08:50:05 INFO - 'SHLVL': '1', 08:50:05 INFO - 'TERM': 'linux', 08:50:05 INFO - 'TMOUT': '86400', 08:50:05 INFO - 'USER': 'cltbld', 08:50:05 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442', 08:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:05 INFO - '_': '/tools/buildbot/bin/python'} 08:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:50:06 INFO - Cleaning up... 08:50:06 INFO - Return code: 0 08:50:06 INFO - Running post-action listener: _resource_record_post_action 08:50:06 INFO - Running post-action listener: _start_resource_monitoring 08:50:06 INFO - Starting resource monitoring. 08:50:06 INFO - [mozharness: 2017-05-11 15:50:06.111745Z] Finished create-virtualenv step (success) 08:50:06 INFO - [mozharness: 2017-05-11 15:50:06.112200Z] Running install step. 08:50:06 INFO - Running pre-action listener: _resource_record_pre_action 08:50:06 INFO - Running main action method: install 08:50:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:06 INFO - Reading from file tmpfile_stdout 08:50:06 INFO - Detecting whether we're running mozinstall >=1.0... 08:50:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:50:06 INFO - Reading from file tmpfile_stdout 08:50:06 INFO - Output received: 08:50:06 INFO - Usage: mozinstall [options] installer 08:50:06 INFO - Options: 08:50:06 INFO - -h, --help show this help message and exit 08:50:06 INFO - -d DEST, --destination=DEST 08:50:06 INFO - Directory to install application into. [default: 08:50:06 INFO - "/builds/slave/test"] 08:50:06 INFO - --app=APP Application being installed. [default: firefox] 08:50:06 INFO - mkdir: /builds/slave/test/build/application 08:50:06 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'] 08:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:50:22 INFO - Reading from file tmpfile_stdout 08:50:22 INFO - Output received: 08:50:22 INFO - /builds/slave/test/build/application/firefox/firefox 08:50:22 INFO - Running post-action listener: _resource_record_post_action 08:50:22 INFO - [mozharness: 2017-05-11 15:50:22.167905Z] Finished install step (success) 08:50:22 INFO - [mozharness: 2017-05-11 15:50:22.168177Z] Running run-tests step. 08:50:22 INFO - Running pre-action listener: _resource_record_pre_action 08:50:22 INFO - Running main action method: run_tests 08:50:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:50:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:50:22 INFO - Python 2.7.3 08:50:22 INFO - Return code: 0 08:50:22 INFO - grabbing minidump binary from tooltool 08:50: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')]} 08:50:22 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 0x2080a30>, '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 0x20817f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2081ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:50:22 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 08:50:22 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 08:50:22 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 08:50:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:50:22 INFO - Return code: 0 08:50:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:50:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:50:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:50:22 INFO - ENV: RUST_BACKTRACE is now 1 08:50:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:50:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:50:22 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/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 08:50:22 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/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 08:50:22 INFO - Using env: {'DISPLAY': ':0', 08:50:22 INFO - 'HOME': '/home/cltbld', 08:50:22 INFO - 'LANG': 'en_US.UTF-8', 08:50:22 INFO - 'LANGUAGE': 'en_US:en', 08:50:22 INFO - 'LOGNAME': 'cltbld', 08:50:22 INFO - 'MAIL': '/var/mail/cltbld', 08:50:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:50:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:50:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:22 INFO - 'MOZ_NO_REMOTE': '1', 08:50:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:50:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:22 INFO - 'NO_EM_RESTART': '1', 08:50:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:22 INFO - 'PWD': '/builds/slave/test', 08:50:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:50:22 INFO - 'RUST_BACKTRACE': '1', 08:50:22 INFO - 'SHELL': '/bin/bash', 08:50:22 INFO - 'SHLVL': '1', 08:50:22 INFO - 'TERM': 'linux', 08:50:22 INFO - 'TMOUT': '86400', 08:50:22 INFO - 'USER': 'cltbld', 08:50:22 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442', 08:50:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:22 INFO - '_': '/tools/buildbot/bin/python'} 08:50:22 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/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 08:50:22 INFO - mozversion application_buildid: 20170511145127 08:50:22 INFO - mozversion application_changeset: 0259418f19ab804b126730ef1d5d03006d6aad52 08:50:22 INFO - mozversion application_display_name: Nightly 08:50:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:50:22 INFO - mozversion application_name: Firefox 08:50:22 INFO - mozversion application_remotingname: firefox 08:50:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:50:22 INFO - mozversion application_vendor: Mozilla 08:50:22 INFO - mozversion application_version: 55.0a1 08:50:22 INFO - mozversion platform_buildid: 20170511145127 08:50:22 INFO - mozversion platform_changeset: 0259418f19ab804b126730ef1d5d03006d6aad52 08:50:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:50:22 INFO - mozversion platform_version: 55.0a1 08:50:22 INFO - using testdate: 1494517822 08:50:22 INFO - actual date: 1494517822 08:50:22 INFO - starting webserver on 'localhost:46288' 08:50:22 INFO - SUITE-START | Running 2 tests 08:50:22 INFO - TEST-START | dromaeo_css 08:50:22 INFO - operating with platform_type : linux_ 08:50:22 INFO - Initialising browser for dromaeo_css test... 08:50:22 INFO - TEST-INFO | started process 3337 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnha93p/profile http://localhost:46288/getInfo.html) 08:50:27 INFO - PID 3337 | __metrics Screen width/height:1600/1200 08:50:27 INFO - PID 3337 | colorDepth:24 08:50:27 INFO - PID 3337 | Browser inner width/height: 1024/695 08:50:27 INFO - PID 3337 | __metrics 08:50:29 INFO - TEST-INFO | 3337: exit 0 08:50:29 INFO - Browser initialized. 08:50:29 INFO - Running cycle 1/1 for dromaeo_css test... 08:50:29 INFO - TEST-INFO | started process 3510 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnha93p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:50:40 INFO - PID 3510 | RSS: Main: 154935296 08:50:40 INFO - PID 3510 | 08:53:45 INFO - PID 3510 | Cycle 1(1): loaded http://localhost:46288/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46288/tests/dromaeo/cssquery-ext.html) 08:53:47 INFO - PID 3510 | RSS: Main: 164896768 08:53:47 INFO - PID 3510 | 08:56:49 INFO - PID 3510 | Cycle 1(1): loaded http://localhost:46288/tests/dromaeo/cssquery-ext.html (next: http://localhost:46288/tests/dromaeo/cssquery-jquery.html) 08:56:50 INFO - PID 3510 | RSS: Main: 161374208 08:56:50 INFO - PID 3510 | 08:59:52 INFO - PID 3510 | Cycle 1(1): loaded http://localhost:46288/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46288/tests/dromaeo/cssquery-mootools.html) 08:59:53 INFO - PID 3510 | RSS: Main: 169091072 08:59:53 INFO - PID 3510 | 09:02:54 INFO - PID 3510 | Cycle 1(1): loaded http://localhost:46288/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46288/tests/dromaeo/cssquery-prototype.html) 09:02:55 INFO - PID 3510 | RSS: Main: 161243136 09:02:55 INFO - PID 3510 | 09:05:58 INFO - PID 3510 | Cycle 1(1): loaded http://localhost:46288/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46288/tests/dromaeo/cssquery-yui.html) 09:05:58 INFO - PID 3510 | RSS: Main: 165335040 09:05:58 INFO - PID 3510 | 09:09:00 INFO - PID 3510 | Cycle 1(1): loaded http://localhost:46288/tests/dromaeo/cssquery-yui.html (next: http://localhost:46288/tests/dromaeo/cssquery-dojo.html) 09:09:01 INFO - PID 3510 | RSS: Main: 168914944 09:09:01 INFO - PID 3510 | 09:09:01 INFO - PID 3510 | __start_tp_report 09:09:01 INFO - PID 3510 | _x_x_mozilla_page_load 09:09:01 INFO - PID 3510 | _x_x_mozilla_page_load_details 09:09:01 INFO - PID 3510 | |i|pagename|runs| 09:09:01 INFO - PID 3510 | |0;dojo.html;2735.466584016118;2764.8479333636647;2782.874770635321;2786.0109661070305;2806.340509980155;5170.844874653757;5172.09488339541;5224.764885580148;5232.6075544334135;5276.314079169707;5189.455107213745;5199.324087868572;5284.577233821295;5330.733463326837;5333.973330133344;4627.259638457831;4654.883627909296;4656.837010704626;4666.76666166692;4698.436187657486;4695.929561056587;4707.317438971347;4731.503192164842;4734.597559207472;4761.047790441909;4602.976985115087;4632.119897219518;4663.347131401607;4681.204195286809;4702.059588082398;4694.108119457326;4701.553352431513;4710.552497512731;4718.386609740746;4739.834105806281;4672.229082201433;4682.3210634458155;4688.367070445514;4694.201985662411;4711.151992641323;5134.768935397916;5172.301739265189;5209.453007434203;5238.319018527567;5269.789208431658;5678.3186017678145;5703.857403564903;5714.057180565202;5739.62692424991;5758.136279558058;5720.11338242573;5725.685087320196;5728.570357223183;5731.742071606787;5748.511376533;5157.6647517911215;5223.869403264949;5270.367555893279;5281.287026251483;5286.788528458896;5803.88392232153;5859.296884373903;5897.233359663216;5898.380670029671;5898.439648233411;5542.7782888684005;5603.3836278009385;5632.408597097327;5658.490735833795;5661.688607126565;5668.322499079178;5692.345380281238;5700.572457065737;5716.542676585863;5735.311762588516;5502.9174562381595;5578.079616863253;5653.321601407857;5654.74553645087;5659.377468478464;5552.500274975191;5562.582806289463;5565.749541270652;5572.58205634579;5591.888162236733;4596.218642830727;4630.490646028934;4654.16225079489;4661.510541393172;4673.392458980311;4021.477207962946;4023.2556976959354;4033.838646454109;4034.253663072341;4070.3894415837863;4865.95134048662;4928.0390323886495;4947.356843610308;4955.256711493233;4961.280614310905;5570.58220633446;5622.32532096151;5634.436556344414;5651.321841379061;5698.943010569924;4924.113659541317;4950.504949505021;4951.851444456672;4966.801327946841;4983.50164983506;5026.547610715053;5031.6729412588065;5034.295198672189;5040.798368065236;5086.796528138833;5271.182966640177;5272.55183309423;5275.419703832652;5370.570354371563;5389.568834493152;5552.056150454513;5597.188407680945;5648.096304591246;5694.601377903507;5779.075347944308;5344.984452953926;5363.490468405495;5372.167314066326;5376.8118115865755;5399.244105825266;5598.692071936082;5630.071038278638;5645.237892884408;5650.0959846424375;5654.971725141348;5661.943380566142;5722.828315150552;5735.3977832327;5736.971315143398;5749.281339832521;5464.781408743605;5527.640703354269;5527.834164975057;5528.308961379827;5531.7234138292115;5481.232627432083;5535.833924982257;5554.361248456479;5557.749901254372;5578.804741834017;5412.025835349517;5439.347278326626;5450.427705091067;5460.3993560707495;5460.563154947674;5488.7530061148145;5539.473749993744;5550.167474878801;5555.22226888244;5565.888682226414;5330.227117068081;5382.273393091882;5397.27136836522;5400.297961265011;5408.513233808976 09:09:01 INFO - PID 3510 | |1;ext.html;594.4738906068128;655.3806652713187;674.7874419557841;1187.0503597122306;1196.1507329795845;33759.493607595876;34174;34181.658183418156;34314.65685343146;34455;31793;32339;32357.51463728046;32387.51418728721;32397.67602323976;6511.1535500385;6900.27547107554;7102.609356485391;7112.395446387038;7118.715251389938;7017.719291228344;7086.610236436994;7120.394766444859;7120.715171393138;7142.035825163614;7073.646317684121;7109.253528379523;7165.498415110945;7178.676959536833;7179.743544879625;7104.538205016657;7121.715131394738;7154.105736782903;7165.6775445105095;7172.031775710265;6783.42340901024;6794.728210871559;6821;6827.52207345486;6841.62371069591;32253;32417.51373729396;32457;32490.837545812356;32582.185445364055;3055.5874956880757;3057.1287183152917;3069;3098.8295643739584;3106.1458099022725;25288.620670689954;25432;25454.618180727302;25524.36189095269;25585;2876.2090425133047;2880.4095160492047;2892.5950366948646;2916.854157292148;2936.8825246990095;146289.26855365656;146754;147626;150626;153864;40125.197496049914;40615.7969210158;40667.7966610165;40686.355386899755;40750.59249407468;42275;42363.30546778094;42487.787561061996;44051.77974110109;45001.324980125326;12355.876441235652;12385.133040687066;12389.194702344319;12429.192102513307;12473.189242699196;10211.540480678388;10246.743831404274;10252.487375631188;10253.794924101476;10264.743381415376;13249.73500529984;13255.668608284677;13282;13292.867071329163;13477.663058423617;5333.280007199056;5335.67985920846;5360.8659783504945;5379.704116273642;5516.531094856982;869.3566760597239;901.4411065139524;917.0737555069428;923.6213152607398;946.0917519181663;21396.78603213979;21459.89270053671;21755.129794808032;21771.67342489864;22057.11771529153;892.5492626223845;984.3650845204803;994.1500017485091;1002.6364144763116;1016.466355163545;9992.700218993441;10517.737871455474;10519.684409467574;10641.680749577525;10712.035916767529;180381;180979;181886;182250;182672;41041.38437923433;41204.79397602993;41412;41419.585804142174;41520.58479415227;1169.9532018719326;1251.5306759965013;1256.4408838067154;1261.8738126187309;1262.9747405051849;18290.268389264813;18638.068096594845;19158.61682766309;19362.322318718776;19396.8060319395;29844.70155298506;36969.81515092407;37958.430623540116;38262.42606360851;38306.80846595749;161668.19165904095;162366;163222.18388907978;163339;163433;30876.38247234998;30902.381952361276;31203.37593248077;31249.531257031616;31260.374792504477;35960.56157753765;36403;36744.813796550865;36960.44559331666;37028.44457333088;28268.43463130767;28403.289917752223;28961.855190723913;29083.854580726962;30460.08619741411;28078.57882131729;28235.858820705766;28429.289267768472;28429.857850710614;29932.251693707833;32033.519497208028;32262;32299.86950456723;32341.191470212492;32431.83784081159;27504.862475687492;27549.72450275552;28319.43361132807;28679.139625811258;29008.06001117199;22100.557988840454;22823.429414264778;22837.543249134593;23066.540018997286;23068.538629227656 09:09:01 INFO - PID 3510 | |2;jquery.html;423.36629984698186;426.4754352146857;427.2395136656752;448.21562266034437;449.87853279614507;17163.798534102632;17309.56726081847;17630.64738705225;17850.82149178508;18103.728444073335;15978.600534986632;16118.597035074128;16518.917405412954;17055.40306089287;17123.22945467454;5546.417626149257;5559.58303127265;5649.717514124277;5661.8393229387875;5694.064018233799;5572.192032155335;5630.577706671996;5659.773609055654;5665.093585026397;5669.603127781057;5470.56235501161;5579.13523403871;5598.1322894951345;5614.438556144394;5663.235463212475;5534.889302213954;5535.778568857261;5557.749901254453;5580.079286917633;5589.580781441408;4808.879778005543;4865.221564549655;4914.0908931847725;4929.679570827885;5031.597472202215;22539.06992091034;22740.545189096127;22931.082756689713;23401.88299058511;23563.528729425314;1605.783219265396;1653.7602047703135;1654.4126834973652;1660.4520508232254;1668.1325710630526;15019.849801502063;15020.849791502163;15611.843881561153;15687.607809804733;15842.60393490172;2106.452322396188;2157.9892100539396;2186.650135978236;2188.6607575825774;2189.2228258968;83683.23425445809;88964.5551772237;90639;97966.51016744942;103270.48364758279;10844.457777111113;11207.607733729443;11237.662870113909;11323.490442930088;11549.133814963743;15201.239938003055;15260.236988150547;15358.923205383902;15396.538103856903;15398.384064637514;7580.279873412017;7936.642851071716;8008.270901420518;8108.75673729789;8139.30815880645;7441.144268409094;7551.433642476836;7578.09062912454;7751.844963100706;7807.063152421632;7253.492255542062;7319.817004574928;7379.778606641809;7398.519096258726;7433.145188303414;2024.7165396844453;2076.8650037747498;2098.853080284396;2105.842061845368;2198.3404978506705;845.4208866926052;865.485036403339;872.2847265242567;874.2874557235832;898.1691934960136;17725.468235952943;17793.288268469376;18206.18072186755;18428.17073231681;18662;873.7204094689765;884.9469031858109;889.7241855024963;892.4110087342323;900.3787386703154;9793.510324483746;10119.696409107739;10126.139278161292;10155.492225388702;10192.796144077078;345545;348066;353553;358172;359889;64347.678261608395;77514;77678;78491;79079;1011.1253765492943;1017.1049476460668;1067.8771941226858;1068.8396740488834;1068.8610480637467;17417.738733918748;17704.29182832672;18148.818511814712;19442.4167274982;19454.708179377038;38185.42721859119;38903.22193556056;39923;39923.201535969696;40542.39186412265;45696;46633;48523.27215091847;48875.26687099625;49331.26003109884;8414.915850841413;8510.234458507746;8510.914890851012;8724.389292749447;9143.817123657622;13403.664908377368;13498.122622029538;13508.729825403634;13661.931690341484;13782.586522404345;10256.333338332985;11216.55133794639;11505.076647421793;11576.826347604625;11785.175037747274;10609.89390106089;10612.787744244917;11047.558097676003;11209.55161793519;11231.71920701989;11835.82246266324;11887;12023.939880300542;12115.212511186744;12197.51209951592;8347.749567512985;8395.664173432995;8456.788580285542;8508.872366914378;8549.572521373782;11532.308061516336;11578.826317605075;11612.477438515118;11799.823002654795;11975.161738678209 09:09:01 INFO - PID 3510 | |3;mootools.html;1260.7415479826636;1291.289790615162;1317.3215793866161;1323.2193006126383;1326.6484381638863;9717.416954982697;10049.397036177834;10302.896971030277;10321.638742644009;10694.197935154856;10282.074613284803;10514.369137851716;10519.579216831318;10520.368777873315;10522.526486308116;2242.1816037146405;2293.094227780026;2300.7469178390365;2302.527981763743;2305.688732021181;2222.7777222277805;2291.3927809130596;2297.3452566018686;2302.5279817637343;2303.2974942642486;2235.4299653588314;2250.966235506469;2282.1213832674457;2287.828412869033;2289.416198869286;2130.733658292698;2164.2100633268824;2173.413178441812;2187.2344679362254;2190.266260802633;1917.3960202536157;1998.810113039259;2082.854200205986;2212.4911270407897;2216.4126506475795;10432.061114499731;10472.109870661003;10529.262951593391;10538.631147909862;10567.524461399256;5706.087026075849;5921.467067963861;5925.703714814285;5934.525237980951;5941.910871336933;3435.4846772984;3655.4151335786414;3672.926541469156;3733.5706393764794;3736.6076561960876;1095.2333366643381;1111.2388014210292;1132.637555982086;1186.353437376623;1192.2071822238202;15202.771958420633;15409.537713868602;15451.690966180613;15487.690246195012;15489.14809685478;4630.282306242538;4636.605888499448;4733.455652599926;4743.430788305425;4948.896718894455;10861.40262285582;10945.45272736376;10966.780664386668;10984.505697243643;10984.725381865357;5573.693446860461;5620.409856965041;5630.211770352154;5640.633358831663;5648.661080335193;5163.4062082860955;5177.249298851721;5272.7100009499845;5289.735513224324;5367.302250707383;3818.770873747584;3925.862594809225;3940.763554186758;3985.80070996449;3991.0621004064024;1170.6839153428527;1176.7822952753768;1195.5158160944832;1196.3061424373843;1211.0372254058045;679.6262055869253;695.9826004349932;703.4723957032226;719.7372958869975;722.1298335505703;5413.864653383697;5534.695591742493;5548.389677135512;5562.666240025612;5566.55467562594;535.9946400535945;546.0117187889932;551.6386766667839;551.8344496650989;559.2478116932718;3584.193556449778;3806.467094606757;3835.712321575893;3852.3065848147603;3887.358585833306;12229.938850305869;12513;12861.228326300452;13028;13357.933210333886;12861.871381286068;13300.733985320432;13315.334233288297;13337.066405351727;13498.257595832127;7400.185979542246;7496.6251687415415;7560;7576.3181313682035;7578.696852125963;5601.915971260516;5604.467575580314;5608.6073974821375;5690.402507736793;5800.651960882361;11948.342841143472;12081.637550873487;12127.87762141604;12144.392780361124;12203.633890983285;11963;12296.938515307365;12413.255204687386;12522.499100035897;12523.06077044207;7813.10149332834;7896.09194942589;7913.050433947963;7916.84166316682;7965.442419030613;9575.186109180797;9584.952075239578;9640.469774162488;9656.37233579815;9694.5152742364;8138.959305203436;8407.831843363221;8489.575521224038;8502.914970850212;8622.655093796178;8065.354771618139;8068.152843951535;8122.106568277367;8259.545724985184;8344.958275208584;7225.096862892138;7342.8251479762985;7364.41084713211;7371.963140184264;7375;4977.875553111201;5064.797408103782;5075.289459475603;5091.567216786615;5371.650842695212;5539.7784088636;5589.273394458694;5693.007447393379;5740.827775166752;5821.883562328814 09:09:01 INFO - PID 3510 | |4;prototype.html;399.8660448749668;400.299475917145;400.4953758264586;401.9879403617892;409.1877622918508;5573.804916827912;5595.685014021702;5601.383847776741;5610.382857885629;5613.775448982046;5377.838664840051;5425.538829199513;5466.114190604245;5475.5072043516075;5496.203050557667;4268.9573104268875;4283.614474697277;4290.155233249701;4294.398784170218;4319.438472998506;4299.849505267316;4301.935470967938;4308.246056940038;4311.741295522263;4331.177076355498;4188.979055104735;4261.424707664472;4264.466941632296;4282.464691913511;4283.143371325732;4261.254280500931;4269.380939763748;4269.594388533069;4277.786110694468;4291.184674911757;3844.3464611016193;3870;3882.3594106972314;3888.844446222148;3890.8443662253476;5262.842114736564;5356.4375740547075;5370.865728356784;5392.676439413648;5403.865473138088;5053.317802096707;5061.215511595708;5062.873428164288;5063.139266324733;5076.13705670037;5755.712214389306;5793.507551858097;5799.536037117021;5800.361960184418;5801.271963349856;3861.8455261789495;3989.3218152914073;4020.778857162855;4028.436018957319;4342.978285108554;5944.702764861783;6078.361772013919;6098.298695650013;6153.661548614825;6160.106784516265;4052.63526282636;4094.877153685394;4100.569440208795;4118.629323360912;4123.340265557556;4172.99848036469;4173.770442625685;4182.372644103348;4185.748855068645;4191.203671302443;4724.527547245248;4771.427428708577;4794.9280760788615;4802.73584952831;4819;5697.4302569742695;5708.885822283614;5710.65736055838;5723.6279641823985;5738.139279108167;1429.9356528956014;1447.2474313356995;1449.681070164562;1451.267110109388;1453.1063396011377;924.7595625137512;963.9132478077007;975.4634950777045;976.8339382305026;977.5307852230827;5079.2381142828135;5089.666268594076;5106.387233532;5116.337190413131;5137.486251374833;6047.304559975659;6049.727762250709;6060.606060606046;6067.666278354644;6067.939320606737;4949.505049495022;5070.797168113308;5083.7203953782155;5112.4120726116225;5140.357455318085;3171.3657268546385;3179.984100079485;3190.7606929479916;3195.792273502215;3214.11611806755;5456.236126942231;5577.776888924479;5611.7474713637985;5634.85912852182;5665.943340566541;6105.511559075263;6161.322254551996;6187.504999600022;6195.659238741912;6198.6280823150755;5615.6630602164005;5639.577031722637;5645.125005624135;5648.604597678123;5661.858453538612;5768.278965129359;5989.371116032754;6032.336442991355;6058.242719660043;6066.211392518944;5871.324797648325;5900.64596124234;5904.5238690327415;5911;5913.142594323885;5463.726813659222;5582.7766889323975;5632.85917852057;5635.436456354331;5653.378128405954;4120;4136.524299705572;4138.482689663792;4143.440635514167;4154.273002224659;5907.995640740998;6002.699865006645;6055.394460553909;6063.636181829104;6076.90884636722;5778.335491418541;5787.826365209051;5819.301683797971;5841.50347220491;5857.4435428634215;5836.474717275466;5846.473817356458;5853.443922827325;5864.237649105589;5869.266341707286;5681.630694004876;5701.714914254354;5752.28096487939;5758.62568933018;5767.567432442667;5856.853578660568;5870.5010074142465;5876.44173803488;5878.209963186344;5887.5289976802605;5469.304515600176;5678.785273743161;5702.116171993348;5708.686022268815;5716.228309178207 09:09:01 INFO - PID 3510 | |5;yui.html;739.3382922284555;749.1497150733916;761.0980987529778;767.3630886364318;771.2827070824133;12580.685482862933;13044.28256445895;13169.670758231048;13385.79921301179;13861.861381386196;15283;15652.608684782886;15676.686466270668;15699.529014129566;16091.758623620626;854.1629203380691;867.5748883047324;870.7300736771621;871.5293741379647;872.1932212703256;916.5783739479814;917.5824999625188;921.9308551858637;922.8523436250201;924.856647219682;970.1801977329145;972.5526257921365;973.1825266775907;973.1873885305778;975.5414954971152;961.956711947964;969.0842154164318;969.5394687523406;970.9902900971041;970.9951450242775;699.4369532526314;703.6868593475905;706.427793487277;708.9397401220903;710.0272626501674;15154.696906061927;15358.385664573403;15596.92201538985;15655.217239137997;15738;15991.680166396607;16076.356945722275;16276.593085172966;16513;16537.173141343006;11396.544138234462;11653.6503904883;11734.354610496419;11780.234284771548;11837.230580012272;2902.085842959461;2904.4626744052416;2905.6513218413716;2909.461749576314;2948.027151040173;68644.65677671629;68996.6550167251;69221;69526.30473695249;71451.2854871455;11896.940515297541;12122.818157727641;12183.269003859798;12240.204386714835;12252.938735306267;21793.237236696958;21820;22103.137309792142;22290.442738931655;22361.44096397603;6004.939950600526;6278.15244941927;6418.326075762071;6526.28210896801;6537.803865884031;2975.3305506260917;3046.6191726034244;3049.2224482756756;3052.1759125036115;3058.801177923428;3591.2637909228547;3667;3679.2457546202963;4194.328907374806;4333.653307735373;799.4244144216156;828.0725587342095;834.4242472693821;837.3845223760532;840.1934143222575;590.4176806159534;597.6892016151577;612.1063247658379;612.1735656863289;628.5976974736172;9809.166220871162;9855.113039826307;10033.685515228522;10410.427426491615;10495.21285903545;568.6076607141059;577.6765011593521;581.44472029212;591.7544219149005;603.2820943077724;4347.152305300499;4397.252467080604;4457.821687132543;4476.082403107355;4504.2793153095345;64783.67608162023;64808.351916480235;64818.67590662016;64984;65914;59027.409725902195;59524;59585.404145958855;59868.40131598628;60174.39825601688;45350.99999999934;46060;48984;49741.25388119181;51683;9887.30788844774;10477.842832357674;10611.363318200933;10816.349994251144;10876.184286178726;25052.749472505042;25616.48767024612;26072.217833465027;26529.867350663124;26586.867065664548;30387.696123038488;30598.847005765718;30727.846360768053;31065.8446707765;31224;14118.717625647634;14209;14273.21497317616;14460.493882714054;14504.927475362556;15489.30298136609;15670.216489175724;15722.528324150293;15744.448944286894;16015.119168445848;14606.488772892897;14608.415663373771;14610.92694536563;14744.115353078849;14778.408863645334;14098.647533811736;14175.716485670022;14185.503507377192;14198.716025679221;14382.568522944328;13935.163890166623;14003;14007.719845603235;14112.858871411154;14293.499727509487;10177.745556361151;10397.16822654201;10508.264421490423;10600.522976465923;10831.620893268699;10097.091261786474;10539.63111291101;10871.945640271748;12313.938430307791;12335.69160770952 09:09:01 INFO - PID 3510 | __end_tp_report 09:09:01 INFO - PID 3510 | __start_cc_report 09:09:01 INFO - PID 3510 | _x_x_mozilla_cycle_collect,367 09:09:01 INFO - PID 3510 | __end_cc_report 09:09:01 INFO - PID 3510 | __startTimestamp1494518941021__endTimestamp 09:09:01 INFO - PID 3510 | 09:09:01 INFO - PID 3510 | ------- Summary: start ------- 09:09:01 INFO - PID 3510 | Number of tests: 6 09:09:01 INFO - PID 3510 | 09:09:01 INFO - PID 3510 | [#0] dojo.html Cycles:165 Average:5192.29 Median:5372.17 stddev:607.75 (11.3%) stddev-sans-first:578.25 09:09:01 INFO - PID 3510 | Values: 2735.5 2764.8 2782.9 2786.0 2806.3 5170.8 5172.1 5224.8 5232.6 5276.3 5189.5 5199.3 5284.6 5330.7 5334.0 4627.3 4654.9 4656.8 4666.8 4698.4 4695.9 4707.3 4731.5 4734.6 4761.0 4603.0 4632.1 4663.3 4681.2 4702.1 4694.1 4701.6 4710.6 4718.4 4739.8 4672.2 4682.3 4688.4 4694.2 4711.2 5134.8 5172.3 5209.5 5238.3 5269.8 5678.3 5703.9 5714.1 5739.6 5758.1 5720.1 5725.7 5728.6 5731.7 5748.5 5157.7 5223.9 5270.4 5281.3 5286.8 5803.9 5859.3 5897.2 5898.4 5898.4 5542.8 5603.4 5632.4 5658.5 5661.7 5668.3 5692.3 5700.6 5716.5 5735.3 5502.9 5578.1 5653.3 5654.7 5659.4 5552.5 5562.6 5565.7 5572.6 5591.9 4596.2 4630.5 4654.2 4661.5 4673.4 4021.5 4023.3 4033.8 4034.3 4070.4 4866.0 4928.0 4947.4 4955.3 4961.3 5570.6 5622.3 5634.4 5651.3 5698.9 4924.1 4950.5 4951.9 4966.8 4983.5 5026.5 5031.7 5034.3 5040.8 5086.8 5271.2 5272.6 5275.4 5370.6 5389.6 5552.1 5597.2 5648.1 5694.6 5779.1 5345.0 5363.5 5372.2 5376.8 5399.2 5598.7 5630.1 5645.2 5650.1 5655.0 5661.9 5722.8 5735.4 5737.0 5749.3 5464.8 5527.6 5527.8 5528.3 5531.7 5481.2 5535.8 5554.4 5557.7 5578.8 5412.0 5439.3 5450.4 5460.4 5460.6 5488.8 5539.5 5550.2 5555.2 5565.9 5330.2 5382.3 5397.3 5400.3 5408.5 09:09:01 INFO - PID 3510 | 09:09:01 INFO - PID 3510 | [#1] ext.html Cycles:180 Average:31261.97 Median:17154.76 stddev:42608.67 (248.4%) stddev-sans-first:42665.97 09:09:01 INFO - PID 3510 | Values: 594.5 655.4 674.8 1187.1 1196.2 33759.5 34174.0 34181.7 34314.7 34455.0 31793.0 32339.0 32357.5 32387.5 32397.7 6511.2 6900.3 7102.6 7112.4 7118.7 7017.7 7086.6 7120.4 7120.7 7142.0 7073.6 7109.3 7165.5 7178.7 7179.7 7104.5 7121.7 7154.1 7165.7 7172.0 6783.4 6794.7 6821.0 6827.5 6841.6 32253.0 32417.5 32457.0 32490.8 32582.2 3055.6 3057.1 3069.0 3098.8 3106.1 25288.6 25432.0 25454.6 25524.4 25585.0 2876.2 2880.4 2892.6 2916.9 2936.9 146289.3 146754.0 147626.0 150626.0 153864.0 40125.2 40615.8 40667.8 40686.4 40750.6 42275.0 42363.3 42487.8 44051.8 45001.3 12355.9 12385.1 12389.2 12429.2 12473.2 10211.5 10246.7 10252.5 10253.8 10264.7 13249.7 13255.7 13282.0 13292.9 13477.7 5333.3 5335.7 5360.9 5379.7 5516.5 869.4 901.4 917.1 923.6 946.1 21396.8 21459.9 21755.1 21771.7 22057.1 892.5 984.4 994.2 1002.6 1016.5 9992.7 10517.7 10519.7 10641.7 10712.0 180381.0 180979.0 181886.0 182250.0 182672.0 41041.4 41204.8 41412.0 41419.6 41520.6 1170.0 1251.5 1256.4 1261.9 1263.0 18290.3 18638.1 19158.6 19362.3 19396.8 29844.7 36969.8 37958.4 38262.4 38306.8 161668.2 162366.0 163222.2 163339.0 163433.0 30876.4 30902.4 31203.4 31249.5 31260.4 35960.6 36403.0 36744.8 36960.4 37028.4 28268.4 28403.3 28961.9 29083.9 30460.1 28078.6 28235.9 28429.3 28429.9 29932.3 32033.5 32262.0 32299.9 32341.2 32431.8 27504.9 27549.7 28319.4 28679.1 29008.1 22100.6 22823.4 22837.5 23066.5 23068.5 09:09:01 INFO - PID 3510 | 09:09:01 INFO - PID 3510 | [#2] jquery.html Cycles:180 Average:24737.97 Median:346805.50 stddev:58989.12 (17.0%) stddev-sans-first:59126.35 09:09:01 INFO - PID 3510 | Values: 423.4 426.5 427.2 448.2 449.9 17163.8 17309.6 17630.6 17850.8 18103.7 15978.6 16118.6 16518.9 17055.4 17123.2 5546.4 5559.6 5649.7 5661.8 5694.1 5572.2 5630.6 5659.8 5665.1 5669.6 5470.6 5579.1 5598.1 5614.4 5663.2 5534.9 5535.8 5557.7 5580.1 5589.6 4808.9 4865.2 4914.1 4929.7 5031.6 22539.1 22740.5 22931.1 23401.9 23563.5 1605.8 1653.8 1654.4 1660.5 1668.1 15019.8 15020.8 15611.8 15687.6 15842.6 2106.5 2158.0 2186.7 2188.7 2189.2 83683.2 88964.6 90639.0 97966.5 103270.5 10844.5 11207.6 11237.7 11323.5 11549.1 15201.2 15260.2 15358.9 15396.5 15398.4 7580.3 7936.6 8008.3 8108.8 8139.3 7441.1 7551.4 7578.1 7751.8 7807.1 7253.5 7319.8 7379.8 7398.5 7433.1 2024.7 2076.9 2098.9 2105.8 2198.3 845.4 865.5 872.3 874.3 898.2 17725.5 17793.3 18206.2 18428.2 18662.0 873.7 884.9 889.7 892.4 900.4 9793.5 10119.7 10126.1 10155.5 10192.8 345545.0 348066.0 353553.0 358172.0 359889.0 64347.7 77514.0 77678.0 78491.0 79079.0 1011.1 1017.1 1067.9 1068.8 1068.9 17417.7 17704.3 18148.8 19442.4 19454.7 38185.4 38903.2 39923.0 39923.2 40542.4 45696.0 46633.0 48523.3 48875.3 49331.3 8414.9 8510.2 8510.9 8724.4 9143.8 13403.7 13498.1 13508.7 13661.9 13782.6 10256.3 11216.6 11505.1 11576.8 11785.2 10609.9 10612.8 11047.6 11209.6 11231.7 11835.8 11887.0 12023.9 12115.2 12197.5 8347.7 8395.7 8456.8 8508.9 8549.6 11532.3 11578.8 11612.5 11799.8 11975.2 09:09:01 INFO - PID 3510 | 09:09:01 INFO - PID 3510 | [#3] mootools.html Cycles:180 Average:6330.37 Median:3812.62 stddev:4066.22 (106.7%) stddev-sans-first:4059.78 09:09:01 INFO - PID 3510 | Values: 1260.7 1291.3 1317.3 1323.2 1326.6 9717.4 10049.4 10302.9 10321.6 10694.2 10282.1 10514.4 10519.6 10520.4 10522.5 2242.2 2293.1 2300.7 2302.5 2305.7 2222.8 2291.4 2297.3 2302.5 2303.3 2235.4 2251.0 2282.1 2287.8 2289.4 2130.7 2164.2 2173.4 2187.2 2190.3 1917.4 1998.8 2082.9 2212.5 2216.4 10432.1 10472.1 10529.3 10538.6 10567.5 5706.1 5921.5 5925.7 5934.5 5941.9 3435.5 3655.4 3672.9 3733.6 3736.6 1095.2 1111.2 1132.6 1186.4 1192.2 15202.8 15409.5 15451.7 15487.7 15489.1 4630.3 4636.6 4733.5 4743.4 4948.9 10861.4 10945.5 10966.8 10984.5 10984.7 5573.7 5620.4 5630.2 5640.6 5648.7 5163.4 5177.2 5272.7 5289.7 5367.3 3818.8 3925.9 3940.8 3985.8 3991.1 1170.7 1176.8 1195.5 1196.3 1211.0 679.6 696.0 703.5 719.7 722.1 5413.9 5534.7 5548.4 5562.7 5566.6 536.0 546.0 551.6 551.8 559.2 3584.2 3806.5 3835.7 3852.3 3887.4 12229.9 12513.0 12861.2 13028.0 13357.9 12861.9 13300.7 13315.3 13337.1 13498.3 7400.2 7496.6 7560.0 7576.3 7578.7 5601.9 5604.5 5608.6 5690.4 5800.7 11948.3 12081.6 12127.9 12144.4 12203.6 11963.0 12296.9 12413.3 12522.5 12523.1 7813.1 7896.1 7913.1 7916.8 7965.4 9575.2 9585.0 9640.5 9656.4 9694.5 8139.0 8407.8 8489.6 8502.9 8622.7 8065.4 8068.2 8122.1 8259.5 8345.0 7225.1 7342.8 7364.4 7372.0 7375.0 4977.9 5064.8 5075.3 5091.6 5371.7 5539.8 5589.3 5693.0 5740.8 5821.9 09:09:01 INFO - PID 3510 | 09:09:01 INFO - PID 3510 | [#4] prototype.html Cycles:180 Average:4816.30 Median:5472.41 stddev:1411.02 (25.8%) stddev-sans-first:1375.49 09:09:01 INFO - PID 3510 | Values: 399.9 400.3 400.5 402.0 409.2 5573.8 5595.7 5601.4 5610.4 5613.8 5377.8 5425.5 5466.1 5475.5 5496.2 4269.0 4283.6 4290.2 4294.4 4319.4 4299.8 4301.9 4308.2 4311.7 4331.2 4189.0 4261.4 4264.5 4282.5 4283.1 4261.3 4269.4 4269.6 4277.8 4291.2 3844.3 3870.0 3882.4 3888.8 3890.8 5262.8 5356.4 5370.9 5392.7 5403.9 5053.3 5061.2 5062.9 5063.1 5076.1 5755.7 5793.5 5799.5 5800.4 5801.3 3861.8 3989.3 4020.8 4028.4 4343.0 5944.7 6078.4 6098.3 6153.7 6160.1 4052.6 4094.9 4100.6 4118.6 4123.3 4173.0 4173.8 4182.4 4185.7 4191.2 4724.5 4771.4 4794.9 4802.7 4819.0 5697.4 5708.9 5710.7 5723.6 5738.1 1429.9 1447.2 1449.7 1451.3 1453.1 924.8 963.9 975.5 976.8 977.5 5079.2 5089.7 5106.4 5116.3 5137.5 6047.3 6049.7 6060.6 6067.7 6067.9 4949.5 5070.8 5083.7 5112.4 5140.4 3171.4 3180.0 3190.8 3195.8 3214.1 5456.2 5577.8 5611.7 5634.9 5665.9 6105.5 6161.3 6187.5 6195.7 6198.6 5615.7 5639.6 5645.1 5648.6 5661.9 5768.3 5989.4 6032.3 6058.2 6066.2 5871.3 5900.6 5904.5 5911.0 5913.1 5463.7 5582.8 5632.9 5635.4 5653.4 4120.0 4136.5 4138.5 4143.4 4154.3 5908.0 6002.7 6055.4 6063.6 6076.9 5778.3 5787.8 5819.3 5841.5 5857.4 5836.5 5846.5 5853.4 5864.2 5869.3 5681.6 5701.7 5752.3 5758.6 5767.6 5856.9 5870.5 5876.4 5878.2 5887.5 5469.3 5678.8 5702.1 5708.7 5716.2 09:09:01 INFO - PID 3510 | 09:09:01 INFO - PID 3510 | [#5] yui.html Cycles:180 Average:15255.27 Median:3050.70 stddev:17950.22 (588.4%) stddev-sans-first:17967.47 09:09:01 INFO - PID 3510 | Values: 739.3 749.1 761.1 767.4 771.3 12580.7 13044.3 13169.7 13385.8 13861.9 15283.0 15652.6 15676.7 15699.5 16091.8 854.2 867.6 870.7 871.5 872.2 916.6 917.6 921.9 922.9 924.9 970.2 972.6 973.2 973.2 975.5 962.0 969.1 969.5 971.0 971.0 699.4 703.7 706.4 708.9 710.0 15154.7 15358.4 15596.9 15655.2 15738.0 15991.7 16076.4 16276.6 16513.0 16537.2 11396.5 11653.7 11734.4 11780.2 11837.2 2902.1 2904.5 2905.7 2909.5 2948.0 68644.7 68996.7 69221.0 69526.3 71451.3 11896.9 12122.8 12183.3 12240.2 12252.9 21793.2 21820.0 22103.1 22290.4 22361.4 6004.9 6278.2 6418.3 6526.3 6537.8 2975.3 3046.6 3049.2 3052.2 3058.8 3591.3 3667.0 3679.2 4194.3 4333.7 799.4 828.1 834.4 837.4 840.2 590.4 597.7 612.1 612.2 628.6 9809.2 9855.1 10033.7 10410.4 10495.2 568.6 577.7 581.4 591.8 603.3 4347.2 4397.3 4457.8 4476.1 4504.3 64783.7 64808.4 64818.7 64984.0 65914.0 59027.4 59524.0 59585.4 59868.4 60174.4 45351.0 46060.0 48984.0 49741.3 51683.0 9887.3 10477.8 10611.4 10816.3 10876.2 25052.7 25616.5 26072.2 26529.9 26586.9 30387.7 30598.8 30727.8 31065.8 31224.0 14118.7 14209.0 14273.2 14460.5 14504.9 15489.3 15670.2 15722.5 15744.4 16015.1 14606.5 14608.4 14610.9 14744.1 14778.4 14098.6 14175.7 14185.5 14198.7 14382.6 13935.2 14003.0 14007.7 14112.9 14293.5 10177.7 10397.2 10508.3 10600.5 10831.6 10097.1 10539.6 10871.9 12313.9 12335.7 09:09:01 INFO - PID 3510 | -------- Summary: end -------- 09:09:01 INFO - PID 3510 | 09:09:01 INFO - TEST-INFO | 3510: exit 0 09:09:01 INFO - TEST-OK | dromaeo_css | took 1119282ms 09:09:01 INFO - TEST-START | kraken 09:09:01 INFO - operating with platform_type : linux_ 09:09:01 INFO - Initialising browser for kraken test... 09:09:01 INFO - TEST-INFO | started process 3924 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMka1UK/profile http://localhost:46288/getInfo.html) 09:09:05 INFO - PID 3924 | __metrics Screen width/height:1600/1200 09:09:05 INFO - PID 3924 | colorDepth:24 09:09:05 INFO - PID 3924 | Browser inner width/height: 1024/695 09:09:05 INFO - PID 3924 | __metrics 09:09:07 INFO - TEST-INFO | 3924: exit 0 09:09:07 INFO - Browser initialized. 09:09:07 INFO - Running cycle 1/1 for kraken test... 09:09:07 INFO - TEST-INFO | started process 4095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMka1UK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:09:19 INFO - PID 4095 | RSS: Main: 155398144 09:09:19 INFO - PID 4095 | 09:09:22 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46288/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46288/tests/kraken/driver.html?testName=audio-beat-detection) 09:09:23 INFO - PID 4095 | RSS: Main: 162185216 09:09:23 INFO - PID 4095 | 09:09:25 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46288/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46288/tests/kraken/driver.html?testName=audio-dft) 09:09:26 INFO - PID 4095 | RSS: Main: 160620544 09:09:26 INFO - PID 4095 | 09:09:29 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46288/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46288/tests/kraken/driver.html?testName=audio-fft) 09:09:29 INFO - PID 4095 | RSS: Main: 156917760 09:09:29 INFO - PID 4095 | 09:09:31 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46288/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46288/tests/kraken/driver.html?testName=audio-oscillator) 09:09:32 INFO - PID 4095 | RSS: Main: 157503488 09:09:32 INFO - PID 4095 | 09:09:34 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46288/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46288/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:09:35 INFO - PID 4095 | RSS: Main: 158134272 09:09:35 INFO - PID 4095 | 09:09:38 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46288/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46288/tests/kraken/driver.html?testName=imaging-darkroom) 09:09:39 INFO - PID 4095 | RSS: Main: 162689024 09:09:39 INFO - PID 4095 | 09:09:42 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46288/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46288/tests/kraken/driver.html?testName=imaging-desaturate) 09:09:43 INFO - PID 4095 | RSS: Main: 161329152 09:09:43 INFO - PID 4095 | 09:09:46 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46288/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46288/tests/kraken/driver.html?testName=json-parse-financial) 09:09:46 INFO - PID 4095 | RSS: Main: 162447360 09:09:46 INFO - PID 4095 | 09:09:48 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46288/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46288/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:09:48 INFO - PID 4095 | RSS: Main: 162574336 09:09:48 INFO - PID 4095 | 09:09:50 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46288/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46288/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:09:51 INFO - PID 4095 | RSS: Main: 162705408 09:09:51 INFO - PID 4095 | 09:09:53 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46288/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46288/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:09:54 INFO - PID 4095 | RSS: Main: 162758656 09:09:54 INFO - PID 4095 | 09:09:56 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46288/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:09:57 INFO - PID 4095 | RSS: Main: 162762752 09:09:57 INFO - PID 4095 | 09:10:00 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:10:01 INFO - PID 4095 | RSS: Main: 162803712 09:10:01 INFO - PID 4095 | 09:10:03 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46288/tests/kraken/driver.html?testName=ai-astar) 09:10:03 INFO - PID 4095 | RSS: Main: 164519936 09:10:03 INFO - PID 4095 | 09:10:03 INFO - PID 4095 | __start_tp_report 09:10:03 INFO - PID 4095 | _x_x_mozilla_page_load 09:10:03 INFO - PID 4095 | _x_x_mozilla_page_load_details 09:10:03 INFO - PID 4095 | |i|pagename|runs| 09:10:03 INFO - PID 4095 | |0;ai-astar;104;113;114;113;113;115;113;111;113;114 09:10:03 INFO - PID 4095 | |1;audio-beat-detection;155;125;123;186;124;123;125;124;145;125 09:10:03 INFO - PID 4095 | |2;audio-dft;164;164;165;162;163;166;167;166;165;163 09:10:03 INFO - PID 4095 | |3;audio-fft;74;78;75;112;76;76;74;77;101;75 09:10:03 INFO - PID 4095 | |4;audio-oscillator;83;85;102;84;83;84;101;82;83;104 09:10:03 INFO - PID 4095 | |5;imaging-gaussian-blur;115;115;114;114;114;113;113;114;119;114 09:10:03 INFO - PID 4095 | |6;imaging-darkroom;151;150;152;151;150;150;151;151;149;151 09:10:03 INFO - PID 4095 | |7;imaging-desaturate;94;95;94;96;94;95;94;95;94;94 09:10:03 INFO - PID 4095 | |8;json-parse-financial;55;53;52;53;54;54;55;57;54;54 09:10:03 INFO - PID 4095 | |9;json-stringify-tinderbox;57;56;56;56;56;55;55;56;55;56 09:10:03 INFO - PID 4095 | |10;stanford-crypto-aes;82;83;82;83;83;82;81;83;82;81 09:10:03 INFO - PID 4095 | |11;stanford-crypto-ccm;131;147;136;140;131;140;135;131;179;135 09:10:03 INFO - PID 4095 | |12;stanford-crypto-pbkdf2;184;191;194;192;191;193;189;186;190;187 09:10:03 INFO - PID 4095 | |13;stanford-crypto-sha256-iterative;73;76;74;71;73;76;71;75;72;73 09:10:03 INFO - PID 4095 | __end_tp_report 09:10:03 INFO - PID 4095 | __start_cc_report 09:10:03 INFO - PID 4095 | _x_x_mozilla_cycle_collect,826 09:10:03 INFO - PID 4095 | __end_cc_report 09:10:03 INFO - PID 4095 | __startTimestamp1494519003496__endTimestamp 09:10:03 INFO - PID 4095 | 09:10:03 INFO - PID 4095 | ------- Summary: start ------- 09:10:03 INFO - PID 4095 | Number of tests: 14 09:10:03 INFO - PID 4095 | 09:10:03 INFO - PID 4095 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:3.09 (2.7%) stddev-sans-first:1.09 09:10:03 INFO - PID 4095 | Values: 104.0 113.0 114.0 113.0 113.0 115.0 113.0 111.0 113.0 114.0 09:10:03 INFO - PID 4095 | 09:10:03 INFO - PID 4095 | [#1] audio-beat-detection Cycles:10 Average:135.50 Median:125.00 stddev:20.89 (16.7%) stddev-sans-first:20.93 09:10:03 INFO - PID 4095 | Values: 155.0 125.0 123.0 186.0 124.0 123.0 125.0 124.0 145.0 125.0 09:10:03 INFO - PID 4095 | 09:10:03 INFO - PID 4095 | [#2] audio-dft Cycles:10 Average:164.50 Median:165.00 stddev:1.58 (1.0%) stddev-sans-first:1.67 09:10:03 INFO - PID 4095 | Values: 164.0 164.0 165.0 162.0 163.0 166.0 167.0 166.0 165.0 163.0 09:10:03 INFO - PID 4095 | 09:10:03 INFO - PID 4095 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.50 stddev:13.33 (17.7%) stddev-sans-first:13.84 09:10:03 INFO - PID 4095 | Values: 74.0 78.0 75.0 112.0 76.0 76.0 74.0 77.0 101.0 75.0 09:10:03 INFO - PID 4095 | 09:10:03 INFO - PID 4095 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:83.00 stddev:9.19 (11.1%) stddev-sans-first:9.48 09:10:03 INFO - PID 4095 | Values: 83.0 85.0 102.0 84.0 83.0 84.0 101.0 82.0 83.0 104.0 09:10:03 INFO - PID 4095 | 09:10:03 INFO - PID 4095 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.00 stddev:1.72 (1.5%) stddev-sans-first:1.81 09:10:03 INFO - PID 4095 | Values: 115.0 115.0 114.0 114.0 114.0 113.0 113.0 114.0 119.0 114.0 09:10:03 INFO - PID 4095 | 09:10:03 INFO - PID 4095 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 09:10:03 INFO - PID 4095 | Values: 151.0 150.0 152.0 151.0 150.0 150.0 151.0 151.0 149.0 151.0 09:10:03 INFO - PID 4095 | 09:10:03 INFO - PID 4095 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 09:10:03 INFO - PID 4095 | Values: 94.0 95.0 94.0 96.0 94.0 95.0 94.0 95.0 94.0 94.0 09:10:03 INFO - PID 4095 | 09:10:03 INFO - PID 4095 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:1.37 (2.5%) stddev-sans-first:1.41 09:10:03 INFO - PID 4095 | Values: 55.0 53.0 52.0 53.0 54.0 54.0 55.0 57.0 54.0 54.0 09:10:03 INFO - PID 4095 | 09:10:03 INFO - PID 4095 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:56.00 stddev:0.63 (1.1%) stddev-sans-first:0.50 09:10:03 INFO - PID 4095 | Values: 57.0 56.0 56.0 56.0 56.0 55.0 55.0 56.0 55.0 56.0 09:10:03 INFO - PID 4095 | 09:10:03 INFO - PID 4095 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.50 stddev:0.79 (1.0%) stddev-sans-first:0.83 09:10:03 INFO - PID 4095 | Values: 82.0 83.0 82.0 83.0 83.0 82.0 81.0 83.0 82.0 81.0 09:10:03 INFO - PID 4095 | 09:10:03 INFO - PID 4095 | [#11] stanford-crypto-ccm Cycles:10 Average:140.50 Median:138.00 stddev:14.44 (10.5%) stddev-sans-first:14.90 09:10:03 INFO - PID 4095 | Values: 131.0 147.0 136.0 140.0 131.0 140.0 135.0 131.0 179.0 135.0 09:10:03 INFO - PID 4095 | 09:10:03 INFO - PID 4095 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.70 Median:191.00 stddev:3.20 (1.7%) stddev-sans-first:2.65 09:10:03 INFO - PID 4095 | Values: 184.0 191.0 194.0 192.0 191.0 193.0 189.0 186.0 190.0 187.0 09:10:03 INFO - PID 4095 | 09:10:03 INFO - PID 4095 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:73.50 stddev:1.84 (2.5%) stddev-sans-first:1.94 09:10:03 INFO - PID 4095 | Values: 73.0 76.0 74.0 71.0 73.0 76.0 71.0 75.0 72.0 73.0 09:10:03 INFO - PID 4095 | -------- Summary: end -------- 09:10:03 INFO - PID 4095 | 09:10:04 INFO - TEST-INFO | 4095: exit 0 09:10:04 INFO - TEST-OK | kraken | took 62781ms 09:10:04 INFO - SUITE-END | took 1182s 09:10:05 INFO - Completed test suite (00:19:42) 09:10:05 INFO - javascript benchmark 09:10:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6796.838570422485, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2735.466584016118, 2764.8479333636647, 2782.874770635321, 2786.0109661070305, 2806.340509980155, 5170.844874653757, 5172.09488339541, 5224.764885580148, 5232.6075544334135, 5276.314079169707, 5189.455107213745, 5199.324087868572, 5284.577233821295, 5330.733463326837, 5333.973330133344, 4627.259638457831, 4654.883627909296, 4656.837010704626, 4666.76666166692, 4698.436187657486, 4695.929561056587, 4707.317438971347, 4731.503192164842, 4734.597559207472, 4761.047790441909, 4602.976985115087, 4632.119897219518, 4663.347131401607, 4681.204195286809, 4702.059588082398, 4694.108119457326, 4701.553352431513, 4710.552497512731, 4718.386609740746, 4739.834105806281, 4672.229082201433, 4682.3210634458155, 4688.367070445514, 4694.201985662411, 4711.151992641323, 5134.768935397916, 5172.301739265189, 5209.453007434203, 5238.319018527567, 5269.789208431658, 5678.3186017678145, 5703.857403564903, 5714.057180565202, 5739.62692424991, 5758.136279558058, 5720.11338242573, 5725.685087320196, 5728.570357223183, 5731.742071606787, 5748.511376533, 5157.6647517911215, 5223.869403264949, 5270.367555893279, 5281.287026251483, 5286.788528458896, 5803.88392232153, 5859.296884373903, 5897.233359663216, 5898.380670029671, 5898.439648233411, 5542.7782888684005, 5603.3836278009385, 5632.408597097327, 5658.490735833795, 5661.688607126565, 5668.322499079178, 5692.345380281238, 5700.572457065737, 5716.542676585863, 5735.311762588516, 5502.9174562381595, 5578.079616863253, 5653.321601407857, 5654.74553645087, 5659.377468478464, 5552.500274975191, 5562.582806289463, 5565.749541270652, 5572.58205634579, 5591.888162236733, 4596.218642830727, 4630.490646028934, 4654.16225079489, 4661.510541393172, 4673.392458980311, 4021.477207962946, 4023.2556976959354, 4033.838646454109, 4034.253663072341, 4070.3894415837863, 4865.95134048662, 4928.0390323886495, 4947.356843610308, 4955.256711493233, 4961.280614310905, 5570.58220633446, 5622.32532096151, 5634.436556344414, 5651.321841379061, 5698.943010569924, 4924.113659541317, 4950.504949505021, 4951.851444456672, 4966.801327946841, 4983.50164983506, 5026.547610715053, 5031.6729412588065, 5034.295198672189, 5040.798368065236, 5086.796528138833, 5271.182966640177, 5272.55183309423, 5275.419703832652, 5370.570354371563, 5389.568834493152, 5552.056150454513, 5597.188407680945, 5648.096304591246, 5694.601377903507, 5779.075347944308, 5344.984452953926, 5363.490468405495, 5372.167314066326, 5376.8118115865755, 5399.244105825266, 5598.692071936082, 5630.071038278638, 5645.237892884408, 5650.0959846424375, 5654.971725141348, 5661.943380566142, 5722.828315150552, 5735.3977832327, 5736.971315143398, 5749.281339832521, 5464.781408743605, 5527.640703354269, 5527.834164975057, 5528.308961379827, 5531.7234138292115, 5481.232627432083, 5535.833924982257, 5554.361248456479, 5557.749901254372, 5578.804741834017, 5412.025835349517, 5439.347278326626, 5450.427705091067, 5460.3993560707495, 5460.563154947674, 5488.7530061148145, 5539.473749993744, 5550.167474878801, 5555.22226888244, 5565.888682226414, 5330.227117068081, 5382.273393091882, 5397.27136836522, 5400.297961265011, 5408.513233808976], "value": 5148.477081729045, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.4738906068128, 655.3806652713187, 674.7874419557841, 1187.0503597122306, 1196.1507329795845, 33759.493607595876, 34174.0, 34181.658183418156, 34314.65685343146, 34455.0, 31793.0, 32339.0, 32357.51463728046, 32387.51418728721, 32397.67602323976, 6511.1535500385, 6900.27547107554, 7102.609356485391, 7112.395446387038, 7118.715251389938, 7017.719291228344, 7086.610236436994, 7120.394766444859, 7120.715171393138, 7142.035825163614, 7073.646317684121, 7109.253528379523, 7165.498415110945, 7178.676959536833, 7179.743544879625, 7104.538205016657, 7121.715131394738, 7154.105736782903, 7165.6775445105095, 7172.031775710265, 6783.42340901024, 6794.728210871559, 6821.0, 6827.52207345486, 6841.62371069591, 32253.0, 32417.51373729396, 32457.0, 32490.837545812356, 32582.185445364055, 3055.5874956880757, 3057.1287183152917, 3069.0, 3098.8295643739584, 3106.1458099022725, 25288.620670689954, 25432.0, 25454.618180727302, 25524.36189095269, 25585.0, 2876.2090425133047, 2880.4095160492047, 2892.5950366948646, 2916.854157292148, 2936.8825246990095, 146289.26855365656, 146754.0, 147626.0, 150626.0, 153864.0, 40125.197496049914, 40615.7969210158, 40667.7966610165, 40686.355386899755, 40750.59249407468, 42275.0, 42363.30546778094, 42487.787561061996, 44051.77974110109, 45001.324980125326, 12355.876441235652, 12385.133040687066, 12389.194702344319, 12429.192102513307, 12473.189242699196, 10211.540480678388, 10246.743831404274, 10252.487375631188, 10253.794924101476, 10264.743381415376, 13249.73500529984, 13255.668608284677, 13282.0, 13292.867071329163, 13477.663058423617, 5333.280007199056, 5335.67985920846, 5360.8659783504945, 5379.704116273642, 5516.531094856982, 869.3566760597239, 901.4411065139524, 917.0737555069428, 923.6213152607398, 946.0917519181663, 21396.78603213979, 21459.89270053671, 21755.129794808032, 21771.67342489864, 22057.11771529153, 892.5492626223845, 984.3650845204803, 994.1500017485091, 1002.6364144763116, 1016.466355163545, 9992.700218993441, 10517.737871455474, 10519.684409467574, 10641.680749577525, 10712.035916767529, 180381.0, 180979.0, 181886.0, 182250.0, 182672.0, 41041.38437923433, 41204.79397602993, 41412.0, 41419.585804142174, 41520.58479415227, 1169.9532018719326, 1251.5306759965013, 1256.4408838067154, 1261.8738126187309, 1262.9747405051849, 18290.268389264813, 18638.068096594845, 19158.61682766309, 19362.322318718776, 19396.8060319395, 29844.70155298506, 36969.81515092407, 37958.430623540116, 38262.42606360851, 38306.80846595749, 161668.19165904095, 162366.0, 163222.18388907978, 163339.0, 163433.0, 30876.38247234998, 30902.381952361276, 31203.37593248077, 31249.531257031616, 31260.374792504477, 35960.56157753765, 36403.0, 36744.813796550865, 36960.44559331666, 37028.44457333088, 28268.43463130767, 28403.289917752223, 28961.855190723913, 29083.854580726962, 30460.08619741411, 28078.57882131729, 28235.858820705766, 28429.289267768472, 28429.857850710614, 29932.251693707833, 32033.519497208028, 32262.0, 32299.86950456723, 32341.191470212492, 32431.83784081159, 27504.862475687492, 27549.72450275552, 28319.43361132807, 28679.139625811258, 29008.06001117199, 22100.557988840454, 22823.429414264778, 22837.543249134593, 23066.540018997286, 23068.538629227656], "value": 14749.239292693752, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.36629984698186, 426.4754352146857, 427.2395136656752, 448.21562266034437, 449.87853279614507, 17163.798534102632, 17309.56726081847, 17630.64738705225, 17850.82149178508, 18103.728444073335, 15978.600534986632, 16118.597035074128, 16518.917405412954, 17055.40306089287, 17123.22945467454, 5546.417626149257, 5559.58303127265, 5649.717514124277, 5661.8393229387875, 5694.064018233799, 5572.192032155335, 5630.577706671996, 5659.773609055654, 5665.093585026397, 5669.603127781057, 5470.56235501161, 5579.13523403871, 5598.1322894951345, 5614.438556144394, 5663.235463212475, 5534.889302213954, 5535.778568857261, 5557.749901254453, 5580.079286917633, 5589.580781441408, 4808.879778005543, 4865.221564549655, 4914.0908931847725, 4929.679570827885, 5031.597472202215, 22539.06992091034, 22740.545189096127, 22931.082756689713, 23401.88299058511, 23563.528729425314, 1605.783219265396, 1653.7602047703135, 1654.4126834973652, 1660.4520508232254, 1668.1325710630526, 15019.849801502063, 15020.849791502163, 15611.843881561153, 15687.607809804733, 15842.60393490172, 2106.452322396188, 2157.9892100539396, 2186.650135978236, 2188.6607575825774, 2189.2228258968, 83683.23425445809, 88964.5551772237, 90639.0, 97966.51016744942, 103270.48364758279, 10844.457777111113, 11207.607733729443, 11237.662870113909, 11323.490442930088, 11549.133814963743, 15201.239938003055, 15260.236988150547, 15358.923205383902, 15396.538103856903, 15398.384064637514, 7580.279873412017, 7936.642851071716, 8008.270901420518, 8108.75673729789, 8139.30815880645, 7441.144268409094, 7551.433642476836, 7578.09062912454, 7751.844963100706, 7807.063152421632, 7253.492255542062, 7319.817004574928, 7379.778606641809, 7398.519096258726, 7433.145188303414, 2024.7165396844453, 2076.8650037747498, 2098.853080284396, 2105.842061845368, 2198.3404978506705, 845.4208866926052, 865.485036403339, 872.2847265242567, 874.2874557235832, 898.1691934960136, 17725.468235952943, 17793.288268469376, 18206.18072186755, 18428.17073231681, 18662.0, 873.7204094689765, 884.9469031858109, 889.7241855024963, 892.4110087342323, 900.3787386703154, 9793.510324483746, 10119.696409107739, 10126.139278161292, 10155.492225388702, 10192.796144077078, 345545.0, 348066.0, 353553.0, 358172.0, 359889.0, 64347.678261608395, 77514.0, 77678.0, 78491.0, 79079.0, 1011.1253765492943, 1017.1049476460668, 1067.8771941226858, 1068.8396740488834, 1068.8610480637467, 17417.738733918748, 17704.29182832672, 18148.818511814712, 19442.4167274982, 19454.708179377038, 38185.42721859119, 38903.22193556056, 39923.0, 39923.201535969696, 40542.39186412265, 45696.0, 46633.0, 48523.27215091847, 48875.26687099625, 49331.26003109884, 8414.915850841413, 8510.234458507746, 8510.914890851012, 8724.389292749447, 9143.817123657622, 13403.664908377368, 13498.122622029538, 13508.729825403634, 13661.931690341484, 13782.586522404345, 10256.333338332985, 11216.55133794639, 11505.076647421793, 11576.826347604625, 11785.175037747274, 10609.89390106089, 10612.787744244917, 11047.558097676003, 11209.55161793519, 11231.71920701989, 11835.82246266324, 11887.0, 12023.939880300542, 12115.212511186744, 12197.51209951592, 8347.749567512985, 8395.664173432995, 8456.788580285542, 8508.872366914378, 8549.572521373782, 11532.308061516336, 11578.826317605075, 11612.477438515118, 11799.823002654795, 11975.161738678209], "value": 9052.43510230358, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1260.7415479826636, 1291.289790615162, 1317.3215793866161, 1323.2193006126383, 1326.6484381638863, 9717.416954982697, 10049.397036177834, 10302.896971030277, 10321.638742644009, 10694.197935154856, 10282.074613284803, 10514.369137851716, 10519.579216831318, 10520.368777873315, 10522.526486308116, 2242.1816037146405, 2293.094227780026, 2300.7469178390365, 2302.527981763743, 2305.688732021181, 2222.7777222277805, 2291.3927809130596, 2297.3452566018686, 2302.5279817637343, 2303.2974942642486, 2235.4299653588314, 2250.966235506469, 2282.1213832674457, 2287.828412869033, 2289.416198869286, 2130.733658292698, 2164.2100633268824, 2173.413178441812, 2187.2344679362254, 2190.266260802633, 1917.3960202536157, 1998.810113039259, 2082.854200205986, 2212.4911270407897, 2216.4126506475795, 10432.061114499731, 10472.109870661003, 10529.262951593391, 10538.631147909862, 10567.524461399256, 5706.087026075849, 5921.467067963861, 5925.703714814285, 5934.525237980951, 5941.910871336933, 3435.4846772984, 3655.4151335786414, 3672.926541469156, 3733.5706393764794, 3736.6076561960876, 1095.2333366643381, 1111.2388014210292, 1132.637555982086, 1186.353437376623, 1192.2071822238202, 15202.771958420633, 15409.537713868602, 15451.690966180613, 15487.690246195012, 15489.14809685478, 4630.282306242538, 4636.605888499448, 4733.455652599926, 4743.430788305425, 4948.896718894455, 10861.40262285582, 10945.45272736376, 10966.780664386668, 10984.505697243643, 10984.725381865357, 5573.693446860461, 5620.409856965041, 5630.211770352154, 5640.633358831663, 5648.661080335193, 5163.4062082860955, 5177.249298851721, 5272.7100009499845, 5289.735513224324, 5367.302250707383, 3818.770873747584, 3925.862594809225, 3940.763554186758, 3985.80070996449, 3991.0621004064024, 1170.6839153428527, 1176.7822952753768, 1195.5158160944832, 1196.3061424373843, 1211.0372254058045, 679.6262055869253, 695.9826004349932, 703.4723957032226, 719.7372958869975, 722.1298335505703, 5413.864653383697, 5534.695591742493, 5548.389677135512, 5562.666240025612, 5566.55467562594, 535.9946400535945, 546.0117187889932, 551.6386766667839, 551.8344496650989, 559.2478116932718, 3584.193556449778, 3806.467094606757, 3835.712321575893, 3852.3065848147603, 3887.358585833306, 12229.938850305869, 12513.0, 12861.228326300452, 13028.0, 13357.933210333886, 12861.871381286068, 13300.733985320432, 13315.334233288297, 13337.066405351727, 13498.257595832127, 7400.185979542246, 7496.6251687415415, 7560.0, 7576.3181313682035, 7578.696852125963, 5601.915971260516, 5604.467575580314, 5608.6073974821375, 5690.402507736793, 5800.651960882361, 11948.342841143472, 12081.637550873487, 12127.87762141604, 12144.392780361124, 12203.633890983285, 11963.0, 12296.938515307365, 12413.255204687386, 12522.499100035897, 12523.06077044207, 7813.10149332834, 7896.09194942589, 7913.050433947963, 7916.84166316682, 7965.442419030613, 9575.186109180797, 9584.952075239578, 9640.469774162488, 9656.37233579815, 9694.5152742364, 8138.959305203436, 8407.831843363221, 8489.575521224038, 8502.914970850212, 8622.655093796178, 8065.354771618139, 8068.152843951535, 8122.106568277367, 8259.545724985184, 8344.958275208584, 7225.096862892138, 7342.8251479762985, 7364.41084713211, 7371.963140184264, 7375.0, 4977.875553111201, 5064.797408103782, 5075.289459475603, 5091.567216786615, 5371.650842695212, 5539.7784088636, 5589.273394458694, 5693.007447393379, 5740.827775166752, 5821.883562328814], "value": 4737.842096557984, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.8660448749668, 400.299475917145, 400.4953758264586, 401.9879403617892, 409.1877622918508, 5573.804916827912, 5595.685014021702, 5601.383847776741, 5610.382857885629, 5613.775448982046, 5377.838664840051, 5425.538829199513, 5466.114190604245, 5475.5072043516075, 5496.203050557667, 4268.9573104268875, 4283.614474697277, 4290.155233249701, 4294.398784170218, 4319.438472998506, 4299.849505267316, 4301.935470967938, 4308.246056940038, 4311.741295522263, 4331.177076355498, 4188.979055104735, 4261.424707664472, 4264.466941632296, 4282.464691913511, 4283.143371325732, 4261.254280500931, 4269.380939763748, 4269.594388533069, 4277.786110694468, 4291.184674911757, 3844.3464611016193, 3870.0, 3882.3594106972314, 3888.844446222148, 3890.8443662253476, 5262.842114736564, 5356.4375740547075, 5370.865728356784, 5392.676439413648, 5403.865473138088, 5053.317802096707, 5061.215511595708, 5062.873428164288, 5063.139266324733, 5076.13705670037, 5755.712214389306, 5793.507551858097, 5799.536037117021, 5800.361960184418, 5801.271963349856, 3861.8455261789495, 3989.3218152914073, 4020.778857162855, 4028.436018957319, 4342.978285108554, 5944.702764861783, 6078.361772013919, 6098.298695650013, 6153.661548614825, 6160.106784516265, 4052.63526282636, 4094.877153685394, 4100.569440208795, 4118.629323360912, 4123.340265557556, 4172.99848036469, 4173.770442625685, 4182.372644103348, 4185.748855068645, 4191.203671302443, 4724.527547245248, 4771.427428708577, 4794.9280760788615, 4802.73584952831, 4819.0, 5697.4302569742695, 5708.885822283614, 5710.65736055838, 5723.6279641823985, 5738.139279108167, 1429.9356528956014, 1447.2474313356995, 1449.681070164562, 1451.267110109388, 1453.1063396011377, 924.7595625137512, 963.9132478077007, 975.4634950777045, 976.8339382305026, 977.5307852230827, 5079.2381142828135, 5089.666268594076, 5106.387233532, 5116.337190413131, 5137.486251374833, 6047.304559975659, 6049.727762250709, 6060.606060606046, 6067.666278354644, 6067.939320606737, 4949.505049495022, 5070.797168113308, 5083.7203953782155, 5112.4120726116225, 5140.357455318085, 3171.3657268546385, 3179.984100079485, 3190.7606929479916, 3195.792273502215, 3214.11611806755, 5456.236126942231, 5577.776888924479, 5611.7474713637985, 5634.85912852182, 5665.943340566541, 6105.511559075263, 6161.322254551996, 6187.504999600022, 6195.659238741912, 6198.6280823150755, 5615.6630602164005, 5639.577031722637, 5645.125005624135, 5648.604597678123, 5661.858453538612, 5768.278965129359, 5989.371116032754, 6032.336442991355, 6058.242719660043, 6066.211392518944, 5871.324797648325, 5900.64596124234, 5904.5238690327415, 5911.0, 5913.142594323885, 5463.726813659222, 5582.7766889323975, 5632.85917852057, 5635.436456354331, 5653.378128405954, 4120.0, 4136.524299705572, 4138.482689663792, 4143.440635514167, 4154.273002224659, 5907.995640740998, 6002.699865006645, 6055.394460553909, 6063.636181829104, 6076.90884636722, 5778.335491418541, 5787.826365209051, 5819.301683797971, 5841.50347220491, 5857.4435428634215, 5836.474717275466, 5846.473817356458, 5853.443922827325, 5864.237649105589, 5869.266341707286, 5681.630694004876, 5701.714914254354, 5752.28096487939, 5758.62568933018, 5767.567432442667, 5856.853578660568, 5870.5010074142465, 5876.44173803488, 5878.209963186344, 5887.5289976802605, 5469.304515600176, 5678.785273743161, 5702.116171993348, 5708.686022268815, 5716.228309178207], "value": 4382.016801519433, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.3382922284555, 749.1497150733916, 761.0980987529778, 767.3630886364318, 771.2827070824133, 12580.685482862933, 13044.28256445895, 13169.670758231048, 13385.79921301179, 13861.861381386196, 15283.0, 15652.608684782886, 15676.686466270668, 15699.529014129566, 16091.758623620626, 854.1629203380691, 867.5748883047324, 870.7300736771621, 871.5293741379647, 872.1932212703256, 916.5783739479814, 917.5824999625188, 921.9308551858637, 922.8523436250201, 924.856647219682, 970.1801977329145, 972.5526257921365, 973.1825266775907, 973.1873885305778, 975.5414954971152, 961.956711947964, 969.0842154164318, 969.5394687523406, 970.9902900971041, 970.9951450242775, 699.4369532526314, 703.6868593475905, 706.427793487277, 708.9397401220903, 710.0272626501674, 15154.696906061927, 15358.385664573403, 15596.92201538985, 15655.217239137997, 15738.0, 15991.680166396607, 16076.356945722275, 16276.593085172966, 16513.0, 16537.173141343006, 11396.544138234462, 11653.6503904883, 11734.354610496419, 11780.234284771548, 11837.230580012272, 2902.085842959461, 2904.4626744052416, 2905.6513218413716, 2909.461749576314, 2948.027151040173, 68644.65677671629, 68996.6550167251, 69221.0, 69526.30473695249, 71451.2854871455, 11896.940515297541, 12122.818157727641, 12183.269003859798, 12240.204386714835, 12252.938735306267, 21793.237236696958, 21820.0, 22103.137309792142, 22290.442738931655, 22361.44096397603, 6004.939950600526, 6278.15244941927, 6418.326075762071, 6526.28210896801, 6537.803865884031, 2975.3305506260917, 3046.6191726034244, 3049.2224482756756, 3052.1759125036115, 3058.801177923428, 3591.2637909228547, 3667.0, 3679.2457546202963, 4194.328907374806, 4333.653307735373, 799.4244144216156, 828.0725587342095, 834.4242472693821, 837.3845223760532, 840.1934143222575, 590.4176806159534, 597.6892016151577, 612.1063247658379, 612.1735656863289, 628.5976974736172, 9809.166220871162, 9855.113039826307, 10033.685515228522, 10410.427426491615, 10495.21285903545, 568.6076607141059, 577.6765011593521, 581.44472029212, 591.7544219149005, 603.2820943077724, 4347.152305300499, 4397.252467080604, 4457.821687132543, 4476.082403107355, 4504.2793153095345, 64783.67608162023, 64808.351916480235, 64818.67590662016, 64984.0, 65914.0, 59027.409725902195, 59524.0, 59585.404145958855, 59868.40131598628, 60174.39825601688, 45350.99999999934, 46060.0, 48984.0, 49741.25388119181, 51683.0, 9887.30788844774, 10477.842832357674, 10611.363318200933, 10816.349994251144, 10876.184286178726, 25052.749472505042, 25616.48767024612, 26072.217833465027, 26529.867350663124, 26586.867065664548, 30387.696123038488, 30598.847005765718, 30727.846360768053, 31065.8446707765, 31224.0, 14118.717625647634, 14209.0, 14273.21497317616, 14460.493882714054, 14504.927475362556, 15489.30298136609, 15670.216489175724, 15722.528324150293, 15744.448944286894, 16015.119168445848, 14606.488772892897, 14608.415663373771, 14610.92694536563, 14744.115353078849, 14778.408863645334, 14098.647533811736, 14175.716485670022, 14185.503507377192, 14198.716025679221, 14382.568522944328, 13935.163890166623, 14003.0, 14007.719845603235, 14112.858871411154, 14293.499727509487, 10177.745556361151, 10397.16822654201, 10508.264421490423, 10600.522976465923, 10831.620893268699, 10097.091261786474, 10539.63111291101, 10871.945640271748, 12313.938430307791, 12335.69160770952], "value": 6907.823868225216, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 114.0, 113.0, 113.0, 115.0, 113.0, 111.0, 113.0, 114.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 123.0, 186.0, 124.0, 123.0, 125.0, 124.0, 145.0, 125.0], "value": 135.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 162.0, 163.0, 166.0, 167.0, 166.0, 165.0, 163.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 75.0, 112.0, 76.0, 76.0, 74.0, 77.0, 101.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 102.0, 84.0, 83.0, 84.0, 101.0, 82.0, 83.0, 104.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0, 119.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 152.0, 151.0, 150.0, 150.0, 151.0, 151.0, 149.0, 151.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 96.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 52.0, 53.0, 54.0, 54.0, 55.0, 57.0, 54.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 56.0, 56.0, 55.0, 55.0, 56.0, 55.0, 56.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 82.0, 83.0, 83.0, 82.0, 81.0, 83.0, 82.0, 81.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 147.0, 136.0, 140.0, 131.0, 140.0, 135.0, 131.0, 179.0, 135.0], "value": 140.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 191.0, 194.0, 192.0, 191.0, 193.0, 189.0, 186.0, 190.0, 187.0], "value": 189.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 74.0, 71.0, 73.0, 76.0, 71.0, 75.0, 72.0, 73.0], "value": 73.4, "unit": "score"}]}]} 09:10:05 INFO - Return code: 0 09:10:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:10:05 INFO - # TBPL SUCCESS # 09:10:05 INFO - Running post-action listener: _resource_record_post_action 09:10:05 INFO - [mozharness: 2017-05-11 16:10:05.308691Z] Finished run-tests step (success) 09:10:05 INFO - Running post-run listener: _resource_record_post_run 09:10:05 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 7827456; Write bytes: 244744192; Read time: 1460; Write time: 153192 09:10:05 INFO - TinderboxPrint: CPU usage
13.2% 09:10:05 INFO - TinderboxPrint: I/O read bytes / time
7,827,456 / 1,460 09:10:05 INFO - TinderboxPrint: I/O write bytes / time
244,744,192 / 153,192 09:10:05 INFO - TinderboxPrint: CPU idle
8,300.0 (86.7%) 09:10:05 INFO - TinderboxPrint: CPU user
1,213.2 (12.7%) 09:10:05 INFO - TinderboxPrint: Swap in / out
0 / 0 09:10:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 389120; Read time: 0; Write time: 64 09:10:05 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 5476352; Write bytes: 244355072; Read time: 892; Write time: 153128 09:10:05 INFO - Running post-run listener: _upload_blobber_files 09:10:05 INFO - Blob upload gear active. 09:10:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:10:05 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 09:10:05 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'] 09:10:05 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 09:10:06 INFO - (blobuploader) - INFO - Open directory for files ... 09:10:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:10:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:10:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:09 INFO - (blobuploader) - INFO - Done attempting. 09:10:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:10:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:10:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:10 INFO - (blobuploader) - INFO - Done attempting. 09:10:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:10:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:10:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:11 INFO - (blobuploader) - INFO - Done attempting. 09:10:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:10:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:10:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:11 INFO - (blobuploader) - INFO - Done attempting. 09:10:11 INFO - (blobuploader) - INFO - Iteration through files over. 09:10:11 INFO - Return code: 0 09:10:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:10:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:10:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/082db3da2a856e8f62b9bf00f8d88895fe8f04acfa1df63a35887165abd46d4e871abacb490dcfe89d71ca43e9477bdcbb073398bfe7b6f80eac7841570f4c1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/92bfbb40d90a63b5d5e6ab9675bd5c75dddfda0ad23978b425289c397a65a5237e2a3321cfdace9a97c3d15a2d832900c37cf78c978f9644ae9d94172bbcfd5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cdc0665a1181e375703c8da93c42601942489a5af366b79aade73379e5d109fb441704caffb2c896a68e313f20f2f115d5f8aa168b650072014736290ede3b1a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac25f981aa5062cde37634358d72445f01caf291b025086c2fa41f9816c87a5673d0001c65df3080a2a5157aa3fab9b5d57292f29210d4ba8590cb6467dc566d"} 09:10:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:10:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:10:12 INFO - Contents: 09:10:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/082db3da2a856e8f62b9bf00f8d88895fe8f04acfa1df63a35887165abd46d4e871abacb490dcfe89d71ca43e9477bdcbb073398bfe7b6f80eac7841570f4c1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/92bfbb40d90a63b5d5e6ab9675bd5c75dddfda0ad23978b425289c397a65a5237e2a3321cfdace9a97c3d15a2d832900c37cf78c978f9644ae9d94172bbcfd5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cdc0665a1181e375703c8da93c42601942489a5af366b79aade73379e5d109fb441704caffb2c896a68e313f20f2f115d5f8aa168b650072014736290ede3b1a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac25f981aa5062cde37634358d72445f01caf291b025086c2fa41f9816c87a5673d0001c65df3080a2a5157aa3fab9b5d57292f29210d4ba8590cb6467dc566d"} 09:10:12 INFO - Running post-run listener: copy_logs_to_upload_dir 09:10:12 INFO - Copying logs to upload dir... 09:10:12 INFO - mkdir: /builds/slave/test/build/upload/logs 09:10:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2266.290945 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 37 mins, 46 secs) (at 2017-05-11 09:10:12.038905) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 09:10:12.042879) ========= 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=3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442 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/082db3da2a856e8f62b9bf00f8d88895fe8f04acfa1df63a35887165abd46d4e871abacb490dcfe89d71ca43e9477bdcbb073398bfe7b6f80eac7841570f4c1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/92bfbb40d90a63b5d5e6ab9675bd5c75dddfda0ad23978b425289c397a65a5237e2a3321cfdace9a97c3d15a2d832900c37cf78c978f9644ae9d94172bbcfd5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cdc0665a1181e375703c8da93c42601942489a5af366b79aade73379e5d109fb441704caffb2c896a68e313f20f2f115d5f8aa168b650072014736290ede3b1a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac25f981aa5062cde37634358d72445f01caf291b025086c2fa41f9816c87a5673d0001c65df3080a2a5157aa3fab9b5d57292f29210d4ba8590cb6467dc566d"} build_url:https://queue.taskcluster.net/v1/task/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011353 build_url: 'https://queue.taskcluster.net/v1/task/c_9vBZQwSGyBLaJaY1ABdg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/082db3da2a856e8f62b9bf00f8d88895fe8f04acfa1df63a35887165abd46d4e871abacb490dcfe89d71ca43e9477bdcbb073398bfe7b6f80eac7841570f4c1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/92bfbb40d90a63b5d5e6ab9675bd5c75dddfda0ad23978b425289c397a65a5237e2a3321cfdace9a97c3d15a2d832900c37cf78c978f9644ae9d94172bbcfd5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cdc0665a1181e375703c8da93c42601942489a5af366b79aade73379e5d109fb441704caffb2c896a68e313f20f2f115d5f8aa168b650072014736290ede3b1a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac25f981aa5062cde37634358d72445f01caf291b025086c2fa41f9816c87a5673d0001c65df3080a2a5157aa3fab9b5d57292f29210d4ba8590cb6467dc566d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 09:10:12.069886) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 09:10:12.070254) ========= 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=3836458cccd887f2d2de3cf1000001de-1494516742.619180-409218442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 09:10:12.152449) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 09:10:12.152767) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 09:10:12.153085) ========= ========= Total master_lag: 0.19 =========