builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-049 starttime: 1493890882.33 results: success (0) revision: 33b92d9c40562dab3d7b602368c75619f1d793f7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 02:41:22.328933) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 02:41:22.329381) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 02:41:22.329675) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 02:41:22.382070) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 02:41:22.382389) ========= 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=db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-04 02:41:22-- 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% 68.7K=0.2s 2017-05-04 02:41:22 (68.7 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.369459 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 02:41:22.795500) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 02:41:22.795807) ========= 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=db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016657 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 02:41:22.850130) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 02:41:22.850483) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 33b92d9c40562dab3d7b602368c75619f1d793f7 --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 33b92d9c40562dab3d7b602368c75619f1d793f7 --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=db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-04 02:41:22,912 truncating revision to first 12 chars 2017-05-04 02:41:22,912 Setting DEBUG logging. 2017-05-04 02:41:22,913 attempt 1/10 2017-05-04 02:41:22,913 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/33b92d9c4056?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-04 02:41:23,269 unpacking tar archive at: mozilla-central-33b92d9c4056/testing/mozharness/ program finished with exit code 0 elapsedTime=1.166365 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 02:41:24.032180) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 02:41:24.035502) ========= script_repo_revision: 33b92d9c40562dab3d7b602368c75619f1d793f7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 02:41:24.035888) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 02:41:24.036155) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 02:41:24.046231) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-05-04 02:41:24.046513) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:41:24 INFO - MultiFileLogger online at 20170504 02:41:24 in /builds/slave/test 02:41:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 02:41:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:41:24 INFO - {'append_to_log': False, 02:41:24 INFO - 'base_work_dir': '/builds/slave/test', 02:41:24 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:41:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:41:24 INFO - 'branch': 'Firefox-Non-PGO', 02:41:24 INFO - 'buildbot_json_path': 'buildprops.json', 02:41:24 INFO - 'config_files': ('talos/linux_config.py',), 02:41:24 INFO - 'default_actions': ('clobber', 02:41:24 INFO - 'read-buildbot-config', 02:41:24 INFO - 'download-and-extract', 02:41:24 INFO - 'populate-webroot', 02:41:24 INFO - 'create-virtualenv', 02:41:24 INFO - 'install', 02:41:24 INFO - 'run-tests'), 02:41:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:41:24 INFO - 'download_minidump_stackwalk': True, 02:41:24 INFO - 'download_symbols': 'ondemand', 02:41:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:41:24 INFO - 'tooltool.py': '/tools/tooltool.py', 02:41:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:41:24 INFO - '/tools/misc-python/virtualenv.py')}, 02:41:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:41:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:41:24 INFO - 'gecko_profile': False, 02:41:24 INFO - 'gecko_profile_interval': 0, 02:41:24 INFO - 'installer_path': 'installer.exe', 02:41:24 INFO - 'log_level': 'info', 02:41:24 INFO - 'log_name': 'talos', 02:41:24 INFO - 'log_to_console': True, 02:41:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:41:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:41:24 INFO - 'opt_config_files': (), 02:41:24 INFO - 'pip_index': False, 02:41:24 INFO - 'suite': 'dromaeojs-e10s', 02:41:24 INFO - 'system_bits': '32', 02:41:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:41:24 INFO - 'title': 'talos-linux64-ix-049', 02:41:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:41:24 INFO - 'use_talos_json': True, 02:41:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:41:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:41:24 INFO - 'work_dir': 'build'} 02:41:24 INFO - [mozharness: 2017-05-04 09:41:24.321403Z] Running clobber step. 02:41:24 INFO - Running pre-action listener: _resource_record_pre_action 02:41:24 INFO - Running main action method: clobber 02:41:24 INFO - rmtree: /builds/slave/test/build 02:41:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:41:25 INFO - Running post-action listener: _resource_record_post_action 02:41:25 INFO - [mozharness: 2017-05-04 09:41:25.222669Z] Finished clobber step (success) 02:41:25 INFO - [mozharness: 2017-05-04 09:41:25.222768Z] Running read-buildbot-config step. 02:41:25 INFO - Running pre-action listener: _resource_record_pre_action 02:41:25 INFO - Running main action method: read_buildbot_config 02:41:25 INFO - Using buildbot properties: 02:41:25 INFO - { 02:41:25 INFO - "project": "", 02:41:25 INFO - "product": "firefox", 02:41:25 INFO - "who": "cbook@mozilla.com", 02:41:25 INFO - "installer_path": "public/build/target.tar.bz2", 02:41:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 02:41:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:41:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 02:41:25 INFO - "stage_platform": "linux64", 02:41:25 INFO - "basedir": "/builds/slave/test", 02:41:25 INFO - "buildnumber": 812, 02:41:25 INFO - "platform": "ubuntu64_hw", 02:41:25 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:41:25 INFO - "slavebuilddir": "test", 02:41:25 INFO - "taskId": "QTzYmMe3SWKugIt492dbVA", 02:41:25 INFO - "branch": "mozilla-central", 02:41:25 INFO - "script_repo_revision": "production", 02:41:25 INFO - "revision": "33b92d9c40562dab3d7b602368c75619f1d793f7", 02:41:25 INFO - "slavename": "talos-linux64-ix-049", 02:41:25 INFO - "repo_path": "mozilla-central" 02:41:25 INFO - } 02:41:25 INFO - Finding installer, test and symbols from parent task. 02:41:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QTzYmMe3SWKugIt492dbVA'}, attempt #1 02:41:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QTzYmMe3SWKugIt492dbVA'}, attempt #1 02:41:26 INFO - Task dependencies: HvsYDJNoRu-69AvXiCsxNg 02:41:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg'}, attempt #1 02:41:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/target.tar.bz2 02:41:26 INFO - Set test_url: https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/test_packages.json 02:41:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/target.crashreporter-symbols.zip 02:41:26 INFO - Running post-action listener: _resource_record_post_action 02:41:26 INFO - [mozharness: 2017-05-04 09:41:26.557161Z] Finished read-buildbot-config step (success) 02:41:26 INFO - [mozharness: 2017-05-04 09:41:26.557378Z] Running download-and-extract step. 02:41:26 INFO - Running pre-action listener: _resource_record_pre_action 02:41:26 INFO - Running main action method: download_and_extract 02:41:26 INFO - mkdir: /builds/slave/test/build/tests 02:41:26 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')]} 02:41:26 INFO - trying https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/target.test_packages.json 02:41:26 INFO - Downloading https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:41:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:41:27 INFO - Downloaded 986 bytes. 02:41:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:41:27 INFO - Using the following test package requirements: 02:41:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:41:27 INFO - u'common': [u'target.common.tests.zip'], 02:41:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:41:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:41:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:41:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:41:27 INFO - u'mozbase': [u'target.common.tests.zip'], 02:41:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:41:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:41:27 INFO - u'web-platform': [u'target.common.tests.zip', 02:41:27 INFO - u'target.web-platform.tests.zip'], 02:41:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:41:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:41:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/target.common.tests.zip 02:41:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:41:27 INFO - Fetch https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/target.common.tests.zip into memory 02:41:28 INFO - Content-Length response header: 58436268 02:41:28 INFO - Bytes received: 58436268 02:41:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:41:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/target.common.tests.zip 02:41:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:41:38 INFO - Fetch https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/target.common.tests.zip into memory 02:41:39 INFO - Content-Length response header: 58436268 02:41:39 INFO - Bytes received: 58436268 02:41:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/target.talos.tests.zip 02:41:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:41:50 INFO - Fetch https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/target.talos.tests.zip into memory 02:41:51 INFO - Content-Length response header: 14408809 02:41:51 INFO - Bytes received: 14408809 02:41:51 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')]} 02:41:51 INFO - trying https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/target.tar.bz2 02:41:51 INFO - Downloading https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:41:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:41:52 INFO - Downloaded 58281909 bytes. 02:41:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/target.tar.bz2 02:41:52 INFO - mkdir: /builds/slave/test/properties 02:41:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:41:52 INFO - Writing to file /builds/slave/test/properties/build_url 02:41:52 INFO - Contents: 02:41:52 INFO - build_url:https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/target.tar.bz2 02:41:52 INFO - Running post-action listener: _resource_record_post_action 02:41:52 INFO - Running post-action listener: set_extra_try_arguments 02:41:52 INFO - [mozharness: 2017-05-04 09:41:52.624083Z] Finished download-and-extract step (success) 02:41:52 INFO - [mozharness: 2017-05-04 09:41:52.624180Z] Running populate-webroot step. 02:41:52 INFO - Running pre-action listener: _resource_record_pre_action 02:41:52 INFO - Running main action method: populate_webroot 02:41:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:41:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:41:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:41:52 INFO - '--tppagecycles', 02:41:52 INFO - '7'], 02:41:52 INFO - 'tests': ['tsvgm']}}, 02:41:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:41:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:41:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:41:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:41:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:41:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:41:52 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:41:52 INFO - 'talos_options': ['--disable-e10s'], 02:41:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:41:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:41:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:41:52 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:41:52 INFO - 'talos_options': ['--disable-e10s'], 02:41:52 INFO - 'tests': ['damp', 'tps']}, 02:41:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:41:52 INFO - 'tests': ['damp', 'tps']}, 02:41:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:41:52 INFO - 'tests': ['dromaeo_dom']}, 02:41:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:41:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:41:52 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:41:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:41:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:41:52 INFO - 'tests': ['a11yr', 02:41:52 INFO - 'ts_paint', 02:41:52 INFO - 'tpaint', 02:41:52 INFO - 'sessionrestore', 02:41:52 INFO - 'sessionrestore_no_auto_restore', 02:41:52 INFO - 'tabpaint']}, 02:41:52 INFO - 'other-e10s': {'tests': ['a11yr', 02:41:52 INFO - 'ts_paint', 02:41:52 INFO - 'tpaint', 02:41:52 INFO - 'sessionrestore', 02:41:52 INFO - 'sessionrestore_no_auto_restore', 02:41:52 INFO - 'tabpaint']}, 02:41:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:41:52 INFO - 'ts_paint', 02:41:52 INFO - 'tpaint', 02:41:52 INFO - 'sessionrestore', 02:41:52 INFO - 'sessionrestore_no_auto_restore', 02:41:52 INFO - 'tabpaint']}, 02:41:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:41:52 INFO - 'ts_paint', 02:41:52 INFO - 'tpaint', 02:41:52 INFO - 'sessionrestore', 02:41:52 INFO - 'sessionrestore_no_auto_restore', 02:41:52 INFO - 'tabpaint']}, 02:41:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:41:52 INFO - 'tests': ['a11yr', 02:41:52 INFO - 'ts_paint', 02:41:52 INFO - 'tpaint', 02:41:52 INFO - 'sessionrestore', 02:41:52 INFO - 'sessionrestore_no_auto_restore', 02:41:52 INFO - 'tabpaint']}, 02:41:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:41:52 INFO - 'tests': ['a11yr', 02:41:52 INFO - 'ts_paint', 02:41:52 INFO - 'tpaint', 02:41:52 INFO - 'sessionrestore', 02:41:52 INFO - 'sessionrestore_no_auto_restore', 02:41:52 INFO - 'tabpaint']}, 02:41:52 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:41:52 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:41:52 INFO - 'bloom_basic_ref']}, 02:41:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:41:52 INFO - 'tests': ['tsvgx', 02:41:52 INFO - 'tsvgr_opacity', 02:41:52 INFO - 'tart', 02:41:52 INFO - 'tscrollx', 02:41:52 INFO - 'cart', 02:41:52 INFO - 'tsvg_static']}, 02:41:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:41:52 INFO - 'tsvgr_opacity', 02:41:52 INFO - 'tart', 02:41:52 INFO - 'tscrollx', 02:41:52 INFO - 'cart', 02:41:52 INFO - 'tsvg_static']}, 02:41:52 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:41:52 INFO - 'talos_options': ['--disable-e10s'], 02:41:52 INFO - 'tests': ['tp5o']}, 02:41:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:41:52 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:41:52 INFO - 'talos_options': ['--disable-e10s', 02:41:52 INFO - '--xperf_path', 02:41:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:41:52 INFO - 'tests': ['tp5n']}, 02:41:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:41:52 INFO - 'talos_options': ['--xperf_path', 02:41:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:41:52 INFO - 'tests': ['tp5n']}}, 02:41:52 INFO - 'talos.zip': {'path': '', 02:41:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:41:52 INFO - Running post-action listener: _resource_record_post_action 02:41:52 INFO - [mozharness: 2017-05-04 09:41:52.637915Z] Finished populate-webroot step (success) 02:41:52 INFO - [mozharness: 2017-05-04 09:41:52.638005Z] Running create-virtualenv step. 02:41:52 INFO - Running pre-action listener: _resource_record_pre_action 02:41:52 INFO - Running main action method: create_virtualenv 02:41:52 INFO - Creating virtualenv /builds/slave/test/build/venv 02:41:52 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 02:41:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:41:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:41:52 INFO - Using real prefix '/usr' 02:41:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:41:53 INFO - Installing distribute.............................................................................................................................................................................................done. 02:41:55 INFO - Installing pip.................done. 02:41:55 INFO - Return code: 0 02:41:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:41:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:41:55 INFO - Reading from file tmpfile_stdout 02:41:55 INFO - Output received: 02:41:55 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) 02:41:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:41:55 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')]} 02:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:55 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')]} 02:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:55 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 0x10501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1148a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12edb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb290>, '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 0x12ebb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ec040>, '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': 'db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004', '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 02:41:55 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 02:41:55 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 02:41:55 INFO - Using env: {'DISPLAY': ':0', 02:41:55 INFO - 'HOME': '/home/cltbld', 02:41:55 INFO - 'LANG': 'en_US.UTF-8', 02:41:55 INFO - 'LANGUAGE': 'en_US:en', 02:41:55 INFO - 'LOGNAME': 'cltbld', 02:41:55 INFO - 'MAIL': '/var/mail/cltbld', 02:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:55 INFO - 'MOZ_NO_REMOTE': '1', 02:41:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:55 INFO - 'NO_EM_RESTART': '1', 02:41:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:55 INFO - 'PWD': '/builds/slave/test', 02:41:55 INFO - 'SHELL': '/bin/bash', 02:41:55 INFO - 'SHLVL': '1', 02:41:55 INFO - 'TERM': 'linux', 02:41:55 INFO - 'TMOUT': '86400', 02:41:55 INFO - 'USER': 'cltbld', 02:41:55 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004', 02:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:55 INFO - '_': '/tools/buildbot/bin/python'} 02:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:55 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 02:41:55 INFO - Cleaning up... 02:41:55 INFO - Return code: 0 02:41:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:41:55 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')]} 02:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:55 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')]} 02:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:55 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 0x10501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1148a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12edb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb290>, '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 0x12ebb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ec040>, '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': 'db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004', '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 02:41:55 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 02:41:55 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 02:41:55 INFO - Using env: {'DISPLAY': ':0', 02:41:55 INFO - 'HOME': '/home/cltbld', 02:41:55 INFO - 'LANG': 'en_US.UTF-8', 02:41:55 INFO - 'LANGUAGE': 'en_US:en', 02:41:55 INFO - 'LOGNAME': 'cltbld', 02:41:55 INFO - 'MAIL': '/var/mail/cltbld', 02:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:55 INFO - 'MOZ_NO_REMOTE': '1', 02:41:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:55 INFO - 'NO_EM_RESTART': '1', 02:41:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:55 INFO - 'PWD': '/builds/slave/test', 02:41:55 INFO - 'SHELL': '/bin/bash', 02:41:55 INFO - 'SHLVL': '1', 02:41:55 INFO - 'TERM': 'linux', 02:41:55 INFO - 'TMOUT': '86400', 02:41:55 INFO - 'USER': 'cltbld', 02:41:55 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004', 02:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:55 INFO - '_': '/tools/buildbot/bin/python'} 02:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:56 INFO - Downloading/unpacking psutil>=3.1.1 02:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:41:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:41:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:41:57 INFO - Installing collected packages: psutil 02:41:57 INFO - Running setup.py install for psutil 02:41:57 INFO - building 'psutil._psutil_linux' extension 02:41:57 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 02:41:58 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 02:41:58 INFO - building 'psutil._psutil_posix' extension 02:41:58 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 02:41:58 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 02:41:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:41:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:41:58 INFO - Successfully installed psutil 02:41:58 INFO - Cleaning up... 02:41:58 INFO - Return code: 0 02:41:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:41:58 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')]} 02:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:58 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')]} 02:41:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:58 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 0x10501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1148a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12edb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb290>, '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 0x12ebb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ec040>, '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': 'db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004', '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 02:41:58 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 02:41:58 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 02:41:58 INFO - Using env: {'DISPLAY': ':0', 02:41:58 INFO - 'HOME': '/home/cltbld', 02:41:58 INFO - 'LANG': 'en_US.UTF-8', 02:41:58 INFO - 'LANGUAGE': 'en_US:en', 02:41:58 INFO - 'LOGNAME': 'cltbld', 02:41:58 INFO - 'MAIL': '/var/mail/cltbld', 02:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:58 INFO - 'MOZ_NO_REMOTE': '1', 02:41:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:58 INFO - 'NO_EM_RESTART': '1', 02:41:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:58 INFO - 'PWD': '/builds/slave/test', 02:41:58 INFO - 'SHELL': '/bin/bash', 02:41:58 INFO - 'SHLVL': '1', 02:41:58 INFO - 'TERM': 'linux', 02:41:58 INFO - 'TMOUT': '86400', 02:41:58 INFO - 'USER': 'cltbld', 02:41:58 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004', 02:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:58 INFO - '_': '/tools/buildbot/bin/python'} 02:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:42:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:42:00 INFO - Installing collected packages: mozsystemmonitor 02:42:00 INFO - Running setup.py install for mozsystemmonitor 02:42:00 INFO - Successfully installed mozsystemmonitor 02:42:00 INFO - Cleaning up... 02:42:00 INFO - Return code: 0 02:42:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1148a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12edb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb290>, '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 0x12ebb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ec040>, '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': 'db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004', '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 02:42:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:42:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:42:00 INFO - Using env: {'DISPLAY': ':0', 02:42:00 INFO - 'HOME': '/home/cltbld', 02:42:00 INFO - 'LANG': 'en_US.UTF-8', 02:42:00 INFO - 'LANGUAGE': 'en_US:en', 02:42:00 INFO - 'LOGNAME': 'cltbld', 02:42:00 INFO - 'MAIL': '/var/mail/cltbld', 02:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:00 INFO - 'MOZ_NO_REMOTE': '1', 02:42:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:00 INFO - 'NO_EM_RESTART': '1', 02:42:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:00 INFO - 'PWD': '/builds/slave/test', 02:42:00 INFO - 'SHELL': '/bin/bash', 02:42:00 INFO - 'SHLVL': '1', 02:42:00 INFO - 'TERM': 'linux', 02:42:00 INFO - 'TMOUT': '86400', 02:42:00 INFO - 'USER': 'cltbld', 02:42:00 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004', 02:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:00 INFO - '_': '/tools/buildbot/bin/python'} 02:42:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:00 INFO - Downloading/unpacking jsonschema==2.5.1 02:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:42:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:42:01 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 02:42:01 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 02:42:01 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 02:42:01 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 02:42:01 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 02:42:01 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 02:42:01 INFO - Downloading functools32-3.2.3-2.tar.gz 02:42:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:42:01 INFO - warning: no files found matching '*.txt' 02:42:01 INFO - no previously-included directories found matching 'build' 02:42:01 INFO - no previously-included directories found matching 'dist' 02:42:01 INFO - no previously-included directories found matching '.git*' 02:42:01 INFO - Installing collected packages: jsonschema, functools32 02:42:01 INFO - Running setup.py install for functools32 02:42:01 INFO - warning: no files found matching '*.txt' 02:42:01 INFO - no previously-included directories found matching 'build' 02:42:01 INFO - no previously-included directories found matching 'dist' 02:42:01 INFO - no previously-included directories found matching '.git*' 02:42:01 INFO - Successfully installed jsonschema functools32 02:42:01 INFO - Cleaning up... 02:42:01 INFO - Return code: 0 02:42:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:01 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 0x10501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1148a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12edb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb290>, '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 0x12ebb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ec040>, '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': 'db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004', '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 02:42:01 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 02:42:01 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 02:42:01 INFO - Using env: {'DISPLAY': ':0', 02:42:01 INFO - 'HOME': '/home/cltbld', 02:42:01 INFO - 'LANG': 'en_US.UTF-8', 02:42:01 INFO - 'LANGUAGE': 'en_US:en', 02:42:01 INFO - 'LOGNAME': 'cltbld', 02:42:01 INFO - 'MAIL': '/var/mail/cltbld', 02:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:01 INFO - 'MOZ_NO_REMOTE': '1', 02:42:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:01 INFO - 'NO_EM_RESTART': '1', 02:42:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:01 INFO - 'PWD': '/builds/slave/test', 02:42:01 INFO - 'SHELL': '/bin/bash', 02:42:01 INFO - 'SHLVL': '1', 02:42:01 INFO - 'TERM': 'linux', 02:42:01 INFO - 'TMOUT': '86400', 02:42:01 INFO - 'USER': 'cltbld', 02:42:01 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004', 02:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:01 INFO - '_': '/tools/buildbot/bin/python'} 02:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:42:02 INFO - Cleaning up... 02:42:02 INFO - Return code: 0 02:42:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:42:02 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')]} 02:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:02 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')]} 02:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:02 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 0x10501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1148a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12edb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb290>, '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 0x12ebb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ec040>, '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': 'db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004', '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 02:42:02 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 02:42:02 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 02:42:02 INFO - Using env: {'DISPLAY': ':0', 02:42:02 INFO - 'HOME': '/home/cltbld', 02:42:02 INFO - 'LANG': 'en_US.UTF-8', 02:42:02 INFO - 'LANGUAGE': 'en_US:en', 02:42:02 INFO - 'LOGNAME': 'cltbld', 02:42:02 INFO - 'MAIL': '/var/mail/cltbld', 02:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:02 INFO - 'MOZ_NO_REMOTE': '1', 02:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:02 INFO - 'NO_EM_RESTART': '1', 02:42:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:02 INFO - 'PWD': '/builds/slave/test', 02:42:02 INFO - 'SHELL': '/bin/bash', 02:42:02 INFO - 'SHLVL': '1', 02:42:02 INFO - 'TERM': 'linux', 02:42:02 INFO - 'TMOUT': '86400', 02:42:02 INFO - 'USER': 'cltbld', 02:42:02 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004', 02:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:02 INFO - '_': '/tools/buildbot/bin/python'} 02:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:02 INFO - Downloading/unpacking blobuploader==1.2.4 02:42:02 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 02:42:02 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 02:42:02 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 02:42:02 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 02:42:02 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 02:42:02 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 02:42:03 INFO - Downloading blobuploader-1.2.4.tar.gz 02:42:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:42:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:42:03 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 02:42:03 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 02:42:03 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 02:42:03 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 02:42:03 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 02:42:03 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 02:42:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:42:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:42:03 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 02:42:03 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 02:42:03 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 02:42:03 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 02:42:03 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 02:42:03 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 02:42:04 INFO - Downloading docopt-0.6.1.tar.gz 02:42:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:42:04 INFO - Installing collected packages: blobuploader, requests, docopt 02:42:04 INFO - Running setup.py install for blobuploader 02:42:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:42:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:42:04 INFO - Running setup.py install for requests 02:42:04 INFO - Running setup.py install for docopt 02:42:04 INFO - Successfully installed blobuploader requests docopt 02:42:04 INFO - Cleaning up... 02:42:04 INFO - Return code: 0 02:42:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:04 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 0x10501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1148a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12edb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb290>, '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 0x12ebb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ec040>, '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': 'db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004', '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 02:42:04 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 02:42:04 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 02:42:04 INFO - Using env: {'DISPLAY': ':0', 02:42:04 INFO - 'HOME': '/home/cltbld', 02:42:04 INFO - 'LANG': 'en_US.UTF-8', 02:42:04 INFO - 'LANGUAGE': 'en_US:en', 02:42:04 INFO - 'LOGNAME': 'cltbld', 02:42:04 INFO - 'MAIL': '/var/mail/cltbld', 02:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:04 INFO - 'MOZ_NO_REMOTE': '1', 02:42:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:04 INFO - 'NO_EM_RESTART': '1', 02:42:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:04 INFO - 'PWD': '/builds/slave/test', 02:42:04 INFO - 'SHELL': '/bin/bash', 02:42:04 INFO - 'SHLVL': '1', 02:42:04 INFO - 'TERM': 'linux', 02:42:04 INFO - 'TMOUT': '86400', 02:42:04 INFO - 'USER': 'cltbld', 02:42:04 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004', 02:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:04 INFO - '_': '/tools/buildbot/bin/python'} 02:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:42:04 INFO - Running setup.py (path:/tmp/pip-NEUDH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:42:04 INFO - Running setup.py (path:/tmp/pip-1b52wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:42:05 INFO - Running setup.py (path:/tmp/pip-Q1_cgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:42:05 INFO - Running setup.py (path:/tmp/pip-BAix8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:42:05 INFO - Running setup.py (path:/tmp/pip-_6QGfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:42:05 INFO - Running setup.py (path:/tmp/pip-LNqnN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:42:05 INFO - Running setup.py (path:/tmp/pip-8CAyTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:42:05 INFO - Running setup.py (path:/tmp/pip-DDHWU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:42:05 INFO - Running setup.py (path:/tmp/pip-brFNpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:42:05 INFO - Running setup.py (path:/tmp/pip-6Kb_Zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:42:05 INFO - Running setup.py (path:/tmp/pip-8VJWEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:42:05 INFO - Running setup.py (path:/tmp/pip-eXdeyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:42:05 INFO - Running setup.py (path:/tmp/pip-tDpsw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:42:05 INFO - Running setup.py (path:/tmp/pip-zHxQID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:42:05 INFO - Running setup.py (path:/tmp/pip-RGRGrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:42:06 INFO - Running setup.py (path:/tmp/pip-8pP1nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:42:06 INFO - Running setup.py (path:/tmp/pip-8g8VDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:42:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:42:06 INFO - Running setup.py install for manifestparser 02:42:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:42:06 INFO - Running setup.py install for mozcrash 02:42:06 INFO - Running setup.py install for mozdebug 02:42:06 INFO - Running setup.py install for mozdevice 02:42:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:42:06 INFO - Running setup.py install for mozfile 02:42:06 INFO - Running setup.py install for mozhttpd 02:42:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:42:06 INFO - Running setup.py install for mozinfo 02:42:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:42:06 INFO - Running setup.py install for mozInstall 02:42:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:42:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:42:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:42:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:42:06 INFO - Running setup.py install for mozleak 02:42:07 INFO - Running setup.py install for mozlog 02:42:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:42:07 INFO - Running setup.py install for moznetwork 02:42:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:42:07 INFO - Running setup.py install for mozprocess 02:42:07 INFO - Running setup.py install for mozprofile 02:42:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:42:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:42:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:42:07 INFO - Running setup.py install for mozrunner 02:42:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:42:07 INFO - Running setup.py install for mozscreenshot 02:42:07 INFO - Running setup.py install for moztest 02:42:07 INFO - Running setup.py install for mozversion 02:42:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:42:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:42:07 INFO - Cleaning up... 02:42:07 INFO - Return code: 0 02:42:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:42: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')]} 02:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42: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')]} 02:42:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:07 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 0x10501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1148a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12edb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb290>, '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 0x12ebb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ec040>, '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': 'db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004', '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 02:42:07 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 02:42:07 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 02:42:07 INFO - Using env: {'DISPLAY': ':0', 02:42:07 INFO - 'HOME': '/home/cltbld', 02:42:07 INFO - 'LANG': 'en_US.UTF-8', 02:42:07 INFO - 'LANGUAGE': 'en_US:en', 02:42:07 INFO - 'LOGNAME': 'cltbld', 02:42:07 INFO - 'MAIL': '/var/mail/cltbld', 02:42:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:07 INFO - 'MOZ_NO_REMOTE': '1', 02:42:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:07 INFO - 'NO_EM_RESTART': '1', 02:42:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:07 INFO - 'PWD': '/builds/slave/test', 02:42:07 INFO - 'SHELL': '/bin/bash', 02:42:07 INFO - 'SHLVL': '1', 02:42:07 INFO - 'TERM': 'linux', 02:42:07 INFO - 'TMOUT': '86400', 02:42:07 INFO - 'USER': 'cltbld', 02:42:07 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004', 02:42:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:07 INFO - '_': '/tools/buildbot/bin/python'} 02:42:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:42:08 INFO - Running setup.py (path:/tmp/pip-odqgo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:42:08 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)) 02:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:42:08 INFO - Running setup.py (path:/tmp/pip-vgoc_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:42:08 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)) 02:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:42:08 INFO - Running setup.py (path:/tmp/pip-xnrTtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:42:08 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)) 02:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:42:08 INFO - Running setup.py (path:/tmp/pip-2pFunQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:42:08 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)) 02:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:42:08 INFO - Running setup.py (path:/tmp/pip-NBgB3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:42:08 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)) 02:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:42:08 INFO - Running setup.py (path:/tmp/pip-8cyRh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:42:08 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)) 02:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:42:08 INFO - Running setup.py (path:/tmp/pip-GuOGZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:42:08 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)) 02:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:42:08 INFO - Running setup.py (path:/tmp/pip-F0fR1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:42:08 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)) 02:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:42:08 INFO - Running setup.py (path:/tmp/pip-UlAxRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:42:08 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)) 02:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:42:08 INFO - Running setup.py (path:/tmp/pip-s5IQLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:42:08 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)) 02:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:42:08 INFO - Running setup.py (path:/tmp/pip-bYfq4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:42:08 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)) 02:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:42:08 INFO - Running setup.py (path:/tmp/pip-4ajXxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:42:09 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)) 02:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:42:09 INFO - Running setup.py (path:/tmp/pip-wTthd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:42:09 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)) 02:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:42:09 INFO - Running setup.py (path:/tmp/pip-QVKmqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:42:09 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)) 02:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:42:09 INFO - Running setup.py (path:/tmp/pip-VLiYU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:42:09 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)) 02:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:42:09 INFO - Running setup.py (path:/tmp/pip-XnnxM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:42:09 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)) 02:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:42:09 INFO - Running setup.py (path:/tmp/pip-JkzUVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:42:09 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)) 02:42:09 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)) 02:42:09 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)) 02:42:09 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)) 02:42:09 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)) 02:42:09 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)) 02:42:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:42: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 02:42: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 02:42: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 02:42: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 02:42: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 02:42: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 02:42:10 INFO - Downloading blessings-1.6.tar.gz 02:42:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:42:10 INFO - Installing collected packages: blessings 02:42:10 INFO - Running setup.py install for blessings 02:42:10 INFO - Successfully installed blessings 02:42:10 INFO - Cleaning up... 02:42:10 INFO - Return code: 0 02:42:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:42:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:42:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:42:10 INFO - Reading from file tmpfile_stdout 02:42:10 INFO - Current package versions: 02:42:10 INFO - argparse == 1.2.1 02:42:10 INFO - blessings == 1.6 02:42:10 INFO - blobuploader == 1.2.4 02:42:10 INFO - docopt == 0.6.1 02:42:10 INFO - functools32 == 3.2.3-2 02:42:10 INFO - jsonschema == 2.5.1 02:42:10 INFO - manifestparser == 1.1 02:42:10 INFO - mozInstall == 1.12 02:42:10 INFO - mozcrash == 1.0 02:42:10 INFO - mozdebug == 0.1 02:42:10 INFO - mozdevice == 0.50 02:42:10 INFO - mozfile == 1.2 02:42:10 INFO - mozhttpd == 0.7 02:42:10 INFO - mozinfo == 0.9 02:42:10 INFO - mozleak == 0.1 02:42:10 INFO - mozlog == 3.4 02:42:10 INFO - moznetwork == 0.27 02:42:10 INFO - mozprocess == 0.25 02:42:10 INFO - mozprofile == 0.28 02:42:10 INFO - mozrunner == 6.13 02:42:10 INFO - mozscreenshot == 0.1 02:42:10 INFO - mozsystemmonitor == 0.3 02:42:10 INFO - moztest == 0.8 02:42:10 INFO - mozversion == 1.4 02:42:10 INFO - psutil == 3.1.1 02:42:10 INFO - requests == 1.2.3 02:42:10 INFO - wsgiref == 0.1.2 02:42:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:42: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')]} 02:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42: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')]} 02:42:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:10 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 0x10501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1148a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12edb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb290>, '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 0x12ebb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ec040>, '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': 'db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004', '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 02:42:10 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 02:42:10 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 02:42:10 INFO - Using env: {'DISPLAY': ':0', 02:42:10 INFO - 'HOME': '/home/cltbld', 02:42:10 INFO - 'LANG': 'en_US.UTF-8', 02:42:10 INFO - 'LANGUAGE': 'en_US:en', 02:42:10 INFO - 'LOGNAME': 'cltbld', 02:42:10 INFO - 'MAIL': '/var/mail/cltbld', 02:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:10 INFO - 'MOZ_NO_REMOTE': '1', 02:42:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:10 INFO - 'NO_EM_RESTART': '1', 02:42:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:10 INFO - 'PWD': '/builds/slave/test', 02:42:10 INFO - 'SHELL': '/bin/bash', 02:42:10 INFO - 'SHLVL': '1', 02:42:10 INFO - 'TERM': 'linux', 02:42:10 INFO - 'TMOUT': '86400', 02:42:10 INFO - 'USER': 'cltbld', 02:42:10 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004', 02:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:10 INFO - '_': '/tools/buildbot/bin/python'} 02:42:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:11 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)) 02:42:11 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)) 02:42:11 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)) 02:42:11 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)) 02:42:11 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)) 02:42:11 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)) 02:42:11 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)) 02:42:11 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)) 02:42:11 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)) 02:42:11 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)) 02:42:11 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)) 02:42:11 INFO - Cleaning up... 02:42:11 INFO - Return code: 0 02:42:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:42:11 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')]} 02:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:11 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')]} 02:42:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:11 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 0x10501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1148a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12edb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12eb290>, '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 0x12ebb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ec040>, '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': 'db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004', '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 02:42:11 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 02:42:11 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 02:42:11 INFO - Using env: {'DISPLAY': ':0', 02:42:11 INFO - 'HOME': '/home/cltbld', 02:42:11 INFO - 'LANG': 'en_US.UTF-8', 02:42:11 INFO - 'LANGUAGE': 'en_US:en', 02:42:11 INFO - 'LOGNAME': 'cltbld', 02:42:11 INFO - 'MAIL': '/var/mail/cltbld', 02:42:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:11 INFO - 'MOZ_NO_REMOTE': '1', 02:42:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:11 INFO - 'NO_EM_RESTART': '1', 02:42:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:11 INFO - 'PWD': '/builds/slave/test', 02:42:11 INFO - 'SHELL': '/bin/bash', 02:42:11 INFO - 'SHLVL': '1', 02:42:11 INFO - 'TERM': 'linux', 02:42:11 INFO - 'TMOUT': '86400', 02:42:11 INFO - 'USER': 'cltbld', 02:42:11 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004', 02:42:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:11 INFO - '_': '/tools/buildbot/bin/python'} 02:42:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:42:11 INFO - Cleaning up... 02:42:11 INFO - Return code: 0 02:42:11 INFO - Running post-action listener: _resource_record_post_action 02:42:11 INFO - Running post-action listener: _start_resource_monitoring 02:42:11 INFO - Starting resource monitoring. 02:42:11 INFO - [mozharness: 2017-05-04 09:42:11.437550Z] Finished create-virtualenv step (success) 02:42:11 INFO - [mozharness: 2017-05-04 09:42:11.438482Z] Running install step. 02:42:11 INFO - Running pre-action listener: _resource_record_pre_action 02:42:11 INFO - Running main action method: install 02:42:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:42:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:42:11 INFO - Reading from file tmpfile_stdout 02:42:11 INFO - Detecting whether we're running mozinstall >=1.0... 02:42:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:42:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:42:11 INFO - Reading from file tmpfile_stdout 02:42:11 INFO - Output received: 02:42:11 INFO - Usage: mozinstall [options] installer 02:42:11 INFO - Options: 02:42:11 INFO - -h, --help show this help message and exit 02:42:11 INFO - -d DEST, --destination=DEST 02:42:11 INFO - Directory to install application into. [default: 02:42:11 INFO - "/builds/slave/test"] 02:42:11 INFO - --app=APP Application being installed. [default: firefox] 02:42:11 INFO - mkdir: /builds/slave/test/build/application 02:42:11 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'] 02:42:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:42:26 INFO - Reading from file tmpfile_stdout 02:42:26 INFO - Output received: 02:42:26 INFO - /builds/slave/test/build/application/firefox/firefox 02:42:26 INFO - Running post-action listener: _resource_record_post_action 02:42:26 INFO - [mozharness: 2017-05-04 09:42:26.603353Z] Finished install step (success) 02:42:26 INFO - [mozharness: 2017-05-04 09:42:26.603627Z] Running run-tests step. 02:42:26 INFO - Running pre-action listener: _resource_record_pre_action 02:42:26 INFO - Running main action method: run_tests 02:42:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:42:26 INFO - Python 2.7.3 02:42:26 INFO - Return code: 0 02:42:26 INFO - grabbing minidump binary from tooltool 02:42:26 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')]} 02:42:26 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 0x12eb290>, '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 0x12ebb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ec040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:42:26 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 02:42:26 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 02:42:26 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 02:42:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:42:26 INFO - Return code: 0 02:42:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:42:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:42:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:42:26 INFO - ENV: RUST_BACKTRACE is now 1 02:42:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:42:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:42:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 02:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 02:42:26 INFO - Using env: {'DISPLAY': ':0', 02:42:26 INFO - 'HOME': '/home/cltbld', 02:42:26 INFO - 'LANG': 'en_US.UTF-8', 02:42:26 INFO - 'LANGUAGE': 'en_US:en', 02:42:26 INFO - 'LOGNAME': 'cltbld', 02:42:26 INFO - 'MAIL': '/var/mail/cltbld', 02:42:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:42:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:26 INFO - 'MOZ_NO_REMOTE': '1', 02:42:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:26 INFO - 'NO_EM_RESTART': '1', 02:42:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:26 INFO - 'PWD': '/builds/slave/test', 02:42:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:42:26 INFO - 'RUST_BACKTRACE': '1', 02:42:26 INFO - 'SHELL': '/bin/bash', 02:42:26 INFO - 'SHLVL': '1', 02:42:26 INFO - 'TERM': 'linux', 02:42:26 INFO - 'TMOUT': '86400', 02:42:26 INFO - 'USER': 'cltbld', 02:42:26 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004', 02:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:26 INFO - '_': '/tools/buildbot/bin/python'} 02:42:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 02:42:26 INFO - mozversion application_buildid: 20170504091753 02:42:26 INFO - mozversion application_changeset: 33b92d9c40562dab3d7b602368c75619f1d793f7 02:42:26 INFO - mozversion application_display_name: Nightly 02:42:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:42:26 INFO - mozversion application_name: Firefox 02:42:26 INFO - mozversion application_remotingname: firefox 02:42:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:42:26 INFO - mozversion application_vendor: Mozilla 02:42:26 INFO - mozversion application_version: 55.0a1 02:42:26 INFO - mozversion platform_buildid: 20170504091753 02:42:26 INFO - mozversion platform_changeset: 33b92d9c40562dab3d7b602368c75619f1d793f7 02:42:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:42:26 INFO - mozversion platform_version: 55.0a1 02:42:26 INFO - using testdate: 1493890946 02:42:26 INFO - actual date: 1493890946 02:42:26 INFO - starting webserver on 'localhost:45447' 02:42:26 INFO - SUITE-START | Running 2 tests 02:42:26 INFO - TEST-START | dromaeo_css 02:42:26 INFO - operating with platform_type : linux_ 02:42:26 INFO - Initialising browser for dromaeo_css test... 02:42:27 INFO - TEST-INFO | started process 3332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkvkUiz/profile http://localhost:45447/getInfo.html) 02:42:33 INFO - PID 3332 | __metrics Screen width/height:1600/1200 02:42:33 INFO - PID 3332 | colorDepth:24 02:42:33 INFO - PID 3332 | Browser inner width/height: 1024/695 02:42:33 INFO - PID 3332 | __metrics 02:42:36 INFO - TEST-INFO | 3332: exit 0 02:42:36 INFO - Browser initialized. 02:42:36 INFO - Running cycle 1/1 for dromaeo_css test... 02:42:36 INFO - TEST-INFO | started process 3504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkvkUiz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:42:48 INFO - PID 3504 | RSS: Main: 160751616 02:42:48 INFO - PID 3504 | 02:45:52 INFO - PID 3504 | Cycle 1(1): loaded http://localhost:45447/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45447/tests/dromaeo/cssquery-ext.html) 02:45:56 INFO - PID 3504 | RSS: Main: 163893248 02:45:56 INFO - PID 3504 | 02:48:58 INFO - PID 3504 | Cycle 1(1): loaded http://localhost:45447/tests/dromaeo/cssquery-ext.html (next: http://localhost:45447/tests/dromaeo/cssquery-jquery.html) 02:48:58 INFO - PID 3504 | RSS: Main: 158441472 02:48:58 INFO - PID 3504 | 02:52:00 INFO - PID 3504 | Cycle 1(1): loaded http://localhost:45447/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45447/tests/dromaeo/cssquery-mootools.html) 02:52:01 INFO - PID 3504 | RSS: Main: 165617664 02:52:01 INFO - PID 3504 | 02:55:03 INFO - PID 3504 | Cycle 1(1): loaded http://localhost:45447/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45447/tests/dromaeo/cssquery-prototype.html) 02:55:03 INFO - PID 3504 | RSS: Main: 158121984 02:55:03 INFO - PID 3504 | 02:58:06 INFO - PID 3504 | Cycle 1(1): loaded http://localhost:45447/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45447/tests/dromaeo/cssquery-yui.html) 02:58:07 INFO - PID 3504 | RSS: Main: 163909632 02:58:07 INFO - PID 3504 | 03:01:08 INFO - PID 3504 | Cycle 1(1): loaded http://localhost:45447/tests/dromaeo/cssquery-yui.html (next: http://localhost:45447/tests/dromaeo/cssquery-dojo.html) 03:01:09 INFO - PID 3504 | RSS: Main: 165912576 03:01:09 INFO - PID 3504 | 03:01:09 INFO - PID 3504 | __start_tp_report 03:01:09 INFO - PID 3504 | _x_x_mozilla_page_load 03:01:09 INFO - PID 3504 | _x_x_mozilla_page_load_details 03:01:09 INFO - PID 3504 | |i|pagename|runs| 03:01:09 INFO - PID 3504 | |0;dojo.html;2770.4874598199335;2774.348028213371;2798.188525327655;2807.1999480148174;2815.1413818785263;5238.240455134003;5390.460953904608;5393.514583687467;5417.45825417458;5422.1595652673805;5339.385970613381;5350.839474815752;5366.4096949335635;5475.67145971242;5477.835664930049;4464.776761161945;4753.809847606091;4760.476347601761;4764.047190561884;4785.186518291899;4813.181759100961;4828;4856.05306965142;4868.2697595360805;4882.121218180726;4688.695234809727;4705.5764981151515;4746.430428348585;4763.64272679547;4790.353302304179;4774.450938142123;4780.641451891122;4788.138135135674;4802.615790736732;4832.806687732486;4712.128256272601;4741.454732705749;4748.192807222746;4755.239161734106;4785.042991401733;5238.214267859814;5290.470952904717;5340.599455040849;5377.489138531833;5389.865253368658;5784;5795.449432303966;5796.50729687977;5797.507211886995;5801.825945221608;5819.447152520504;5842.591018628697;5842.707864606753;5843.065109582489;5847.093700476433;5344.198370244494;5386.407495175527;5392.676439413648;5393.622446428791;5395.622306438511;5902.557308201902;5926.940730592725;5942.168096466498;5949.9107513387335;5961.970190149022;5667.40492248308;5688.857778555569;5699.487046165865;5702.8289151325525;5707;5861.531077513874;5861.736221870026;5867.826434713074;5928.258967629046;5940.316863560746;5814.215080964101;5822.214001109881;5826.504747096545;5831.358550559435;5833;5687.77248910039;5759.798407055817;5810.5351571875;5825.796097136665;5831.387704290988;4752.928706069342;4794.640401969867;4796.640251981115;4800.279958006327;4809.591184749265;4155.625993660585;4177.603127702924;4194.832206711759;4230.323148296257;4254.936175957363;4934.9753251233515;4950.133726597831;4959.70241785494;4962.851114466572;4999.350084488993;5732.484076433141;5818.389069147764;5877.9118313225335;5886.05823068307;5938.910916336258;4893.168161412568;4942.950570494321;4964.726940018334;4968.552830245295;4974.104661161025;5151.510606492452;5184.714840683799;5189.7405129743365;5189.766460509286;5231.163013917755;5316.441773613869;5413.918791218056;5419.3225846769155;5420.105682562333;5424.2406063151975;5777.2200752897825;5818.476337129509;5906.911396328973;5907.438793314628;5908.084246941731;5319.893602128013;5325.840224793263;5372.059889519241;5403.351597808288;5428.891422171613;5651.971740141273;5674.404187560247;5683.863227354628;5688.5733569981585;5719.742611582572;5733.770649173986;5812;5818.418158184148;5833.970830145822;5834.329052159056;5610.102383618601;5616.803411880728;5621.353544342453;5624.437556244507;5628.662280263197;5560.054790685513;5600.991821472174;5608.6073974823;5614.915776263278;5631.099024156116;5441.591880608891;5453.836384908459;5485.259489968803;5490.670559766427;5497.038018346853;5672.262605861211;5679.062954612608;5679.886402271849;5681.545476361798;5689.829305120853;5506.311711036121;5510.063289240758;5520.917186242129;5526.778928842801;5551.195076713934 03:01:09 INFO - PID 3504 | |1;ext.html;715.8496715689705;736.1534235629026;950.6435086842434;964.4020707161561;1103.751655877427;28804;31572.842135789346;31848.203794905137;32314;32331;30002.549961750537;30280.24299392511;30297.697023029763;30358.54462183069;30375.240618984535;6221.471174950123;6378.585391949531;6382.457491113261;6390.584612000228;7048.929510704878;6920.10038694969;7076.115485564304;7077.469189810759;7077.823054423655;7079.327463890922;7046.85906281874;7073.610951397671;7089.539179953286;7096.43228541718;7104.538205016684;7015.368616824459;7026.683799229047;7043.542169758949;7075.150981882207;7082.539634923739;6937.375636192716;6942.409895158918;6987.161540615108;7008.544444611084;7023.683934222972;31275.84362078198;31308;31521.21196970071;31630.36739265225;31740.841295793372;2936.7063293670462;2963.9851800741076;2981.344104297073;2996.625421822272;3000.8649610767566;24307.756922430726;24347.634785478233;24596.385090372885;24598.385040373956;24721.752782472126;2755.669319681631;2757.7380148885823;2759.213624117137;2769.9169024929283;2773.3898542320658;143102;143342;143393;144621;144815.27592362076;36020;37960;38075.23849523049;38142;38648.613513864504;40142.397864032064;40277.39583906244;40284.798576006935;40421.59578404237;40533;11258.380789056517;11442.37066961325;11456.885431145749;11461.770764584662;11474.94262528682;8952.731418057469;9039.186473217442;9128.954355228181;9234.49210293427;9251.306152038624;12486;12499.312537810507;12535.561255356019;12560.30918299484;12643.683907902376;5223.503767142115;5326.147816349366;5337.2527846101575;5339.5728341732565;5433.347998240237;831.6465502161557;858.429144618834;872.1191596487594;893.5353616119581;894.821035792844;19690.412367531757;20865.37403877886;20884;20973.79026209749;21056.26303079385;921.7142685767434;933.9766505837273;951.5717926932908;962.6341990043738;965.8551217317458;10655.30740501865;10805.189610779224;11014.944925275322;11066.336019838835;11159.107271418266;178583;179159;179490;179680;180415;39700.20599587992;39866.20267594632;39905.2018959625;39982.80094594825;40052.39921401181;1195.483507217295;1204.4158583087196;1224.3572124634638;1228.1403017887515;1230.034422977958;19554;19630.607387852448;20055.398338049883;20564.588708225452;20993.685094723896;27198.72801272041;27324.726752733015;27418.5887211688;27457;27470;135831;139073;149899;151126;151643;30182.84908575443;30316.090517284516;30442.238944026576;30525.23686907845;30632.387352252383;35655;36064.45903311505;36068;36367;36570.8171459141;27430.5885411715;27608.54893138358;28312.150635480968;28560.85719571389;29129.7087029127;26384.208473745817;26466;26903.192904212905;27085.322866928484;28321.291967700974;30174.245643859078;30221.848890756286;30232.24419389445;30274.394512110073;30480.84759576188;26119.216423507325;26309.736902630728;26781.330466738487;26892.193234203005;27908.58137127904;21101.788982110596;21634.459138521663;21800.45498862541;21835.454113647287;22052.448688782908 03:01:09 INFO - PID 3504 | |2;jquery.html;399.28328650073115;406.4370846377766;416.29853696521366;424.60299619855425;434.9217140914634;16907.1546422679;17548;17559;17582.560435989108;18453.815461845377;18830.90584547079;19116.139773710183;19130.904345478288;19141.42575722727;19412.708809367872;5352.678839269637;5425.457454254562;5492.368377636583;5516.862078448031;5548.167774833767;5511.559075273988;5579.330480342364;5585.3297604287545;5589.133684278943;5607.074832652607;5394.811181608645;5451.945480545203;5462.972685136589;5518.862028449301;5572.192032155335;5446.673199608016;5467.58993075517;5479.068558345071;5483.725813709319;5513.724313784295;4861.270809378586;4928.137575924235;4963.4292056413615;5010.69935803853;5054.06499797535;22157;22301.442463938532;22498.66252006221;22694.659580106312;22950.42623934415;1616.1757503673211;1665.6585399992973;1676.8155502894672;1680.495851244634;1685.9578510537212;14661.926690366587;14769.556913292618;14802.777958330633;15008.47470338533;15024.323905424282;2019.6667549854255;2069.9172033118657;2090.3728881335537;2118.152738904435;2129.95740085199;88550;88592;90182.5490872548;90401.54799226028;91627.00475942863;10478.476076196159;10745.14038876888;10973.83539246912;11028.117750579935;11121.888781112086;15057.623559411102;15104.471343503144;15139.697206055816;15159.469418570297;15193.924030379778;7066.646667666596;7167.569945803269;7241.348278654947;7387.667554959932;7416.25837416254;6959.791206263821;6970.337817907291;6981.441484681213;7154.642267886585;7212.206657267697;6761.898571521431;6873.656317184121;6947.89578156328;6997.475189360818;7012.789616311519;1895.2134864031273;1918.7121931710356;1937.6124775045048;1939.6702560564738;2077.8649387789746;833.4082801211208;853.5646820121658;862.7584276402491;867.7830542364409;895.6909866096187;16865.66268674644;17022.82977170237;17080.743788843178;17302.567435814206;17864.19611117477;867.6659486097898;876.9166929141721;885.4864178776423;889.0975659705405;898.4699027573632;9056.426504615127;9387;9671.081247281498;9685.564149613285;9747.3664211826;360593;365220;367440;369343;369566;69995.65002174956;71298.64350678213;72410.9138362925;72470.63764681143;75618.62190689011;1013.7972405518926;1035.7773078788098;1058.4866339825178;1066.8293073108266;1071.978560428787;14727.852721472647;14772.48296309624;14774.039687420283;14968.625784355478;15491.922540387226;36818.447723283636;38906.22187556289;39889.40165897456;40083.198336033696;40229.597704023756;47968;47998.84005219704;48159.518404815506;48341.758291208316;48460.757696211294;8055.959720201361;8122.147174546824;8192.549409782281;8400.41197116196;8446.66213351459;12718.427670754652;13369.465221391036;13461.932690336485;13536.864631353561;13741.725165496833;11039.83440248413;11445.885541144815;11573;11697.473613687574;11965.102617303563;10353.17174626013;10482.63310784119;10632.468376581295;11054.723631909266;11128.888711112786;11281.661550153509;11460.426978651201;11743.706407339885;11806.763864722485;12084.879151208375;8025.438219324825;8129.390295727962;8202.712905048294;8471.526674063605;8502.277306429023;11197.496112675111;11455.255408398427;11556.191066625255;11690.357030363411;11772.764544709229 03:01:09 INFO - PID 3504 | |3;mootools.html;1251.7746805574998;1293.1982171053949;1301.4663987765011;1309.378045428421;1314.1786383510307;9652.565634546445;9997.450140242292;10090.495475226237;10180.18558515319;10395.116415104725;10141.695749127539;10232.07911287984;10304.38173709578;10310.432926189056;10312;2098.853080284377;2147.3235930681863;2148.796673862642;2163.556470923457;2163.816075633573;2058.7632422271404;2116.33335499318;2123.7557680866744;2128.8935553222354;2136.647453170225;2069.5860827834417;2075.4707549574837;2121.7666056733747;2124.129107066103;2132.7867213278705;1920.7791104023006;1935.3806781829749;1942.291063761731;1949.41517544736;1956.1197461142542;1950.2686492565288;1953.7655481342188;1962.2641509433963;2063.607914496241;2073.4194425560718;10232;10256.076953074184;10333.379997200193;10354.482275886176;10354.534045967874;5453.127499600045;5631;5695.857603559903;5702.087665973466;5702.657840529581;3108.300632357724;3292.571965644475;3334.0164651427885;3346.7322614190807;3385.6614338565946;1016.4054028393399;1019.6125472320545;1021.0402221911454;1075.8063548561256;1077.6012875236213;14664.780028299478;14709;14780.926095369561;14805.481808136663;14865.108093514316;4454.710443821206;4542.704724192917;4777.880552986203;4802.255650374198;4837.854864354075;10837.891621083845;10854.29447085937;10860.837087443695;10870.293430926964;10871.29336593119;5209.322788037531;5211.452797456288;5222.556082732935;5224.7126408047925;5240;4988.201887697951;4998.775055122528;5042.571381432619;5127.97436012825;5134.8973020540125;3774.1130834253927;3784.4890939722786;3861.498005259298;3922.7057970652313;3953.6046395360236;1060.6764936694228;1070.1492313610697;1076;1083.2309060567086;1091.7052395853075;677.7119724117231;687.7592842505084;696.5263620737946;709.2907092907093;713.9571625702474;5466.070767969455;6320.5891617044745;6374.521910856612;6411.775587854403;6486.545941784124;834.1575009240711;837.7486753973783;841.188253335522;851.3742399336483;854.1031916487663;3744.382176940774;3779.905502362463;3857.3056849767313;3867.3038853006165;3935.193285376491;13005.869941300654;13230.272335021666;13523.932380338036;13555.118917270345;13605.115667481581;13167.209967401986;13175.209487430784;13193.538226162038;13301.66745831362;13309.534166304133;7489.812754681177;7505.249475052451;7546.396288297033;7574.394048476109;7730.690772369155;5883.2057672213705;5906.557008224315;5999.340072592098;6029.125776762433;6098.054801505774;11749.412529373327;11822.054235661299;11845.348505831917;12091.334976576372;12130.575429859913;11872.940635296769;12361;12366.258024518558;12428.067894907737;12428.316442595744;7260.89108663381;7360;7366.815829604088;7374.631268436664;7387.298206670358;9208.585613647536;9225.677101301422;9262.629494820132;9376.437413755197;9386.43681379092;7975.282224599582;8019.438639295427;8020.358371330163;8031.759047228593;8043.316318113026;7615.504992175491;7651.426143039405;7671.309582137635;7693.49992250502;7869.213078692085;7473.738419155304;7474.551526908403;7548;7554.584497852671;7556;4799.928001080057;5098.413682426569;5177.741112944413;5207.270982062439;5386.030514507426;5240.109181439241;5291.682499050069;5302.1781623848365;5334.093204155225;5511.173324001432 03:01:09 INFO - PID 3504 | |4;prototype.html;354.9858005679773;370.5201763715988;371.22599380292087;374.0797637810985;374.6403452685422;5516.641418307807;5692.402297758737;5710;5721.570882183837;5726.37009928908;5420.647657902234;5516.227728118067;5524.475174858382;5533.142362933741;5546.417626149257;4116.567760385161;4120.876373708794;4130.938035929464;4132.173565286939;4151.14901445203;4087.7093939378788;4131.772752498611;4150;4153.314703073989;4166.562510936354;4068.8982775430554;4074.1851629674034;4081.8979525511804;4083.3666533386586;4117.279476091687;4076.4496792932873;4102.118044620391;4103.569125241851;4108.732932359417;4123.36087906372;3569.161247106928;3576.535050443452;3581.713462922986;3582.158192824684;3582.946255806165;5270.629636294591;5390;5395;5443;5461.126219804852;4817.397825271841;4819.879503012417;4837.274408838667;4838.443578988426;4841.225403935388;5730.19777231188;5880.647161170301;5882.588218824684;5883.117532370179;5901.852453688693;3990.0024993751563;3994;4000.159966407058;4002.1195337025806;4025.5169379674335;6066.998945174041;6166.445019948226;6260.499160067184;6273.153124328249;6309.5898766580485;4091.672666186698;4096.487939007624;4099.200655872076;4100.34394496879;4118.979405103015;4171.165766846643;4175.958240417557;4176.77027763476;4181.498220213593;4191.287481128215;4756;4815.566599006106;4855;4874.878128046827;4886.242632391985;5890.587658863924;5892.882142357129;5912.733926973297;5918.141869428909;5921.624673935901;1422.8292604887479;1437.8497202238377;1439.6976634906578;1449.0436312034008;1450.4633285684365;939.4128669581512;944.9480278584606;947.3889341374775;952.9190018848476;962.2830990911675;5114.923276150861;5133.101707201225;5143.17709166539;5178.404483484373;5193.610479214074;6131.049687298476;6131.96934015327;6189.81430557084;6197.752089916443;6198.597091189148;4927.359443272351;5039;5079.771410286546;5110.594586488671;5144.228365745168;3230.9192270193435;3264.3308121834966;3269.346130773855;3272;3276.0990727550115;5478.205660179252;5602.2717046783655;5653.830385088454;5655.745491452894;5668.526183192317;6222.62664240147;6244.937550624436;6258.123862659231;6273.560850740404;6289.905651415233;5580.748866301026;5641.887162256814;5645.576581756384;5660.29246344207;5681.460261275255;5965;6089.878202436015;6125.9693701531205;6146.200993870947;6163.414475624809;5889.263842019747;6054.848628784315;6056.454919057306;6066.817995460143;6069.453749162597;5618.775248989995;5657.2079908811975;5664.178694089416;5671.801486947937;5680.176374425768;3974.900627484336;4005.9584508028706;4018.3168861293066;4022.1352409232154;4024.2896768873698;6022.427869352405;6133.233345831771;6140.324564298013;6171.876562468815;6176.073588961692;5844.912326315194;5920.259967504062;5930.762769489172;5932.79235226765;5940.732667029907;5776.653400795965;5815.615597604961;5903.963132719205;5916.822495325147;5935.881282374415;5759.568032397503;5791.623544469596;5792.710364481674;5795.275590551181;5812.7674893003805;5949.78029503942;5953.91069133972;5962.910556341745;5972.820815375546;5979.073243647242;5625.606207565595;5676.2337084493065;5759.934412133769;5767.538596912321;5786.479216870502 03:01:09 INFO - PID 3504 | |5;yui.html;722.678408108392;745.8098184962834;747.1631772414893;761.4099073218255;764.4572353628924;11492.482838272277;11549.364784936824;12379.56671516497;13232.73534529309;13245;14257.429702811902;14699.118052916832;14835.258237088156;14903.031302965299;14942.775858362133;815.6288888555707;826.6775957376628;827.8302947895697;829.4359835311985;830.4477522447565;894.3337213775746;898.9370744047919;899.33449247557;900.6667533012794;901.378049146087;922.3866129024225;927.972160835176;930.3998920696147;932.0167223579122;936.484933286693;915.7756349694301;921.1065266691298;922.5064590444114;922.6632279218037;922.7139586728102;679.0696745458704;680.8263892707328;683.8016975077221;684.3464491410691;686.821426429132;12445.93777031118;12578.937105314506;12584.559540416132;13071.281079540622;13274.269915154662;15047.322870470854;15088.17015064171;15521.379144834193;15526.689466210613;15598.454054108051;11741.647750567497;11972;12050.216735912225;12097.637070887888;12152.756944861141;2430.4895971845935;2455.202059330707;2458.6434966929874;2461.2616215135386;2463.593507071349;67037.66481167563;67130.66434667844;67455.3254467454;68810.65594672094;69047;10082.24383171265;10182.898171018343;10389.740256493496;11624.418779061014;11811.645650630495;21244.150233990465;21528.246511372028;21725.565488690452;21818.672719909213;21887.452813679465;5906.40935906406;6046.697665116814;6048.334683184846;6060.575759696867;6125.295591007091;2797.608334833125;2851.3584443500463;2851.828890266591;2853.2866783304175;2873.281679580105;3147.669494703069;3204.9679503205134;3207.6792320767736;3253.072874230833;3253.8047717137047;680.0547239337325;684.5995092870627;685.7462738786581;686.1834417043702;691.374306252842;597.6682940967718;602.6354055796268;603.5352778360638;604.4469310580857;627.1658693937053;9680.41917484939;9954.751131221778;10043.146332561668;10157.288989770794;10245.436500992517;589.8230530840816;599.8230521996022;600.5225845452876;605.4913872347162;616.8550390658191;4615.330777037311;4618;4712.104700106968;4715.929261061086;4741.288806679026;65604.34395656078;66281;66473;68239.31760682429;68544.97182542266;58074.7096264516;58090.419095809346;59115;59412.70293648504;59546.40453595408;48449.75775121172;49310.50689493059;50097;50984;51211;9232.127008681791;9971.850422243528;9972.152367048882;9991.800163996533;10014.449205293779;26118.608220876322;26139.869300653376;26432.471350573265;26696.733032669425;27462.862685686443;31708.682913170574;32020.67979320177;32605.836970814995;33050.17374565655;33106.66893331036;10512.894871051192;10572.629957951434;10703.571857125628;10830.18773591968;10901.182411319025;12662.873371266538;12838.550650727553;13207.933960330522;13209.339533023118;13218.405171767487;11455.198136130392;11612.419379031184;11702.648920532398;11798.115141364604;11923.463444144862;11769.470373833026;11823.408829558315;12149.75700486003;12163.878361216628;12270.509179632714;12316.81524777147;12387.504499820267;12480.750384992069;12527.624171274876;12610.684732881751;8018.238267364591;8053.275205231557;8298.875516867372;8378.53918034514;8455.281301089477;9588.616455341707;9613.951930240304;9655.951720241354;9733.805323893625;9943.25425593069 03:01:09 INFO - PID 3504 | __end_tp_report 03:01:09 INFO - PID 3504 | __start_cc_report 03:01:09 INFO - PID 3504 | _x_x_mozilla_cycle_collect,356 03:01:09 INFO - PID 3504 | __end_cc_report 03:01:09 INFO - PID 3504 | __startTimestamp1493892069123__endTimestamp 03:01:09 INFO - PID 3504 | 03:01:09 INFO - PID 3504 | ------- Summary: start ------- 03:01:09 INFO - PID 3504 | Number of tests: 6 03:01:09 INFO - PID 3504 | 03:01:09 INFO - PID 3504 | [#0] dojo.html Cycles:165 Average:5298.39 Median:5428.89 stddev:627.57 (11.6%) stddev-sans-first:597.35 03:01:09 INFO - PID 3504 | Values: 2770.5 2774.3 2798.2 2807.2 2815.1 5238.2 5390.5 5393.5 5417.5 5422.2 5339.4 5350.8 5366.4 5475.7 5477.8 4464.8 4753.8 4760.5 4764.0 4785.2 4813.2 4828.0 4856.1 4868.3 4882.1 4688.7 4705.6 4746.4 4763.6 4790.4 4774.5 4780.6 4788.1 4802.6 4832.8 4712.1 4741.5 4748.2 4755.2 4785.0 5238.2 5290.5 5340.6 5377.5 5389.9 5784.0 5795.4 5796.5 5797.5 5801.8 5819.4 5842.6 5842.7 5843.1 5847.1 5344.2 5386.4 5392.7 5393.6 5395.6 5902.6 5926.9 5942.2 5949.9 5962.0 5667.4 5688.9 5699.5 5702.8 5707.0 5861.5 5861.7 5867.8 5928.3 5940.3 5814.2 5822.2 5826.5 5831.4 5833.0 5687.8 5759.8 5810.5 5825.8 5831.4 4752.9 4794.6 4796.6 4800.3 4809.6 4155.6 4177.6 4194.8 4230.3 4254.9 4935.0 4950.1 4959.7 4962.9 4999.4 5732.5 5818.4 5877.9 5886.1 5938.9 4893.2 4943.0 4964.7 4968.6 4974.1 5151.5 5184.7 5189.7 5189.8 5231.2 5316.4 5413.9 5419.3 5420.1 5424.2 5777.2 5818.5 5906.9 5907.4 5908.1 5319.9 5325.8 5372.1 5403.4 5428.9 5652.0 5674.4 5683.9 5688.6 5719.7 5733.8 5812.0 5818.4 5834.0 5834.3 5610.1 5616.8 5621.4 5624.4 5628.7 5560.1 5601.0 5608.6 5614.9 5631.1 5441.6 5453.8 5485.3 5490.7 5497.0 5672.3 5679.1 5679.9 5681.5 5689.8 5506.3 5510.1 5520.9 5526.8 5551.2 03:01:09 INFO - PID 3504 | 03:01:09 INFO - PID 3504 | [#1] ext.html Cycles:180 Average:29637.37 Median:30227.05 stddev:40551.75 (134.2%) stddev-sans-first:40607.36 03:01:09 INFO - PID 3504 | Values: 715.8 736.2 950.6 964.4 1103.8 28804.0 31572.8 31848.2 32314.0 32331.0 30002.5 30280.2 30297.7 30358.5 30375.2 6221.5 6378.6 6382.5 6390.6 7048.9 6920.1 7076.1 7077.5 7077.8 7079.3 7046.9 7073.6 7089.5 7096.4 7104.5 7015.4 7026.7 7043.5 7075.2 7082.5 6937.4 6942.4 6987.2 7008.5 7023.7 31275.8 31308.0 31521.2 31630.4 31740.8 2936.7 2964.0 2981.3 2996.6 3000.9 24307.8 24347.6 24596.4 24598.4 24721.8 2755.7 2757.7 2759.2 2769.9 2773.4 143102.0 143342.0 143393.0 144621.0 144815.3 36020.0 37960.0 38075.2 38142.0 38648.6 40142.4 40277.4 40284.8 40421.6 40533.0 11258.4 11442.4 11456.9 11461.8 11474.9 8952.7 9039.2 9129.0 9234.5 9251.3 12486.0 12499.3 12535.6 12560.3 12643.7 5223.5 5326.1 5337.3 5339.6 5433.3 831.6 858.4 872.1 893.5 894.8 19690.4 20865.4 20884.0 20973.8 21056.3 921.7 934.0 951.6 962.6 965.9 10655.3 10805.2 11014.9 11066.3 11159.1 178583.0 179159.0 179490.0 179680.0 180415.0 39700.2 39866.2 39905.2 39982.8 40052.4 1195.5 1204.4 1224.4 1228.1 1230.0 19554.0 19630.6 20055.4 20564.6 20993.7 27198.7 27324.7 27418.6 27457.0 27470.0 135831.0 139073.0 149899.0 151126.0 151643.0 30182.8 30316.1 30442.2 30525.2 30632.4 35655.0 36064.5 36068.0 36367.0 36570.8 27430.6 27608.5 28312.2 28560.9 29129.7 26384.2 26466.0 26903.2 27085.3 28321.3 30174.2 30221.8 30232.2 30274.4 30480.8 26119.2 26309.7 26781.3 26892.2 27908.6 21101.8 21634.5 21800.5 21835.5 22052.4 03:01:09 INFO - PID 3504 | 03:01:09 INFO - PID 3504 | [#2] jquery.html Cycles:180 Average:24730.49 Median:204236.11 stddev:60939.49 (29.8%) stddev-sans-first:61083.06 03:01:09 INFO - PID 3504 | Values: 399.3 406.4 416.3 424.6 434.9 16907.2 17548.0 17559.0 17582.6 18453.8 18830.9 19116.1 19130.9 19141.4 19412.7 5352.7 5425.5 5492.4 5516.9 5548.2 5511.6 5579.3 5585.3 5589.1 5607.1 5394.8 5451.9 5463.0 5518.9 5572.2 5446.7 5467.6 5479.1 5483.7 5513.7 4861.3 4928.1 4963.4 5010.7 5054.1 22157.0 22301.4 22498.7 22694.7 22950.4 1616.2 1665.7 1676.8 1680.5 1686.0 14661.9 14769.6 14802.8 15008.5 15024.3 2019.7 2069.9 2090.4 2118.2 2130.0 88550.0 88592.0 90182.5 90401.5 91627.0 10478.5 10745.1 10973.8 11028.1 11121.9 15057.6 15104.5 15139.7 15159.5 15193.9 7066.6 7167.6 7241.3 7387.7 7416.3 6959.8 6970.3 6981.4 7154.6 7212.2 6761.9 6873.7 6947.9 6997.5 7012.8 1895.2 1918.7 1937.6 1939.7 2077.9 833.4 853.6 862.8 867.8 895.7 16865.7 17022.8 17080.7 17302.6 17864.2 867.7 876.9 885.5 889.1 898.5 9056.4 9387.0 9671.1 9685.6 9747.4 360593.0 365220.0 367440.0 369343.0 369566.0 69995.7 71298.6 72410.9 72470.6 75618.6 1013.8 1035.8 1058.5 1066.8 1072.0 14727.9 14772.5 14774.0 14968.6 15491.9 36818.4 38906.2 39889.4 40083.2 40229.6 47968.0 47998.8 48159.5 48341.8 48460.8 8056.0 8122.1 8192.5 8400.4 8446.7 12718.4 13369.5 13461.9 13536.9 13741.7 11039.8 11445.9 11573.0 11697.5 11965.1 10353.2 10482.6 10632.5 11054.7 11128.9 11281.7 11460.4 11743.7 11806.8 12084.9 8025.4 8129.4 8202.7 8471.5 8502.3 11197.5 11455.3 11556.2 11690.4 11772.8 03:01:09 INFO - PID 3504 | 03:01:09 INFO - PID 3504 | [#3] mootools.html Cycles:180 Average:6223.56 Median:3782.20 stddev:4034.43 (106.7%) stddev-sans-first:4028.45 03:01:09 INFO - PID 3504 | Values: 1251.8 1293.2 1301.5 1309.4 1314.2 9652.6 9997.5 10090.5 10180.2 10395.1 10141.7 10232.1 10304.4 10310.4 10312.0 2098.9 2147.3 2148.8 2163.6 2163.8 2058.8 2116.3 2123.8 2128.9 2136.6 2069.6 2075.5 2121.8 2124.1 2132.8 1920.8 1935.4 1942.3 1949.4 1956.1 1950.3 1953.8 1962.3 2063.6 2073.4 10232.0 10256.1 10333.4 10354.5 10354.5 5453.1 5631.0 5695.9 5702.1 5702.7 3108.3 3292.6 3334.0 3346.7 3385.7 1016.4 1019.6 1021.0 1075.8 1077.6 14664.8 14709.0 14780.9 14805.5 14865.1 4454.7 4542.7 4777.9 4802.3 4837.9 10837.9 10854.3 10860.8 10870.3 10871.3 5209.3 5211.5 5222.6 5224.7 5240.0 4988.2 4998.8 5042.6 5128.0 5134.9 3774.1 3784.5 3861.5 3922.7 3953.6 1060.7 1070.1 1076.0 1083.2 1091.7 677.7 687.8 696.5 709.3 714.0 5466.1 6320.6 6374.5 6411.8 6486.5 834.2 837.7 841.2 851.4 854.1 3744.4 3779.9 3857.3 3867.3 3935.2 13005.9 13230.3 13523.9 13555.1 13605.1 13167.2 13175.2 13193.5 13301.7 13309.5 7489.8 7505.2 7546.4 7574.4 7730.7 5883.2 5906.6 5999.3 6029.1 6098.1 11749.4 11822.1 11845.3 12091.3 12130.6 11872.9 12361.0 12366.3 12428.1 12428.3 7260.9 7360.0 7366.8 7374.6 7387.3 9208.6 9225.7 9262.6 9376.4 9386.4 7975.3 8019.4 8020.4 8031.8 8043.3 7615.5 7651.4 7671.3 7693.5 7869.2 7473.7 7474.6 7548.0 7554.6 7556.0 4799.9 5098.4 5177.7 5207.3 5386.0 5240.1 5291.7 5302.2 5334.1 5511.2 03:01:09 INFO - PID 3504 | 03:01:09 INFO - PID 3504 | [#4] prototype.html Cycles:180 Average:4823.22 Median:5539.78 stddev:1461.43 (26.4%) stddev-sans-first:1426.53 03:01:09 INFO - PID 3504 | Values: 355.0 370.5 371.2 374.1 374.6 5516.6 5692.4 5710.0 5721.6 5726.4 5420.6 5516.2 5524.5 5533.1 5546.4 4116.6 4120.9 4130.9 4132.2 4151.1 4087.7 4131.8 4150.0 4153.3 4166.6 4068.9 4074.2 4081.9 4083.4 4117.3 4076.4 4102.1 4103.6 4108.7 4123.4 3569.2 3576.5 3581.7 3582.2 3582.9 5270.6 5390.0 5395.0 5443.0 5461.1 4817.4 4819.9 4837.3 4838.4 4841.2 5730.2 5880.6 5882.6 5883.1 5901.9 3990.0 3994.0 4000.2 4002.1 4025.5 6067.0 6166.4 6260.5 6273.2 6309.6 4091.7 4096.5 4099.2 4100.3 4119.0 4171.2 4176.0 4176.8 4181.5 4191.3 4756.0 4815.6 4855.0 4874.9 4886.2 5890.6 5892.9 5912.7 5918.1 5921.6 1422.8 1437.8 1439.7 1449.0 1450.5 939.4 944.9 947.4 952.9 962.3 5114.9 5133.1 5143.2 5178.4 5193.6 6131.0 6132.0 6189.8 6197.8 6198.6 4927.4 5039.0 5079.8 5110.6 5144.2 3230.9 3264.3 3269.3 3272.0 3276.1 5478.2 5602.3 5653.8 5655.7 5668.5 6222.6 6244.9 6258.1 6273.6 6289.9 5580.7 5641.9 5645.6 5660.3 5681.5 5965.0 6089.9 6126.0 6146.2 6163.4 5889.3 6054.8 6056.5 6066.8 6069.5 5618.8 5657.2 5664.2 5671.8 5680.2 3974.9 4006.0 4018.3 4022.1 4024.3 6022.4 6133.2 6140.3 6171.9 6176.1 5844.9 5920.3 5930.8 5932.8 5940.7 5776.7 5815.6 5904.0 5916.8 5935.9 5759.6 5791.6 5792.7 5795.3 5812.8 5949.8 5953.9 5962.9 5972.8 5979.1 5625.6 5676.2 5759.9 5767.5 5786.5 03:01:09 INFO - PID 3504 | 03:01:09 INFO - PID 3504 | [#5] yui.html Cycles:180 Average:14623.10 Median:4665.05 stddev:18158.67 (389.2%) stddev-sans-first:18179.61 03:01:09 INFO - PID 3504 | Values: 722.7 745.8 747.2 761.4 764.5 11492.5 11549.4 12379.6 13232.7 13245.0 14257.4 14699.1 14835.3 14903.0 14942.8 815.6 826.7 827.8 829.4 830.4 894.3 898.9 899.3 900.7 901.4 922.4 928.0 930.4 932.0 936.5 915.8 921.1 922.5 922.7 922.7 679.1 680.8 683.8 684.3 686.8 12445.9 12578.9 12584.6 13071.3 13274.3 15047.3 15088.2 15521.4 15526.7 15598.5 11741.6 11972.0 12050.2 12097.6 12152.8 2430.5 2455.2 2458.6 2461.3 2463.6 67037.7 67130.7 67455.3 68810.7 69047.0 10082.2 10182.9 10389.7 11624.4 11811.6 21244.2 21528.2 21725.6 21818.7 21887.5 5906.4 6046.7 6048.3 6060.6 6125.3 2797.6 2851.4 2851.8 2853.3 2873.3 3147.7 3205.0 3207.7 3253.1 3253.8 680.1 684.6 685.7 686.2 691.4 597.7 602.6 603.5 604.4 627.2 9680.4 9954.8 10043.1 10157.3 10245.4 589.8 599.8 600.5 605.5 616.9 4615.3 4618.0 4712.1 4715.9 4741.3 65604.3 66281.0 66473.0 68239.3 68545.0 58074.7 58090.4 59115.0 59412.7 59546.4 48449.8 49310.5 50097.0 50984.0 51211.0 9232.1 9971.9 9972.2 9991.8 10014.4 26118.6 26139.9 26432.5 26696.7 27462.9 31708.7 32020.7 32605.8 33050.2 33106.7 10512.9 10572.6 10703.6 10830.2 10901.2 12662.9 12838.6 13207.9 13209.3 13218.4 11455.2 11612.4 11702.6 11798.1 11923.5 11769.5 11823.4 12149.8 12163.9 12270.5 12316.8 12387.5 12480.8 12527.6 12610.7 8018.2 8053.3 8298.9 8378.5 8455.3 9588.6 9614.0 9656.0 9733.8 9943.3 03:01:09 INFO - PID 3504 | -------- Summary: end -------- 03:01:09 INFO - PID 3504 | 03:01:09 INFO - TEST-INFO | 3504: exit 0 03:01:09 INFO - TEST-OK | dromaeo_css | took 1122916ms 03:01:09 INFO - TEST-START | kraken 03:01:09 INFO - operating with platform_type : linux_ 03:01:09 INFO - Initialising browser for kraken test... 03:01:09 INFO - TEST-INFO | started process 3918 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAV1INS/profile http://localhost:45447/getInfo.html) 03:01:13 INFO - PID 3918 | __metrics Screen width/height:1600/1200 03:01:13 INFO - PID 3918 | colorDepth:24 03:01:13 INFO - PID 3918 | Browser inner width/height: 1024/695 03:01:13 INFO - PID 3918 | __metrics 03:01:15 INFO - TEST-INFO | 3918: exit 0 03:01:15 INFO - Browser initialized. 03:01:15 INFO - Running cycle 1/1 for kraken test... 03:01:15 INFO - TEST-INFO | started process 4090 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAV1INS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:01:27 INFO - PID 4090 | RSS: Main: 160067584 03:01:27 INFO - PID 4090 | 03:01:30 INFO - PID 4090 | Cycle 1(1): loaded http://localhost:45447/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45447/tests/kraken/driver.html?testName=audio-beat-detection) 03:01:31 INFO - PID 4090 | RSS: Main: 165421056 03:01:31 INFO - PID 4090 | 03:01:34 INFO - PID 4090 | Cycle 1(1): loaded http://localhost:45447/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45447/tests/kraken/driver.html?testName=audio-dft) 03:01:34 INFO - PID 4090 | RSS: Main: 164397056 03:01:34 INFO - PID 4090 | 03:01:37 INFO - PID 4090 | Cycle 1(1): loaded http://localhost:45447/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45447/tests/kraken/driver.html?testName=audio-fft) 03:01:38 INFO - PID 4090 | RSS: Main: 160530432 03:01:38 INFO - PID 4090 | 03:01:40 INFO - PID 4090 | Cycle 1(1): loaded http://localhost:45447/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45447/tests/kraken/driver.html?testName=audio-oscillator) 03:01:41 INFO - PID 4090 | RSS: Main: 161353728 03:01:41 INFO - PID 4090 | 03:01:43 INFO - PID 4090 | Cycle 1(1): loaded http://localhost:45447/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45447/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:01:43 INFO - PID 4090 | RSS: Main: 161861632 03:01:43 INFO - PID 4090 | 03:01:47 INFO - PID 4090 | Cycle 1(1): loaded http://localhost:45447/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45447/tests/kraken/driver.html?testName=imaging-darkroom) 03:01:47 INFO - PID 4090 | RSS: Main: 167325696 03:01:47 INFO - PID 4090 | 03:01:51 INFO - PID 4090 | Cycle 1(1): loaded http://localhost:45447/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45447/tests/kraken/driver.html?testName=imaging-desaturate) 03:01:51 INFO - PID 4090 | RSS: Main: 165339136 03:01:51 INFO - PID 4090 | 03:01:54 INFO - PID 4090 | Cycle 1(1): loaded http://localhost:45447/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45447/tests/kraken/driver.html?testName=json-parse-financial) 03:01:55 INFO - PID 4090 | RSS: Main: 166178816 03:01:55 INFO - PID 4090 | 03:01:56 INFO - PID 4090 | Cycle 1(1): loaded http://localhost:45447/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45447/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:01:57 INFO - PID 4090 | RSS: Main: 166547456 03:01:57 INFO - PID 4090 | 03:01:59 INFO - PID 4090 | Cycle 1(1): loaded http://localhost:45447/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45447/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:01:59 INFO - PID 4090 | RSS: Main: 166813696 03:01:59 INFO - PID 4090 | 03:02:02 INFO - PID 4090 | Cycle 1(1): loaded http://localhost:45447/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45447/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:02:02 INFO - PID 4090 | RSS: Main: 166981632 03:02:02 INFO - PID 4090 | 03:02:05 INFO - PID 4090 | Cycle 1(1): loaded http://localhost:45447/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45447/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:02:06 INFO - PID 4090 | RSS: Main: 166744064 03:02:06 INFO - PID 4090 | 03:02:09 INFO - PID 4090 | Cycle 1(1): loaded http://localhost:45447/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45447/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:02:10 INFO - PID 4090 | RSS: Main: 166961152 03:02:10 INFO - PID 4090 | 03:02:11 INFO - PID 4090 | Cycle 1(1): loaded http://localhost:45447/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45447/tests/kraken/driver.html?testName=ai-astar) 03:02:12 INFO - PID 4090 | RSS: Main: 168460288 03:02:12 INFO - PID 4090 | 03:02:12 INFO - PID 4090 | __start_tp_report 03:02:12 INFO - PID 4090 | _x_x_mozilla_page_load 03:02:12 INFO - PID 4090 | _x_x_mozilla_page_load_details 03:02:12 INFO - PID 4090 | |i|pagename|runs| 03:02:12 INFO - PID 4090 | |0;ai-astar;104;112;110;112;111;112;114;111;111;113 03:02:12 INFO - PID 4090 | |1;audio-beat-detection;164;122;129;173;123;124;123;124;147;124 03:02:12 INFO - PID 4090 | |2;audio-dft;164;164;163;167;167;178;165;165;165;162 03:02:12 INFO - PID 4090 | |3;audio-fft;77;74;74;120;74;75;77;75;98;77 03:02:12 INFO - PID 4090 | |4;audio-oscillator;85;84;104;84;83;83;110;83;83;108 03:02:12 INFO - PID 4090 | |5;imaging-gaussian-blur;114;113;114;113;113;115;114;118;115;115 03:02:12 INFO - PID 4090 | |6;imaging-darkroom;151;151;150;152;150;151;149;149;150;149 03:02:12 INFO - PID 4090 | |7;imaging-desaturate;94;94;96;97;95;94;94;95;95;95 03:02:12 INFO - PID 4090 | |8;json-parse-financial;53;57;53;54;55;55;58;55;54;55 03:02:12 INFO - PID 4090 | |9;json-stringify-tinderbox;54;55;55;55;55;55;55;54;55;54 03:02:12 INFO - PID 4090 | |10;stanford-crypto-aes;82;80;100;82;81;84;80;91;91;82 03:02:12 INFO - PID 4090 | |11;stanford-crypto-ccm;142;132;139;140;133;138;142;130;178;141 03:02:12 INFO - PID 4090 | |12;stanford-crypto-pbkdf2;181;192;202;194;189;192;190;197;199;190 03:02:12 INFO - PID 4090 | |13;stanford-crypto-sha256-iterative;74;73;72;71;72;71;74;70;71;70 03:02:12 INFO - PID 4090 | __end_tp_report 03:02:12 INFO - PID 4090 | __start_cc_report 03:02:12 INFO - PID 4090 | _x_x_mozilla_cycle_collect,848 03:02:12 INFO - PID 4090 | __end_cc_report 03:02:12 INFO - PID 4090 | __startTimestamp1493892132150__endTimestamp 03:02:12 INFO - PID 4090 | 03:02:12 INFO - PID 4090 | ------- Summary: start ------- 03:02:12 INFO - PID 4090 | Number of tests: 14 03:02:12 INFO - PID 4090 | 03:02:12 INFO - PID 4090 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.71 (2.4%) stddev-sans-first:1.20 03:02:12 INFO - PID 4090 | Values: 104.0 112.0 110.0 112.0 111.0 112.0 114.0 111.0 111.0 113.0 03:02:12 INFO - PID 4090 | 03:02:12 INFO - PID 4090 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:126.50 stddev:19.10 (15.1%) stddev-sans-first:17.21 03:02:12 INFO - PID 4090 | Values: 164.0 122.0 129.0 173.0 123.0 124.0 123.0 124.0 147.0 124.0 03:02:12 INFO - PID 4090 | 03:02:12 INFO - PID 4090 | [#2] audio-dft Cycles:10 Average:166.00 Median:165.00 stddev:4.50 (2.7%) stddev-sans-first:4.71 03:02:12 INFO - PID 4090 | Values: 164.0 164.0 163.0 167.0 167.0 178.0 165.0 165.0 165.0 162.0 03:02:12 INFO - PID 4090 | 03:02:12 INFO - PID 4090 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:15.15 (19.9%) stddev-sans-first:15.95 03:02:12 INFO - PID 4090 | Values: 77.0 74.0 74.0 120.0 74.0 75.0 77.0 75.0 98.0 77.0 03:02:12 INFO - PID 4090 | 03:02:12 INFO - PID 4090 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:83.00 stddev:11.59 (14.0%) stddev-sans-first:12.10 03:02:12 INFO - PID 4090 | Values: 85.0 84.0 104.0 84.0 83.0 83.0 110.0 83.0 83.0 108.0 03:02:12 INFO - PID 4090 | 03:02:12 INFO - PID 4090 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:1.51 (1.3%) stddev-sans-first:1.59 03:02:12 INFO - PID 4090 | Values: 114.0 113.0 114.0 113.0 113.0 115.0 114.0 118.0 115.0 115.0 03:02:12 INFO - PID 4090 | 03:02:12 INFO - PID 4090 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:150.50 stddev:1.03 (0.7%) stddev-sans-first:1.05 03:02:12 INFO - PID 4090 | Values: 151.0 151.0 150.0 152.0 150.0 151.0 149.0 149.0 150.0 149.0 03:02:12 INFO - PID 4090 | 03:02:12 INFO - PID 4090 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.99 (1.0%) stddev-sans-first:1.00 03:02:12 INFO - PID 4090 | Values: 94.0 94.0 96.0 97.0 95.0 94.0 94.0 95.0 95.0 95.0 03:02:12 INFO - PID 4090 | 03:02:12 INFO - PID 4090 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:1.60 (2.9%) stddev-sans-first:1.54 03:02:12 INFO - PID 4090 | Values: 53.0 57.0 53.0 54.0 55.0 55.0 58.0 55.0 54.0 55.0 03:02:12 INFO - PID 4090 | 03:02:12 INFO - PID 4090 | [#9] json-stringify-tinderbox Cycles:10 Average:54.70 Median:55.00 stddev:0.48 (0.9%) stddev-sans-first:0.44 03:02:12 INFO - PID 4090 | Values: 54.0 55.0 55.0 55.0 55.0 55.0 55.0 54.0 55.0 54.0 03:02:12 INFO - PID 4090 | 03:02:12 INFO - PID 4090 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:82.00 stddev:6.58 (8.0%) stddev-sans-first:6.87 03:02:12 INFO - PID 4090 | Values: 82.0 80.0 100.0 82.0 81.0 84.0 80.0 91.0 91.0 82.0 03:02:12 INFO - PID 4090 | 03:02:12 INFO - PID 4090 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:140.50 stddev:13.53 (9.6%) stddev-sans-first:14.35 03:02:12 INFO - PID 4090 | Values: 142.0 132.0 139.0 140.0 133.0 138.0 142.0 130.0 178.0 141.0 03:02:12 INFO - PID 4090 | 03:02:12 INFO - PID 4090 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.60 Median:193.00 stddev:5.89 (3.1%) stddev-sans-first:4.51 03:02:12 INFO - PID 4090 | Values: 181.0 192.0 202.0 194.0 189.0 192.0 190.0 197.0 199.0 190.0 03:02:12 INFO - PID 4090 | 03:02:12 INFO - PID 4090 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:72.00 stddev:1.48 (2.0%) stddev-sans-first:1.33 03:02:12 INFO - PID 4090 | Values: 74.0 73.0 72.0 71.0 72.0 71.0 74.0 70.0 71.0 70.0 03:02:12 INFO - PID 4090 | -------- Summary: end -------- 03:02:12 INFO - PID 4090 | 03:02:13 INFO - TEST-INFO | 4090: exit 0 03:02:13 INFO - TEST-OK | kraken | took 63540ms 03:02:13 INFO - SUITE-END | took 1186s 03:02:13 INFO - Completed test suite (00:19:46) 03:02:13 INFO - javascript benchmark 03:02:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6638.643078534617, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2770.4874598199335, 2774.348028213371, 2798.188525327655, 2807.1999480148174, 2815.1413818785263, 5238.240455134003, 5390.460953904608, 5393.514583687467, 5417.45825417458, 5422.1595652673805, 5339.385970613381, 5350.839474815752, 5366.4096949335635, 5475.67145971242, 5477.835664930049, 4464.776761161945, 4753.809847606091, 4760.476347601761, 4764.047190561884, 4785.186518291899, 4813.181759100961, 4828.0, 4856.05306965142, 4868.2697595360805, 4882.121218180726, 4688.695234809727, 4705.5764981151515, 4746.430428348585, 4763.64272679547, 4790.353302304179, 4774.450938142123, 4780.641451891122, 4788.138135135674, 4802.615790736732, 4832.806687732486, 4712.128256272601, 4741.454732705749, 4748.192807222746, 4755.239161734106, 4785.042991401733, 5238.214267859814, 5290.470952904717, 5340.599455040849, 5377.489138531833, 5389.865253368658, 5784.0, 5795.449432303966, 5796.50729687977, 5797.507211886995, 5801.825945221608, 5819.447152520504, 5842.591018628697, 5842.707864606753, 5843.065109582489, 5847.093700476433, 5344.198370244494, 5386.407495175527, 5392.676439413648, 5393.622446428791, 5395.622306438511, 5902.557308201902, 5926.940730592725, 5942.168096466498, 5949.9107513387335, 5961.970190149022, 5667.40492248308, 5688.857778555569, 5699.487046165865, 5702.8289151325525, 5707.0, 5861.531077513874, 5861.736221870026, 5867.826434713074, 5928.258967629046, 5940.316863560746, 5814.215080964101, 5822.214001109881, 5826.504747096545, 5831.358550559435, 5833.0, 5687.77248910039, 5759.798407055817, 5810.5351571875, 5825.796097136665, 5831.387704290988, 4752.928706069342, 4794.640401969867, 4796.640251981115, 4800.279958006327, 4809.591184749265, 4155.625993660585, 4177.603127702924, 4194.832206711759, 4230.323148296257, 4254.936175957363, 4934.9753251233515, 4950.133726597831, 4959.70241785494, 4962.851114466572, 4999.350084488993, 5732.484076433141, 5818.389069147764, 5877.9118313225335, 5886.05823068307, 5938.910916336258, 4893.168161412568, 4942.950570494321, 4964.726940018334, 4968.552830245295, 4974.104661161025, 5151.510606492452, 5184.714840683799, 5189.7405129743365, 5189.766460509286, 5231.163013917755, 5316.441773613869, 5413.918791218056, 5419.3225846769155, 5420.105682562333, 5424.2406063151975, 5777.2200752897825, 5818.476337129509, 5906.911396328973, 5907.438793314628, 5908.084246941731, 5319.893602128013, 5325.840224793263, 5372.059889519241, 5403.351597808288, 5428.891422171613, 5651.971740141273, 5674.404187560247, 5683.863227354628, 5688.5733569981585, 5719.742611582572, 5733.770649173986, 5812.0, 5818.418158184148, 5833.970830145822, 5834.329052159056, 5610.102383618601, 5616.803411880728, 5621.353544342453, 5624.437556244507, 5628.662280263197, 5560.054790685513, 5600.991821472174, 5608.6073974823, 5614.915776263278, 5631.099024156116, 5441.591880608891, 5453.836384908459, 5485.259489968803, 5490.670559766427, 5497.038018346853, 5672.262605861211, 5679.062954612608, 5679.886402271849, 5681.545476361798, 5689.829305120853, 5506.311711036121, 5510.063289240758, 5520.917186242129, 5526.778928842801, 5551.195076713934], "value": 5252.52441423592, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.8496715689705, 736.1534235629026, 950.6435086842434, 964.4020707161561, 1103.751655877427, 28804.0, 31572.842135789346, 31848.203794905137, 32314.0, 32331.0, 30002.549961750537, 30280.24299392511, 30297.697023029763, 30358.54462183069, 30375.240618984535, 6221.471174950123, 6378.585391949531, 6382.457491113261, 6390.584612000228, 7048.929510704878, 6920.10038694969, 7076.115485564304, 7077.469189810759, 7077.823054423655, 7079.327463890922, 7046.85906281874, 7073.610951397671, 7089.539179953286, 7096.43228541718, 7104.538205016684, 7015.368616824459, 7026.683799229047, 7043.542169758949, 7075.150981882207, 7082.539634923739, 6937.375636192716, 6942.409895158918, 6987.161540615108, 7008.544444611084, 7023.683934222972, 31275.84362078198, 31308.0, 31521.21196970071, 31630.36739265225, 31740.841295793372, 2936.7063293670462, 2963.9851800741076, 2981.344104297073, 2996.625421822272, 3000.8649610767566, 24307.756922430726, 24347.634785478233, 24596.385090372885, 24598.385040373956, 24721.752782472126, 2755.669319681631, 2757.7380148885823, 2759.213624117137, 2769.9169024929283, 2773.3898542320658, 143102.0, 143342.0, 143393.0, 144621.0, 144815.27592362076, 36020.0, 37960.0, 38075.23849523049, 38142.0, 38648.613513864504, 40142.397864032064, 40277.39583906244, 40284.798576006935, 40421.59578404237, 40533.0, 11258.380789056517, 11442.37066961325, 11456.885431145749, 11461.770764584662, 11474.94262528682, 8952.731418057469, 9039.186473217442, 9128.954355228181, 9234.49210293427, 9251.306152038624, 12486.0, 12499.312537810507, 12535.561255356019, 12560.30918299484, 12643.683907902376, 5223.503767142115, 5326.147816349366, 5337.2527846101575, 5339.5728341732565, 5433.347998240237, 831.6465502161557, 858.429144618834, 872.1191596487594, 893.5353616119581, 894.821035792844, 19690.412367531757, 20865.37403877886, 20884.0, 20973.79026209749, 21056.26303079385, 921.7142685767434, 933.9766505837273, 951.5717926932908, 962.6341990043738, 965.8551217317458, 10655.30740501865, 10805.189610779224, 11014.944925275322, 11066.336019838835, 11159.107271418266, 178583.0, 179159.0, 179490.0, 179680.0, 180415.0, 39700.20599587992, 39866.20267594632, 39905.2018959625, 39982.80094594825, 40052.39921401181, 1195.483507217295, 1204.4158583087196, 1224.3572124634638, 1228.1403017887515, 1230.034422977958, 19554.0, 19630.607387852448, 20055.398338049883, 20564.588708225452, 20993.685094723896, 27198.72801272041, 27324.726752733015, 27418.5887211688, 27457.0, 27470.0, 135831.0, 139073.0, 149899.0, 151126.0, 151643.0, 30182.84908575443, 30316.090517284516, 30442.238944026576, 30525.23686907845, 30632.387352252383, 35655.0, 36064.45903311505, 36068.0, 36367.0, 36570.8171459141, 27430.5885411715, 27608.54893138358, 28312.150635480968, 28560.85719571389, 29129.7087029127, 26384.208473745817, 26466.0, 26903.192904212905, 27085.322866928484, 28321.291967700974, 30174.245643859078, 30221.848890756286, 30232.24419389445, 30274.394512110073, 30480.84759576188, 26119.216423507325, 26309.736902630728, 26781.330466738487, 26892.193234203005, 27908.58137127904, 21101.788982110596, 21634.459138521663, 21800.45498862541, 21835.454113647287, 22052.448688782908], "value": 14128.682037629105, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.28328650073115, 406.4370846377766, 416.29853696521366, 424.60299619855425, 434.9217140914634, 16907.1546422679, 17548.0, 17559.0, 17582.560435989108, 18453.815461845377, 18830.90584547079, 19116.139773710183, 19130.904345478288, 19141.42575722727, 19412.708809367872, 5352.678839269637, 5425.457454254562, 5492.368377636583, 5516.862078448031, 5548.167774833767, 5511.559075273988, 5579.330480342364, 5585.3297604287545, 5589.133684278943, 5607.074832652607, 5394.811181608645, 5451.945480545203, 5462.972685136589, 5518.862028449301, 5572.192032155335, 5446.673199608016, 5467.58993075517, 5479.068558345071, 5483.725813709319, 5513.724313784295, 4861.270809378586, 4928.137575924235, 4963.4292056413615, 5010.69935803853, 5054.06499797535, 22157.0, 22301.442463938532, 22498.66252006221, 22694.659580106312, 22950.42623934415, 1616.1757503673211, 1665.6585399992973, 1676.8155502894672, 1680.495851244634, 1685.9578510537212, 14661.926690366587, 14769.556913292618, 14802.777958330633, 15008.47470338533, 15024.323905424282, 2019.6667549854255, 2069.9172033118657, 2090.3728881335537, 2118.152738904435, 2129.95740085199, 88550.0, 88592.0, 90182.5490872548, 90401.54799226028, 91627.00475942863, 10478.476076196159, 10745.14038876888, 10973.83539246912, 11028.117750579935, 11121.888781112086, 15057.623559411102, 15104.471343503144, 15139.697206055816, 15159.469418570297, 15193.924030379778, 7066.646667666596, 7167.569945803269, 7241.348278654947, 7387.667554959932, 7416.25837416254, 6959.791206263821, 6970.337817907291, 6981.441484681213, 7154.642267886585, 7212.206657267697, 6761.898571521431, 6873.656317184121, 6947.89578156328, 6997.475189360818, 7012.789616311519, 1895.2134864031273, 1918.7121931710356, 1937.6124775045048, 1939.6702560564738, 2077.8649387789746, 833.4082801211208, 853.5646820121658, 862.7584276402491, 867.7830542364409, 895.6909866096187, 16865.66268674644, 17022.82977170237, 17080.743788843178, 17302.567435814206, 17864.19611117477, 867.6659486097898, 876.9166929141721, 885.4864178776423, 889.0975659705405, 898.4699027573632, 9056.426504615127, 9387.0, 9671.081247281498, 9685.564149613285, 9747.3664211826, 360593.0, 365220.0, 367440.0, 369343.0, 369566.0, 69995.65002174956, 71298.64350678213, 72410.9138362925, 72470.63764681143, 75618.62190689011, 1013.7972405518926, 1035.7773078788098, 1058.4866339825178, 1066.8293073108266, 1071.978560428787, 14727.852721472647, 14772.48296309624, 14774.039687420283, 14968.625784355478, 15491.922540387226, 36818.447723283636, 38906.22187556289, 39889.40165897456, 40083.198336033696, 40229.597704023756, 47968.0, 47998.84005219704, 48159.518404815506, 48341.758291208316, 48460.757696211294, 8055.959720201361, 8122.147174546824, 8192.549409782281, 8400.41197116196, 8446.66213351459, 12718.427670754652, 13369.465221391036, 13461.932690336485, 13536.864631353561, 13741.725165496833, 11039.83440248413, 11445.885541144815, 11573.0, 11697.473613687574, 11965.102617303563, 10353.17174626013, 10482.63310784119, 10632.468376581295, 11054.723631909266, 11128.888711112786, 11281.661550153509, 11460.426978651201, 11743.706407339885, 11806.763864722485, 12084.879151208375, 8025.438219324825, 8129.390295727962, 8202.712905048294, 8471.526674063605, 8502.277306429023, 11197.496112675111, 11455.255408398427, 11556.191066625255, 11690.357030363411, 11772.764544709229], "value": 8829.96865312313, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1251.7746805574998, 1293.1982171053949, 1301.4663987765011, 1309.378045428421, 1314.1786383510307, 9652.565634546445, 9997.450140242292, 10090.495475226237, 10180.18558515319, 10395.116415104725, 10141.695749127539, 10232.07911287984, 10304.38173709578, 10310.432926189056, 10312.0, 2098.853080284377, 2147.3235930681863, 2148.796673862642, 2163.556470923457, 2163.816075633573, 2058.7632422271404, 2116.33335499318, 2123.7557680866744, 2128.8935553222354, 2136.647453170225, 2069.5860827834417, 2075.4707549574837, 2121.7666056733747, 2124.129107066103, 2132.7867213278705, 1920.7791104023006, 1935.3806781829749, 1942.291063761731, 1949.41517544736, 1956.1197461142542, 1950.2686492565288, 1953.7655481342188, 1962.2641509433963, 2063.607914496241, 2073.4194425560718, 10232.0, 10256.076953074184, 10333.379997200193, 10354.482275886176, 10354.534045967874, 5453.127499600045, 5631.0, 5695.857603559903, 5702.087665973466, 5702.657840529581, 3108.300632357724, 3292.571965644475, 3334.0164651427885, 3346.7322614190807, 3385.6614338565946, 1016.4054028393399, 1019.6125472320545, 1021.0402221911454, 1075.8063548561256, 1077.6012875236213, 14664.780028299478, 14709.0, 14780.926095369561, 14805.481808136663, 14865.108093514316, 4454.710443821206, 4542.704724192917, 4777.880552986203, 4802.255650374198, 4837.854864354075, 10837.891621083845, 10854.29447085937, 10860.837087443695, 10870.293430926964, 10871.29336593119, 5209.322788037531, 5211.452797456288, 5222.556082732935, 5224.7126408047925, 5240.0, 4988.201887697951, 4998.775055122528, 5042.571381432619, 5127.97436012825, 5134.8973020540125, 3774.1130834253927, 3784.4890939722786, 3861.498005259298, 3922.7057970652313, 3953.6046395360236, 1060.6764936694228, 1070.1492313610697, 1076.0, 1083.2309060567086, 1091.7052395853075, 677.7119724117231, 687.7592842505084, 696.5263620737946, 709.2907092907093, 713.9571625702474, 5466.070767969455, 6320.5891617044745, 6374.521910856612, 6411.775587854403, 6486.545941784124, 834.1575009240711, 837.7486753973783, 841.188253335522, 851.3742399336483, 854.1031916487663, 3744.382176940774, 3779.905502362463, 3857.3056849767313, 3867.3038853006165, 3935.193285376491, 13005.869941300654, 13230.272335021666, 13523.932380338036, 13555.118917270345, 13605.115667481581, 13167.209967401986, 13175.209487430784, 13193.538226162038, 13301.66745831362, 13309.534166304133, 7489.812754681177, 7505.249475052451, 7546.396288297033, 7574.394048476109, 7730.690772369155, 5883.2057672213705, 5906.557008224315, 5999.340072592098, 6029.125776762433, 6098.054801505774, 11749.412529373327, 11822.054235661299, 11845.348505831917, 12091.334976576372, 12130.575429859913, 11872.940635296769, 12361.0, 12366.258024518558, 12428.067894907737, 12428.316442595744, 7260.89108663381, 7360.0, 7366.815829604088, 7374.631268436664, 7387.298206670358, 9208.585613647536, 9225.677101301422, 9262.629494820132, 9376.437413755197, 9386.43681379092, 7975.282224599582, 8019.438639295427, 8020.358371330163, 8031.759047228593, 8043.316318113026, 7615.504992175491, 7651.426143039405, 7671.309582137635, 7693.49992250502, 7869.213078692085, 7473.738419155304, 7474.551526908403, 7548.0, 7554.584497852671, 7556.0, 4799.928001080057, 5098.413682426569, 5177.741112944413, 5207.270982062439, 5386.030514507426, 5240.109181439241, 5291.682499050069, 5302.1781623848365, 5334.093204155225, 5511.173324001432], "value": 4661.644497126834, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.9858005679773, 370.5201763715988, 371.22599380292087, 374.0797637810985, 374.6403452685422, 5516.641418307807, 5692.402297758737, 5710.0, 5721.570882183837, 5726.37009928908, 5420.647657902234, 5516.227728118067, 5524.475174858382, 5533.142362933741, 5546.417626149257, 4116.567760385161, 4120.876373708794, 4130.938035929464, 4132.173565286939, 4151.14901445203, 4087.7093939378788, 4131.772752498611, 4150.0, 4153.314703073989, 4166.562510936354, 4068.8982775430554, 4074.1851629674034, 4081.8979525511804, 4083.3666533386586, 4117.279476091687, 4076.4496792932873, 4102.118044620391, 4103.569125241851, 4108.732932359417, 4123.36087906372, 3569.161247106928, 3576.535050443452, 3581.713462922986, 3582.158192824684, 3582.946255806165, 5270.629636294591, 5390.0, 5395.0, 5443.0, 5461.126219804852, 4817.397825271841, 4819.879503012417, 4837.274408838667, 4838.443578988426, 4841.225403935388, 5730.19777231188, 5880.647161170301, 5882.588218824684, 5883.117532370179, 5901.852453688693, 3990.0024993751563, 3994.0, 4000.159966407058, 4002.1195337025806, 4025.5169379674335, 6066.998945174041, 6166.445019948226, 6260.499160067184, 6273.153124328249, 6309.5898766580485, 4091.672666186698, 4096.487939007624, 4099.200655872076, 4100.34394496879, 4118.979405103015, 4171.165766846643, 4175.958240417557, 4176.77027763476, 4181.498220213593, 4191.287481128215, 4756.0, 4815.566599006106, 4855.0, 4874.878128046827, 4886.242632391985, 5890.587658863924, 5892.882142357129, 5912.733926973297, 5918.141869428909, 5921.624673935901, 1422.8292604887479, 1437.8497202238377, 1439.6976634906578, 1449.0436312034008, 1450.4633285684365, 939.4128669581512, 944.9480278584606, 947.3889341374775, 952.9190018848476, 962.2830990911675, 5114.923276150861, 5133.101707201225, 5143.17709166539, 5178.404483484373, 5193.610479214074, 6131.049687298476, 6131.96934015327, 6189.81430557084, 6197.752089916443, 6198.597091189148, 4927.359443272351, 5039.0, 5079.771410286546, 5110.594586488671, 5144.228365745168, 3230.9192270193435, 3264.3308121834966, 3269.346130773855, 3272.0, 3276.0990727550115, 5478.205660179252, 5602.2717046783655, 5653.830385088454, 5655.745491452894, 5668.526183192317, 6222.62664240147, 6244.937550624436, 6258.123862659231, 6273.560850740404, 6289.905651415233, 5580.748866301026, 5641.887162256814, 5645.576581756384, 5660.29246344207, 5681.460261275255, 5965.0, 6089.878202436015, 6125.9693701531205, 6146.200993870947, 6163.414475624809, 5889.263842019747, 6054.848628784315, 6056.454919057306, 6066.817995460143, 6069.453749162597, 5618.775248989995, 5657.2079908811975, 5664.178694089416, 5671.801486947937, 5680.176374425768, 3974.900627484336, 4005.9584508028706, 4018.3168861293066, 4022.1352409232154, 4024.2896768873698, 6022.427869352405, 6133.233345831771, 6140.324564298013, 6171.876562468815, 6176.073588961692, 5844.912326315194, 5920.259967504062, 5930.762769489172, 5932.79235226765, 5940.732667029907, 5776.653400795965, 5815.615597604961, 5903.963132719205, 5916.822495325147, 5935.881282374415, 5759.568032397503, 5791.623544469596, 5792.710364481674, 5795.275590551181, 5812.7674893003805, 5949.78029503942, 5953.91069133972, 5962.910556341745, 5972.820815375546, 5979.073243647242, 5625.606207565595, 5676.2337084493065, 5759.934412133769, 5767.538596912321, 5786.479216870502], "value": 4365.352279010294, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.678408108392, 745.8098184962834, 747.1631772414893, 761.4099073218255, 764.4572353628924, 11492.482838272277, 11549.364784936824, 12379.56671516497, 13232.73534529309, 13245.0, 14257.429702811902, 14699.118052916832, 14835.258237088156, 14903.031302965299, 14942.775858362133, 815.6288888555707, 826.6775957376628, 827.8302947895697, 829.4359835311985, 830.4477522447565, 894.3337213775746, 898.9370744047919, 899.33449247557, 900.6667533012794, 901.378049146087, 922.3866129024225, 927.972160835176, 930.3998920696147, 932.0167223579122, 936.484933286693, 915.7756349694301, 921.1065266691298, 922.5064590444114, 922.6632279218037, 922.7139586728102, 679.0696745458704, 680.8263892707328, 683.8016975077221, 684.3464491410691, 686.821426429132, 12445.93777031118, 12578.937105314506, 12584.559540416132, 13071.281079540622, 13274.269915154662, 15047.322870470854, 15088.17015064171, 15521.379144834193, 15526.689466210613, 15598.454054108051, 11741.647750567497, 11972.0, 12050.216735912225, 12097.637070887888, 12152.756944861141, 2430.4895971845935, 2455.202059330707, 2458.6434966929874, 2461.2616215135386, 2463.593507071349, 67037.66481167563, 67130.66434667844, 67455.3254467454, 68810.65594672094, 69047.0, 10082.24383171265, 10182.898171018343, 10389.740256493496, 11624.418779061014, 11811.645650630495, 21244.150233990465, 21528.246511372028, 21725.565488690452, 21818.672719909213, 21887.452813679465, 5906.40935906406, 6046.697665116814, 6048.334683184846, 6060.575759696867, 6125.295591007091, 2797.608334833125, 2851.3584443500463, 2851.828890266591, 2853.2866783304175, 2873.281679580105, 3147.669494703069, 3204.9679503205134, 3207.6792320767736, 3253.072874230833, 3253.8047717137047, 680.0547239337325, 684.5995092870627, 685.7462738786581, 686.1834417043702, 691.374306252842, 597.6682940967718, 602.6354055796268, 603.5352778360638, 604.4469310580857, 627.1658693937053, 9680.41917484939, 9954.751131221778, 10043.146332561668, 10157.288989770794, 10245.436500992517, 589.8230530840816, 599.8230521996022, 600.5225845452876, 605.4913872347162, 616.8550390658191, 4615.330777037311, 4618.0, 4712.104700106968, 4715.929261061086, 4741.288806679026, 65604.34395656078, 66281.0, 66473.0, 68239.31760682429, 68544.97182542266, 58074.7096264516, 58090.419095809346, 59115.0, 59412.70293648504, 59546.40453595408, 48449.75775121172, 49310.50689493059, 50097.0, 50984.0, 51211.0, 9232.127008681791, 9971.850422243528, 9972.152367048882, 9991.800163996533, 10014.449205293779, 26118.608220876322, 26139.869300653376, 26432.471350573265, 26696.733032669425, 27462.862685686443, 31708.682913170574, 32020.67979320177, 32605.836970814995, 33050.17374565655, 33106.66893331036, 10512.894871051192, 10572.629957951434, 10703.571857125628, 10830.18773591968, 10901.182411319025, 12662.873371266538, 12838.550650727553, 13207.933960330522, 13209.339533023118, 13218.405171767487, 11455.198136130392, 11612.419379031184, 11702.648920532398, 11798.115141364604, 11923.463444144862, 11769.470373833026, 11823.408829558315, 12149.75700486003, 12163.878361216628, 12270.509179632714, 12316.81524777147, 12387.504499820267, 12480.750384992069, 12527.624171274876, 12610.684732881751, 8018.238267364591, 8053.275205231557, 8298.875516867372, 8378.53918034514, 8455.281301089477, 9588.616455341707, 9613.951930240304, 9655.951720241354, 9733.805323893625, 9943.25425593069], "value": 6418.864196301719, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 110.0, 112.0, 111.0, 112.0, 114.0, 111.0, 111.0, 113.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 122.0, 129.0, 173.0, 123.0, 124.0, 123.0, 124.0, 147.0, 124.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 167.0, 167.0, 178.0, 165.0, 165.0, 165.0, 162.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 74.0, 120.0, 74.0, 75.0, 77.0, 75.0, 98.0, 77.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 104.0, 84.0, 83.0, 83.0, 110.0, 83.0, 83.0, 108.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 113.0, 113.0, 115.0, 114.0, 118.0, 115.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 150.0, 152.0, 150.0, 151.0, 149.0, 149.0, 150.0, 149.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 96.0, 97.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 57.0, 53.0, 54.0, 55.0, 55.0, 58.0, 55.0, 54.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 54.0, 55.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 100.0, 82.0, 81.0, 84.0, 80.0, 91.0, 91.0, 82.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 132.0, 139.0, 140.0, 133.0, 138.0, 142.0, 130.0, 178.0, 141.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 192.0, 202.0, 194.0, 189.0, 192.0, 190.0, 197.0, 199.0, 190.0], "value": 192.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 72.0, 71.0, 72.0, 71.0, 74.0, 70.0, 71.0, 70.0], "value": 71.8, "unit": "score"}]}]} 03:02:13 INFO - Return code: 0 03:02:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:02:13 INFO - # TBPL SUCCESS # 03:02:13 INFO - Running post-action listener: _resource_record_post_action 03:02:13 INFO - [mozharness: 2017-05-04 10:02:13.948055Z] Finished run-tests step (success) 03:02:13 INFO - Running post-run listener: _resource_record_post_run 03:02:14 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 7843840; Write bytes: 370155520; Read time: 1932; Write time: 267960 03:02:14 INFO - TinderboxPrint: CPU usage
13.3% 03:02:14 INFO - TinderboxPrint: I/O read bytes / time
7,843,840 / 1,932 03:02:14 INFO - TinderboxPrint: I/O write bytes / time
370,155,520 / 267,960 03:02:14 INFO - TinderboxPrint: CPU idle
8,319.1 (86.7%) 03:02:14 INFO - TinderboxPrint: CPU user
1,215.3 (12.7%) 03:02:14 INFO - TinderboxPrint: Swap in / out
0 / 0 03:02:14 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 8192; Write bytes: 114814976; Read time: 228; Write time: 100852 03:02:14 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 5492736; Write bytes: 255340544; Read time: 1124; Write time: 167108 03:02:14 INFO - Running post-run listener: _upload_blobber_files 03:02:14 INFO - Blob upload gear active. 03:02:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:02: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 03:02: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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:02: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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:02:15 INFO - (blobuploader) - INFO - Open directory for files ... 03:02:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:02:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:02:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:02:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:02:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:02:15 INFO - (blobuploader) - INFO - Done attempting. 03:02:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:02:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:02:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:02:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:02:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:02:17 INFO - (blobuploader) - INFO - Done attempting. 03:02:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:02:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:02:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:02:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:02:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:02:18 INFO - (blobuploader) - INFO - Done attempting. 03:02:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:02:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:02:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:02:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:02:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:02:22 INFO - (blobuploader) - INFO - Done attempting. 03:02:22 INFO - (blobuploader) - INFO - Iteration through files over. 03:02:22 INFO - Return code: 0 03:02:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:02:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:02:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f24269135f21ad42bdf16661fd53045b00f8f2d3acc80744458a87cf75aee327b989c879dfb6afb6a98360916b69e6358560a302547da168e3715f4aab780546", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e22103bbfbab00b8aed25032867870ba85d1e0b88c0f0538c799ef6f44366e7f524a1c72470c3433b0536520d5b114f7eb1ab1dcabe92ca72a5991645db93da0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70722ed7654c18624d9afc5498cf5c7af1ddb559e445f4f82d1f0ff7abb1b48d5b5edb8029290904ba3709feb6a93efa93cb561b01c8e6ffc6677dded4e1ae76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/76725b611b3749828c2577e013d65bb1c31c4f60052b717a8335b1366ef700abfd91059c29cb855ccb36f2c6d5ef2e2ef40dc3286e1293814462aa16eeab616c"} 03:02:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:02:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:02:22 INFO - Contents: 03:02:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f24269135f21ad42bdf16661fd53045b00f8f2d3acc80744458a87cf75aee327b989c879dfb6afb6a98360916b69e6358560a302547da168e3715f4aab780546", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e22103bbfbab00b8aed25032867870ba85d1e0b88c0f0538c799ef6f44366e7f524a1c72470c3433b0536520d5b114f7eb1ab1dcabe92ca72a5991645db93da0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70722ed7654c18624d9afc5498cf5c7af1ddb559e445f4f82d1f0ff7abb1b48d5b5edb8029290904ba3709feb6a93efa93cb561b01c8e6ffc6677dded4e1ae76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/76725b611b3749828c2577e013d65bb1c31c4f60052b717a8335b1366ef700abfd91059c29cb855ccb36f2c6d5ef2e2ef40dc3286e1293814462aa16eeab616c"} 03:02:22 INFO - Running post-run listener: copy_logs_to_upload_dir 03:02:22 INFO - Copying logs to upload dir... 03:02:22 INFO - mkdir: /builds/slave/test/build/upload/logs 03:02:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.314530 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-05-04 03:02:22.391855) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 03:02:22.399717) ========= 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=db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f24269135f21ad42bdf16661fd53045b00f8f2d3acc80744458a87cf75aee327b989c879dfb6afb6a98360916b69e6358560a302547da168e3715f4aab780546", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e22103bbfbab00b8aed25032867870ba85d1e0b88c0f0538c799ef6f44366e7f524a1c72470c3433b0536520d5b114f7eb1ab1dcabe92ca72a5991645db93da0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70722ed7654c18624d9afc5498cf5c7af1ddb559e445f4f82d1f0ff7abb1b48d5b5edb8029290904ba3709feb6a93efa93cb561b01c8e6ffc6677dded4e1ae76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/76725b611b3749828c2577e013d65bb1c31c4f60052b717a8335b1366ef700abfd91059c29cb855ccb36f2c6d5ef2e2ef40dc3286e1293814462aa16eeab616c"} build_url:https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011134 build_url: 'https://queue.taskcluster.net/v1/task/HvsYDJNoRu-69AvXiCsxNg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f24269135f21ad42bdf16661fd53045b00f8f2d3acc80744458a87cf75aee327b989c879dfb6afb6a98360916b69e6358560a302547da168e3715f4aab780546", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e22103bbfbab00b8aed25032867870ba85d1e0b88c0f0538c799ef6f44366e7f524a1c72470c3433b0536520d5b114f7eb1ab1dcabe92ca72a5991645db93da0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70722ed7654c18624d9afc5498cf5c7af1ddb559e445f4f82d1f0ff7abb1b48d5b5edb8029290904ba3709feb6a93efa93cb561b01c8e6ffc6677dded4e1ae76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/76725b611b3749828c2577e013d65bb1c31c4f60052b717a8335b1366ef700abfd91059c29cb855ccb36f2c6d5ef2e2ef40dc3286e1293814462aa16eeab616c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 03:02:22.427702) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 03:02:22.427997) ========= 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=db7e7c15f3ca076d53731445000001ba-1493889120.977939-351126004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 03:02:22.506808) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 03:02:22.507107) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 03:02:22.510381) ========= ========= Total master_lag: 0.22 =========