builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-006 starttime: 1493993974.33 results: success (0) revision: 9348b76977e833f108cf77dff75b0fab887a2fc1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 07:19:34.334605) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 07:19:34.339509) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 07:19:34.339831) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 07:19:34.359010) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:19:34.359346) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-05 07:19:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 54.9M=0s 2017-05-05 07:19:35 (54.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.149728 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:19:34.527824) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:19:34.528226) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016064 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:19:34.578345) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:19:34.581985) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9348b76977e833f108cf77dff75b0fab887a2fc1 --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 9348b76977e833f108cf77dff75b0fab887a2fc1 --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=e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-05 07:19:35,572 truncating revision to first 12 chars 2017-05-05 07:19:35,572 Setting DEBUG logging. 2017-05-05 07:19:35,572 attempt 1/10 2017-05-05 07:19:35,572 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9348b76977e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-05 07:19:35,853 unpacking tar archive at: mozilla-central-9348b76977e8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.559065 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:19:35.160117) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 07:19:35.160744) ========= script_repo_revision: 9348b76977e833f108cf77dff75b0fab887a2fc1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 07:19:35.161222) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 07:19:35.162600) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 07:19:35.174605) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-05-05 07:19:35.175155) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:19:36 INFO - MultiFileLogger online at 20170505 07:19:36 in /builds/slave/test 07:19:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:19:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:19:36 INFO - {'append_to_log': False, 07:19:36 INFO - 'base_work_dir': '/builds/slave/test', 07:19:36 INFO - 'blob_upload_branch': 'Firefox', 07:19:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:19:36 INFO - 'branch': 'Firefox', 07:19:36 INFO - 'buildbot_json_path': 'buildprops.json', 07:19:36 INFO - 'config_files': ('talos/linux_config.py',), 07:19:36 INFO - 'default_actions': ('clobber', 07:19:36 INFO - 'read-buildbot-config', 07:19:36 INFO - 'download-and-extract', 07:19:36 INFO - 'populate-webroot', 07:19:36 INFO - 'create-virtualenv', 07:19:36 INFO - 'install', 07:19:36 INFO - 'run-tests'), 07:19:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:19:36 INFO - 'download_minidump_stackwalk': True, 07:19:36 INFO - 'download_symbols': 'ondemand', 07:19:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:19:36 INFO - 'tooltool.py': '/tools/tooltool.py', 07:19:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:19:36 INFO - '/tools/misc-python/virtualenv.py')}, 07:19:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:19:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:19:36 INFO - 'gecko_profile': False, 07:19:36 INFO - 'gecko_profile_interval': 0, 07:19:36 INFO - 'installer_path': 'installer.exe', 07:19:36 INFO - 'log_level': 'info', 07:19:36 INFO - 'log_name': 'talos', 07:19:36 INFO - 'log_to_console': True, 07:19:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:19:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:19:36 INFO - 'opt_config_files': (), 07:19:36 INFO - 'pip_index': False, 07:19:36 INFO - 'suite': 'dromaeojs-e10s', 07:19:36 INFO - 'system_bits': '32', 07:19:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:19:36 INFO - 'title': 'talos-linux64-ix-006', 07:19:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:19:36 INFO - 'use_talos_json': True, 07:19:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:19:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:19:36 INFO - 'work_dir': 'build'} 07:19:36 INFO - [mozharness: 2017-05-05 14:19:36.260981Z] Running clobber step. 07:19:36 INFO - Running pre-action listener: _resource_record_pre_action 07:19:36 INFO - Running main action method: clobber 07:19:36 INFO - rmtree: /builds/slave/test/build 07:19:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:19:37 INFO - Running post-action listener: _resource_record_post_action 07:19:37 INFO - [mozharness: 2017-05-05 14:19:37.195756Z] Finished clobber step (success) 07:19:37 INFO - [mozharness: 2017-05-05 14:19:37.195855Z] Running read-buildbot-config step. 07:19:37 INFO - Running pre-action listener: _resource_record_pre_action 07:19:37 INFO - Running main action method: read_buildbot_config 07:19:37 INFO - Using buildbot properties: 07:19:37 INFO - { 07:19:37 INFO - "project": "", 07:19:37 INFO - "product": "firefox", 07:19:37 INFO - "who": "cbook@mozilla.com", 07:19:37 INFO - "installer_path": "public/build/target.tar.bz2", 07:19:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:19:37 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:19:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:19:37 INFO - "stage_platform": "linux64-pgo", 07:19:37 INFO - "basedir": "/builds/slave/test", 07:19:37 INFO - "buildnumber": 196, 07:19:37 INFO - "platform": "ubuntu64_hw", 07:19:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:19:37 INFO - "slavebuilddir": "test", 07:19:37 INFO - "taskId": "dFaLjsHQQBmcBuIpDwwjGQ", 07:19:37 INFO - "branch": "mozilla-central", 07:19:37 INFO - "script_repo_revision": "production", 07:19:37 INFO - "revision": "9348b76977e833f108cf77dff75b0fab887a2fc1", 07:19:37 INFO - "slavename": "talos-linux64-ix-006", 07:19:37 INFO - "repo_path": "mozilla-central" 07:19:37 INFO - } 07:19:37 INFO - Finding installer, test and symbols from parent task. 07:19:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dFaLjsHQQBmcBuIpDwwjGQ'}, attempt #1 07:19:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dFaLjsHQQBmcBuIpDwwjGQ'}, attempt #1 07:19:38 INFO - Task dependencies: YwrTf5ZhTJmSd6M0Ez5Zog 07:19:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog'}, attempt #1 07:19:38 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/target.tar.bz2 07:19:38 INFO - Set test_url: https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/test_packages.json 07:19:38 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/target.crashreporter-symbols.zip 07:19:38 INFO - Running post-action listener: _resource_record_post_action 07:19:38 INFO - [mozharness: 2017-05-05 14:19:38.590160Z] Finished read-buildbot-config step (success) 07:19:38 INFO - [mozharness: 2017-05-05 14:19:38.590378Z] Running download-and-extract step. 07:19:38 INFO - Running pre-action listener: _resource_record_pre_action 07:19:38 INFO - Running main action method: download_and_extract 07:19:38 INFO - mkdir: /builds/slave/test/build/tests 07:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:38 INFO - trying https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/target.test_packages.json 07:19:38 INFO - Downloading https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:19:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:19:39 INFO - Downloaded 986 bytes. 07:19:39 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:19:39 INFO - Using the following test package requirements: 07:19:39 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:19:39 INFO - u'common': [u'target.common.tests.zip'], 07:19:39 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:19:39 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:19:39 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:19:39 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:19:39 INFO - u'mozbase': [u'target.common.tests.zip'], 07:19:39 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:19:39 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:19:39 INFO - u'web-platform': [u'target.common.tests.zip', 07:19:39 INFO - u'target.web-platform.tests.zip'], 07:19:39 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:19:39 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:19:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/target.common.tests.zip 07:19:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:19:39 INFO - Fetch https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/target.common.tests.zip into memory 07:19:40 INFO - Content-Length response header: 60565137 07:19:40 INFO - Bytes received: 60565137 07:19:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:19:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/target.common.tests.zip 07:19:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:19:50 INFO - Fetch https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/target.common.tests.zip into memory 07:19:51 INFO - Content-Length response header: 60565137 07:19:51 INFO - Bytes received: 60565137 07:20:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/target.talos.tests.zip 07:20:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:20:02 INFO - Fetch https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/target.talos.tests.zip into memory 07:20:03 INFO - Content-Length response header: 14408697 07:20:03 INFO - Bytes received: 14408697 07:20:03 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')]} 07:20:03 INFO - trying https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/target.tar.bz2 07:20:03 INFO - Downloading https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:20:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:20:04 INFO - Downloaded 64054691 bytes. 07:20:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/target.tar.bz2 07:20:04 INFO - mkdir: /builds/slave/test/properties 07:20:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:20:04 INFO - Writing to file /builds/slave/test/properties/build_url 07:20:04 INFO - Contents: 07:20:04 INFO - build_url:https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/target.tar.bz2 07:20:04 INFO - Running post-action listener: _resource_record_post_action 07:20:04 INFO - Running post-action listener: set_extra_try_arguments 07:20:04 INFO - [mozharness: 2017-05-05 14:20:04.571988Z] Finished download-and-extract step (success) 07:20:04 INFO - [mozharness: 2017-05-05 14:20:04.572084Z] Running populate-webroot step. 07:20:04 INFO - Running pre-action listener: _resource_record_pre_action 07:20:04 INFO - Running main action method: populate_webroot 07:20:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:20:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:20:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:20:04 INFO - '--tppagecycles', 07:20:04 INFO - '7'], 07:20:04 INFO - 'tests': ['tsvgm']}}, 07:20:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:20:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:20:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:20:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:20:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:20:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:20:04 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:20:04 INFO - 'talos_options': ['--disable-e10s'], 07:20:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:20:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:20:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:20:04 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:20:04 INFO - 'talos_options': ['--disable-e10s'], 07:20:04 INFO - 'tests': ['damp', 'tps']}, 07:20:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:20:04 INFO - 'tests': ['damp', 'tps']}, 07:20:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:20:04 INFO - 'tests': ['dromaeo_dom']}, 07:20:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:20:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:20:04 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 07:20:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:20:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:20:04 INFO - 'tests': ['a11yr', 07:20:04 INFO - 'ts_paint', 07:20:04 INFO - 'tpaint', 07:20:04 INFO - 'sessionrestore', 07:20:04 INFO - 'sessionrestore_no_auto_restore', 07:20:04 INFO - 'tabpaint']}, 07:20:04 INFO - 'other-e10s': {'tests': ['a11yr', 07:20:04 INFO - 'ts_paint', 07:20:04 INFO - 'tpaint', 07:20:04 INFO - 'sessionrestore', 07:20:04 INFO - 'sessionrestore_no_auto_restore', 07:20:04 INFO - 'tabpaint']}, 07:20:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:20:04 INFO - 'ts_paint', 07:20:04 INFO - 'tpaint', 07:20:04 INFO - 'sessionrestore', 07:20:04 INFO - 'sessionrestore_no_auto_restore', 07:20:04 INFO - 'tabpaint']}, 07:20:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:20:04 INFO - 'ts_paint', 07:20:04 INFO - 'tpaint', 07:20:04 INFO - 'sessionrestore', 07:20:04 INFO - 'sessionrestore_no_auto_restore', 07:20:04 INFO - 'tabpaint']}, 07:20:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:20:04 INFO - 'tests': ['a11yr', 07:20:04 INFO - 'ts_paint', 07:20:04 INFO - 'tpaint', 07:20:04 INFO - 'sessionrestore', 07:20:04 INFO - 'sessionrestore_no_auto_restore', 07:20:04 INFO - 'tabpaint']}, 07:20:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:20:04 INFO - 'tests': ['a11yr', 07:20:04 INFO - 'ts_paint', 07:20:04 INFO - 'tpaint', 07:20:04 INFO - 'sessionrestore', 07:20:04 INFO - 'sessionrestore_no_auto_restore', 07:20:04 INFO - 'tabpaint']}, 07:20:04 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 07:20:04 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 07:20:04 INFO - 'bloom_basic_ref']}, 07:20:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:20:04 INFO - 'tests': ['tsvgx', 07:20:04 INFO - 'tsvgr_opacity', 07:20:04 INFO - 'tart', 07:20:04 INFO - 'tscrollx', 07:20:04 INFO - 'cart', 07:20:04 INFO - 'tsvg_static']}, 07:20:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:20:04 INFO - 'tsvgr_opacity', 07:20:04 INFO - 'tart', 07:20:04 INFO - 'tscrollx', 07:20:04 INFO - 'cart', 07:20:04 INFO - 'tsvg_static']}, 07:20:04 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:20:04 INFO - 'talos_options': ['--disable-e10s'], 07:20:04 INFO - 'tests': ['tp5o']}, 07:20:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:20:04 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:20:04 INFO - 'talos_options': ['--disable-e10s', 07:20:04 INFO - '--xperf_path', 07:20:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:20:04 INFO - 'tests': ['tp5n']}, 07:20:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:20:04 INFO - 'talos_options': ['--xperf_path', 07:20:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:20:04 INFO - 'tests': ['tp5n']}}, 07:20:04 INFO - 'talos.zip': {'path': '', 07:20:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:20:04 INFO - Running post-action listener: _resource_record_post_action 07:20:04 INFO - [mozharness: 2017-05-05 14:20:04.585759Z] Finished populate-webroot step (success) 07:20:04 INFO - [mozharness: 2017-05-05 14:20:04.585848Z] Running create-virtualenv step. 07:20:04 INFO - Running pre-action listener: _resource_record_pre_action 07:20:04 INFO - Running main action method: create_virtualenv 07:20:04 INFO - Creating virtualenv /builds/slave/test/build/venv 07:20:04 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 07:20:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:20:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:20:04 INFO - Using real prefix '/usr' 07:20:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:20:05 INFO - Installing distribute.............................................................................................................................................................................................done. 07:20:07 INFO - Installing pip.................done. 07:20:07 INFO - Return code: 0 07:20:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:20:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:20:07 INFO - Reading from file tmpfile_stdout 07:20:07 INFO - Output received: 07:20:07 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) 07:20:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:20:07 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')]} 07:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:07 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')]} 07:20:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:07 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 0x24bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2759b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2757290>, '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 0x2757b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2758040>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521', '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 07:20:07 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 07:20:07 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 07:20:07 INFO - Using env: {'DISPLAY': ':0', 07:20:07 INFO - 'HOME': '/home/cltbld', 07:20:07 INFO - 'LANG': 'en_US.UTF-8', 07:20:07 INFO - 'LANGUAGE': 'en_US:en', 07:20:07 INFO - 'LOGNAME': 'cltbld', 07:20:07 INFO - 'MAIL': '/var/mail/cltbld', 07:20:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:07 INFO - 'MOZ_NO_REMOTE': '1', 07:20:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:07 INFO - 'NO_EM_RESTART': '1', 07:20:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:07 INFO - 'PWD': '/builds/slave/test', 07:20:07 INFO - 'SHELL': '/bin/bash', 07:20:07 INFO - 'SHLVL': '1', 07:20:07 INFO - 'TERM': 'linux', 07:20:07 INFO - 'TMOUT': '86400', 07:20:07 INFO - 'USER': 'cltbld', 07:20:07 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521', 07:20:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:07 INFO - '_': '/tools/buildbot/bin/python'} 07:20:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:07 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 07:20:07 INFO - Cleaning up... 07:20:07 INFO - Return code: 0 07:20:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:20:07 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')]} 07:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:07 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')]} 07:20:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:07 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 0x24bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2759b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2757290>, '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 0x2757b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2758040>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521', '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 07:20:07 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 07:20:07 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 07:20:07 INFO - Using env: {'DISPLAY': ':0', 07:20:07 INFO - 'HOME': '/home/cltbld', 07:20:07 INFO - 'LANG': 'en_US.UTF-8', 07:20:07 INFO - 'LANGUAGE': 'en_US:en', 07:20:07 INFO - 'LOGNAME': 'cltbld', 07:20:07 INFO - 'MAIL': '/var/mail/cltbld', 07:20:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:07 INFO - 'MOZ_NO_REMOTE': '1', 07:20:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:07 INFO - 'NO_EM_RESTART': '1', 07:20:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:07 INFO - 'PWD': '/builds/slave/test', 07:20:07 INFO - 'SHELL': '/bin/bash', 07:20:07 INFO - 'SHLVL': '1', 07:20:07 INFO - 'TERM': 'linux', 07:20:07 INFO - 'TMOUT': '86400', 07:20:07 INFO - 'USER': 'cltbld', 07:20:07 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521', 07:20:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:07 INFO - '_': '/tools/buildbot/bin/python'} 07:20:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:07 INFO - Downloading/unpacking psutil>=3.1.1 07:20:07 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 07:20:07 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 07:20:07 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 07:20:07 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 07:20:07 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 07:20:07 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 07:20:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:20:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:20:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:20:08 INFO - Installing collected packages: psutil 07:20:08 INFO - Running setup.py install for psutil 07:20:09 INFO - building 'psutil._psutil_linux' extension 07:20:09 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 07:20: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 07:20:09 INFO - building 'psutil._psutil_posix' extension 07:20: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 07:20: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 07:20:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:20:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:20:09 INFO - Successfully installed psutil 07:20:09 INFO - Cleaning up... 07:20:09 INFO - Return code: 0 07:20:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:20: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')]} 07:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20: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')]} 07:20:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20: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 0x24bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2759b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2757290>, '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 0x2757b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2758040>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521', '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 07:20: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 07:20: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 07:20:09 INFO - Using env: {'DISPLAY': ':0', 07:20:09 INFO - 'HOME': '/home/cltbld', 07:20:09 INFO - 'LANG': 'en_US.UTF-8', 07:20:09 INFO - 'LANGUAGE': 'en_US:en', 07:20:09 INFO - 'LOGNAME': 'cltbld', 07:20:09 INFO - 'MAIL': '/var/mail/cltbld', 07:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:09 INFO - 'MOZ_NO_REMOTE': '1', 07:20:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:09 INFO - 'NO_EM_RESTART': '1', 07:20:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:09 INFO - 'PWD': '/builds/slave/test', 07:20:09 INFO - 'SHELL': '/bin/bash', 07:20:09 INFO - 'SHLVL': '1', 07:20:09 INFO - 'TERM': 'linux', 07:20:09 INFO - 'TMOUT': '86400', 07:20:09 INFO - 'USER': 'cltbld', 07:20:09 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521', 07:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:09 INFO - '_': '/tools/buildbot/bin/python'} 07:20:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:20: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 07:20: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 07:20: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 07:20: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 07:20: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 07:20: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 07:20:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:20:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:20:10 INFO - Installing collected packages: mozsystemmonitor 07:20:10 INFO - Running setup.py install for mozsystemmonitor 07:20:10 INFO - Successfully installed mozsystemmonitor 07:20:10 INFO - Cleaning up... 07:20:10 INFO - Return code: 0 07:20:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:20:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2759b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2757290>, '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 0x2757b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2758040>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521', '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 07:20:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:20:10 INFO - Using env: {'DISPLAY': ':0', 07:20:10 INFO - 'HOME': '/home/cltbld', 07:20:10 INFO - 'LANG': 'en_US.UTF-8', 07:20:10 INFO - 'LANGUAGE': 'en_US:en', 07:20:10 INFO - 'LOGNAME': 'cltbld', 07:20:10 INFO - 'MAIL': '/var/mail/cltbld', 07:20:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:10 INFO - 'MOZ_NO_REMOTE': '1', 07:20:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:10 INFO - 'NO_EM_RESTART': '1', 07:20:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:10 INFO - 'PWD': '/builds/slave/test', 07:20:10 INFO - 'SHELL': '/bin/bash', 07:20:10 INFO - 'SHLVL': '1', 07:20:10 INFO - 'TERM': 'linux', 07:20:11 INFO - 'TMOUT': '86400', 07:20:11 INFO - 'USER': 'cltbld', 07:20:11 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521', 07:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:11 INFO - '_': '/tools/buildbot/bin/python'} 07:20:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:11 INFO - Downloading/unpacking jsonschema==2.5.1 07:20:11 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 07:20:11 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 07:20:11 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 07:20:11 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 07:20:11 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 07:20:11 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 07:20:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:20:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:12 INFO - Downloading functools32-3.2.3-2.tar.gz 07:20:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:20:12 INFO - warning: no files found matching '*.txt' 07:20:12 INFO - no previously-included directories found matching 'build' 07:20:12 INFO - no previously-included directories found matching 'dist' 07:20:12 INFO - no previously-included directories found matching '.git*' 07:20:12 INFO - Installing collected packages: jsonschema, functools32 07:20:12 INFO - Running setup.py install for functools32 07:20:12 INFO - warning: no files found matching '*.txt' 07:20:12 INFO - no previously-included directories found matching 'build' 07:20:12 INFO - no previously-included directories found matching 'dist' 07:20:12 INFO - no previously-included directories found matching '.git*' 07:20:12 INFO - Successfully installed jsonschema functools32 07:20:12 INFO - Cleaning up... 07:20:12 INFO - Return code: 0 07:20:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:20:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2759b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2757290>, '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 0x2757b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2758040>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521', '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 07:20:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:20:12 INFO - Using env: {'DISPLAY': ':0', 07:20:12 INFO - 'HOME': '/home/cltbld', 07:20:12 INFO - 'LANG': 'en_US.UTF-8', 07:20:12 INFO - 'LANGUAGE': 'en_US:en', 07:20:12 INFO - 'LOGNAME': 'cltbld', 07:20:12 INFO - 'MAIL': '/var/mail/cltbld', 07:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:12 INFO - 'MOZ_NO_REMOTE': '1', 07:20:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:12 INFO - 'NO_EM_RESTART': '1', 07:20:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:12 INFO - 'PWD': '/builds/slave/test', 07:20:12 INFO - 'SHELL': '/bin/bash', 07:20:12 INFO - 'SHLVL': '1', 07:20:12 INFO - 'TERM': 'linux', 07:20:12 INFO - 'TMOUT': '86400', 07:20:12 INFO - 'USER': 'cltbld', 07:20:12 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521', 07:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:12 INFO - '_': '/tools/buildbot/bin/python'} 07:20:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:20:12 INFO - Cleaning up... 07:20:12 INFO - Return code: 0 07:20:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:20:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2759b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2757290>, '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 0x2757b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2758040>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521', '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 07:20:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:20:12 INFO - Using env: {'DISPLAY': ':0', 07:20:12 INFO - 'HOME': '/home/cltbld', 07:20:12 INFO - 'LANG': 'en_US.UTF-8', 07:20:12 INFO - 'LANGUAGE': 'en_US:en', 07:20:12 INFO - 'LOGNAME': 'cltbld', 07:20:12 INFO - 'MAIL': '/var/mail/cltbld', 07:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:12 INFO - 'MOZ_NO_REMOTE': '1', 07:20:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:12 INFO - 'NO_EM_RESTART': '1', 07:20:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:12 INFO - 'PWD': '/builds/slave/test', 07:20:12 INFO - 'SHELL': '/bin/bash', 07:20:12 INFO - 'SHLVL': '1', 07:20:12 INFO - 'TERM': 'linux', 07:20:12 INFO - 'TMOUT': '86400', 07:20:12 INFO - 'USER': 'cltbld', 07:20:12 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521', 07:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:12 INFO - '_': '/tools/buildbot/bin/python'} 07:20:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:13 INFO - Downloading/unpacking blobuploader==1.2.4 07:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:14 INFO - Downloading blobuploader-1.2.4.tar.gz 07:20:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:20:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:20:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:20:14 INFO - Downloading docopt-0.6.1.tar.gz 07:20:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:20:14 INFO - Installing collected packages: blobuploader, requests, docopt 07:20:14 INFO - Running setup.py install for blobuploader 07:20:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:20:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:20:14 INFO - Running setup.py install for requests 07:20:15 INFO - Running setup.py install for docopt 07:20:15 INFO - Successfully installed blobuploader requests docopt 07:20:15 INFO - Cleaning up... 07:20:15 INFO - Return code: 0 07:20:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:15 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 0x24bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2759b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2757290>, '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 0x2757b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2758040>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521', '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 07:20:15 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 07:20:15 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 07:20:15 INFO - Using env: {'DISPLAY': ':0', 07:20:15 INFO - 'HOME': '/home/cltbld', 07:20:15 INFO - 'LANG': 'en_US.UTF-8', 07:20:15 INFO - 'LANGUAGE': 'en_US:en', 07:20:15 INFO - 'LOGNAME': 'cltbld', 07:20:15 INFO - 'MAIL': '/var/mail/cltbld', 07:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:15 INFO - 'MOZ_NO_REMOTE': '1', 07:20:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:15 INFO - 'NO_EM_RESTART': '1', 07:20:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:15 INFO - 'PWD': '/builds/slave/test', 07:20:15 INFO - 'SHELL': '/bin/bash', 07:20:15 INFO - 'SHLVL': '1', 07:20:15 INFO - 'TERM': 'linux', 07:20:15 INFO - 'TMOUT': '86400', 07:20:15 INFO - 'USER': 'cltbld', 07:20:15 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521', 07:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:15 INFO - '_': '/tools/buildbot/bin/python'} 07:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:20:15 INFO - Running setup.py (path:/tmp/pip-TzROkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:20:15 INFO - Running setup.py (path:/tmp/pip-nupd99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:20:15 INFO - Running setup.py (path:/tmp/pip-0d83gH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:20:15 INFO - Running setup.py (path:/tmp/pip-QS1gLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:20:15 INFO - Running setup.py (path:/tmp/pip-Ni0R86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:20:16 INFO - Running setup.py (path:/tmp/pip-ru5ptU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:20:16 INFO - Running setup.py (path:/tmp/pip-K9AkQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:20:16 INFO - Running setup.py (path:/tmp/pip-uTSdEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:20:16 INFO - Running setup.py (path:/tmp/pip-pIRWH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:20:16 INFO - Running setup.py (path:/tmp/pip-mLKu2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:20:16 INFO - Running setup.py (path:/tmp/pip-aBB_2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:20:16 INFO - Running setup.py (path:/tmp/pip-eZGSli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:20:16 INFO - Running setup.py (path:/tmp/pip-M6CeJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:20:16 INFO - Running setup.py (path:/tmp/pip-9YHDW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:20:16 INFO - Running setup.py (path:/tmp/pip-jWHkdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:20:16 INFO - Running setup.py (path:/tmp/pip-DXcaov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:20:16 INFO - Running setup.py (path:/tmp/pip-CjUdYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:20:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:20:16 INFO - Running setup.py install for manifestparser 07:20:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:20:17 INFO - Running setup.py install for mozcrash 07:20:17 INFO - Running setup.py install for mozdebug 07:20:17 INFO - Running setup.py install for mozdevice 07:20:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:20:17 INFO - Running setup.py install for mozfile 07:20:17 INFO - Running setup.py install for mozhttpd 07:20:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:20:17 INFO - Running setup.py install for mozinfo 07:20:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:20:17 INFO - Running setup.py install for mozInstall 07:20:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:20:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:20:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:20:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:20:17 INFO - Running setup.py install for mozleak 07:20:17 INFO - Running setup.py install for mozlog 07:20:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:20:17 INFO - Running setup.py install for moznetwork 07:20:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:20:18 INFO - Running setup.py install for mozprocess 07:20:18 INFO - Running setup.py install for mozprofile 07:20:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:20:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:20:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:20:18 INFO - Running setup.py install for mozrunner 07:20:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:20:18 INFO - Running setup.py install for mozscreenshot 07:20:18 INFO - Running setup.py install for moztest 07:20:18 INFO - Running setup.py install for mozversion 07:20:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:20:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:20:18 INFO - Cleaning up... 07:20:18 INFO - Return code: 0 07:20:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:18 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 0x24bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2759b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2757290>, '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 0x2757b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2758040>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521', '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 07:20:18 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 07:20:18 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 07:20:18 INFO - Using env: {'DISPLAY': ':0', 07:20:18 INFO - 'HOME': '/home/cltbld', 07:20:18 INFO - 'LANG': 'en_US.UTF-8', 07:20:18 INFO - 'LANGUAGE': 'en_US:en', 07:20:18 INFO - 'LOGNAME': 'cltbld', 07:20:18 INFO - 'MAIL': '/var/mail/cltbld', 07:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:18 INFO - 'MOZ_NO_REMOTE': '1', 07:20:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:18 INFO - 'NO_EM_RESTART': '1', 07:20:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:18 INFO - 'PWD': '/builds/slave/test', 07:20:18 INFO - 'SHELL': '/bin/bash', 07:20:18 INFO - 'SHLVL': '1', 07:20:18 INFO - 'TERM': 'linux', 07:20:18 INFO - 'TMOUT': '86400', 07:20:18 INFO - 'USER': 'cltbld', 07:20:18 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521', 07:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:18 INFO - '_': '/tools/buildbot/bin/python'} 07:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:20:18 INFO - Running setup.py (path:/tmp/pip-IWeBzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:20:18 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)) 07:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:20:18 INFO - Running setup.py (path:/tmp/pip-smagIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:20:19 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)) 07:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:20:19 INFO - Running setup.py (path:/tmp/pip-rYvBUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:20:19 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)) 07:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:20:19 INFO - Running setup.py (path:/tmp/pip-3MCP8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:20:19 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)) 07:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:20:19 INFO - Running setup.py (path:/tmp/pip-gCbqCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:20:19 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)) 07:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:20:19 INFO - Running setup.py (path:/tmp/pip-QmWFtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:20:19 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)) 07:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:20:19 INFO - Running setup.py (path:/tmp/pip-kbKCnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:20:19 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)) 07:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:20:19 INFO - Running setup.py (path:/tmp/pip-Sg_1gB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:20:19 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)) 07:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:20:19 INFO - Running setup.py (path:/tmp/pip-cMNBLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:20:19 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)) 07:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:20:19 INFO - Running setup.py (path:/tmp/pip-OZNHfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:20:19 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)) 07:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:20:19 INFO - Running setup.py (path:/tmp/pip-1Eiub8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:20:19 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)) 07:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:20:19 INFO - Running setup.py (path:/tmp/pip-BcHWgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:20:19 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)) 07:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:20:19 INFO - Running setup.py (path:/tmp/pip-3wgDmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:20:19 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)) 07:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:20:19 INFO - Running setup.py (path:/tmp/pip-lbLD5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:20:19 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)) 07:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:20:19 INFO - Running setup.py (path:/tmp/pip-Nj0KYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:20:20 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)) 07:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:20:20 INFO - Running setup.py (path:/tmp/pip-LUW5Rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:20:20 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)) 07:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:20:20 INFO - Running setup.py (path:/tmp/pip-EF0m3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:20:20 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)) 07:20:20 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)) 07:20:20 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)) 07:20:20 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)) 07:20:20 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)) 07:20:20 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)) 07:20:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:20:20 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 07:20:20 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 07:20:20 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 07:20:20 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 07:20:20 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 07:20:20 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 07:20:21 INFO - Downloading blessings-1.6.tar.gz 07:20:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:20:21 INFO - Installing collected packages: blessings 07:20:21 INFO - Running setup.py install for blessings 07:20:21 INFO - Successfully installed blessings 07:20:21 INFO - Cleaning up... 07:20:21 INFO - Return code: 0 07:20:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:20:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:20:21 INFO - Reading from file tmpfile_stdout 07:20:21 INFO - Current package versions: 07:20:21 INFO - argparse == 1.2.1 07:20:21 INFO - blessings == 1.6 07:20:21 INFO - blobuploader == 1.2.4 07:20:21 INFO - docopt == 0.6.1 07:20:21 INFO - functools32 == 3.2.3-2 07:20:21 INFO - jsonschema == 2.5.1 07:20:21 INFO - manifestparser == 1.1 07:20:21 INFO - mozInstall == 1.12 07:20:21 INFO - mozcrash == 1.0 07:20:21 INFO - mozdebug == 0.1 07:20:21 INFO - mozdevice == 0.50 07:20:21 INFO - mozfile == 1.2 07:20:21 INFO - mozhttpd == 0.7 07:20:21 INFO - mozinfo == 0.9 07:20:21 INFO - mozleak == 0.1 07:20:21 INFO - mozlog == 3.4 07:20:21 INFO - moznetwork == 0.27 07:20:21 INFO - mozprocess == 0.25 07:20:21 INFO - mozprofile == 0.28 07:20:21 INFO - mozrunner == 6.13 07:20:21 INFO - mozscreenshot == 0.1 07:20:21 INFO - mozsystemmonitor == 0.3 07:20:21 INFO - moztest == 0.8 07:20:21 INFO - mozversion == 1.4 07:20:21 INFO - psutil == 3.1.1 07:20:21 INFO - requests == 1.2.3 07:20:21 INFO - wsgiref == 0.1.2 07:20:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:20:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:21 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 0x24bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2759b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2757290>, '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 0x2757b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2758040>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521', '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 07:20:21 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 07:20:21 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 07:20:21 INFO - Using env: {'DISPLAY': ':0', 07:20:21 INFO - 'HOME': '/home/cltbld', 07:20:21 INFO - 'LANG': 'en_US.UTF-8', 07:20:21 INFO - 'LANGUAGE': 'en_US:en', 07:20:21 INFO - 'LOGNAME': 'cltbld', 07:20:21 INFO - 'MAIL': '/var/mail/cltbld', 07:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:21 INFO - 'MOZ_NO_REMOTE': '1', 07:20:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:21 INFO - 'NO_EM_RESTART': '1', 07:20:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:21 INFO - 'PWD': '/builds/slave/test', 07:20:21 INFO - 'SHELL': '/bin/bash', 07:20:21 INFO - 'SHLVL': '1', 07:20:21 INFO - 'TERM': 'linux', 07:20:21 INFO - 'TMOUT': '86400', 07:20:21 INFO - 'USER': 'cltbld', 07:20:21 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521', 07:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:21 INFO - '_': '/tools/buildbot/bin/python'} 07:20:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:21 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)) 07:20:21 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)) 07:20:21 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)) 07:20:21 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)) 07:20:21 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)) 07:20:21 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)) 07:20:21 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)) 07:20:21 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)) 07:20:21 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)) 07:20:21 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)) 07:20:21 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)) 07:20:21 INFO - Cleaning up... 07:20:21 INFO - Return code: 0 07:20:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:20:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:21 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 0x24bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2759b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2757290>, '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 0x2757b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2758040>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521', '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 07:20:21 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 07:20:21 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 07:20:21 INFO - Using env: {'DISPLAY': ':0', 07:20:21 INFO - 'HOME': '/home/cltbld', 07:20:21 INFO - 'LANG': 'en_US.UTF-8', 07:20:21 INFO - 'LANGUAGE': 'en_US:en', 07:20:21 INFO - 'LOGNAME': 'cltbld', 07:20:21 INFO - 'MAIL': '/var/mail/cltbld', 07:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:21 INFO - 'MOZ_NO_REMOTE': '1', 07:20:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:21 INFO - 'NO_EM_RESTART': '1', 07:20:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:21 INFO - 'PWD': '/builds/slave/test', 07:20:21 INFO - 'SHELL': '/bin/bash', 07:20:21 INFO - 'SHLVL': '1', 07:20:21 INFO - 'TERM': 'linux', 07:20:21 INFO - 'TMOUT': '86400', 07:20:21 INFO - 'USER': 'cltbld', 07:20:21 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521', 07:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:21 INFO - '_': '/tools/buildbot/bin/python'} 07:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:20:22 INFO - Cleaning up... 07:20:22 INFO - Return code: 0 07:20:22 INFO - Running post-action listener: _resource_record_post_action 07:20:22 INFO - Running post-action listener: _start_resource_monitoring 07:20:22 INFO - Starting resource monitoring. 07:20:22 INFO - [mozharness: 2017-05-05 14:20:22.226414Z] Finished create-virtualenv step (success) 07:20:22 INFO - [mozharness: 2017-05-05 14:20:22.226931Z] Running install step. 07:20:22 INFO - Running pre-action listener: _resource_record_pre_action 07:20:22 INFO - Running main action method: install 07:20:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:20:22 INFO - Reading from file tmpfile_stdout 07:20:22 INFO - Detecting whether we're running mozinstall >=1.0... 07:20:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:20:22 INFO - Reading from file tmpfile_stdout 07:20:22 INFO - Output received: 07:20:22 INFO - Usage: mozinstall [options] installer 07:20:22 INFO - Options: 07:20:22 INFO - -h, --help show this help message and exit 07:20:22 INFO - -d DEST, --destination=DEST 07:20:22 INFO - Directory to install application into. [default: 07:20:22 INFO - "/builds/slave/test"] 07:20:22 INFO - --app=APP Application being installed. [default: firefox] 07:20:22 INFO - mkdir: /builds/slave/test/build/application 07:20:22 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'] 07:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:20:38 INFO - Reading from file tmpfile_stdout 07:20:38 INFO - Output received: 07:20:38 INFO - /builds/slave/test/build/application/firefox/firefox 07:20:38 INFO - Running post-action listener: _resource_record_post_action 07:20:38 INFO - [mozharness: 2017-05-05 14:20:38.785814Z] Finished install step (success) 07:20:38 INFO - [mozharness: 2017-05-05 14:20:38.786084Z] Running run-tests step. 07:20:38 INFO - Running pre-action listener: _resource_record_pre_action 07:20:38 INFO - Running main action method: run_tests 07:20:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:20:38 INFO - Python 2.7.3 07:20:38 INFO - Return code: 0 07:20:38 INFO - grabbing minidump binary from tooltool 07:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:20:38 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 0x2757290>, '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 0x2757b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2758040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:20:38 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 07:20:38 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 07:20:38 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 07:20:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:20:38 INFO - Return code: 0 07:20:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:20:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:20:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:20:38 INFO - ENV: RUST_BACKTRACE is now 1 07:20:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:20:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:20:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 07:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 07:20:38 INFO - Using env: {'DISPLAY': ':0', 07:20:38 INFO - 'HOME': '/home/cltbld', 07:20:38 INFO - 'LANG': 'en_US.UTF-8', 07:20:38 INFO - 'LANGUAGE': 'en_US:en', 07:20:38 INFO - 'LOGNAME': 'cltbld', 07:20:38 INFO - 'MAIL': '/var/mail/cltbld', 07:20:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:20:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:38 INFO - 'MOZ_NO_REMOTE': '1', 07:20:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:20:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:38 INFO - 'NO_EM_RESTART': '1', 07:20:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:38 INFO - 'PWD': '/builds/slave/test', 07:20:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:20:38 INFO - 'RUST_BACKTRACE': '1', 07:20:38 INFO - 'SHELL': '/bin/bash', 07:20:38 INFO - 'SHLVL': '1', 07:20:38 INFO - 'TERM': 'linux', 07:20:38 INFO - 'TMOUT': '86400', 07:20:38 INFO - 'USER': 'cltbld', 07:20:38 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521', 07:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:38 INFO - '_': '/tools/buildbot/bin/python'} 07:20:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 07:20:39 INFO - mozversion application_buildid: 20170505131750 07:20:39 INFO - mozversion application_changeset: 9348b76977e833f108cf77dff75b0fab887a2fc1 07:20:39 INFO - mozversion application_display_name: Nightly 07:20:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:20:39 INFO - mozversion application_name: Firefox 07:20:39 INFO - mozversion application_remotingname: firefox 07:20:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:20:39 INFO - mozversion application_vendor: Mozilla 07:20:39 INFO - mozversion application_version: 55.0a1 07:20:39 INFO - mozversion platform_buildid: 20170505131750 07:20:39 INFO - mozversion platform_changeset: 9348b76977e833f108cf77dff75b0fab887a2fc1 07:20:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:20:39 INFO - mozversion platform_version: 55.0a1 07:20:39 INFO - using testdate: 1493994039 07:20:39 INFO - actual date: 1493994039 07:20:39 INFO - starting webserver on 'localhost:46220' 07:20:39 INFO - SUITE-START | Running 2 tests 07:20:39 INFO - TEST-START | dromaeo_css 07:20:39 INFO - operating with platform_type : linux_ 07:20:39 INFO - Initialising browser for dromaeo_css test... 07:20:39 INFO - TEST-INFO | started process 1957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjl671X/profile http://localhost:46220/getInfo.html) 07:20:43 INFO - PID 1957 | __metrics Screen width/height:1600/1200 07:20:43 INFO - PID 1957 | colorDepth:24 07:20:43 INFO - PID 1957 | Browser inner width/height: 1024/695 07:20:43 INFO - PID 1957 | __metrics 07:20:44 INFO - TEST-INFO | 1957: exit 0 07:20:44 INFO - Browser initialized. 07:20:44 INFO - Running cycle 1/1 for dromaeo_css test... 07:20:44 INFO - TEST-INFO | started process 2128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjl671X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:20:56 INFO - PID 2128 | RSS: Main: 155885568 07:20:56 INFO - PID 2128 | 07:23:58 INFO - PID 2128 | Cycle 1(1): loaded http://localhost:46220/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46220/tests/dromaeo/cssquery-ext.html) 07:24:00 INFO - PID 2128 | RSS: Main: 162996224 07:24:00 INFO - PID 2128 | 07:27:01 INFO - PID 2128 | Cycle 1(1): loaded http://localhost:46220/tests/dromaeo/cssquery-ext.html (next: http://localhost:46220/tests/dromaeo/cssquery-jquery.html) 07:27:02 INFO - PID 2128 | RSS: Main: 156565504 07:27:02 INFO - PID 2128 | 07:30:04 INFO - PID 2128 | Cycle 1(1): loaded http://localhost:46220/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46220/tests/dromaeo/cssquery-mootools.html) 07:30:04 INFO - PID 2128 | RSS: Main: 163721216 07:30:04 INFO - PID 2128 | 07:33:06 INFO - PID 2128 | Cycle 1(1): loaded http://localhost:46220/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46220/tests/dromaeo/cssquery-prototype.html) 07:33:06 INFO - PID 2128 | RSS: Main: 156921856 07:33:06 INFO - PID 2128 | 07:36:09 INFO - PID 2128 | Cycle 1(1): loaded http://localhost:46220/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46220/tests/dromaeo/cssquery-yui.html) 07:36:10 INFO - PID 2128 | RSS: Main: 162226176 07:36:10 INFO - PID 2128 | 07:39:11 INFO - PID 2128 | Cycle 1(1): loaded http://localhost:46220/tests/dromaeo/cssquery-yui.html (next: http://localhost:46220/tests/dromaeo/cssquery-dojo.html) 07:39:12 INFO - PID 2128 | RSS: Main: 163782656 07:39:12 INFO - PID 2128 | 07:39:12 INFO - PID 2128 | __start_tp_report 07:39:12 INFO - PID 2128 | _x_x_mozilla_page_load 07:39:12 INFO - PID 2128 | _x_x_mozilla_page_load_details 07:39:12 INFO - PID 2128 | |i|pagename|runs| 07:39:12 INFO - PID 2128 | |0;dojo.html;3416.9829150854243;3418.589769227693;3439.6044454887697;3443.5523381960343;3452.879149229776;5946.851328716784;6032.396760323971;6034.275886893568;6050.092486127083;6082.057281121422;6020.909686354697;6028.125921741344;6119.204503414561;6137.4076293189555;6144.877102457948;5038.360669483346;5286.3392075990505;5358.973205133969;5363.678179309234;5365.678059316434;5433.782648694048;5484.040292948738;5504.834854954358;5508.91736623951;5513.255710479074;5310.814121505768;5369.40936496985;5372.0867452532775;5432.91850622241;5454.181872719124;5417.485338892799;5458.044842152647;5472.315960504937;5474.562035037187;5487.835364939058;5346.1713434417725;5397.8110766123;5409.43200963901;5409.459054094598;5419.187121931703;5945.583809133363;6034.969825150846;6106.72519736613;6107.664078475682;6114.419130182626;6394.8721025579225;6516.380943810331;6582.5063120265695;6589.835254118638;6658.833529161761;6684.064231007663;6692.397684208396;6695.598264104169;6700.296468870747;6704.1954965403975;6088.695565221721;6146.231721034871;6204.565680402328;6231.065340199007;6241.96879015602;6506.284308726036;6570.737170513222;6642.86714265712;6788.253292137861;6812.352826481477;6345.809625711236;6364.109024736541;6388.872222555616;6523.739050438025;6566.4418524425955;6479.060536222221;6586.4072233498255;6611.438027767694;6639.468842492685;6641.601503909685;6594.8351291218105;6640.734370625121;6641.070250164981;6645.867082658319;6656.667166641649;6436.774712885027;6513.055606936968;6518.185226846645;6646.700898459581;6664.5334826561675;5007.574356179765;5056.469070747518;5082.085224659523;5085.593152547861;5092.898142037213;4462.062966776948;4465.732056076581;4475.060237350128;4488.663350248745;4563.840265590688;6245.687715614201;6260.780872669435;6262.2172228471445;6285.120083188357;6302.936970630327;6475.7733479328;6509.1863517060365;6555.541112122106;6683.966580167068;6692.765753198614;6290.559660823698;6301.14934483848;6323.336049714806;6327.746890124344;6331.936680633226;5711.8000869969355;5714.571407144481;5730.7421166047625;5763.7982670606325;5828.708564571754;6771.93228067713;6862.313768623198;6871.278515755774;6938.410235130071;7015;6523.18460192476;6634.933650663432;6646.700898459484;6666.733330666913;6670.299618539983;6929.376356127973;6994.790156295319;7000.684969176297;7010.123734533184;7017.298270172942;6376.107344971615;6471.805845824632;6518.185226846645;6553.5084868634085;6582;6504.6747662615735;6559.048937903882;6635.469162467088;6675.899861502178;6691.1636045494315;6440.484761219185;6470.48236141117;6482.481401487776;6483;6488.091667166506;6294.685265736786;6385.169927909342;6413.967930160506;6454.428245561725;6500.057491663777;6367.713452894724;6384.680765961776;6414.583052101599;6430.517711171775;6469.997150441689;6521.087047813215;6525.836854078686;6526.706298216686;6543.967280163759;6547.803565893031;6130.693465326805;6326.114343991937;6347.71435285404;6351.237851457855;6354.555181137461 07:39:12 INFO - PID 2128 | |1;ext.html;680.5984469163193;731.1372580355181;745.027738800865;1120.4341807387264;1142.4459137318404;35447.29105417893;36225.45661815075;36292.81853590732;36304;36394.63605363946;37600.623993760055;37813;37935.430968535424;38001.23997520048;38047.809760951226;6977.930220697779;7044.929550704504;7147.749828755968;7158.747219236639;7179.784606461814;7101.786946391617;7108.360247577717;7131.358177764;7137.964310178468;7183.281671832801;7120.715171393138;7206.891896621555;7219.0976127984;7245.673944672476;7265.382442492368;7150.213476517579;7158.7494437694695;7195.640217989079;7207.243239459834;7208.135023797152;6982.301769823028;6995.8600827983155;6999.335063168991;7029.507934444591;7034.7537836176;34328.65671343305;34335.82832085848;34511.137221569414;34590.481142782875;34690.4389302482;3452.6202117767025;3495.1611613212644;3519.595246546629;3525.435930251173;3526.3828829954914;28038.579421308696;28050.298742531395;28310.575341369895;28352.149435516967;28394;3709.5548534176073;3712.424574191005;3723.478712980185;3735.831887565039;3742.0644838790304;192681.5854731618;195960;197620;208930;218883.90558047267;45911.17932617094;46107;46306.30540541895;46326.305105423446;46610;47523.76238118787;47731;53253;53264.46735532595;53756;15753.13357765334;15970.60073498172;15980.600484987968;15983.041017538984;15998.680026399406;12579.37103144839;12676.683082922817;12680.365981700877;12718.10973231865;12756.362181890869;14556.199409032393;14578.781318280235;14581;14659.413623454942;14662.193579353238;5831.241938547962;5886.852828679317;6025.860819409134;6030.427109424598;6039.577229593886;1017.9847302290472;1060.4909643371225;1095.895889890459;1100.0594491709633;1143.1255089856268;25011.4997700045;25172.370690732878;25473.363165921;25655.615165772528;26068.60897086545;1205.2527432991426;1206.867244603093;1210.1891732539043;1214.5931113077042;1239.423667994387;13422.597322080353;13592.320383980761;13613;13659.453621855213;13680.384382702803;260496;261106;262257;262700;263452;50580;50841.49158508368;50966.490335096176;51066.744666277176;51236.487635123915;1500.2648702135875;1520.1335238913714;1543.9305231264395;1555.2379334126422;1557.6028112831382;24085.75914240835;24640;24991.87504062468;25023.749762502142;25097.623535647344;37089.44365834461;37325.25349493049;37508.2498350026;37513;37620.435693465166;211783;211931;212873;213967;214348;33466.665333346355;33516.162095947795;33587.328253435284;33968;34129.829350853084;39892;40068.79965600153;40172.799136005306;41295.1740965173;41515.7924210377;27717;28153.718462815108;28238;28881.277968050967;29609.555856661736;30355.544666830458;31402.768576309754;32252;32709.509357360133;33165.17087072746;38154.61845381511;38171.809140954116;38296.61703382931;38485;38561.614383855805;30968.53547196839;30978;31055.378892421573;31732.524012139376;32563.40670085576;25376;25805.612915806654;25952;26090;26520.204393868215 07:39:12 INFO - PID 2128 | |2;jquery.html;438.9956100438995;439.54726631569486;454.98407555735554;462.61833986960767;466.8576084294291;19045.428637140907;19944.102515386807;20450;20599;20727.792722072794;21698.783012169875;22712.205072822453;23303.417414564643;23395.64906526399;23417.297481075595;5484.561235101182;5622.606417550773;5632.3804381518;5640.830775076754;5641.407652196502;5320.600954928376;5576.972115139439;5591.440855914397;5593.720313984305;5600.5799565032585;5549.084401073818;5562.137868630369;5569.331680198382;5576;5587.525060369873;5351.598630102758;5550;5550.944490555104;5559.277293951781;5559.583031272671;4958.404991401055;5043.9747801260755;5048.116579598555;5052.444231134572;5071.1632580624155;25891.611625825626;26022.21933341984;26323.34191645205;26334.20997370082;26626.06808761684;2174.3911704722705;2200.2739096098408;2202.7246594175726;2214.944626384337;2230.408941630469;16902.07038612876;17175.484735457958;17475.47573572782;17539.73690394645;17858.19638116275;2251.324602619208;2259.898304576298;2274.4200228941513;2284.954300913989;2292.33522278539;111811.44094279477;112752;118792.40603797013;119308;122861;12392.194507356993;12541.184822986477;12799.680007999688;13007.674808129683;13067.150635208682;18013;18014.909925450287;18086.728699069525;18104.818951810576;18148;8627.827443451095;8641.222289993932;8810.911890881009;8913.420627659181;8974.37179397449;7976.282134607914;8127.349812015024;8140.466045141284;8223.136570660114;8336.416450848503;7997.560134192675;8092.8381432371025;8219.383546234056;8274.213949674771;8316.667333306721;2282.1213832674207;2304.469971906471;2312.710416687501;2322.8954697038675;2462.212092130537;1016.6086056868158;1037.2428127466992;1041.7187359412917;1054.1408751867357;1059.8304271316551;19824.405267841987;21446.047414156656;21454.356369308945;21546.569068618854;21707.782922170576;1046.68076236747;1055.9260851740457;1061.6655753437642;1061.787642471509;1063.8457423673524;11010.39442830652;11658.94170529142;11710;11814.88185118155;11861.525538978516;480933.8055569384;488260;490085;496588;499012;92656;96555.20466901189;98460.50769746248;98751;99973;1121.506537123663;1163.5113252433998;1199.772043311768;1201.3152503073165;1203.1277323940074;17526.386576469762;17737.37919172823;17880.910595446938;17896.731549026514;18032;46929;47425;47469.762651186524;49555.7522212401;49625;59675.50811229754;60274.698626506586;61420.38579614147;62018;62697.37302627098;9337.626494940398;9594.18449431806;9671.419714817133;9727.513624318897;9974.950125249326;15136.924315378352;15405.537833865003;15544.922275388551;15899.28453219631;16316.59208519749;13447.663808404868;13548.187108773505;13570.457181713016;13609.251491168081;13680.657983550092;12525.123241373016;12543.93728031354;12574.182678125893;12707.872921271039;12927.482900683868;13476.393562289917;13566.118202316818;13842.307884605529;13947.442102315794;14164.220967846868;9407.529623518934;9535.618575256913;9560.330776845554;9586;9960.452175130438;13037;13155.408006639533;13270.27013514266;13510.594682159552;13559.322033898068 07:39:12 INFO - PID 2128 | |3;mootools.html;1340.5978206538039;1398.5454727213657;1398.580425872238;1401.075290308396;1406.2054938959482;10595.78808423832;10762.838557421625;10996.505157267922;11028.889711102896;11048.558057677683;11161.497732602033;11215.607453739121;11319.943400283008;11351.943240283808;11400.543978240881;2357.233898982829;2385.546746118232;2393.6648869158244;2394.8682822444844;2411.9035238590436;2291.072115793098;2306.1813056365;2329.9650505242435;2336.2407217654245;2341.590221711202;2154.8383871209644;2156.385430152399;2176.9020394082304;2178;2183.858049226803;2259.5029093599383;2268.965965510519;2290.4731911660247;2294.0823670531836;2295.8737269450176;1914.1960376641844;1992.1035534009754;2266.4560505478566;2313;2319.327395055449;11210.103191744642;11226.66320010401;11274.32354058751;11287.435628218556;11299.322040677585;6062.302835173968;6296.748130074791;6321.367863213688;6336.176297081396;6357.141785858896;3763.4919285896326;3972.682185425188;4045.615666511677;4056.450605719995;4125.071858831769;1305.9477620895152;1337.4917531338028;1361.9591412257548;1396.2250950722346;1402.978955315671;16160.434384796594;16179.83820161807;16202.75695864563;16243.756343654737;16254.75617865733;4965.925511117336;5029.974850125799;5200.6879587224885;5208.270842082112;5227.477252274742;11545.595904143483;11548.133889958119;11607.6517704469;11621.6513504595;11671.766564668658;6124.5712800103565;6184.165137706442;6194.5973511721595;6207.379262073847;6208.50331973441;5845.152452894306;5884.264466941632;5893.764249429974;5930.703464826742;6046.18376519173;4159.646430053479;4182.916341673211;4185.665146788249;4233.322668373045;4257.957420425818;1189.7501524679742;1191.755690083531;1197.5030362399507;1204.1029433072417;1207.8007128823647;796.6415113199083;810.6473683947502;825.793551612097;829.0755807274966;849.8640217565284;5837.532997360201;5900.409959004065;5973.55198360116;6019.849503762353;6058.909116363258;640.4268179978893;650.4146268358421;653.3172834388076;662.2781168526329;668.7391917152314;3905.4727611772614;4011.859584914514;4292.892677683083;4379.671524635665;4409.250427427345;14431;14530.709385812224;14918.254087295592;14981.625459363604;15040.623984400478;14227.715445691236;14617.561473155822;14736.715809049614;14817.481388151364;14938;8954.686585969459;9069.863952040725;9140.588673509708;9327.486988215713;9344.112309330738;6532.41208291256;6683.030960510796;6768.424683901923;6812.114425124901;6946.687399066953;13047.608571742863;13069;13183.274919879499;13219.471221151047;13341.866581334063;13295.135816171918;13437.328133593477;13530.932345338604;13648.727025459237;13789.586312410644;8786.956065219632;9110.271178305587;9338.206252468617;9431.198348140484;9452.669156579486;10917.727056823644;10939.945300273448;10990.285631433931;11003.504842282277;11009.944950275198;9132.086791320815;9309.534523273674;9497.620095196115;9499.145076943109;9567.808643827224;9123.863142052742;9147.405418647766;9206.815863682556;9253.167214950687;9487.620495180116;7118.8932166018585;7201.783946481614;7250;7265.636718163965;7275.527090739085;6095.481884039907;6107.358727333566;6128.172696686069;6155.953487906977;6304.338044505261;6147.508199344131;6298.622082675054;6309.3690630936535;6492.35076492347;6500.057491663777 07:39:12 INFO - PID 2128 | |4;prototype.html;411.0504734064311;414.5419311660615;419.9937000944984;423.5425740200584;427.15849775941405;6010.8797824043495;6187.5668703190795;6229.750809967607;6232.626042437457;6247.593906396081;5993.940060599392;6042.788502402417;6071.392860713938;6086.178365920599;6101.725422355994;4514.503404625489;4590.70160439572;4604.355390245369;4615.007773328751;4642.883927901796;4626.259798432252;4628.745419001953;4639.16495030896;4640.60554852838;4658.208104622222;4606.33208184813;4609.608183304423;4617.399738034051;4628.791704373311;4635.513271106536;4635.698679585833;4667.789949452283;4741.668083234175;4767.261074533453;4795.6882802618065;4323.654107671378;4328;4344.717593356453;4346.413234213404;4370.562943705636;5949.553783466257;6018.337982821886;6062.696865156725;6095.116208149793;6107.236595425572;5720.742566584472;5738.913916291259;5743.9425605744245;5759.48164665178;5781.248437703114;6602.401691078374;6609.537332386735;6617.371349721769;6629.801105966829;6637.502187335969;4857.975710121426;4862.756862156878;4909.607231421478;4943.085529177078;5004.274380214885;6684.331566843325;6877.277885821966;6899.17209934806;6939.757108501229;6947.235804061549;4770.141374552544;4792.520747925179;4802.855914322576;4815.927761083586;4820.879478013007;4850.054239423279;4860.3681521401995;4862.176683743596;4865.5864251538305;4873.683210591371;5467.917981230285;5545.584081193927;5555.666660000332;5559.249501317351;5586.162075688598;6517.641529715911;6525.021246813016;6533.497295622034;6552.410283074546;6553.8361540960905;1791.3461586521087;1794.6321004194108;1798.352593066495;1804.9909750451427;1812.9728054078935;1244.8630650628425;1270.6632742323293;1291.5350473829415;1300.590314051071;1315.526410492222;6301.684915754194;6315.8105256841445;6333.2400111985935;6375.489960803125;6378.2346118466085;6679.231888332807;6702.229243637044;6722.932770672329;6734.56225345351;6735.764248251287;6025.9096113558335;6219.284782250009;6255.343188965184;6302.243730752339;6378.936210637834;3545.8227088645463;3553.5913369962786;3556.7332450066347;3574.91062723434;3580.15866271426;6909.825329693964;6975.267596902354;7045.964770176116;7051.400630946325;7093.92906070943;6872.831618624746;6879.724811007603;6884.759033433806;6931.826704332432;6943;6754.527183097136;7047.68285427157;7071.29287071299;7112.715491380287;7144.9642751785905;6732.124823772878;6762.019507171531;6763.222229443677;6764.729410823512;6778.186617605918;6516.315786842313;6536.411722944958;6632.369924857131;6662;6663.466922646274;6996.230414654486;7017.3684368407085;7061.788146355618;7070.7525236616475;7085.0435191248525;4603.217453032926;4605.769711514344;4618.145643056046;4621.584057434847;4639.536046395334;6763.695633696397;6767.187937447341;6811.046453496416;6814.591124532346;6877.724891004304;6567.9671601643595;6598.637074960731;6611.900821487778;6619.602823830585;6624.56940298879;6428.55000149985;6509.772157974448;6564.868702625825;6578.572392794453;6630.126856760181;6561.475081993524;6580.440662543546;6584.473242140713;6592.43964263043;6594.340565943367;6428.582142160744;6580;6630.9668451657435;6637.590363853444;6681.69932353055;6417.1657684500715;6436.195475565554;6436.485081193587;6475.255345635313;6491.4806815455595 07:39:12 INFO - PID 2128 | |5;yui.html;848.626183552909;869.6477926439792;880.3441436130084;883.7437143228464;894.0567701075363;15465.536033918987;15918.283677234538;15955;18647;20292.898535507302;17270.2228399722;17511.299548018094;17746.201420936057;18365.90817045913;18859.62280754384;984.3749219245794;1003.6788227767081;1009.4599389326712;1013.2906965124406;1015.2385710716962;986.0780170540531;1011.9190464762838;1036.533559898045;1038.7403149212696;1038.7558923652934;1076.6178006807588;1080.686600885742;1086.6739978006606;1087.47257580074;1089.4280502736049;1063.5692544519482;1077.5582011375297;1078.4338222433207;1078.800421921943;1078.8112080385902;794.1185284334384;795.018152581567;798.2137594469443;798.4171554764996;800.4836880212231;16373.508794736177;16519.421820236355;16553.172341382884;17092.40176593813;17132.914335428242;18668.346607868796;18933.242670293173;19079.141438635295;19178.232870685155;19300.80699193004;13977.3710183042;14333.28333583327;14375.568732938029;14492.985491015634;14530.92734536331;3345.8159801210923;3366.461366181399;3372.5109859070544;3379.8141102239365;3381.1209085637665;90736.99999999935;91191.54404228003;91362;91651;92785;14417;14514.346854391366;14571.271436428136;14749.262536873113;14791.450051987445;26634.6004809928;27113.45773084527;27308.45383092327;27438.862805685843;28056.43887122246;7656.846863062708;8445.493270403795;8453.281471074904;8585.098564650621;8603.139686031473;4069.2878746219294;4167.729097608646;4199.559046300155;4200.05498762782;4218.156368726206;4422.358757980075;4528.117017181618;4532;4544.318352247124;4667.229907065296;903.6633804688569;914.6844338703137;918.9540522973958;925.4817302310593;927.0636656976368;682.7610336382326;698.448225901532;711.7935798618342;718.2781304788758;730.050933786076;11122.110231181487;11630.53477860893;11726.296422214695;12142.575009874789;12234.21980612658;714.7677004973405;715.6493318274008;716.6237725194211;722.1298335505703;743.2084829656399;5695.345035320908;5965.373635768268;6099.451049405486;6230.158928544679;6312.021636646327;76535.23464765392;78443.60778196073;78978;79636.60181699054;82688;67609.20320076663;68228.65885670639;68456.6577167121;69000;72459;60517.09224361638;60633;61454.07818882631;61497;62446.37553624497;11645.5341786331;11899.464524096264;12002.819957700816;12173.573924912585;12186.817197741864;32060.5190922141;32596.83701581477;32617.510737338485;32700.182495437806;33815.83092084622;39085.41371879367;52612;52982.755438496664;55326;55436.445635543125;15081;15132.697346053237;15328.540143795704;15337.846621533641;15388.538343849703;18236.270549177883;18290;18374.540636484195;18945.810541894403;19031.619367612846;16258;16273.75589366184;16469.176541172656;16509.09199994012;16906.915465422593;15801.20993950321;15914.204289785695;16171.191440427696;16244.269007894436;16419.58951026234;14414.207218603078;14492.492762753252;14673.119612822838;14897.255137243312;14898.404063837324;11080.168987325822;11418.885811141783;11438.771224575628;11503.539858405904;11724.296542207494;11046.668599942015;11173.441327933408;11210.43947802623;11408;11547.364894930859 07:39:12 INFO - PID 2128 | __end_tp_report 07:39:12 INFO - PID 2128 | __start_cc_report 07:39:12 INFO - PID 2128 | _x_x_mozilla_cycle_collect,333 07:39:12 INFO - PID 2128 | __end_cc_report 07:39:12 INFO - PID 2128 | __startTimestamp1493995152135__endTimestamp 07:39:12 INFO - PID 2128 | 07:39:12 INFO - PID 2128 | ------- Summary: start ------- 07:39:12 INFO - PID 2128 | Number of tests: 6 07:39:12 INFO - PID 2128 | 07:39:12 INFO - PID 2128 | [#0] dojo.html Cycles:165 Average:6096.24 Median:6364.11 stddev:744.75 (11.7%) stddev-sans-first:716.76 07:39:12 INFO - PID 2128 | Values: 3417.0 3418.6 3439.6 3443.6 3452.9 5946.9 6032.4 6034.3 6050.1 6082.1 6020.9 6028.1 6119.2 6137.4 6144.9 5038.4 5286.3 5359.0 5363.7 5365.7 5433.8 5484.0 5504.8 5508.9 5513.3 5310.8 5369.4 5372.1 5432.9 5454.2 5417.5 5458.0 5472.3 5474.6 5487.8 5346.2 5397.8 5409.4 5409.5 5419.2 5945.6 6035.0 6106.7 6107.7 6114.4 6394.9 6516.4 6582.5 6589.8 6658.8 6684.1 6692.4 6695.6 6700.3 6704.2 6088.7 6146.2 6204.6 6231.1 6242.0 6506.3 6570.7 6642.9 6788.3 6812.4 6345.8 6364.1 6388.9 6523.7 6566.4 6479.1 6586.4 6611.4 6639.5 6641.6 6594.8 6640.7 6641.1 6645.9 6656.7 6436.8 6513.1 6518.2 6646.7 6664.5 5007.6 5056.5 5082.1 5085.6 5092.9 4462.1 4465.7 4475.1 4488.7 4563.8 6245.7 6260.8 6262.2 6285.1 6302.9 6475.8 6509.2 6555.5 6684.0 6692.8 6290.6 6301.1 6323.3 6327.7 6331.9 5711.8 5714.6 5730.7 5763.8 5828.7 6771.9 6862.3 6871.3 6938.4 7015.0 6523.2 6634.9 6646.7 6666.7 6670.3 6929.4 6994.8 7000.7 7010.1 7017.3 6376.1 6471.8 6518.2 6553.5 6582.0 6504.7 6559.0 6635.5 6675.9 6691.2 6440.5 6470.5 6482.5 6483.0 6488.1 6294.7 6385.2 6414.0 6454.4 6500.1 6367.7 6384.7 6414.6 6430.5 6470.0 6521.1 6525.8 6526.7 6544.0 6547.8 6130.7 6326.1 6347.7 6351.2 6354.6 07:39:12 INFO - PID 2128 | 07:39:12 INFO - PID 2128 | [#1] ext.html Cycles:180 Average:38650.33 Median:34048.91 stddev:59111.78 (173.6%) stddev-sans-first:59208.85 07:39:12 INFO - PID 2128 | Values: 680.6 731.1 745.0 1120.4 1142.4 35447.3 36225.5 36292.8 36304.0 36394.6 37600.6 37813.0 37935.4 38001.2 38047.8 6977.9 7044.9 7147.7 7158.7 7179.8 7101.8 7108.4 7131.4 7138.0 7183.3 7120.7 7206.9 7219.1 7245.7 7265.4 7150.2 7158.7 7195.6 7207.2 7208.1 6982.3 6995.9 6999.3 7029.5 7034.8 34328.7 34335.8 34511.1 34590.5 34690.4 3452.6 3495.2 3519.6 3525.4 3526.4 28038.6 28050.3 28310.6 28352.1 28394.0 3709.6 3712.4 3723.5 3735.8 3742.1 192681.6 195960.0 197620.0 208930.0 218883.9 45911.2 46107.0 46306.3 46326.3 46610.0 47523.8 47731.0 53253.0 53264.5 53756.0 15753.1 15970.6 15980.6 15983.0 15998.7 12579.4 12676.7 12680.4 12718.1 12756.4 14556.2 14578.8 14581.0 14659.4 14662.2 5831.2 5886.9 6025.9 6030.4 6039.6 1018.0 1060.5 1095.9 1100.1 1143.1 25011.5 25172.4 25473.4 25655.6 26068.6 1205.3 1206.9 1210.2 1214.6 1239.4 13422.6 13592.3 13613.0 13659.5 13680.4 260496.0 261106.0 262257.0 262700.0 263452.0 50580.0 50841.5 50966.5 51066.7 51236.5 1500.3 1520.1 1543.9 1555.2 1557.6 24085.8 24640.0 24991.9 25023.7 25097.6 37089.4 37325.3 37508.2 37513.0 37620.4 211783.0 211931.0 212873.0 213967.0 214348.0 33466.7 33516.2 33587.3 33968.0 34129.8 39892.0 40068.8 40172.8 41295.2 41515.8 27717.0 28153.7 28238.0 28881.3 29609.6 30355.5 31402.8 32252.0 32709.5 33165.2 38154.6 38171.8 38296.6 38485.0 38561.6 30968.5 30978.0 31055.4 31732.5 32563.4 25376.0 25805.6 25952.0 26090.0 26520.2 07:39:12 INFO - PID 2128 | 07:39:12 INFO - PID 2128 | [#2] jquery.html Cycles:180 Average:31503.48 Median:2283.54 stddev:81788.70 (3581.7%) stddev-sans-first:81984.88 07:39:12 INFO - PID 2128 | Values: 439.0 439.5 455.0 462.6 466.9 19045.4 19944.1 20450.0 20599.0 20727.8 21698.8 22712.2 23303.4 23395.6 23417.3 5484.6 5622.6 5632.4 5640.8 5641.4 5320.6 5577.0 5591.4 5593.7 5600.6 5549.1 5562.1 5569.3 5576.0 5587.5 5351.6 5550.0 5550.9 5559.3 5559.6 4958.4 5044.0 5048.1 5052.4 5071.2 25891.6 26022.2 26323.3 26334.2 26626.1 2174.4 2200.3 2202.7 2214.9 2230.4 16902.1 17175.5 17475.5 17539.7 17858.2 2251.3 2259.9 2274.4 2285.0 2292.3 111811.4 112752.0 118792.4 119308.0 122861.0 12392.2 12541.2 12799.7 13007.7 13067.2 18013.0 18014.9 18086.7 18104.8 18148.0 8627.8 8641.2 8810.9 8913.4 8974.4 7976.3 8127.3 8140.5 8223.1 8336.4 7997.6 8092.8 8219.4 8274.2 8316.7 2282.1 2304.5 2312.7 2322.9 2462.2 1016.6 1037.2 1041.7 1054.1 1059.8 19824.4 21446.0 21454.4 21546.6 21707.8 1046.7 1055.9 1061.7 1061.8 1063.8 11010.4 11658.9 11710.0 11814.9 11861.5 480933.8 488260.0 490085.0 496588.0 499012.0 92656.0 96555.2 98460.5 98751.0 99973.0 1121.5 1163.5 1199.8 1201.3 1203.1 17526.4 17737.4 17880.9 17896.7 18032.0 46929.0 47425.0 47469.8 49555.8 49625.0 59675.5 60274.7 61420.4 62018.0 62697.4 9337.6 9594.2 9671.4 9727.5 9975.0 15136.9 15405.5 15544.9 15899.3 16316.6 13447.7 13548.2 13570.5 13609.3 13680.7 12525.1 12543.9 12574.2 12707.9 12927.5 13476.4 13566.1 13842.3 13947.4 14164.2 9407.5 9535.6 9560.3 9586.0 9960.5 13037.0 13155.4 13270.3 13510.6 13559.3 07:39:12 INFO - PID 2128 | 07:39:12 INFO - PID 2128 | [#3] mootools.html Cycles:180 Average:6958.29 Median:3834.48 stddev:4468.67 (116.5%) stddev-sans-first:4461.27 07:39:12 INFO - PID 2128 | Values: 1340.6 1398.5 1398.6 1401.1 1406.2 10595.8 10762.8 10996.5 11028.9 11048.6 11161.5 11215.6 11319.9 11351.9 11400.5 2357.2 2385.5 2393.7 2394.9 2411.9 2291.1 2306.2 2330.0 2336.2 2341.6 2154.8 2156.4 2176.9 2178.0 2183.9 2259.5 2269.0 2290.5 2294.1 2295.9 1914.2 1992.1 2266.5 2313.0 2319.3 11210.1 11226.7 11274.3 11287.4 11299.3 6062.3 6296.7 6321.4 6336.2 6357.1 3763.5 3972.7 4045.6 4056.5 4125.1 1305.9 1337.5 1362.0 1396.2 1403.0 16160.4 16179.8 16202.8 16243.8 16254.8 4965.9 5030.0 5200.7 5208.3 5227.5 11545.6 11548.1 11607.7 11621.7 11671.8 6124.6 6184.2 6194.6 6207.4 6208.5 5845.2 5884.3 5893.8 5930.7 6046.2 4159.6 4182.9 4185.7 4233.3 4258.0 1189.8 1191.8 1197.5 1204.1 1207.8 796.6 810.6 825.8 829.1 849.9 5837.5 5900.4 5973.6 6019.8 6058.9 640.4 650.4 653.3 662.3 668.7 3905.5 4011.9 4292.9 4379.7 4409.3 14431.0 14530.7 14918.3 14981.6 15040.6 14227.7 14617.6 14736.7 14817.5 14938.0 8954.7 9069.9 9140.6 9327.5 9344.1 6532.4 6683.0 6768.4 6812.1 6946.7 13047.6 13069.0 13183.3 13219.5 13341.9 13295.1 13437.3 13530.9 13648.7 13789.6 8787.0 9110.3 9338.2 9431.2 9452.7 10917.7 10939.9 10990.3 11003.5 11009.9 9132.1 9309.5 9497.6 9499.1 9567.8 9123.9 9147.4 9206.8 9253.2 9487.6 7118.9 7201.8 7250.0 7265.6 7275.5 6095.5 6107.4 6128.2 6156.0 6304.3 6147.5 6298.6 6309.4 6492.4 6500.1 07:39:12 INFO - PID 2128 | 07:39:12 INFO - PID 2128 | [#4] prototype.html Cycles:180 Average:5527.98 Median:6240.11 stddev:1624.96 (26.0%) stddev-sans-first:1583.48 07:39:12 INFO - PID 2128 | Values: 411.1 414.5 420.0 423.5 427.2 6010.9 6187.6 6229.8 6232.6 6247.6 5993.9 6042.8 6071.4 6086.2 6101.7 4514.5 4590.7 4604.4 4615.0 4642.9 4626.3 4628.7 4639.2 4640.6 4658.2 4606.3 4609.6 4617.4 4628.8 4635.5 4635.7 4667.8 4741.7 4767.3 4795.7 4323.7 4328.0 4344.7 4346.4 4370.6 5949.6 6018.3 6062.7 6095.1 6107.2 5720.7 5738.9 5743.9 5759.5 5781.2 6602.4 6609.5 6617.4 6629.8 6637.5 4858.0 4862.8 4909.6 4943.1 5004.3 6684.3 6877.3 6899.2 6939.8 6947.2 4770.1 4792.5 4802.9 4815.9 4820.9 4850.1 4860.4 4862.2 4865.6 4873.7 5467.9 5545.6 5555.7 5559.2 5586.2 6517.6 6525.0 6533.5 6552.4 6553.8 1791.3 1794.6 1798.4 1805.0 1813.0 1244.9 1270.7 1291.5 1300.6 1315.5 6301.7 6315.8 6333.2 6375.5 6378.2 6679.2 6702.2 6722.9 6734.6 6735.8 6025.9 6219.3 6255.3 6302.2 6378.9 3545.8 3553.6 3556.7 3574.9 3580.2 6909.8 6975.3 7046.0 7051.4 7093.9 6872.8 6879.7 6884.8 6931.8 6943.0 6754.5 7047.7 7071.3 7112.7 7145.0 6732.1 6762.0 6763.2 6764.7 6778.2 6516.3 6536.4 6632.4 6662.0 6663.5 6996.2 7017.4 7061.8 7070.8 7085.0 4603.2 4605.8 4618.1 4621.6 4639.5 6763.7 6767.2 6811.0 6814.6 6877.7 6568.0 6598.6 6611.9 6619.6 6624.6 6428.6 6509.8 6564.9 6578.6 6630.1 6561.5 6580.4 6584.5 6592.4 6594.3 6428.6 6580.0 6631.0 6637.6 6681.7 6417.2 6436.2 6436.5 6475.3 6491.5 07:39:12 INFO - PID 2128 | 07:39:12 INFO - PID 2128 | [#5] yui.html Cycles:180 Average:18738.89 Median:19239.52 stddev:22885.62 (119.0%) stddev-sans-first:22910.39 07:39:12 INFO - PID 2128 | Values: 848.6 869.6 880.3 883.7 894.1 15465.5 15918.3 15955.0 18647.0 20292.9 17270.2 17511.3 17746.2 18365.9 18859.6 984.4 1003.7 1009.5 1013.3 1015.2 986.1 1011.9 1036.5 1038.7 1038.8 1076.6 1080.7 1086.7 1087.5 1089.4 1063.6 1077.6 1078.4 1078.8 1078.8 794.1 795.0 798.2 798.4 800.5 16373.5 16519.4 16553.2 17092.4 17132.9 18668.3 18933.2 19079.1 19178.2 19300.8 13977.4 14333.3 14375.6 14493.0 14530.9 3345.8 3366.5 3372.5 3379.8 3381.1 90737.0 91191.5 91362.0 91651.0 92785.0 14417.0 14514.3 14571.3 14749.3 14791.5 26634.6 27113.5 27308.5 27438.9 28056.4 7656.8 8445.5 8453.3 8585.1 8603.1 4069.3 4167.7 4199.6 4200.1 4218.2 4422.4 4528.1 4532.0 4544.3 4667.2 903.7 914.7 919.0 925.5 927.1 682.8 698.4 711.8 718.3 730.1 11122.1 11630.5 11726.3 12142.6 12234.2 714.8 715.6 716.6 722.1 743.2 5695.3 5965.4 6099.5 6230.2 6312.0 76535.2 78443.6 78978.0 79636.6 82688.0 67609.2 68228.7 68456.7 69000.0 72459.0 60517.1 60633.0 61454.1 61497.0 62446.4 11645.5 11899.5 12002.8 12173.6 12186.8 32060.5 32596.8 32617.5 32700.2 33815.8 39085.4 52612.0 52982.8 55326.0 55436.4 15081.0 15132.7 15328.5 15337.8 15388.5 18236.3 18290.0 18374.5 18945.8 19031.6 16258.0 16273.8 16469.2 16509.1 16906.9 15801.2 15914.2 16171.2 16244.3 16419.6 14414.2 14492.5 14673.1 14897.3 14898.4 11080.2 11418.9 11438.8 11503.5 11724.3 11046.7 11173.4 11210.4 11408.0 11547.4 07:39:12 INFO - PID 2128 | -------- Summary: end -------- 07:39:12 INFO - PID 2128 | 07:39:12 INFO - TEST-INFO | 2128: exit 0 07:39:12 INFO - TEST-OK | dromaeo_css | took 1113858ms 07:39:12 INFO - TEST-START | kraken 07:39:12 INFO - operating with platform_type : linux_ 07:39:12 INFO - Initialising browser for kraken test... 07:39:12 INFO - TEST-INFO | started process 2683 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1yowCW/profile http://localhost:46220/getInfo.html) 07:39:16 INFO - PID 2683 | __metrics Screen width/height:1600/1200 07:39:16 INFO - PID 2683 | colorDepth:24 07:39:16 INFO - PID 2683 | Browser inner width/height: 1024/695 07:39:16 INFO - PID 2683 | __metrics 07:39:18 INFO - TEST-INFO | 2683: exit 0 07:39:18 INFO - Browser initialized. 07:39:18 INFO - Running cycle 1/1 for kraken test... 07:39:18 INFO - TEST-INFO | started process 2953 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1yowCW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:39:30 INFO - PID 2953 | RSS: Main: 156573696 07:39:30 INFO - PID 2953 | 07:39:32 INFO - PID 2953 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46220/tests/kraken/driver.html?testName=audio-beat-detection) 07:39:33 INFO - PID 2953 | RSS: Main: 162746368 07:39:33 INFO - PID 2953 | 07:39:36 INFO - PID 2953 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46220/tests/kraken/driver.html?testName=audio-dft) 07:39:36 INFO - PID 2953 | RSS: Main: 161038336 07:39:36 INFO - PID 2953 | 07:39:39 INFO - PID 2953 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46220/tests/kraken/driver.html?testName=audio-fft) 07:39:40 INFO - PID 2953 | RSS: Main: 157016064 07:39:40 INFO - PID 2953 | 07:39:42 INFO - PID 2953 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46220/tests/kraken/driver.html?testName=audio-oscillator) 07:39:43 INFO - PID 2953 | RSS: Main: 158457856 07:39:43 INFO - PID 2953 | 07:39:45 INFO - PID 2953 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46220/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:39:45 INFO - PID 2953 | RSS: Main: 158404608 07:39:45 INFO - PID 2953 | 07:39:48 INFO - PID 2953 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46220/tests/kraken/driver.html?testName=imaging-darkroom) 07:39:49 INFO - PID 2953 | RSS: Main: 162799616 07:39:49 INFO - PID 2953 | 07:39:52 INFO - PID 2953 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46220/tests/kraken/driver.html?testName=imaging-desaturate) 07:39:53 INFO - PID 2953 | RSS: Main: 165339136 07:39:53 INFO - PID 2953 | 07:39:56 INFO - PID 2953 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46220/tests/kraken/driver.html?testName=json-parse-financial) 07:39:56 INFO - PID 2953 | RSS: Main: 164810752 07:39:56 INFO - PID 2953 | 07:39:58 INFO - PID 2953 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46220/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:39:58 INFO - PID 2953 | RSS: Main: 164069376 07:39:58 INFO - PID 2953 | 07:40:00 INFO - PID 2953 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46220/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:40:01 INFO - PID 2953 | RSS: Main: 164446208 07:40:01 INFO - PID 2953 | 07:40:03 INFO - PID 2953 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46220/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:40:03 INFO - PID 2953 | RSS: Main: 164835328 07:40:03 INFO - PID 2953 | 07:40:06 INFO - PID 2953 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46220/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:40:07 INFO - PID 2953 | RSS: Main: 164573184 07:40:07 INFO - PID 2953 | 07:40:10 INFO - PID 2953 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46220/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:40:10 INFO - PID 2953 | RSS: Main: 165122048 07:40:10 INFO - PID 2953 | 07:40:12 INFO - PID 2953 | Cycle 1(1): loaded http://localhost:46220/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46220/tests/kraken/driver.html?testName=ai-astar) 07:40:12 INFO - PID 2953 | RSS: Main: 167153664 07:40:12 INFO - PID 2953 | 07:40:12 INFO - PID 2953 | __start_tp_report 07:40:12 INFO - PID 2953 | _x_x_mozilla_page_load 07:40:12 INFO - PID 2953 | _x_x_mozilla_page_load_details 07:40:12 INFO - PID 2953 | |i|pagename|runs| 07:40:12 INFO - PID 2953 | |0;ai-astar;101;110;111;112;110;110;110;111;110;112 07:40:12 INFO - PID 2953 | |1;audio-beat-detection;147;119;120;171;121;121;118;116;139;117 07:40:12 INFO - PID 2953 | |2;audio-dft;164;164;163;162;164;161;167;168;172;164 07:40:12 INFO - PID 2953 | |3;audio-fft;73;77;77;98;74;73;74;75;91;74 07:40:12 INFO - PID 2953 | |4;audio-oscillator;84;84;101;82;84;83;94;81;81;107 07:40:12 INFO - PID 2953 | |5;imaging-gaussian-blur;114;114;113;113;114;114;114;114;114;114 07:40:12 INFO - PID 2953 | |6;imaging-darkroom;149;148;148;148;150;148;149;148;149;148 07:40:12 INFO - PID 2953 | |7;imaging-desaturate;94;95;94;94;94;95;94;94;95;94 07:40:12 INFO - PID 2953 | |8;json-parse-financial;46;49;45;46;49;47;47;48;47;48 07:40:12 INFO - PID 2953 | |9;json-stringify-tinderbox;56;56;61;56;56;56;55;56;56;55 07:40:12 INFO - PID 2953 | |10;stanford-crypto-aes;82;83;82;85;81;81;84;82;83;83 07:40:12 INFO - PID 2953 | |11;stanford-crypto-ccm;127;125;127;130;129;127;135;131;176;126 07:40:12 INFO - PID 2953 | |12;stanford-crypto-pbkdf2;180;185;175;184;185;184;189;193;185;184 07:40:12 INFO - PID 2953 | |13;stanford-crypto-sha256-iterative;66;68;66;65;64;69;66;64;66;64 07:40:12 INFO - PID 2953 | __end_tp_report 07:40:12 INFO - PID 2953 | __start_cc_report 07:40:12 INFO - PID 2953 | _x_x_mozilla_cycle_collect,761 07:40:12 INFO - PID 2953 | __end_cc_report 07:40:12 INFO - PID 2953 | __startTimestamp1493995212621__endTimestamp 07:40:12 INFO - PID 2953 | 07:40:12 INFO - PID 2953 | ------- Summary: start ------- 07:40:12 INFO - PID 2953 | Number of tests: 14 07:40:12 INFO - PID 2953 | 07:40:12 INFO - PID 2953 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:3.16 (2.9%) stddev-sans-first:0.87 07:40:12 INFO - PID 2953 | Values: 101.0 110.0 111.0 112.0 110.0 110.0 110.0 111.0 110.0 112.0 07:40:12 INFO - PID 2953 | 07:40:12 INFO - PID 2953 | [#1] audio-beat-detection Cycles:10 Average:128.90 Median:121.00 stddev:18.05 (14.9%) stddev-sans-first:17.91 07:40:12 INFO - PID 2953 | Values: 147.0 119.0 120.0 171.0 121.0 121.0 118.0 116.0 139.0 117.0 07:40:12 INFO - PID 2953 | 07:40:12 INFO - PID 2953 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:3.25 (2.0%) stddev-sans-first:3.43 07:40:12 INFO - PID 2953 | Values: 164.0 164.0 163.0 162.0 164.0 161.0 167.0 168.0 172.0 164.0 07:40:12 INFO - PID 2953 | 07:40:12 INFO - PID 2953 | [#3] audio-fft Cycles:10 Average:78.60 Median:76.00 stddev:8.66 (11.4%) stddev-sans-first:8.94 07:40:12 INFO - PID 2953 | Values: 73.0 77.0 77.0 98.0 74.0 73.0 74.0 75.0 91.0 74.0 07:40:12 INFO - PID 2953 | 07:40:12 INFO - PID 2953 | [#4] audio-oscillator Cycles:10 Average:88.10 Median:83.50 stddev:9.27 (11.1%) stddev-sans-first:9.71 07:40:12 INFO - PID 2953 | Values: 84.0 84.0 101.0 82.0 84.0 83.0 94.0 81.0 81.0 107.0 07:40:12 INFO - PID 2953 | 07:40:12 INFO - PID 2953 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:40:12 INFO - PID 2953 | Values: 114.0 114.0 113.0 113.0 114.0 114.0 114.0 114.0 114.0 114.0 07:40:12 INFO - PID 2953 | 07:40:12 INFO - PID 2953 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 07:40:12 INFO - PID 2953 | Values: 149.0 148.0 148.0 148.0 150.0 148.0 149.0 148.0 149.0 148.0 07:40:12 INFO - PID 2953 | 07:40:12 INFO - PID 2953 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:40:12 INFO - PID 2953 | Values: 94.0 95.0 94.0 94.0 94.0 95.0 94.0 94.0 95.0 94.0 07:40:12 INFO - PID 2953 | 07:40:12 INFO - PID 2953 | [#8] json-parse-financial Cycles:10 Average:47.20 Median:47.50 stddev:1.32 (2.8%) stddev-sans-first:1.32 07:40:12 INFO - PID 2953 | Values: 46.0 49.0 45.0 46.0 49.0 47.0 47.0 48.0 47.0 48.0 07:40:12 INFO - PID 2953 | 07:40:12 INFO - PID 2953 | [#9] json-stringify-tinderbox Cycles:10 Average:56.30 Median:56.00 stddev:1.70 (3.0%) stddev-sans-first:1.80 07:40:12 INFO - PID 2953 | Values: 56.0 56.0 61.0 56.0 56.0 56.0 55.0 56.0 56.0 55.0 07:40:12 INFO - PID 2953 | 07:40:12 INFO - PID 2953 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:1.26 (1.5%) stddev-sans-first:1.32 07:40:12 INFO - PID 2953 | Values: 82.0 83.0 82.0 85.0 81.0 81.0 84.0 82.0 83.0 83.0 07:40:12 INFO - PID 2953 | 07:40:12 INFO - PID 2953 | [#11] stanford-crypto-ccm Cycles:10 Average:133.30 Median:129.50 stddev:15.28 (11.8%) stddev-sans-first:16.04 07:40:12 INFO - PID 2953 | Values: 127.0 125.0 127.0 130.0 129.0 127.0 135.0 131.0 176.0 126.0 07:40:12 INFO - PID 2953 | 07:40:12 INFO - PID 2953 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.40 Median:185.00 stddev:4.77 (2.6%) stddev-sans-first:4.78 07:40:12 INFO - PID 2953 | Values: 180.0 185.0 175.0 184.0 185.0 184.0 189.0 193.0 185.0 184.0 07:40:12 INFO - PID 2953 | 07:40:12 INFO - PID 2953 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.69 (2.6%) stddev-sans-first:1.79 07:40:12 INFO - PID 2953 | Values: 66.0 68.0 66.0 65.0 64.0 69.0 66.0 64.0 66.0 64.0 07:40:12 INFO - PID 2953 | -------- Summary: end -------- 07:40:12 INFO - PID 2953 | 07:40:13 INFO - TEST-INFO | 2953: exit 0 07:40:13 INFO - TEST-OK | kraken | took 60839ms 07:40:13 INFO - SUITE-END | took 1174s 07:40:13 INFO - Completed test suite (00:19:34) 07:40:13 INFO - javascript benchmark 07:40:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7804.30703153741, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3416.9829150854243, 3418.589769227693, 3439.6044454887697, 3443.5523381960343, 3452.879149229776, 5946.851328716784, 6032.396760323971, 6034.275886893568, 6050.092486127083, 6082.057281121422, 6020.909686354697, 6028.125921741344, 6119.204503414561, 6137.4076293189555, 6144.877102457948, 5038.360669483346, 5286.3392075990505, 5358.973205133969, 5363.678179309234, 5365.678059316434, 5433.782648694048, 5484.040292948738, 5504.834854954358, 5508.91736623951, 5513.255710479074, 5310.814121505768, 5369.40936496985, 5372.0867452532775, 5432.91850622241, 5454.181872719124, 5417.485338892799, 5458.044842152647, 5472.315960504937, 5474.562035037187, 5487.835364939058, 5346.1713434417725, 5397.8110766123, 5409.43200963901, 5409.459054094598, 5419.187121931703, 5945.583809133363, 6034.969825150846, 6106.72519736613, 6107.664078475682, 6114.419130182626, 6394.8721025579225, 6516.380943810331, 6582.5063120265695, 6589.835254118638, 6658.833529161761, 6684.064231007663, 6692.397684208396, 6695.598264104169, 6700.296468870747, 6704.1954965403975, 6088.695565221721, 6146.231721034871, 6204.565680402328, 6231.065340199007, 6241.96879015602, 6506.284308726036, 6570.737170513222, 6642.86714265712, 6788.253292137861, 6812.352826481477, 6345.809625711236, 6364.109024736541, 6388.872222555616, 6523.739050438025, 6566.4418524425955, 6479.060536222221, 6586.4072233498255, 6611.438027767694, 6639.468842492685, 6641.601503909685, 6594.8351291218105, 6640.734370625121, 6641.070250164981, 6645.867082658319, 6656.667166641649, 6436.774712885027, 6513.055606936968, 6518.185226846645, 6646.700898459581, 6664.5334826561675, 5007.574356179765, 5056.469070747518, 5082.085224659523, 5085.593152547861, 5092.898142037213, 4462.062966776948, 4465.732056076581, 4475.060237350128, 4488.663350248745, 4563.840265590688, 6245.687715614201, 6260.780872669435, 6262.2172228471445, 6285.120083188357, 6302.936970630327, 6475.7733479328, 6509.1863517060365, 6555.541112122106, 6683.966580167068, 6692.765753198614, 6290.559660823698, 6301.14934483848, 6323.336049714806, 6327.746890124344, 6331.936680633226, 5711.8000869969355, 5714.571407144481, 5730.7421166047625, 5763.7982670606325, 5828.708564571754, 6771.93228067713, 6862.313768623198, 6871.278515755774, 6938.410235130071, 7015.0, 6523.18460192476, 6634.933650663432, 6646.700898459484, 6666.733330666913, 6670.299618539983, 6929.376356127973, 6994.790156295319, 7000.684969176297, 7010.123734533184, 7017.298270172942, 6376.107344971615, 6471.805845824632, 6518.185226846645, 6553.5084868634085, 6582.0, 6504.6747662615735, 6559.048937903882, 6635.469162467088, 6675.899861502178, 6691.1636045494315, 6440.484761219185, 6470.48236141117, 6482.481401487776, 6483.0, 6488.091667166506, 6294.685265736786, 6385.169927909342, 6413.967930160506, 6454.428245561725, 6500.057491663777, 6367.713452894724, 6384.680765961776, 6414.583052101599, 6430.517711171775, 6469.997150441689, 6521.087047813215, 6525.836854078686, 6526.706298216686, 6543.967280163759, 6547.803565893031, 6130.693465326805, 6326.114343991937, 6347.71435285404, 6351.237851457855, 6354.555181137461], "value": 6042.282581289872, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.5984469163193, 731.1372580355181, 745.027738800865, 1120.4341807387264, 1142.4459137318404, 35447.29105417893, 36225.45661815075, 36292.81853590732, 36304.0, 36394.63605363946, 37600.623993760055, 37813.0, 37935.430968535424, 38001.23997520048, 38047.809760951226, 6977.930220697779, 7044.929550704504, 7147.749828755968, 7158.747219236639, 7179.784606461814, 7101.786946391617, 7108.360247577717, 7131.358177764, 7137.964310178468, 7183.281671832801, 7120.715171393138, 7206.891896621555, 7219.0976127984, 7245.673944672476, 7265.382442492368, 7150.213476517579, 7158.7494437694695, 7195.640217989079, 7207.243239459834, 7208.135023797152, 6982.301769823028, 6995.8600827983155, 6999.335063168991, 7029.507934444591, 7034.7537836176, 34328.65671343305, 34335.82832085848, 34511.137221569414, 34590.481142782875, 34690.4389302482, 3452.6202117767025, 3495.1611613212644, 3519.595246546629, 3525.435930251173, 3526.3828829954914, 28038.579421308696, 28050.298742531395, 28310.575341369895, 28352.149435516967, 28394.0, 3709.5548534176073, 3712.424574191005, 3723.478712980185, 3735.831887565039, 3742.0644838790304, 192681.5854731618, 195960.0, 197620.0, 208930.0, 218883.90558047267, 45911.17932617094, 46107.0, 46306.30540541895, 46326.305105423446, 46610.0, 47523.76238118787, 47731.0, 53253.0, 53264.46735532595, 53756.0, 15753.13357765334, 15970.60073498172, 15980.600484987968, 15983.041017538984, 15998.680026399406, 12579.37103144839, 12676.683082922817, 12680.365981700877, 12718.10973231865, 12756.362181890869, 14556.199409032393, 14578.781318280235, 14581.0, 14659.413623454942, 14662.193579353238, 5831.241938547962, 5886.852828679317, 6025.860819409134, 6030.427109424598, 6039.577229593886, 1017.9847302290472, 1060.4909643371225, 1095.895889890459, 1100.0594491709633, 1143.1255089856268, 25011.4997700045, 25172.370690732878, 25473.363165921, 25655.615165772528, 26068.60897086545, 1205.2527432991426, 1206.867244603093, 1210.1891732539043, 1214.5931113077042, 1239.423667994387, 13422.597322080353, 13592.320383980761, 13613.0, 13659.453621855213, 13680.384382702803, 260496.0, 261106.0, 262257.0, 262700.0, 263452.0, 50580.0, 50841.49158508368, 50966.490335096176, 51066.744666277176, 51236.487635123915, 1500.2648702135875, 1520.1335238913714, 1543.9305231264395, 1555.2379334126422, 1557.6028112831382, 24085.75914240835, 24640.0, 24991.87504062468, 25023.749762502142, 25097.623535647344, 37089.44365834461, 37325.25349493049, 37508.2498350026, 37513.0, 37620.435693465166, 211783.0, 211931.0, 212873.0, 213967.0, 214348.0, 33466.665333346355, 33516.162095947795, 33587.328253435284, 33968.0, 34129.829350853084, 39892.0, 40068.79965600153, 40172.799136005306, 41295.1740965173, 41515.7924210377, 27717.0, 28153.718462815108, 28238.0, 28881.277968050967, 29609.555856661736, 30355.544666830458, 31402.768576309754, 32252.0, 32709.509357360133, 33165.17087072746, 38154.61845381511, 38171.809140954116, 38296.61703382931, 38485.0, 38561.614383855805, 30968.53547196839, 30978.0, 31055.378892421573, 31732.524012139376, 32563.40670085576, 25376.0, 25805.612915806654, 25952.0, 26090.0, 26520.204393868215], "value": 16935.781916160216, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [438.9956100438995, 439.54726631569486, 454.98407555735554, 462.61833986960767, 466.8576084294291, 19045.428637140907, 19944.102515386807, 20450.0, 20599.0, 20727.792722072794, 21698.783012169875, 22712.205072822453, 23303.417414564643, 23395.64906526399, 23417.297481075595, 5484.561235101182, 5622.606417550773, 5632.3804381518, 5640.830775076754, 5641.407652196502, 5320.600954928376, 5576.972115139439, 5591.440855914397, 5593.720313984305, 5600.5799565032585, 5549.084401073818, 5562.137868630369, 5569.331680198382, 5576.0, 5587.525060369873, 5351.598630102758, 5550.0, 5550.944490555104, 5559.277293951781, 5559.583031272671, 4958.404991401055, 5043.9747801260755, 5048.116579598555, 5052.444231134572, 5071.1632580624155, 25891.611625825626, 26022.21933341984, 26323.34191645205, 26334.20997370082, 26626.06808761684, 2174.3911704722705, 2200.2739096098408, 2202.7246594175726, 2214.944626384337, 2230.408941630469, 16902.07038612876, 17175.484735457958, 17475.47573572782, 17539.73690394645, 17858.19638116275, 2251.324602619208, 2259.898304576298, 2274.4200228941513, 2284.954300913989, 2292.33522278539, 111811.44094279477, 112752.0, 118792.40603797013, 119308.0, 122861.0, 12392.194507356993, 12541.184822986477, 12799.680007999688, 13007.674808129683, 13067.150635208682, 18013.0, 18014.909925450287, 18086.728699069525, 18104.818951810576, 18148.0, 8627.827443451095, 8641.222289993932, 8810.911890881009, 8913.420627659181, 8974.37179397449, 7976.282134607914, 8127.349812015024, 8140.466045141284, 8223.136570660114, 8336.416450848503, 7997.560134192675, 8092.8381432371025, 8219.383546234056, 8274.213949674771, 8316.667333306721, 2282.1213832674207, 2304.469971906471, 2312.710416687501, 2322.8954697038675, 2462.212092130537, 1016.6086056868158, 1037.2428127466992, 1041.7187359412917, 1054.1408751867357, 1059.8304271316551, 19824.405267841987, 21446.047414156656, 21454.356369308945, 21546.569068618854, 21707.782922170576, 1046.68076236747, 1055.9260851740457, 1061.6655753437642, 1061.787642471509, 1063.8457423673524, 11010.39442830652, 11658.94170529142, 11710.0, 11814.88185118155, 11861.525538978516, 480933.8055569384, 488260.0, 490085.0, 496588.0, 499012.0, 92656.0, 96555.20466901189, 98460.50769746248, 98751.0, 99973.0, 1121.506537123663, 1163.5113252433998, 1199.772043311768, 1201.3152503073165, 1203.1277323940074, 17526.386576469762, 17737.37919172823, 17880.910595446938, 17896.731549026514, 18032.0, 46929.0, 47425.0, 47469.762651186524, 49555.7522212401, 49625.0, 59675.50811229754, 60274.698626506586, 61420.38579614147, 62018.0, 62697.37302627098, 9337.626494940398, 9594.18449431806, 9671.419714817133, 9727.513624318897, 9974.950125249326, 15136.924315378352, 15405.537833865003, 15544.922275388551, 15899.28453219631, 16316.59208519749, 13447.663808404868, 13548.187108773505, 13570.457181713016, 13609.251491168081, 13680.657983550092, 12525.123241373016, 12543.93728031354, 12574.182678125893, 12707.872921271039, 12927.482900683868, 13476.393562289917, 13566.118202316818, 13842.307884605529, 13947.442102315794, 14164.220967846868, 9407.529623518934, 9535.618575256913, 9560.330776845554, 9586.0, 9960.452175130438, 13037.0, 13155.408006639533, 13270.27013514266, 13510.594682159552, 13559.322033898068], "value": 10322.913383621602, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.5978206538039, 1398.5454727213657, 1398.580425872238, 1401.075290308396, 1406.2054938959482, 10595.78808423832, 10762.838557421625, 10996.505157267922, 11028.889711102896, 11048.558057677683, 11161.497732602033, 11215.607453739121, 11319.943400283008, 11351.943240283808, 11400.543978240881, 2357.233898982829, 2385.546746118232, 2393.6648869158244, 2394.8682822444844, 2411.9035238590436, 2291.072115793098, 2306.1813056365, 2329.9650505242435, 2336.2407217654245, 2341.590221711202, 2154.8383871209644, 2156.385430152399, 2176.9020394082304, 2178.0, 2183.858049226803, 2259.5029093599383, 2268.965965510519, 2290.4731911660247, 2294.0823670531836, 2295.8737269450176, 1914.1960376641844, 1992.1035534009754, 2266.4560505478566, 2313.0, 2319.327395055449, 11210.103191744642, 11226.66320010401, 11274.32354058751, 11287.435628218556, 11299.322040677585, 6062.302835173968, 6296.748130074791, 6321.367863213688, 6336.176297081396, 6357.141785858896, 3763.4919285896326, 3972.682185425188, 4045.615666511677, 4056.450605719995, 4125.071858831769, 1305.9477620895152, 1337.4917531338028, 1361.9591412257548, 1396.2250950722346, 1402.978955315671, 16160.434384796594, 16179.83820161807, 16202.75695864563, 16243.756343654737, 16254.75617865733, 4965.925511117336, 5029.974850125799, 5200.6879587224885, 5208.270842082112, 5227.477252274742, 11545.595904143483, 11548.133889958119, 11607.6517704469, 11621.6513504595, 11671.766564668658, 6124.5712800103565, 6184.165137706442, 6194.5973511721595, 6207.379262073847, 6208.50331973441, 5845.152452894306, 5884.264466941632, 5893.764249429974, 5930.703464826742, 6046.18376519173, 4159.646430053479, 4182.916341673211, 4185.665146788249, 4233.322668373045, 4257.957420425818, 1189.7501524679742, 1191.755690083531, 1197.5030362399507, 1204.1029433072417, 1207.8007128823647, 796.6415113199083, 810.6473683947502, 825.793551612097, 829.0755807274966, 849.8640217565284, 5837.532997360201, 5900.409959004065, 5973.55198360116, 6019.849503762353, 6058.909116363258, 640.4268179978893, 650.4146268358421, 653.3172834388076, 662.2781168526329, 668.7391917152314, 3905.4727611772614, 4011.859584914514, 4292.892677683083, 4379.671524635665, 4409.250427427345, 14431.0, 14530.709385812224, 14918.254087295592, 14981.625459363604, 15040.623984400478, 14227.715445691236, 14617.561473155822, 14736.715809049614, 14817.481388151364, 14938.0, 8954.686585969459, 9069.863952040725, 9140.588673509708, 9327.486988215713, 9344.112309330738, 6532.41208291256, 6683.030960510796, 6768.424683901923, 6812.114425124901, 6946.687399066953, 13047.608571742863, 13069.0, 13183.274919879499, 13219.471221151047, 13341.866581334063, 13295.135816171918, 13437.328133593477, 13530.932345338604, 13648.727025459237, 13789.586312410644, 8786.956065219632, 9110.271178305587, 9338.206252468617, 9431.198348140484, 9452.669156579486, 10917.727056823644, 10939.945300273448, 10990.285631433931, 11003.504842282277, 11009.944950275198, 9132.086791320815, 9309.534523273674, 9497.620095196115, 9499.145076943109, 9567.808643827224, 9123.863142052742, 9147.405418647766, 9206.815863682556, 9253.167214950687, 9487.620495180116, 7118.8932166018585, 7201.783946481614, 7250.0, 7265.636718163965, 7275.527090739085, 6095.481884039907, 6107.358727333566, 6128.172696686069, 6155.953487906977, 6304.338044505261, 6147.508199344131, 6298.622082675054, 6309.3690630936535, 6492.35076492347, 6500.057491663777], "value": 5189.546366363643, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.0504734064311, 414.5419311660615, 419.9937000944984, 423.5425740200584, 427.15849775941405, 6010.8797824043495, 6187.5668703190795, 6229.750809967607, 6232.626042437457, 6247.593906396081, 5993.940060599392, 6042.788502402417, 6071.392860713938, 6086.178365920599, 6101.725422355994, 4514.503404625489, 4590.70160439572, 4604.355390245369, 4615.007773328751, 4642.883927901796, 4626.259798432252, 4628.745419001953, 4639.16495030896, 4640.60554852838, 4658.208104622222, 4606.33208184813, 4609.608183304423, 4617.399738034051, 4628.791704373311, 4635.513271106536, 4635.698679585833, 4667.789949452283, 4741.668083234175, 4767.261074533453, 4795.6882802618065, 4323.654107671378, 4328.0, 4344.717593356453, 4346.413234213404, 4370.562943705636, 5949.553783466257, 6018.337982821886, 6062.696865156725, 6095.116208149793, 6107.236595425572, 5720.742566584472, 5738.913916291259, 5743.9425605744245, 5759.48164665178, 5781.248437703114, 6602.401691078374, 6609.537332386735, 6617.371349721769, 6629.801105966829, 6637.502187335969, 4857.975710121426, 4862.756862156878, 4909.607231421478, 4943.085529177078, 5004.274380214885, 6684.331566843325, 6877.277885821966, 6899.17209934806, 6939.757108501229, 6947.235804061549, 4770.141374552544, 4792.520747925179, 4802.855914322576, 4815.927761083586, 4820.879478013007, 4850.054239423279, 4860.3681521401995, 4862.176683743596, 4865.5864251538305, 4873.683210591371, 5467.917981230285, 5545.584081193927, 5555.666660000332, 5559.249501317351, 5586.162075688598, 6517.641529715911, 6525.021246813016, 6533.497295622034, 6552.410283074546, 6553.8361540960905, 1791.3461586521087, 1794.6321004194108, 1798.352593066495, 1804.9909750451427, 1812.9728054078935, 1244.8630650628425, 1270.6632742323293, 1291.5350473829415, 1300.590314051071, 1315.526410492222, 6301.684915754194, 6315.8105256841445, 6333.2400111985935, 6375.489960803125, 6378.2346118466085, 6679.231888332807, 6702.229243637044, 6722.932770672329, 6734.56225345351, 6735.764248251287, 6025.9096113558335, 6219.284782250009, 6255.343188965184, 6302.243730752339, 6378.936210637834, 3545.8227088645463, 3553.5913369962786, 3556.7332450066347, 3574.91062723434, 3580.15866271426, 6909.825329693964, 6975.267596902354, 7045.964770176116, 7051.400630946325, 7093.92906070943, 6872.831618624746, 6879.724811007603, 6884.759033433806, 6931.826704332432, 6943.0, 6754.527183097136, 7047.68285427157, 7071.29287071299, 7112.715491380287, 7144.9642751785905, 6732.124823772878, 6762.019507171531, 6763.222229443677, 6764.729410823512, 6778.186617605918, 6516.315786842313, 6536.411722944958, 6632.369924857131, 6662.0, 6663.466922646274, 6996.230414654486, 7017.3684368407085, 7061.788146355618, 7070.7525236616475, 7085.0435191248525, 4603.217453032926, 4605.769711514344, 4618.145643056046, 4621.584057434847, 4639.536046395334, 6763.695633696397, 6767.187937447341, 6811.046453496416, 6814.591124532346, 6877.724891004304, 6567.9671601643595, 6598.637074960731, 6611.900821487778, 6619.602823830585, 6624.56940298879, 6428.55000149985, 6509.772157974448, 6564.868702625825, 6578.572392794453, 6630.126856760181, 6561.475081993524, 6580.440662543546, 6584.473242140713, 6592.43964263043, 6594.340565943367, 6428.582142160744, 6580.0, 6630.9668451657435, 6637.590363853444, 6681.69932353055, 6417.1657684500715, 6436.195475565554, 6436.485081193587, 6475.255345635313, 6491.4806815455595], "value": 5034.0298255427615, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [848.626183552909, 869.6477926439792, 880.3441436130084, 883.7437143228464, 894.0567701075363, 15465.536033918987, 15918.283677234538, 15955.0, 18647.0, 20292.898535507302, 17270.2228399722, 17511.299548018094, 17746.201420936057, 18365.90817045913, 18859.62280754384, 984.3749219245794, 1003.6788227767081, 1009.4599389326712, 1013.2906965124406, 1015.2385710716962, 986.0780170540531, 1011.9190464762838, 1036.533559898045, 1038.7403149212696, 1038.7558923652934, 1076.6178006807588, 1080.686600885742, 1086.6739978006606, 1087.47257580074, 1089.4280502736049, 1063.5692544519482, 1077.5582011375297, 1078.4338222433207, 1078.800421921943, 1078.8112080385902, 794.1185284334384, 795.018152581567, 798.2137594469443, 798.4171554764996, 800.4836880212231, 16373.508794736177, 16519.421820236355, 16553.172341382884, 17092.40176593813, 17132.914335428242, 18668.346607868796, 18933.242670293173, 19079.141438635295, 19178.232870685155, 19300.80699193004, 13977.3710183042, 14333.28333583327, 14375.568732938029, 14492.985491015634, 14530.92734536331, 3345.8159801210923, 3366.461366181399, 3372.5109859070544, 3379.8141102239365, 3381.1209085637665, 90736.99999999935, 91191.54404228003, 91362.0, 91651.0, 92785.0, 14417.0, 14514.346854391366, 14571.271436428136, 14749.262536873113, 14791.450051987445, 26634.6004809928, 27113.45773084527, 27308.45383092327, 27438.862805685843, 28056.43887122246, 7656.846863062708, 8445.493270403795, 8453.281471074904, 8585.098564650621, 8603.139686031473, 4069.2878746219294, 4167.729097608646, 4199.559046300155, 4200.05498762782, 4218.156368726206, 4422.358757980075, 4528.117017181618, 4532.0, 4544.318352247124, 4667.229907065296, 903.6633804688569, 914.6844338703137, 918.9540522973958, 925.4817302310593, 927.0636656976368, 682.7610336382326, 698.448225901532, 711.7935798618342, 718.2781304788758, 730.050933786076, 11122.110231181487, 11630.53477860893, 11726.296422214695, 12142.575009874789, 12234.21980612658, 714.7677004973405, 715.6493318274008, 716.6237725194211, 722.1298335505703, 743.2084829656399, 5695.345035320908, 5965.373635768268, 6099.451049405486, 6230.158928544679, 6312.021636646327, 76535.23464765392, 78443.60778196073, 78978.0, 79636.60181699054, 82688.0, 67609.20320076663, 68228.65885670639, 68456.6577167121, 69000.0, 72459.0, 60517.09224361638, 60633.0, 61454.07818882631, 61497.0, 62446.37553624497, 11645.5341786331, 11899.464524096264, 12002.819957700816, 12173.573924912585, 12186.817197741864, 32060.5190922141, 32596.83701581477, 32617.510737338485, 32700.182495437806, 33815.83092084622, 39085.41371879367, 52612.0, 52982.755438496664, 55326.0, 55436.445635543125, 15081.0, 15132.697346053237, 15328.540143795704, 15337.846621533641, 15388.538343849703, 18236.270549177883, 18290.0, 18374.540636484195, 18945.810541894403, 19031.619367612846, 16258.0, 16273.75589366184, 16469.176541172656, 16509.09199994012, 16906.915465422593, 15801.20993950321, 15914.204289785695, 16171.191440427696, 16244.269007894436, 16419.58951026234, 14414.207218603078, 14492.492762753252, 14673.119612822838, 14897.255137243312, 14898.404063837324, 11080.168987325822, 11418.885811141783, 11438.771224575628, 11503.539858405904, 11724.296542207494, 11046.668599942015, 11173.441327933408, 11210.43947802623, 11408.0, 11547.364894930859], "value": 8186.978155524171, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1496.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 111.0, 112.0, 110.0, 110.0, 110.0, 111.0, 110.0, 112.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 119.0, 120.0, 171.0, 121.0, 121.0, 118.0, 116.0, 139.0, 117.0], "value": 128.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 162.0, 164.0, 161.0, 167.0, 168.0, 172.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 77.0, 98.0, 74.0, 73.0, 74.0, 75.0, 91.0, 74.0], "value": 78.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 101.0, 82.0, 84.0, 83.0, 94.0, 81.0, 81.0, 107.0], "value": 88.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 148.0, 150.0, 148.0, 149.0, 148.0, 149.0, 148.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 49.0, 45.0, 46.0, 49.0, 47.0, 47.0, 48.0, 47.0, 48.0], "value": 47.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 61.0, 56.0, 56.0, 56.0, 55.0, 56.0, 56.0, 55.0], "value": 56.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 82.0, 85.0, 81.0, 81.0, 84.0, 82.0, 83.0, 83.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 125.0, 127.0, 130.0, 129.0, 127.0, 135.0, 131.0, 176.0, 126.0], "value": 133.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 185.0, 175.0, 184.0, 185.0, 184.0, 189.0, 193.0, 185.0, 184.0], "value": 184.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 66.0, 65.0, 64.0, 69.0, 66.0, 64.0, 66.0, 64.0], "value": 65.8, "unit": "score"}]}]} 07:40:13 INFO - Return code: 0 07:40:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:40:13 INFO - # TBPL SUCCESS # 07:40:13 INFO - Running post-action listener: _resource_record_post_action 07:40:13 INFO - [mozharness: 2017-05-05 14:40:13.930791Z] Finished run-tests step (success) 07:40:13 INFO - Running post-run listener: _resource_record_post_run 07:40:14 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 2732032; Write bytes: 358645760; Read time: 640; Write time: 274644 07:40:14 INFO - TinderboxPrint: CPU usage
13.3% 07:40:14 INFO - TinderboxPrint: I/O read bytes / time
2,732,032 / 640 07:40:14 INFO - TinderboxPrint: I/O write bytes / time
358,645,760 / 274,644 07:40:14 INFO - TinderboxPrint: CPU idle
8,244.3 (86.7%) 07:40:14 INFO - TinderboxPrint: CPU user
1,203.9 (12.7%) 07:40:14 INFO - TinderboxPrint: Swap in / out
0 / 0 07:40:14 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 103358464; Read time: 8; Write time: 105072 07:40:14 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 2723840; Write bytes: 254697472; Read time: 620; Write time: 169544 07:40:14 INFO - Running post-run listener: _upload_blobber_files 07:40:14 INFO - Blob upload gear active. 07:40:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:40:14 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 07:40:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:40:15 INFO - (blobuploader) - INFO - Open directory for files ... 07:40:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:40:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:40:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:40:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:40:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:40:15 INFO - (blobuploader) - INFO - Done attempting. 07:40:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:40:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:40:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:40:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:40:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:40:19 INFO - (blobuploader) - INFO - Done attempting. 07:40:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:40:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:40:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:40:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:40:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:40:20 INFO - (blobuploader) - INFO - Done attempting. 07:40:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:40:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:40:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:40:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:40:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:40:21 INFO - (blobuploader) - INFO - Done attempting. 07:40:21 INFO - (blobuploader) - INFO - Iteration through files over. 07:40:21 INFO - Return code: 0 07:40:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:40:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:40:21 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/644b0171686b460b23b9c5a92e0fcc27054d8a4696634039fa44d7a6a457f70297326b5a22b7b7c20e8a191bb0ddd371e3eca507407ec63a789da3b50562657e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4d22f1da17adfbcfe542e030136d958af6caf83579f9eb8feb2530895f52348c435699af2da6a8207834d9458137e24cc0de6c5f3efccce7db5c335c275dbd3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43a7cb2e2006e3897760dd11139b51acfd8e6e8e9c006624499a3c13c5f76ed0eede67dfa7d1497c917acb83ae4dbffce9fc60ed55d4c196c76c1e87af55fd1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/339104477e7e334a957b8cd02cb0fa15182adb4f477774bf24fcef032c90e21a57463789dd7d70e0090ee35e68fe0ea3b8b92b7336f190e04575c54cb8b9a610"} 07:40:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:40:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:40:21 INFO - Contents: 07:40:21 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/644b0171686b460b23b9c5a92e0fcc27054d8a4696634039fa44d7a6a457f70297326b5a22b7b7c20e8a191bb0ddd371e3eca507407ec63a789da3b50562657e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4d22f1da17adfbcfe542e030136d958af6caf83579f9eb8feb2530895f52348c435699af2da6a8207834d9458137e24cc0de6c5f3efccce7db5c335c275dbd3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43a7cb2e2006e3897760dd11139b51acfd8e6e8e9c006624499a3c13c5f76ed0eede67dfa7d1497c917acb83ae4dbffce9fc60ed55d4c196c76c1e87af55fd1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/339104477e7e334a957b8cd02cb0fa15182adb4f477774bf24fcef032c90e21a57463789dd7d70e0090ee35e68fe0ea3b8b92b7336f190e04575c54cb8b9a610"} 07:40:21 INFO - Running post-run listener: copy_logs_to_upload_dir 07:40:21 INFO - Copying logs to upload dir... 07:40:21 INFO - mkdir: /builds/slave/test/build/upload/logs 07:40:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.061496 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-05-05 07:40:20.280758) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 07:40:20.287888) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/644b0171686b460b23b9c5a92e0fcc27054d8a4696634039fa44d7a6a457f70297326b5a22b7b7c20e8a191bb0ddd371e3eca507407ec63a789da3b50562657e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4d22f1da17adfbcfe542e030136d958af6caf83579f9eb8feb2530895f52348c435699af2da6a8207834d9458137e24cc0de6c5f3efccce7db5c335c275dbd3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43a7cb2e2006e3897760dd11139b51acfd8e6e8e9c006624499a3c13c5f76ed0eede67dfa7d1497c917acb83ae4dbffce9fc60ed55d4c196c76c1e87af55fd1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/339104477e7e334a957b8cd02cb0fa15182adb4f477774bf24fcef032c90e21a57463789dd7d70e0090ee35e68fe0ea3b8b92b7336f190e04575c54cb8b9a610"} build_url:https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011161 build_url: 'https://queue.taskcluster.net/v1/task/YwrTf5ZhTJmSd6M0Ez5Zog/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/644b0171686b460b23b9c5a92e0fcc27054d8a4696634039fa44d7a6a457f70297326b5a22b7b7c20e8a191bb0ddd371e3eca507407ec63a789da3b50562657e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4d22f1da17adfbcfe542e030136d958af6caf83579f9eb8feb2530895f52348c435699af2da6a8207834d9458137e24cc0de6c5f3efccce7db5c335c275dbd3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43a7cb2e2006e3897760dd11139b51acfd8e6e8e9c006624499a3c13c5f76ed0eede67dfa7d1497c917acb83ae4dbffce9fc60ed55d4c196c76c1e87af55fd1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/339104477e7e334a957b8cd02cb0fa15182adb4f477774bf24fcef032c90e21a57463789dd7d70e0090ee35e68fe0ea3b8b92b7336f190e04575c54cb8b9a610"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 07:40:20.319986) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:40:20.320315) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1493993826.515459-1799321521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:40:20.404387) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 07:40:20.404782) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 07:40:20.405083) ========= ========= Total master_lag: 0.22 =========