builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-044 starttime: 1494420081.73 results: success (0) revision: f8d40e7fe132b7c73a8f610484b790e6063006e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 05:41:21.731425) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 05:41:21.731896) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 05:41:21.732350) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 05:41:21.748437) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 05:41:21.748932) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-10 05: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% 12.1M=0.001s 2017-05-10 05:41:22 (12.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126879 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 05:41:21.892704) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 05:41:21.893050) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021943 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 05:41:21.941995) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 05:41:21.942363) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f8d40e7fe132b7c73a8f610484b790e6063006e3 --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 f8d40e7fe132b7c73a8f610484b790e6063006e3 --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=88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-10 05:41:22,726 truncating revision to first 12 chars 2017-05-10 05:41:22,726 Setting DEBUG logging. 2017-05-10 05:41:22,726 attempt 1/10 2017-05-10 05:41:22,726 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f8d40e7fe132?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-10 05:41:23,261 unpacking tar archive at: mozilla-central-f8d40e7fe132/testing/mozharness/ program finished with exit code 0 elapsedTime=0.938004 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 05:41:22.894265) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 05:41:22.894598) ========= script_repo_revision: f8d40e7fe132b7c73a8f610484b790e6063006e3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 05:41:22.895035) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 05:41:22.895299) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 05:41:22.904941) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-10 05:41:22.905225) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:41:23 INFO - MultiFileLogger online at 20170510 05:41:23 in /builds/slave/test 05:41:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:41:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:41:23 INFO - {'append_to_log': False, 05:41:23 INFO - 'base_work_dir': '/builds/slave/test', 05:41:23 INFO - 'blob_upload_branch': 'Firefox', 05:41:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:41:23 INFO - 'branch': 'Firefox', 05:41:23 INFO - 'buildbot_json_path': 'buildprops.json', 05:41:23 INFO - 'config_files': ('talos/linux_config.py',), 05:41:23 INFO - 'default_actions': ('clobber', 05:41:23 INFO - 'read-buildbot-config', 05:41:23 INFO - 'download-and-extract', 05:41:23 INFO - 'populate-webroot', 05:41:23 INFO - 'create-virtualenv', 05:41:23 INFO - 'install', 05:41:23 INFO - 'run-tests'), 05:41:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:41:23 INFO - 'download_minidump_stackwalk': True, 05:41:23 INFO - 'download_symbols': 'ondemand', 05:41:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:41:23 INFO - 'tooltool.py': '/tools/tooltool.py', 05:41:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:41:23 INFO - '/tools/misc-python/virtualenv.py')}, 05:41:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:41:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:41:23 INFO - 'gecko_profile': False, 05:41:23 INFO - 'gecko_profile_interval': 0, 05:41:23 INFO - 'installer_path': 'installer.exe', 05:41:23 INFO - 'log_level': 'info', 05:41:23 INFO - 'log_name': 'talos', 05:41:23 INFO - 'log_to_console': True, 05:41:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:41:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:41:23 INFO - 'opt_config_files': (), 05:41:23 INFO - 'pip_index': False, 05:41:23 INFO - 'suite': 'dromaeojs-e10s', 05:41:23 INFO - 'system_bits': '32', 05:41:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:41:23 INFO - 'title': 'talos-linux64-ix-044', 05:41:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:41:23 INFO - 'use_talos_json': True, 05:41:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:41:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:41:23 INFO - 'work_dir': 'build'} 05:41:23 INFO - [mozharness: 2017-05-10 12:41:23.786057Z] Running clobber step. 05:41:23 INFO - Running pre-action listener: _resource_record_pre_action 05:41:23 INFO - Running main action method: clobber 05:41:23 INFO - rmtree: /builds/slave/test/build 05:41:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:41:24 INFO - Running post-action listener: _resource_record_post_action 05:41:24 INFO - [mozharness: 2017-05-10 12:41:24.722165Z] Finished clobber step (success) 05:41:24 INFO - [mozharness: 2017-05-10 12:41:24.722266Z] Running read-buildbot-config step. 05:41:24 INFO - Running pre-action listener: _resource_record_pre_action 05:41:24 INFO - Running main action method: read_buildbot_config 05:41:24 INFO - Using buildbot properties: 05:41:24 INFO - { 05:41:24 INFO - "project": "", 05:41:24 INFO - "product": "firefox", 05:41:24 INFO - "who": "cbook@mozilla.com", 05:41:24 INFO - "installer_path": "public/build/target.tar.bz2", 05:41:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 05:41:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:41:24 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 05:41:24 INFO - "stage_platform": "linux64-stylo", 05:41:24 INFO - "basedir": "/builds/slave/test", 05:41:24 INFO - "buildnumber": 76, 05:41:24 INFO - "platform": "ubuntu64_hw_stylo", 05:41:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:41:24 INFO - "slavebuilddir": "test", 05:41:24 INFO - "taskId": "X181ASWcSgiO0X0ycb4oEQ", 05:41:24 INFO - "branch": "mozilla-central", 05:41:24 INFO - "script_repo_revision": "production", 05:41:24 INFO - "revision": "f8d40e7fe132b7c73a8f610484b790e6063006e3", 05:41:24 INFO - "slavename": "talos-linux64-ix-044", 05:41:24 INFO - "repo_path": "mozilla-central" 05:41:24 INFO - } 05:41:24 INFO - Finding installer, test and symbols from parent task. 05:41:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X181ASWcSgiO0X0ycb4oEQ'}, attempt #1 05:41:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X181ASWcSgiO0X0ycb4oEQ'}, attempt #1 05:41:25 INFO - Task dependencies: Pkm2Oq24SfWtyt4E5GrX9w 05:41:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w'}, attempt #1 05:41:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/target.tar.bz2 05:41:26 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/test_packages.json 05:41:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/target.crashreporter-symbols.zip 05:41:26 INFO - Running post-action listener: _resource_record_post_action 05:41:26 INFO - [mozharness: 2017-05-10 12:41:26.122109Z] Finished read-buildbot-config step (success) 05:41:26 INFO - [mozharness: 2017-05-10 12:41:26.122327Z] Running download-and-extract step. 05:41:26 INFO - Running pre-action listener: _resource_record_pre_action 05:41:26 INFO - Running main action method: download_and_extract 05:41:26 INFO - mkdir: /builds/slave/test/build/tests 05: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')]} 05:41:26 INFO - trying https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/target.test_packages.json 05:41:26 INFO - Downloading https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:41:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:41:26 INFO - Downloaded 986 bytes. 05:41:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:41:26 INFO - Using the following test package requirements: 05:41:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:41:26 INFO - u'common': [u'target.common.tests.zip'], 05:41:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:41:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:41:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:41:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:41:26 INFO - u'mozbase': [u'target.common.tests.zip'], 05:41:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:41:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:41:26 INFO - u'web-platform': [u'target.common.tests.zip', 05:41:26 INFO - u'target.web-platform.tests.zip'], 05:41:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:41:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:41:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/target.common.tests.zip 05:41:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:41:26 INFO - Fetch https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/target.common.tests.zip into memory 05:41:29 INFO - Content-Length response header: 58451443 05:41:29 INFO - Bytes received: 58451443 05:41:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:41:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/target.common.tests.zip 05:41:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:41:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/target.common.tests.zip into memory 05:41:40 INFO - Content-Length response header: 58451443 05:41:40 INFO - Bytes received: 58451443 05:41:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/target.talos.tests.zip 05:41:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:41:50 INFO - Fetch https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/target.talos.tests.zip into memory 05:41:52 INFO - Content-Length response header: 14409362 05:41:52 INFO - Bytes received: 14409362 05:41:52 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')]} 05:41:52 INFO - trying https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/target.tar.bz2 05:41:52 INFO - Downloading https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:41:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:41:54 INFO - Downloaded 64556278 bytes. 05:41:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/target.tar.bz2 05:41:54 INFO - mkdir: /builds/slave/test/properties 05:41:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:41:54 INFO - Writing to file /builds/slave/test/properties/build_url 05:41:54 INFO - Contents: 05:41:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/target.tar.bz2 05:41:54 INFO - Running post-action listener: _resource_record_post_action 05:41:54 INFO - Running post-action listener: set_extra_try_arguments 05:41:54 INFO - [mozharness: 2017-05-10 12:41:54.644555Z] Finished download-and-extract step (success) 05:41:54 INFO - [mozharness: 2017-05-10 12:41:54.644760Z] Running populate-webroot step. 05:41:54 INFO - Running pre-action listener: _resource_record_pre_action 05:41:54 INFO - Running main action method: populate_webroot 05:41:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:41:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:41:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:41:54 INFO - '--tppagecycles', 05:41:54 INFO - '7'], 05:41:54 INFO - 'tests': ['tsvgm']}}, 05:41:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:41:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:41:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:41:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:41:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:41:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:41:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:41:54 INFO - 'talos_options': ['--disable-e10s'], 05:41:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:41:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:41:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:41:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:41:54 INFO - 'talos_options': ['--disable-e10s'], 05:41:54 INFO - 'tests': ['damp', 'tps']}, 05:41:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:41:54 INFO - 'tests': ['damp', 'tps']}, 05:41:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:41:54 INFO - 'tests': ['dromaeo_dom']}, 05:41:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:41:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:41:54 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:41:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:41:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:41:54 INFO - 'tests': ['a11yr', 05:41:54 INFO - 'ts_paint', 05:41:54 INFO - 'tpaint', 05:41:54 INFO - 'sessionrestore', 05:41:54 INFO - 'sessionrestore_no_auto_restore', 05:41:54 INFO - 'tabpaint']}, 05:41:54 INFO - 'other-e10s': {'tests': ['a11yr', 05:41:54 INFO - 'ts_paint', 05:41:54 INFO - 'tpaint', 05:41:54 INFO - 'sessionrestore', 05:41:54 INFO - 'sessionrestore_no_auto_restore', 05:41:54 INFO - 'tabpaint']}, 05:41:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:41:54 INFO - 'ts_paint', 05:41:54 INFO - 'tpaint', 05:41:54 INFO - 'sessionrestore', 05:41:54 INFO - 'sessionrestore_no_auto_restore', 05:41:54 INFO - 'tabpaint']}, 05:41:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:41:54 INFO - 'ts_paint', 05:41:54 INFO - 'tpaint', 05:41:54 INFO - 'sessionrestore', 05:41:54 INFO - 'sessionrestore_no_auto_restore', 05:41:54 INFO - 'tabpaint']}, 05:41:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:41:54 INFO - 'tests': ['a11yr', 05:41:54 INFO - 'ts_paint', 05:41:54 INFO - 'tpaint', 05:41:54 INFO - 'sessionrestore', 05:41:54 INFO - 'sessionrestore_no_auto_restore', 05:41:54 INFO - 'tabpaint']}, 05:41:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:41:54 INFO - 'tests': ['a11yr', 05:41:54 INFO - 'ts_paint', 05:41:54 INFO - 'tpaint', 05:41:54 INFO - 'sessionrestore', 05:41:54 INFO - 'sessionrestore_no_auto_restore', 05:41:54 INFO - 'tabpaint']}, 05:41:54 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:41:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:41:54 INFO - 'bloom_basic_ref']}, 05:41:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:41:54 INFO - 'tests': ['tsvgx', 05:41:54 INFO - 'tsvgr_opacity', 05:41:54 INFO - 'tart', 05:41:54 INFO - 'tscrollx', 05:41:54 INFO - 'cart', 05:41:54 INFO - 'tsvg_static']}, 05:41:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:41:54 INFO - 'tsvgr_opacity', 05:41:54 INFO - 'tart', 05:41:54 INFO - 'tscrollx', 05:41:54 INFO - 'cart', 05:41:54 INFO - 'tsvg_static']}, 05:41:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:41:54 INFO - 'talos_options': ['--disable-e10s'], 05:41:54 INFO - 'tests': ['tp5o']}, 05:41:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:41:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:41:54 INFO - 'talos_options': ['--disable-e10s', 05:41:54 INFO - '--xperf_path', 05:41:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:41:54 INFO - 'tests': ['tp5n']}, 05:41:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:41:54 INFO - 'talos_options': ['--xperf_path', 05:41:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:41:54 INFO - 'tests': ['tp5n']}}, 05:41:54 INFO - 'talos.zip': {'path': '', 05:41:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:41:54 INFO - Running post-action listener: _resource_record_post_action 05:41:54 INFO - [mozharness: 2017-05-10 12:41:54.666245Z] Finished populate-webroot step (success) 05:41:54 INFO - [mozharness: 2017-05-10 12:41:54.666334Z] Running create-virtualenv step. 05:41:54 INFO - Running pre-action listener: _resource_record_pre_action 05:41:54 INFO - Running main action method: create_virtualenv 05:41:54 INFO - Creating virtualenv /builds/slave/test/build/venv 05:41:54 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 05:41:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:41:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:41:54 INFO - Using real prefix '/usr' 05:41:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:41:55 INFO - Installing distribute.............................................................................................................................................................................................done. 05:41:57 INFO - Installing pip.................done. 05:41:57 INFO - Return code: 0 05:41:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:41:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:41:57 INFO - Reading from file tmpfile_stdout 05:41:57 INFO - Output received: 05:41:57 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) 05:41:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:41:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:57 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 0x1ee01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2252770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224fa30>, '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 0x22507f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2250ca0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071', '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 05:41:57 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 05:41:57 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 05:41:57 INFO - Using env: {'DISPLAY': ':0', 05:41:57 INFO - 'HOME': '/home/cltbld', 05:41:57 INFO - 'LANG': 'en_US.UTF-8', 05:41:57 INFO - 'LANGUAGE': 'en_US:en', 05:41:57 INFO - 'LOGNAME': 'cltbld', 05:41:57 INFO - 'MAIL': '/var/mail/cltbld', 05:41:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:57 INFO - 'MOZ_NO_REMOTE': '1', 05:41:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:57 INFO - 'NO_EM_RESTART': '1', 05:41:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:57 INFO - 'PWD': '/builds/slave/test', 05:41:57 INFO - 'SHELL': '/bin/bash', 05:41:57 INFO - 'SHLVL': '1', 05:41:57 INFO - 'TERM': 'linux', 05:41:57 INFO - 'TMOUT': '86400', 05:41:57 INFO - 'USER': 'cltbld', 05:41:57 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071', 05:41:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:57 INFO - '_': '/tools/buildbot/bin/python'} 05:41:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:57 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 05:41:57 INFO - Cleaning up... 05:41:57 INFO - Return code: 0 05:41:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:41:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:57 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 0x1ee01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2252770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224fa30>, '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 0x22507f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2250ca0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071', '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 05:41:57 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 05:41:57 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 05:41:57 INFO - Using env: {'DISPLAY': ':0', 05:41:57 INFO - 'HOME': '/home/cltbld', 05:41:57 INFO - 'LANG': 'en_US.UTF-8', 05:41:57 INFO - 'LANGUAGE': 'en_US:en', 05:41:57 INFO - 'LOGNAME': 'cltbld', 05:41:57 INFO - 'MAIL': '/var/mail/cltbld', 05:41:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:57 INFO - 'MOZ_NO_REMOTE': '1', 05:41:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:57 INFO - 'NO_EM_RESTART': '1', 05:41:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:57 INFO - 'PWD': '/builds/slave/test', 05:41:57 INFO - 'SHELL': '/bin/bash', 05:41:57 INFO - 'SHLVL': '1', 05:41:57 INFO - 'TERM': 'linux', 05:41:57 INFO - 'TMOUT': '86400', 05:41:57 INFO - 'USER': 'cltbld', 05:41:57 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071', 05:41:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:57 INFO - '_': '/tools/buildbot/bin/python'} 05:41:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:57 INFO - Downloading/unpacking psutil>=3.1.1 05:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:41:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:41:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:41:59 INFO - Installing collected packages: psutil 05:41:59 INFO - Running setup.py install for psutil 05:41:59 INFO - building 'psutil._psutil_linux' extension 05:41:59 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 05:41:59 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 05:41:59 INFO - building 'psutil._psutil_posix' extension 05:41:59 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 05:41:59 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 05:41:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:41:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:41:59 INFO - Successfully installed psutil 05:41:59 INFO - Cleaning up... 05:41:59 INFO - Return code: 0 05:41:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:41:59 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')]} 05:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:59 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')]} 05:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:59 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 0x1ee01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2252770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224fa30>, '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 0x22507f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2250ca0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071', '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 05:41:59 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 05:41:59 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 05:41:59 INFO - Using env: {'DISPLAY': ':0', 05:41:59 INFO - 'HOME': '/home/cltbld', 05:41:59 INFO - 'LANG': 'en_US.UTF-8', 05:41:59 INFO - 'LANGUAGE': 'en_US:en', 05:41:59 INFO - 'LOGNAME': 'cltbld', 05:41:59 INFO - 'MAIL': '/var/mail/cltbld', 05:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:59 INFO - 'MOZ_NO_REMOTE': '1', 05:41:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:59 INFO - 'NO_EM_RESTART': '1', 05:41:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:59 INFO - 'PWD': '/builds/slave/test', 05:41:59 INFO - 'SHELL': '/bin/bash', 05:41:59 INFO - 'SHLVL': '1', 05:41:59 INFO - 'TERM': 'linux', 05:41:59 INFO - 'TMOUT': '86400', 05:41:59 INFO - 'USER': 'cltbld', 05:41:59 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071', 05:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:59 INFO - '_': '/tools/buildbot/bin/python'} 05:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 05: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 05: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 05: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 05: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 05: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 05: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 05:42:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:42:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:42:01 INFO - Installing collected packages: mozsystemmonitor 05:42:01 INFO - Running setup.py install for mozsystemmonitor 05:42:01 INFO - Successfully installed mozsystemmonitor 05:42:01 INFO - Cleaning up... 05:42:01 INFO - Return code: 0 05:42:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05: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')]} 05:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05: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')]} 05:42:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05: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', '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 0x1ee01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2252770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224fa30>, '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 0x22507f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2250ca0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071', '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 05: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05: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 jsonschema==2.5.1 05:42:01 INFO - Using env: {'DISPLAY': ':0', 05:42:01 INFO - 'HOME': '/home/cltbld', 05:42:01 INFO - 'LANG': 'en_US.UTF-8', 05:42:01 INFO - 'LANGUAGE': 'en_US:en', 05:42:01 INFO - 'LOGNAME': 'cltbld', 05:42:01 INFO - 'MAIL': '/var/mail/cltbld', 05:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:01 INFO - 'MOZ_NO_REMOTE': '1', 05:42:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:01 INFO - 'NO_EM_RESTART': '1', 05:42:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:01 INFO - 'PWD': '/builds/slave/test', 05:42:01 INFO - 'SHELL': '/bin/bash', 05:42:01 INFO - 'SHLVL': '1', 05:42:01 INFO - 'TERM': 'linux', 05:42:01 INFO - 'TMOUT': '86400', 05:42:01 INFO - 'USER': 'cltbld', 05:42:01 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071', 05:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:01 INFO - '_': '/tools/buildbot/bin/python'} 05:42:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:01 INFO - Downloading/unpacking jsonschema==2.5.1 05: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 05: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 05: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 05: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 05: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 05: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 05:42:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:42:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05: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 05: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 05: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 05: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 05: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 05: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 05:42:02 INFO - Downloading functools32-3.2.3-2.tar.gz 05:42:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:42:02 INFO - warning: no files found matching '*.txt' 05:42:02 INFO - no previously-included directories found matching 'build' 05:42:02 INFO - no previously-included directories found matching 'dist' 05:42:02 INFO - no previously-included directories found matching '.git*' 05:42:02 INFO - Installing collected packages: jsonschema, functools32 05:42:02 INFO - Running setup.py install for functools32 05:42:02 INFO - warning: no files found matching '*.txt' 05:42:02 INFO - no previously-included directories found matching 'build' 05:42:02 INFO - no previously-included directories found matching 'dist' 05:42:02 INFO - no previously-included directories found matching '.git*' 05:42:03 INFO - Successfully installed jsonschema functools32 05:42:03 INFO - Cleaning up... 05:42:03 INFO - Return code: 0 05:42:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:03 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 0x1ee01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2252770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224fa30>, '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 0x22507f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2250ca0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071', '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 05:42:03 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 05:42:03 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 05:42:03 INFO - Using env: {'DISPLAY': ':0', 05:42:03 INFO - 'HOME': '/home/cltbld', 05:42:03 INFO - 'LANG': 'en_US.UTF-8', 05:42:03 INFO - 'LANGUAGE': 'en_US:en', 05:42:03 INFO - 'LOGNAME': 'cltbld', 05:42:03 INFO - 'MAIL': '/var/mail/cltbld', 05:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:03 INFO - 'MOZ_NO_REMOTE': '1', 05:42:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:03 INFO - 'NO_EM_RESTART': '1', 05:42:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:03 INFO - 'PWD': '/builds/slave/test', 05:42:03 INFO - 'SHELL': '/bin/bash', 05:42:03 INFO - 'SHLVL': '1', 05:42:03 INFO - 'TERM': 'linux', 05:42:03 INFO - 'TMOUT': '86400', 05:42:03 INFO - 'USER': 'cltbld', 05:42:03 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071', 05:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:03 INFO - '_': '/tools/buildbot/bin/python'} 05:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:42:03 INFO - Cleaning up... 05:42:03 INFO - Return code: 0 05:42:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:03 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 0x1ee01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2252770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224fa30>, '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 0x22507f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2250ca0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071', '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 05:42:03 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 05:42:03 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 05:42:03 INFO - Using env: {'DISPLAY': ':0', 05:42:03 INFO - 'HOME': '/home/cltbld', 05:42:03 INFO - 'LANG': 'en_US.UTF-8', 05:42:03 INFO - 'LANGUAGE': 'en_US:en', 05:42:03 INFO - 'LOGNAME': 'cltbld', 05:42:03 INFO - 'MAIL': '/var/mail/cltbld', 05:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:03 INFO - 'MOZ_NO_REMOTE': '1', 05:42:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:03 INFO - 'NO_EM_RESTART': '1', 05:42:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:03 INFO - 'PWD': '/builds/slave/test', 05:42:03 INFO - 'SHELL': '/bin/bash', 05:42:03 INFO - 'SHLVL': '1', 05:42:03 INFO - 'TERM': 'linux', 05:42:03 INFO - 'TMOUT': '86400', 05:42:03 INFO - 'USER': 'cltbld', 05:42:03 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071', 05:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:03 INFO - '_': '/tools/buildbot/bin/python'} 05:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:03 INFO - Downloading/unpacking blobuploader==1.2.4 05: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 05: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 05: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 05: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 05: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 05: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 05:42:04 INFO - Downloading blobuploader-1.2.4.tar.gz 05:42:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:42:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:42:04 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 05:42:04 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 05:42:04 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 05:42:04 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 05:42:04 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 05:42:04 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 05:42:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:42:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:42:05 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 05:42:05 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 05:42:05 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 05:42:05 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 05:42:05 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 05:42:05 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 05:42:05 INFO - Downloading docopt-0.6.1.tar.gz 05:42:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:42:05 INFO - Installing collected packages: blobuploader, requests, docopt 05:42:05 INFO - Running setup.py install for blobuploader 05:42:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:42:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:42:05 INFO - Running setup.py install for requests 05:42:05 INFO - Running setup.py install for docopt 05:42:05 INFO - Successfully installed blobuploader requests docopt 05:42:05 INFO - Cleaning up... 05:42:05 INFO - Return code: 0 05:42:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:42:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:42:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:05 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 0x1ee01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2252770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224fa30>, '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 0x22507f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2250ca0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071', '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 05:42:05 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 05:42:05 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 05:42:05 INFO - Using env: {'DISPLAY': ':0', 05:42:05 INFO - 'HOME': '/home/cltbld', 05:42:05 INFO - 'LANG': 'en_US.UTF-8', 05:42:05 INFO - 'LANGUAGE': 'en_US:en', 05:42:05 INFO - 'LOGNAME': 'cltbld', 05:42:05 INFO - 'MAIL': '/var/mail/cltbld', 05:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:05 INFO - 'MOZ_NO_REMOTE': '1', 05:42:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:05 INFO - 'NO_EM_RESTART': '1', 05:42:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:05 INFO - 'PWD': '/builds/slave/test', 05:42:05 INFO - 'SHELL': '/bin/bash', 05:42:05 INFO - 'SHLVL': '1', 05:42:05 INFO - 'TERM': 'linux', 05:42:05 INFO - 'TMOUT': '86400', 05:42:05 INFO - 'USER': 'cltbld', 05:42:05 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071', 05:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:05 INFO - '_': '/tools/buildbot/bin/python'} 05:42:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:42:06 INFO - Running setup.py (path:/tmp/pip-tNUMla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:42:06 INFO - Running setup.py (path:/tmp/pip-d3o9bK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:42:06 INFO - Running setup.py (path:/tmp/pip-4VOe7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:42:06 INFO - Running setup.py (path:/tmp/pip-yz1PAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:42:06 INFO - Running setup.py (path:/tmp/pip-o6yajA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:42:06 INFO - Running setup.py (path:/tmp/pip-baxuM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:42:06 INFO - Running setup.py (path:/tmp/pip-G1baAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:42:06 INFO - Running setup.py (path:/tmp/pip-SdzNq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:42:06 INFO - Running setup.py (path:/tmp/pip-y498mP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:42:06 INFO - Running setup.py (path:/tmp/pip-7ZjuZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:42:06 INFO - Running setup.py (path:/tmp/pip-De0poJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:42:06 INFO - Running setup.py (path:/tmp/pip-OzJBsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:42:06 INFO - Running setup.py (path:/tmp/pip-4OfJ3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:42:06 INFO - Running setup.py (path:/tmp/pip-MYemuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:07 INFO - Running setup.py (path:/tmp/pip-TWVtOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:42:07 INFO - Running setup.py (path:/tmp/pip-GP1sNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:42:07 INFO - Running setup.py (path:/tmp/pip-10yU1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:42:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:42:07 INFO - Running setup.py install for manifestparser 05:42:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:42:07 INFO - Running setup.py install for mozcrash 05:42:07 INFO - Running setup.py install for mozdebug 05:42:07 INFO - Running setup.py install for mozdevice 05:42:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:42:07 INFO - Running setup.py install for mozfile 05:42:07 INFO - Running setup.py install for mozhttpd 05:42:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:42:07 INFO - Running setup.py install for mozinfo 05:42:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:42:07 INFO - Running setup.py install for mozInstall 05:42:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:42:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:42:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:42:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:42:08 INFO - Running setup.py install for mozleak 05:42:08 INFO - Running setup.py install for mozlog 05:42:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:42:08 INFO - Running setup.py install for moznetwork 05:42:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:42:08 INFO - Running setup.py install for mozprocess 05:42:08 INFO - Running setup.py install for mozprofile 05:42:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:42:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:42:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:42:08 INFO - Running setup.py install for mozrunner 05:42:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:42:08 INFO - Running setup.py install for mozscreenshot 05:42:08 INFO - Running setup.py install for moztest 05:42:08 INFO - Running setup.py install for mozversion 05:42:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:42:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:42:09 INFO - Cleaning up... 05:42:09 INFO - Return code: 0 05:42:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:09 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 0x1ee01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2252770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224fa30>, '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 0x22507f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2250ca0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071', '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 05:42:09 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 05:42:09 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 05:42:09 INFO - Using env: {'DISPLAY': ':0', 05:42:09 INFO - 'HOME': '/home/cltbld', 05:42:09 INFO - 'LANG': 'en_US.UTF-8', 05:42:09 INFO - 'LANGUAGE': 'en_US:en', 05:42:09 INFO - 'LOGNAME': 'cltbld', 05:42:09 INFO - 'MAIL': '/var/mail/cltbld', 05:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:09 INFO - 'MOZ_NO_REMOTE': '1', 05:42:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:09 INFO - 'NO_EM_RESTART': '1', 05:42:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:09 INFO - 'PWD': '/builds/slave/test', 05:42:09 INFO - 'SHELL': '/bin/bash', 05:42:09 INFO - 'SHLVL': '1', 05:42:09 INFO - 'TERM': 'linux', 05:42:09 INFO - 'TMOUT': '86400', 05:42:09 INFO - 'USER': 'cltbld', 05:42:09 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071', 05:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:09 INFO - '_': '/tools/buildbot/bin/python'} 05:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:42:09 INFO - Running setup.py (path:/tmp/pip-YETunm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:42:09 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)) 05:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:42:09 INFO - Running setup.py (path:/tmp/pip-3rNfGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:42:09 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)) 05:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:42:09 INFO - Running setup.py (path:/tmp/pip-pA37_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:42:09 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)) 05:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:42:09 INFO - Running setup.py (path:/tmp/pip-xWeLDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:42:09 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)) 05:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:42:09 INFO - Running setup.py (path:/tmp/pip-1mxy17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:42:09 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)) 05:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:42:09 INFO - Running setup.py (path:/tmp/pip-qSmaI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:42:09 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)) 05:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:42:09 INFO - Running setup.py (path:/tmp/pip-ZOGkck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:42:09 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)) 05:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:42:09 INFO - Running setup.py (path:/tmp/pip-js13fN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:42:09 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)) 05:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:42:09 INFO - Running setup.py (path:/tmp/pip-T5ezKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:42:09 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)) 05:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:42:09 INFO - Running setup.py (path:/tmp/pip-7uaLn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:42:09 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)) 05:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:42:09 INFO - Running setup.py (path:/tmp/pip-QngU_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:42:10 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)) 05:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:42:10 INFO - Running setup.py (path:/tmp/pip-JVYFga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:42:10 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)) 05:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:42:10 INFO - Running setup.py (path:/tmp/pip-9F_RI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:42:10 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)) 05:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:42:10 INFO - Running setup.py (path:/tmp/pip-vVD2qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:42:10 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)) 05:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:10 INFO - Running setup.py (path:/tmp/pip-vMtzG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:10 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)) 05:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:42:10 INFO - Running setup.py (path:/tmp/pip-eJi5e2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:42:10 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)) 05:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:42:10 INFO - Running setup.py (path:/tmp/pip-I6heNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:42:10 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)) 05:42:10 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)) 05:42:10 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)) 05:42:10 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)) 05:42:10 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)) 05:42:10 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)) 05:42:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:11 INFO - Downloading blessings-1.6.tar.gz 05:42:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:42:11 INFO - Installing collected packages: blessings 05:42:11 INFO - Running setup.py install for blessings 05:42:11 INFO - Successfully installed blessings 05:42:11 INFO - Cleaning up... 05:42:11 INFO - Return code: 0 05:42:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:42:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:42:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:42:12 INFO - Reading from file tmpfile_stdout 05:42:12 INFO - Current package versions: 05:42:12 INFO - argparse == 1.2.1 05:42:12 INFO - blessings == 1.6 05:42:12 INFO - blobuploader == 1.2.4 05:42:12 INFO - docopt == 0.6.1 05:42:12 INFO - functools32 == 3.2.3-2 05:42:12 INFO - jsonschema == 2.5.1 05:42:12 INFO - manifestparser == 1.1 05:42:12 INFO - mozInstall == 1.12 05:42:12 INFO - mozcrash == 1.0 05:42:12 INFO - mozdebug == 0.1 05:42:12 INFO - mozdevice == 0.50 05:42:12 INFO - mozfile == 1.2 05:42:12 INFO - mozhttpd == 0.7 05:42:12 INFO - mozinfo == 0.9 05:42:12 INFO - mozleak == 0.1 05:42:12 INFO - mozlog == 3.4 05:42:12 INFO - moznetwork == 0.27 05:42:12 INFO - mozprocess == 0.25 05:42:12 INFO - mozprofile == 0.28 05:42:12 INFO - mozrunner == 6.13 05:42:12 INFO - mozscreenshot == 0.1 05:42:12 INFO - mozsystemmonitor == 0.3 05:42:12 INFO - moztest == 0.8 05:42:12 INFO - mozversion == 1.4 05:42:12 INFO - psutil == 3.1.1 05:42:12 INFO - requests == 1.2.3 05:42:12 INFO - wsgiref == 0.1.2 05:42:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:12 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 0x1ee01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2252770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224fa30>, '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 0x22507f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2250ca0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071', '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 05:42:12 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 05:42:12 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 05:42:12 INFO - Using env: {'DISPLAY': ':0', 05:42:12 INFO - 'HOME': '/home/cltbld', 05:42:12 INFO - 'LANG': 'en_US.UTF-8', 05:42:12 INFO - 'LANGUAGE': 'en_US:en', 05:42:12 INFO - 'LOGNAME': 'cltbld', 05:42:12 INFO - 'MAIL': '/var/mail/cltbld', 05:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:12 INFO - 'MOZ_NO_REMOTE': '1', 05:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:12 INFO - 'NO_EM_RESTART': '1', 05:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:12 INFO - 'PWD': '/builds/slave/test', 05:42:12 INFO - 'SHELL': '/bin/bash', 05:42:12 INFO - 'SHLVL': '1', 05:42:12 INFO - 'TERM': 'linux', 05:42:12 INFO - 'TMOUT': '86400', 05:42:12 INFO - 'USER': 'cltbld', 05:42:12 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071', 05:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:12 INFO - '_': '/tools/buildbot/bin/python'} 05:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:12 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)) 05:42:12 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)) 05:42:12 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)) 05:42:12 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)) 05:42:12 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)) 05:42:12 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)) 05:42:12 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)) 05:42:12 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)) 05:42:12 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)) 05:42:12 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)) 05:42:12 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)) 05:42:12 INFO - Cleaning up... 05:42:12 INFO - Return code: 0 05:42:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20aca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2252770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224fa30>, '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 0x22507f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2250ca0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071', '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 05:42:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:42:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:42:12 INFO - Using env: {'DISPLAY': ':0', 05:42:12 INFO - 'HOME': '/home/cltbld', 05:42:12 INFO - 'LANG': 'en_US.UTF-8', 05:42:12 INFO - 'LANGUAGE': 'en_US:en', 05:42:12 INFO - 'LOGNAME': 'cltbld', 05:42:12 INFO - 'MAIL': '/var/mail/cltbld', 05:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:12 INFO - 'MOZ_NO_REMOTE': '1', 05:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:12 INFO - 'NO_EM_RESTART': '1', 05:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:12 INFO - 'PWD': '/builds/slave/test', 05:42:12 INFO - 'SHELL': '/bin/bash', 05:42:12 INFO - 'SHLVL': '1', 05:42:12 INFO - 'TERM': 'linux', 05:42:12 INFO - 'TMOUT': '86400', 05:42:12 INFO - 'USER': 'cltbld', 05:42:12 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071', 05:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:12 INFO - '_': '/tools/buildbot/bin/python'} 05:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:42:12 INFO - Cleaning up... 05:42:12 INFO - Return code: 0 05:42:12 INFO - Running post-action listener: _resource_record_post_action 05:42:12 INFO - Running post-action listener: _start_resource_monitoring 05:42:12 INFO - Starting resource monitoring. 05:42:12 INFO - [mozharness: 2017-05-10 12:42:12.563799Z] Finished create-virtualenv step (success) 05:42:12 INFO - [mozharness: 2017-05-10 12:42:12.564261Z] Running install step. 05:42:12 INFO - Running pre-action listener: _resource_record_pre_action 05:42:12 INFO - Running main action method: install 05:42:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:42:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:42:12 INFO - Reading from file tmpfile_stdout 05:42:12 INFO - Detecting whether we're running mozinstall >=1.0... 05:42:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:42:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:42:12 INFO - Reading from file tmpfile_stdout 05:42:12 INFO - Output received: 05:42:12 INFO - Usage: mozinstall [options] installer 05:42:12 INFO - Options: 05:42:12 INFO - -h, --help show this help message and exit 05:42:12 INFO - -d DEST, --destination=DEST 05:42:12 INFO - Directory to install application into. [default: 05:42:12 INFO - "/builds/slave/test"] 05:42:12 INFO - --app=APP Application being installed. [default: firefox] 05:42:12 INFO - mkdir: /builds/slave/test/build/application 05:42:12 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'] 05:42:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:42:29 INFO - Reading from file tmpfile_stdout 05:42:29 INFO - Output received: 05:42:29 INFO - /builds/slave/test/build/application/firefox/firefox 05:42:29 INFO - Running post-action listener: _resource_record_post_action 05:42:29 INFO - [mozharness: 2017-05-10 12:42:29.080664Z] Finished install step (success) 05:42:29 INFO - [mozharness: 2017-05-10 12:42:29.080939Z] Running run-tests step. 05:42:29 INFO - Running pre-action listener: _resource_record_pre_action 05:42:29 INFO - Running main action method: run_tests 05:42:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:42:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:42:29 INFO - Python 2.7.3 05:42:29 INFO - Return code: 0 05:42:29 INFO - grabbing minidump binary from tooltool 05:42:29 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')]} 05:42:29 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 0x224fa30>, '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 0x22507f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2250ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:42:29 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 05:42:29 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 05:42:29 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 05:42:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:42:29 INFO - Return code: 0 05:42:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:42:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:42:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:42:29 INFO - ENV: RUST_BACKTRACE is now 1 05:42:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:42:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:42:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 05:42:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 05:42:29 INFO - Using env: {'DISPLAY': ':0', 05:42:29 INFO - 'HOME': '/home/cltbld', 05:42:29 INFO - 'LANG': 'en_US.UTF-8', 05:42:29 INFO - 'LANGUAGE': 'en_US:en', 05:42:29 INFO - 'LOGNAME': 'cltbld', 05:42:29 INFO - 'MAIL': '/var/mail/cltbld', 05:42:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:42:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:29 INFO - 'MOZ_NO_REMOTE': '1', 05:42:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:29 INFO - 'NO_EM_RESTART': '1', 05:42:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:29 INFO - 'PWD': '/builds/slave/test', 05:42:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:42:29 INFO - 'RUST_BACKTRACE': '1', 05:42:29 INFO - 'SHELL': '/bin/bash', 05:42:29 INFO - 'SHLVL': '1', 05:42:29 INFO - 'TERM': 'linux', 05:42:29 INFO - 'TMOUT': '86400', 05:42:29 INFO - 'USER': 'cltbld', 05:42:29 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071', 05:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:29 INFO - '_': '/tools/buildbot/bin/python'} 05:42:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 05:42:29 INFO - mozversion application_buildid: 20170510120601 05:42:29 INFO - mozversion application_changeset: f8d40e7fe132b7c73a8f610484b790e6063006e3 05:42:29 INFO - mozversion application_display_name: Nightly 05:42:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:42:29 INFO - mozversion application_name: Firefox 05:42:29 INFO - mozversion application_remotingname: firefox 05:42:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:42:29 INFO - mozversion application_vendor: Mozilla 05:42:29 INFO - mozversion application_version: 55.0a1 05:42:29 INFO - mozversion platform_buildid: 20170510120601 05:42:29 INFO - mozversion platform_changeset: f8d40e7fe132b7c73a8f610484b790e6063006e3 05:42:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:42:29 INFO - mozversion platform_version: 55.0a1 05:42:29 INFO - using testdate: 1494420149 05:42:29 INFO - actual date: 1494420149 05:42:29 INFO - starting webserver on 'localhost:39254' 05:42:29 INFO - SUITE-START | Running 2 tests 05:42:29 INFO - TEST-START | dromaeo_css 05:42:29 INFO - operating with platform_type : linux_ 05:42:29 INFO - Initialising browser for dromaeo_css test... 05:42:29 INFO - TEST-INFO | started process 25991 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr_jw82/profile http://localhost:39254/getInfo.html) 05:42:33 INFO - PID 25991 | __metrics Screen width/height:1600/1200 05:42:33 INFO - PID 25991 | colorDepth:24 05:42:33 INFO - PID 25991 | Browser inner width/height: 1024/695 05:42:33 INFO - PID 25991 | __metrics 05:42:34 INFO - TEST-INFO | 25991: exit 0 05:42:34 INFO - Browser initialized. 05:42:34 INFO - Running cycle 1/1 for dromaeo_css test... 05:42:34 INFO - TEST-INFO | started process 26183 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr_jw82/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:42:46 INFO - PID 26183 | RSS: Main: 169308160 05:42:46 INFO - PID 26183 | 05:45:50 INFO - PID 26183 | Cycle 1(1): loaded http://localhost:39254/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39254/tests/dromaeo/cssquery-ext.html) 05:45:54 INFO - PID 26183 | RSS: Main: 183648256 05:45:54 INFO - PID 26183 | 05:48:56 INFO - PID 26183 | Cycle 1(1): loaded http://localhost:39254/tests/dromaeo/cssquery-ext.html (next: http://localhost:39254/tests/dromaeo/cssquery-jquery.html) 05:48:56 INFO - PID 26183 | RSS: Main: 180662272 05:48:56 INFO - PID 26183 | 05:51:58 INFO - PID 26183 | Cycle 1(1): loaded http://localhost:39254/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39254/tests/dromaeo/cssquery-mootools.html) 05:51:59 INFO - PID 26183 | RSS: Main: 189325312 05:51:59 INFO - PID 26183 | 05:55:01 INFO - PID 26183 | Cycle 1(1): loaded http://localhost:39254/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39254/tests/dromaeo/cssquery-prototype.html) 05:55:02 INFO - PID 26183 | RSS: Main: 182136832 05:55:02 INFO - PID 26183 | 05:58:04 INFO - PID 26183 | Cycle 1(1): loaded http://localhost:39254/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39254/tests/dromaeo/cssquery-yui.html) 05:58:05 INFO - PID 26183 | RSS: Main: 187072512 05:58:05 INFO - PID 26183 | 06:01:07 INFO - PID 26183 | Cycle 1(1): loaded http://localhost:39254/tests/dromaeo/cssquery-yui.html (next: http://localhost:39254/tests/dromaeo/cssquery-dojo.html) 06:01:07 INFO - PID 26183 | RSS: Main: 190435328 06:01:07 INFO - PID 26183 | 06:01:07 INFO - PID 26183 | __start_tp_report 06:01:07 INFO - PID 26183 | _x_x_mozilla_page_load 06:01:07 INFO - PID 26183 | _x_x_mozilla_page_load_details 06:01:07 INFO - PID 26183 | |i|pagename|runs| 06:01:07 INFO - PID 26183 | |0;dojo.html;2762.28180673025;2775.6252905857705;2800.747932686058;2811.845348505832;2817.7604903583197;5196.246544251091;5296.655717378372;5328.706921119337;5353.491418315254;5373.1134362830135;5271.736413179345;5285.365756109272;5301.7084060376665;5393.460653934604;5396.865078373043;4703.176944034797;4710.670253082286;4724.4566874809325;4739.573438390544;4773.403324584427;4767.261074533453;4768.380110585619;4798.016406636649;4810.158222311082;4816.518348165173;4636.072785442925;4642.605378542828;4710.8351207707565;4727.7163370197895;4743.857684269477;4727.338172655831;4735.550122738368;4743.976280118612;4761.47623761386;4787.16224660683;4679.15775160471;4711.646626502992;4721.055788842245;4721.551452611996;4732.982408782128;5051.595872330205;5134.974325128388;5141.997310524449;5146.433892271884;5193.506616871391;5676.347220069703;5688.516476099495;5827.067669172954;5828.766849326022;5829.154772557956;5807.622504537234;5811.418858114154;5823.155642431823;5824.126381042835;5878.794242201545;5386.973065134649;5398.163284690879;5407.621466497308;5411.134218525017;5417.26866872975;5670.7731690732735;5825.563082768809;5850.976079186125;5935.347111817697;5935.851603709942;5595.524380427709;5634.352049514358;5650.7739690412745;5690.7439165237665;5693;5710.057840456361;5718.199452076713;5721.998650236192;5732.369439361667;5738.225339579187;5590.944090559124;5615.494605485526;5681.403452637496;5689.516391106719;5701.828945131652;5573.3869274380595;5627.465390787868;5656.575756818255;5667.404922483162;5700.116481945305;4769.475357710649;4777.8327758528285;4784.210605250164;4799.6400269979895;4827.155247831615;4039;4050.9392359114636;4088.34586466164;4110.219058378899;4133.627973482341;4868.172410690191;4914.0908931847725;4935.703857768545;4939.629527785431;4967.329410529533;5763.740631671585;5796.971015144897;5797.971010145006;5812.099124635688;5816.912746308809;4880.389951256093;4933.950660493421;4938.111139994764;4942.703437793743;4979.253112033224;5010;5012.097822392005;5081.187010078444;5085.160948443466;5096.719680417613;5324.281222034976;5325.227841962971;5325.281087053353;5325.893482130258;5328.413874473727;5672.5745569081655;5720.914186287292;5736.569757268138;5742.684152371659;5743.167240750151;5289.7355132244;5293.523582877559;5298.81454149103;5300.920486192633;5338.172583249602;5576.553875690016;5582.944170558405;5606;5642.407547207484;5647.943520564741;5648.435156484483;5760.107183386582;5760.481556659921;5763.625364351304;5786.594938354443;5509.3664228612615;5547.861303467445;5553.222548843084;5556.111022236423;5559.305086864142;5481.862953426196;5483.835484935458;5488.4237155098135;5488.780448782164;5496;5418.45815418455;5443.618946673695;5465.207544906046;5470.699111548903;5472.069748142746;5456.154296084113;5552.639078459887;5592.664440133605;5599.132134519156;5602.159676048625;5456.399796022355;5460.6996615186545;5465.699386533779;5520.337559492887;5526.392096869422 06:01:07 INFO - PID 26183 | |1;ext.html;659.2319947261441;678.9083473731047;1053.6680945502167;1075.6181555547785;1150.045462266319;30099.849500752494;32882.177945551346;32937.67062329379;32960.67039329606;33068.66931330686;30455;30847.537286940715;30956;30979.38041239174;31028.379432411395;6255.90616140756;6341.556091073615;6397.488200943913;6412.230532336126;6424.71088801005;6976.162860456752;7035.577865328071;7064.717411303542;7071.292870712913;7075.540089894166;7031.226565077837;7032.753853615124;7070.116235470567;7070.681819318117;7118.323759242864;6993.440524758058;7019.754308599226;7030.472714546404;7092.397146242602;7099.751508697171;6884.827879303008;6886.621235832027;6917.412019978308;6921.688524016431;6932.306769323028;31301.06096817099;31760.04719858385;31774;31791;31842.522362164586;3077.123019939329;3098.4577698902826;3103.674114217997;3122.9219269518217;3129.1394866411692;24300;24341;24434.389140271458;24467;24512.264632061066;3152.133163380066;3194.4250034993693;3220.6618305077864;3222.9033129006166;3242.1408326793417;140717;141724;141946;141971;142536.2873185638;37955;40210.79894600508;41487.792561037;41655.375169372484;41940;40817.79591102026;40849.38725919054;41370.586294137276;41374.37938430926;41444.37833432501;12561.309127997865;12719.300438475788;12720.109592328448;12743;12743.745125097632;9934.751631209278;10019.949900250453;10034.899651003543;10077.496125193711;10077.798444031077;12611.180273282207;12632.178908370926;12715.109942304134;12725.809112863315;12842.935785321013;5230.660007099526;5280.973595132;5319.414864364917;5337.492938170868;5346.893062138735;894.1371576428647;926.8007378413539;929.4702019848621;950.273041123541;967.583938906277;20606;21275;21318.147274108862;21362.359129226148;21560.56878862414;1012.2762225009154;1013.7465633591602;1014.1582486536157;1028.840529717895;1040.1782591752583;11003.26859450428;11190.440477976068;11310.773784524263;11349.503109315938;11491.655250342503;166197;166318.1684091596;166550;167099;167667;40008.39798448351;40024.1995160101;40342.79828600838;40381.394279085835;40457.59542404597;1215.604928398274;1261.0668105601972;1261.8107283907304;1267.1066897837002;1277.271954985668;19551.413457596296;19694.50763730861;19927.900360498104;20852.582948340645;20935.8953205233;29571.704282957755;29577.26056848596;29605.703942960296;29661.406771864873;29720.554191686708;148655;148760;149124;149168;149210;28231.43537129287;28332;29539.704602953694;30727.385452290382;30984;36439.45340819943;36712.449313259785;36970.63029369672;37029.62970370369;37040.62959370372;26657;27647.30881727973;27914.86042569774;27957.301067473476;28677.13968580946;27316.31709207286;27371.452570948866;28252;28689.713102868704;29029.12912612625;30801;30807;30889;30893.227669308446;30994.84502577563;26826.731732682423;27039.72960270451;27772.72227277782;28020.859895700392;29028.12915612535;20118;22799.544009119392;22829.20097796569;22834.657480137477;22863.542729145658 06:01:07 INFO - PID 26183 | |2;jquery.html;417.7096917642238;423.8791944295875;427.57669906792285;429.5125033087445;444.34015487001795;13911.79132313016;16160.27278772455;16878.662426751456;16952.23714932828;17308.30766769331;17927.731084033716;17941.372051978182;18148.546286342847;18255.54361140972;18403.63192736148;5393.59548033897;5414.8917021659645;5492.80775172869;5547.3343198816;5583;5354.598405119632;5449.264349312852;5473.972630136844;5475.479829416199;5479;5257.631965762398;5433.293671822657;5454.045542030149;5468.808591699291;5486.890262194754;5445.754941027643;5471.781128754845;5492.972535137339;5494.230807686887;5507.421720719327;4898.412190537123;4901.068796928608;4935.481774413671;4939.678920870132;4955.157623204064;21584.676229856566;21739.456513587127;21767.020484078254;21816.781832181634;22115.115395384164;1676.8490835824712;1693.618935739461;1696.5843368374703;1699.2438364927611;1700.7533907583331;14995.475158369514;15353.385864565404;15374.154421506813;15539.844601553952;15627.374905003786;1875.7467741854812;1915.4062240705425;1936.9612607747906;1953.677643188872;1962.519182800223;89797.55101224517;90845.09154908432;91251.54374228153;92134.5393273036;92923.53538232333;10958;11141.660251347146;11152.442377881074;11401;11463.88536114645;15509;15661.216939152997;15797.447089351817;15798.92100539513;15848.68302633941;7800.960995194988;7955.363570914313;8072.273495385443;8082.19178082187;8117.310028647513;7138;7173.6771845267085;7213.675384607705;7420.369268612229;7449.664765085584;7079.681414336367;7121.537100088478;7201.207867134611;7222.244156664594;7273.309035641606;2085.4994801247894;2095.6123117223365;2113.8943052847294;2123.9575208496053;2197.143114185469;878.8066625342415;907.1880666803174;913.0823522360118;917.1745429113718;939.8919124300656;16856.74714879278;19462.22151113968;21262.362129136152;21548.13807447716;21672.13311467555;900.4327273817453;920.5443305563655;923.958421871004;930.2372054914905;940.9529523523796;9306.627734890664;9746.805063898682;9909.108180263811;9915.256355773347;9965;353007;353366;362603;370149;370980;72832.27167728361;74212.62893685498;74646.6267668669;74668.62665686745;75261.24738752542;1057.8095942730383;1114.164376717462;1136.5283407386007;1138.2942575603179;1138.3397629374942;17407.95552266868;17417;18072.63854722872;18231.817681823013;18241.179146938684;39302.6069739299;40412.79793601013;40759.1848163041;41446.79276603598;42167.36748948829;46931.296030560254;48973;49213.753931230116;49254.75372623114;51428.74285628548;8179.182081791773;8365.205305495969;8434.662613495637;8448.197421244971;8510.106438823834;12412.441440135397;12982;13137.277449740355;13168.209907405586;13363.331833408096;11225.101991840469;11312.83030754523;11547.422628868355;11800.2329848563;11873.346965916611;10719.464026798785;10895.673129806119;11237;11249.381284029458;11304.208705390873;10731.517081731497;10768.676939691823;10793.514291856729;10971.890281097087;11094.334339939307;8471.364647651573;8744.69393571222;8851.822963540564;8914.86627700572;9053.977357588814;11257;11567.248128871597;11579.363135027317;11695.473703683525;12058.15592908488 06:01:07 INFO - PID 26183 | |3;mootools.html;1306.7778477658799;1354.3702178487008;1365.706373129777;1368.59626410209;1369.4453746232775;9873.950630246847;10280.074793268604;10291.588336466542;10353;10601.84097238542;10363.481825908711;10427.32222405545;10482.790344193112;10527.789444211112;10529.420881851494;2216.612092883743;2245.4835387860803;2247.202243203664;2247.3819699582664;2256.808171305441;2171.5776166610895;2198.2633719361766;2205.184081889703;2220.0897631970897;2220.245116660335;2206.6359050756605;2215.2246713650256;2229.643257078868;2237.2169740590743;2244.2145249162745;2190.87950162741;2206.1065268566176;2240.2943072931976;2243.8204943604474;2253.5380247049316;2095.224766836265;2188.737351517828;2237.44063984004;2248.8650680959195;2257.3340864444863;10125.797484050352;10187;10194.59221631134;10202.285839991204;10215.438150901697;5495.175723641446;5634.267545219136;5679.119736440858;5690.573207009449;5717.285339332583;3297.96702032979;3437.1407148212948;3522.6125126236093;3539.239063601338;3620.25784714133;1093.9507722152443;1100.4717735486931;1106.6016234155697;1153.555880985818;1156.0693641618493;14996.775048374284;15076;15130.39478420873;15189.088654680754;15221.086734795948;4780.450248221429;4974.651774375831;5000.499950004971;5009.073321435546;5075.187969924795;10942.234043617029;10947.233693641369;10953.3427994319;10957.780844383227;10987.175961802897;5688;5712.942870571324;5752.395998420189;5753.827385178452;5758.971205143947;5146.150885103991;5267.604929630293;5318.574514038867;5355;5382.219578161144;3810.2569998850513;3957.6635985940943;3960.386140148282;4016.176683779818;4036.798160091984;1122.887711228887;1128.8250321200228;1141.303804679145;1143.845580846575;1150.5340337163461;678.9762358317436;711.2993701204309;715.4562532475356;718.2207305073949;730.050933786076;5216.66091704038;5310.654807437581;5355.973220133875;5390.838274851761;5441.755121019484;545.3537557993711;550.1884720037992;552.1882832236606;553.3442870198827;554.692145859044;3146.9625553177084;3163.8892638757534;3223.5325877747596;3228.935421291561;3303.075138961047;12917.418716157796;12950.093493455368;13316.6670833228;13499.527516536875;13515.864841351657;13020.348982550835;13328.400221990034;13447.327633618475;13498.325083745773;13527.053106282467;7724.497907635986;7794.805129871798;7899.328557072713;7938.801529961797;7945.761627151194;5399.649022813504;5475.4250803665045;5504.972475137599;5582.0231459495235;5663.915041274467;11931.76136477283;12057.819132713192;12060.15578909503;12351.19717218378;12438.751224975631;11925.76148477043;12241.143119981516;12325.075619328765;12415.130940834417;12415.44130514147;7803.96098019529;7920.168382319774;7968.601569921365;7996.520208787491;8007.959960200162;9432.905670943202;9634.373765705206;9692.224622030362;9783.706488805346;9792.657256995972;8393.580320983805;8461.280791132576;8494.1081186477;8546.871796922927;8706.695265665672;7924.20757924203;7970.681172753025;8097.473664211808;8155.143709910374;8312.293455056388;7291.234420385783;7452.664630091767;7473.476856620202;7482.663280152297;7494.925050749423;4815.6147508198555;4860.562549370574;4922.1140194765285;5153.613478989166;5158.871028224325;5193.506616871391;5219.243209734491;5336.17289320156;5349.491798279158;5370.275012873212 06:01:07 INFO - PID 26183 | |4;prototype.html;396.92458432897746;399.494639281309;403.8465383154401;409.62723921231685;416.6520955002575;5552.305961754781;5589.972050139743;5592.259792701572;5603.159526071091;5606.299212598426;5289.153735402337;5357.4374690657505;5445.646033007862;5448.782048718046;5494.423085576017;4267.253230684633;4271.273883439822;4280.914381712364;4283.571642835707;4290.42079319291;4276.562359455112;4282.207791558571;4287.6569874410125;4304.31131019037;4315.4389929309145;4179.6447301979215;4247.171801498709;4260.531341552427;4262.97868510657;4287.378330142127;4246.023414614656;4247.808848601805;4253.043065310311;4253.893652658678;4271.188474189894;3864.2271545690974;3869.7097717671286;3875.65119139276;3879.262940041383;3881.611838816124;5157.53582177602;5277.730575852382;5318.840434786963;5329.600279979017;5338.62629615927;5053.166227572447;5059.139946209153;5064.139096353629;5092.210707340369;5104.489551044903;5832.562557808139;5854.18041474194;5855.033919403293;5855.736491857877;5873.500752436048;4223.429836972;4321.7775132669;4327.459067616548;4331.675124365685;4352;5934;6003.459688628044;6072.544559158081;6080.817575472743;6100.267967843798;4043.353063509883;4065.654419374386;4083.3262511685834;4088.2232375848494;4115.238680844053;4159.91680166395;4163.417121602978;4165.229432554987;4173.227952828736;4180.289350810309;4725.432948046257;4785.712857228577;4791.904161916812;4816.4220293564995;4827.637927155477;5798.710064496759;5799.478046975708;5802.303723553201;5827.863566604557;5831.650100993869;1428;1437.856214378554;1439.9712005759827;1442.1995792335144;1447.3414596358632;915.9725208243764;959.7408699651055;964.4165280005636;973.9513024348754;978.4031740638205;5026.788213186186;5046.041252162077;5051;5057.620678449131;5062.670926389773;5984.132300816357;5987.970060149672;6015.2781666200335;6020.638761674313;6028.156058151862;4867.1969125093965;5023.547880690755;5045.84862454127;5081.385069498225;5098.2097774844215;3150.8582113804932;3153.952690709641;3172.0959526534825;3189.728873045771;3194.552762613236;5419.566434685215;5561.916571251434;5566.165075238666;5566.276384070045;5579.2746942897975;6127.264728232641;6157.599756015845;6159.84600384994;6160.661163635953;6193.256809182927;5565.632792160765;5569.637973531708;5576.442355764391;5581.855719577396;5586.245856809279;5845.532357411312;5986.700664966647;6009.639421634716;6016.7292471838;6035.78874739382;5942.970285148546;5945.791897283574;5961;5969.194158788508;5979.671118088547;5397.514223719884;5542.501174894118;5579.828236070471;5582.525485333792;5604.663720176803;4073.816678249427;4094.242565125461;4124.835006599702;4125.938110928279;4127.484064491939;5886.146508756292;6052.939470605237;6055.636661800306;6057.697115144137;6062.666553339609;5790.176094530209;5823.9516886960755;5827.251824452732;5842.211301474246;5847.795327163529;5805.593608447368;5825.155352473952;5840.620359676607;5842.766289348378;5849.678267695147;5534.944650553604;5691.8861622768145;5739.282589676291;5744.339400968942;5755.194272801895;5877;5885.911711324248;5893.292804863272;5898.439648233411;5913.172155898092;5504.0643090675485;5694.974904517227;5717.742701578522;5763.135529670583;5763.423657634371 06:01:07 INFO - PID 26183 | |5;yui.html;741.6551303643811;768.4352001279059;769.3114662377176;781.7537475695156;790.3440144679914;12941.094123411365;13296.401661925225;13311.467541298349;15711.842881571181;15837.366505339773;15533.689326213469;15688.980216285934;15761.60595985101;15821.208939553035;16352.672946541063;876.0669886570813;888.1074520107284;891.7012800711769;892.6830975003877;893.7676204186926;902.2285945516587;902.6118768929358;905.597009330848;905.714699869539;906.207068814787;945.8250223708601;947.393668052447;948.2840455456121;951.2247518272586;951.509972364233;934.3459578295186;937.7702462896566;941.8398872191743;942.9669961551347;943.0286804591248;695.9095317608678;695.9860802783967;696.3976160621077;697.6023666510091;697.8255436140964;14316.856831431656;14721.779173312409;14757.631059223499;14762.114273143538;14798.630034249123;15746.842531574766;15913;15951.92024039884;16051.438199662956;16081.839181608268;12435.3782310885;12453.688657783538;12506.74986500274;12702.618921432279;12703.364831758376;2928.5167947288674;2932.208303757973;2944.661363943131;2949.8348152479653;2954.039937020477;67966;68167;68562.65718671425;68596.6570167146;70322;10068.848967265498;10548.894511054792;12883.29141897186;12900.483980640669;12915.677108072185;22295.554088918456;22906.541869162524;22945.196918107787;22945.426364341027;22980.425489362566;6346.777862774781;6373.52198585108;6427.421532062043;6429.54993150475;6476.481881449473;2915.9125226243245;2966.4363770883465;2967.0802051364144;2967.451021561018;2969.8218106913223;3551.9289614207573;3555.2178520725397;3609.639036096369;3625.148090198801;3646.1431563582537;753.5968256982488;756.5347311403557;758.6548120605112;765.3303359560384;769.2960940739162;619.5910698938679;634.1185751804994;636.1126228910643;636.1412093673504;641.0960545630732;9657.32398732096;9971.451570163566;10473.423961682181;10555.10281626055;10774.622888198875;616.6300219868133;617.0971630396546;620.8975519039399;623.8845813524513;637.5314144104173;4612.630989520897;4619.445666520039;4630.652701047435;4645.767711614473;4667.789949452283;63164.368356316765;64105.03842442367;64567.677161613894;64582.67708661521;65608.67195663991;56124.71937640367;56659.43340566624;57025.429745702844;57245.427545724844;57460;50405.74797125991;50811.23783143256;51318.48681513212;52090.47909520856;52804.73597631987;9405.529723513933;9483.241340692866;9524.761880953032;9595.520223988633;9891.703248902544;27164.592531112445;27655.723442765317;27740.861295694198;27798.722012779614;27871;32496.512552311262;32608.83695581507;33147.50278745869;33532.32935341328;34340.656593434745;11992.340421276913;12194.268343899394;12251.938740306241;12307.507699691912;12315.815262770886;13547.119437236548;13776.10455320401;13823.308834558433;13967;14035.789463158266;12503.499860005499;12540.122191446511;12631.178973366701;12772.233665980071;12842.87157128454;12506.874931250935;13980.650483737987;14513.782293265398;14808.851911480748;14995;14023.509177179158;14024.719505610035;14253.714925701635;14297.64255893611;14635;10836.945815270874;10965.725856853642;11492;11616.477258523219;11670.88329116698;11457;12620.495180192689;12750.68123296925;12842;12856.807147892601 06:01:07 INFO - PID 26183 | __end_tp_report 06:01:07 INFO - PID 26183 | __start_cc_report 06:01:07 INFO - PID 26183 | _x_x_mozilla_cycle_collect,368 06:01:07 INFO - PID 26183 | __end_cc_report 06:01:07 INFO - PID 26183 | __startTimestamp1494421267607__endTimestamp 06:01:07 INFO - PID 26183 | 06:01:07 INFO - PID 26183 | ------- Summary: start ------- 06:01:07 INFO - PID 26183 | Number of tests: 6 06:01:07 INFO - PID 26183 | 06:01:07 INFO - PID 26183 | [#0] dojo.html Cycles:165 Average:5230.39 Median:5407.62 stddev:609.01 (11.3%) stddev-sans-first:579.28 06:01:07 INFO - PID 26183 | Values: 2762.3 2775.6 2800.7 2811.8 2817.8 5196.2 5296.7 5328.7 5353.5 5373.1 5271.7 5285.4 5301.7 5393.5 5396.9 4703.2 4710.7 4724.5 4739.6 4773.4 4767.3 4768.4 4798.0 4810.2 4816.5 4636.1 4642.6 4710.8 4727.7 4743.9 4727.3 4735.6 4744.0 4761.5 4787.2 4679.2 4711.6 4721.1 4721.6 4733.0 5051.6 5135.0 5142.0 5146.4 5193.5 5676.3 5688.5 5827.1 5828.8 5829.2 5807.6 5811.4 5823.2 5824.1 5878.8 5387.0 5398.2 5407.6 5411.1 5417.3 5670.8 5825.6 5851.0 5935.3 5935.9 5595.5 5634.4 5650.8 5690.7 5693.0 5710.1 5718.2 5722.0 5732.4 5738.2 5590.9 5615.5 5681.4 5689.5 5701.8 5573.4 5627.5 5656.6 5667.4 5700.1 4769.5 4777.8 4784.2 4799.6 4827.2 4039.0 4050.9 4088.3 4110.2 4133.6 4868.2 4914.1 4935.7 4939.6 4967.3 5763.7 5797.0 5798.0 5812.1 5816.9 4880.4 4934.0 4938.1 4942.7 4979.3 5010.0 5012.1 5081.2 5085.2 5096.7 5324.3 5325.2 5325.3 5325.9 5328.4 5672.6 5720.9 5736.6 5742.7 5743.2 5289.7 5293.5 5298.8 5300.9 5338.2 5576.6 5582.9 5606.0 5642.4 5647.9 5648.4 5760.1 5760.5 5763.6 5786.6 5509.4 5547.9 5553.2 5556.1 5559.3 5481.9 5483.8 5488.4 5488.8 5496.0 5418.5 5443.6 5465.2 5470.7 5472.1 5456.2 5552.6 5592.7 5599.1 5602.2 5456.4 5460.7 5465.7 5520.3 5526.4 06:01:07 INFO - PID 26183 | 06:01:07 INFO - PID 26183 | [#1] ext.html Cycles:180 Average:29724.33 Median:30277.42 stddev:39362.12 (130.0%) stddev-sans-first:39412.04 06:01:07 INFO - PID 26183 | Values: 659.2 678.9 1053.7 1075.6 1150.0 30099.8 32882.2 32937.7 32960.7 33068.7 30455.0 30847.5 30956.0 30979.4 31028.4 6255.9 6341.6 6397.5 6412.2 6424.7 6976.2 7035.6 7064.7 7071.3 7075.5 7031.2 7032.8 7070.1 7070.7 7118.3 6993.4 7019.8 7030.5 7092.4 7099.8 6884.8 6886.6 6917.4 6921.7 6932.3 31301.1 31760.0 31774.0 31791.0 31842.5 3077.1 3098.5 3103.7 3122.9 3129.1 24300.0 24341.0 24434.4 24467.0 24512.3 3152.1 3194.4 3220.7 3222.9 3242.1 140717.0 141724.0 141946.0 141971.0 142536.3 37955.0 40210.8 41487.8 41655.4 41940.0 40817.8 40849.4 41370.6 41374.4 41444.4 12561.3 12719.3 12720.1 12743.0 12743.7 9934.8 10019.9 10034.9 10077.5 10077.8 12611.2 12632.2 12715.1 12725.8 12842.9 5230.7 5281.0 5319.4 5337.5 5346.9 894.1 926.8 929.5 950.3 967.6 20606.0 21275.0 21318.1 21362.4 21560.6 1012.3 1013.7 1014.2 1028.8 1040.2 11003.3 11190.4 11310.8 11349.5 11491.7 166197.0 166318.2 166550.0 167099.0 167667.0 40008.4 40024.2 40342.8 40381.4 40457.6 1215.6 1261.1 1261.8 1267.1 1277.3 19551.4 19694.5 19927.9 20852.6 20935.9 29571.7 29577.3 29605.7 29661.4 29720.6 148655.0 148760.0 149124.0 149168.0 149210.0 28231.4 28332.0 29539.7 30727.4 30984.0 36439.5 36712.4 36970.6 37029.6 37040.6 26657.0 27647.3 27914.9 27957.3 28677.1 27316.3 27371.5 28252.0 28689.7 29029.1 30801.0 30807.0 30889.0 30893.2 30994.8 26826.7 27039.7 27772.7 28020.9 29028.1 20118.0 22799.5 22829.2 22834.7 22863.5 06:01:07 INFO - PID 26183 | 06:01:07 INFO - PID 26183 | [#2] jquery.html Cycles:180 Average:24936.63 Median:39857.70 stddev:60342.53 (151.4%) stddev-sans-first:60483.72 06:01:07 INFO - PID 26183 | Values: 417.7 423.9 427.6 429.5 444.3 13911.8 16160.3 16878.7 16952.2 17308.3 17927.7 17941.4 18148.5 18255.5 18403.6 5393.6 5414.9 5492.8 5547.3 5583.0 5354.6 5449.3 5474.0 5475.5 5479.0 5257.6 5433.3 5454.0 5468.8 5486.9 5445.8 5471.8 5493.0 5494.2 5507.4 4898.4 4901.1 4935.5 4939.7 4955.2 21584.7 21739.5 21767.0 21816.8 22115.1 1676.8 1693.6 1696.6 1699.2 1700.8 14995.5 15353.4 15374.2 15539.8 15627.4 1875.7 1915.4 1937.0 1953.7 1962.5 89797.6 90845.1 91251.5 92134.5 92923.5 10958.0 11141.7 11152.4 11401.0 11463.9 15509.0 15661.2 15797.4 15798.9 15848.7 7801.0 7955.4 8072.3 8082.2 8117.3 7138.0 7173.7 7213.7 7420.4 7449.7 7079.7 7121.5 7201.2 7222.2 7273.3 2085.5 2095.6 2113.9 2124.0 2197.1 878.8 907.2 913.1 917.2 939.9 16856.7 19462.2 21262.4 21548.1 21672.1 900.4 920.5 924.0 930.2 941.0 9306.6 9746.8 9909.1 9915.3 9965.0 353007.0 353366.0 362603.0 370149.0 370980.0 72832.3 74212.6 74646.6 74668.6 75261.2 1057.8 1114.2 1136.5 1138.3 1138.3 17408.0 17417.0 18072.6 18231.8 18241.2 39302.6 40412.8 40759.2 41446.8 42167.4 46931.3 48973.0 49213.8 49254.8 51428.7 8179.2 8365.2 8434.7 8448.2 8510.1 12412.4 12982.0 13137.3 13168.2 13363.3 11225.1 11312.8 11547.4 11800.2 11873.3 10719.5 10895.7 11237.0 11249.4 11304.2 10731.5 10768.7 10793.5 10971.9 11094.3 8471.4 8744.7 8851.8 8914.9 9054.0 11257.0 11567.2 11579.4 11695.5 12058.2 06:01:07 INFO - PID 26183 | 06:01:07 INFO - PID 26183 | [#3] mootools.html Cycles:180 Average:6305.05 Median:3479.88 stddev:4088.31 (117.5%) stddev-sans-first:4082.52 06:01:07 INFO - PID 26183 | Values: 1306.8 1354.4 1365.7 1368.6 1369.4 9874.0 10280.1 10291.6 10353.0 10601.8 10363.5 10427.3 10482.8 10527.8 10529.4 2216.6 2245.5 2247.2 2247.4 2256.8 2171.6 2198.3 2205.2 2220.1 2220.2 2206.6 2215.2 2229.6 2237.2 2244.2 2190.9 2206.1 2240.3 2243.8 2253.5 2095.2 2188.7 2237.4 2248.9 2257.3 10125.8 10187.0 10194.6 10202.3 10215.4 5495.2 5634.3 5679.1 5690.6 5717.3 3298.0 3437.1 3522.6 3539.2 3620.3 1094.0 1100.5 1106.6 1153.6 1156.1 14996.8 15076.0 15130.4 15189.1 15221.1 4780.5 4974.7 5000.5 5009.1 5075.2 10942.2 10947.2 10953.3 10957.8 10987.2 5688.0 5712.9 5752.4 5753.8 5759.0 5146.2 5267.6 5318.6 5355.0 5382.2 3810.3 3957.7 3960.4 4016.2 4036.8 1122.9 1128.8 1141.3 1143.8 1150.5 679.0 711.3 715.5 718.2 730.1 5216.7 5310.7 5356.0 5390.8 5441.8 545.4 550.2 552.2 553.3 554.7 3147.0 3163.9 3223.5 3228.9 3303.1 12917.4 12950.1 13316.7 13499.5 13515.9 13020.3 13328.4 13447.3 13498.3 13527.1 7724.5 7794.8 7899.3 7938.8 7945.8 5399.6 5475.4 5505.0 5582.0 5663.9 11931.8 12057.8 12060.2 12351.2 12438.8 11925.8 12241.1 12325.1 12415.1 12415.4 7804.0 7920.2 7968.6 7996.5 8008.0 9432.9 9634.4 9692.2 9783.7 9792.7 8393.6 8461.3 8494.1 8546.9 8706.7 7924.2 7970.7 8097.5 8155.1 8312.3 7291.2 7452.7 7473.5 7482.7 7494.9 4815.6 4860.6 4922.1 5153.6 5158.9 5193.5 5219.2 5336.2 5349.5 5370.3 06:01:07 INFO - PID 26183 | 06:01:07 INFO - PID 26183 | [#4] prototype.html Cycles:180 Average:4811.97 Median:5471.60 stddev:1407.46 (25.7%) stddev-sans-first:1371.84 06:01:07 INFO - PID 26183 | Values: 396.9 399.5 403.8 409.6 416.7 5552.3 5590.0 5592.3 5603.2 5606.3 5289.2 5357.4 5445.6 5448.8 5494.4 4267.3 4271.3 4280.9 4283.6 4290.4 4276.6 4282.2 4287.7 4304.3 4315.4 4179.6 4247.2 4260.5 4263.0 4287.4 4246.0 4247.8 4253.0 4253.9 4271.2 3864.2 3869.7 3875.7 3879.3 3881.6 5157.5 5277.7 5318.8 5329.6 5338.6 5053.2 5059.1 5064.1 5092.2 5104.5 5832.6 5854.2 5855.0 5855.7 5873.5 4223.4 4321.8 4327.5 4331.7 4352.0 5934.0 6003.5 6072.5 6080.8 6100.3 4043.4 4065.7 4083.3 4088.2 4115.2 4159.9 4163.4 4165.2 4173.2 4180.3 4725.4 4785.7 4791.9 4816.4 4827.6 5798.7 5799.5 5802.3 5827.9 5831.7 1428.0 1437.9 1440.0 1442.2 1447.3 916.0 959.7 964.4 974.0 978.4 5026.8 5046.0 5051.0 5057.6 5062.7 5984.1 5988.0 6015.3 6020.6 6028.2 4867.2 5023.5 5045.8 5081.4 5098.2 3150.9 3154.0 3172.1 3189.7 3194.6 5419.6 5561.9 5566.2 5566.3 5579.3 6127.3 6157.6 6159.8 6160.7 6193.3 5565.6 5569.6 5576.4 5581.9 5586.2 5845.5 5986.7 6009.6 6016.7 6035.8 5943.0 5945.8 5961.0 5969.2 5979.7 5397.5 5542.5 5579.8 5582.5 5604.7 4073.8 4094.2 4124.8 4125.9 4127.5 5886.1 6052.9 6055.6 6057.7 6062.7 5790.2 5824.0 5827.3 5842.2 5847.8 5805.6 5825.2 5840.6 5842.8 5849.7 5534.9 5691.9 5739.3 5744.3 5755.2 5877.0 5885.9 5893.3 5898.4 5913.2 5504.1 5695.0 5717.7 5763.1 5763.4 06:01:07 INFO - PID 26183 | 06:01:07 INFO - PID 26183 | [#5] yui.html Cycles:180 Average:15244.57 Median:33339.92 stddev:17919.62 (53.7%) stddev-sans-first:17936.79 06:01:07 INFO - PID 26183 | Values: 741.7 768.4 769.3 781.8 790.3 12941.1 13296.4 13311.5 15711.8 15837.4 15533.7 15689.0 15761.6 15821.2 16352.7 876.1 888.1 891.7 892.7 893.8 902.2 902.6 905.6 905.7 906.2 945.8 947.4 948.3 951.2 951.5 934.3 937.8 941.8 943.0 943.0 695.9 696.0 696.4 697.6 697.8 14316.9 14721.8 14757.6 14762.1 14798.6 15746.8 15913.0 15951.9 16051.4 16081.8 12435.4 12453.7 12506.7 12702.6 12703.4 2928.5 2932.2 2944.7 2949.8 2954.0 67966.0 68167.0 68562.7 68596.7 70322.0 10068.8 10548.9 12883.3 12900.5 12915.7 22295.6 22906.5 22945.2 22945.4 22980.4 6346.8 6373.5 6427.4 6429.5 6476.5 2915.9 2966.4 2967.1 2967.5 2969.8 3551.9 3555.2 3609.6 3625.1 3646.1 753.6 756.5 758.7 765.3 769.3 619.6 634.1 636.1 636.1 641.1 9657.3 9971.5 10473.4 10555.1 10774.6 616.6 617.1 620.9 623.9 637.5 4612.6 4619.4 4630.7 4645.8 4667.8 63164.4 64105.0 64567.7 64582.7 65608.7 56124.7 56659.4 57025.4 57245.4 57460.0 50405.7 50811.2 51318.5 52090.5 52804.7 9405.5 9483.2 9524.8 9595.5 9891.7 27164.6 27655.7 27740.9 27798.7 27871.0 32496.5 32608.8 33147.5 33532.3 34340.7 11992.3 12194.3 12251.9 12307.5 12315.8 13547.1 13776.1 13823.3 13967.0 14035.8 12503.5 12540.1 12631.2 12772.2 12842.9 12506.9 13980.7 14513.8 14808.9 14995.0 14023.5 14024.7 14253.7 14297.6 14635.0 10836.9 10965.7 11492.0 11616.5 11670.9 11457.0 12620.5 12750.7 12842.0 12856.8 06:01:07 INFO - PID 26183 | -------- Summary: end -------- 06:01:07 INFO - PID 26183 | 06:01:08 INFO - TEST-INFO | 26183: exit 0 06:01:08 INFO - TEST-OK | dromaeo_css | took 1119033ms 06:01:08 INFO - TEST-START | kraken 06:01:08 INFO - operating with platform_type : linux_ 06:01:08 INFO - Initialising browser for kraken test... 06:01:08 INFO - TEST-INFO | started process 26616 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN0GFGf/profile http://localhost:39254/getInfo.html) 06:01:12 INFO - PID 26616 | __metrics Screen width/height:1600/1200 06:01:12 INFO - PID 26616 | colorDepth:24 06:01:12 INFO - PID 26616 | Browser inner width/height: 1024/695 06:01:12 INFO - PID 26616 | __metrics 06:01:14 INFO - TEST-INFO | 26616: exit 0 06:01:14 INFO - Browser initialized. 06:01:14 INFO - Running cycle 1/1 for kraken test... 06:01:14 INFO - TEST-INFO | started process 26808 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN0GFGf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:01:25 INFO - PID 26808 | RSS: Main: 169185280 06:01:25 INFO - PID 26808 | 06:01:28 INFO - PID 26808 | Cycle 1(1): loaded http://localhost:39254/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39254/tests/kraken/driver.html?testName=audio-beat-detection) 06:01:29 INFO - PID 26808 | RSS: Main: 178487296 06:01:29 INFO - PID 26808 | 06:01:32 INFO - PID 26808 | Cycle 1(1): loaded http://localhost:39254/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39254/tests/kraken/driver.html?testName=audio-dft) 06:01:32 INFO - PID 26808 | RSS: Main: 177844224 06:01:32 INFO - PID 26808 | 06:01:35 INFO - PID 26808 | Cycle 1(1): loaded http://localhost:39254/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39254/tests/kraken/driver.html?testName=audio-fft) 06:01:36 INFO - PID 26808 | RSS: Main: 173617152 06:01:36 INFO - PID 26808 | 06:01:38 INFO - PID 26808 | Cycle 1(1): loaded http://localhost:39254/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39254/tests/kraken/driver.html?testName=audio-oscillator) 06:01:39 INFO - PID 26808 | RSS: Main: 174669824 06:01:39 INFO - PID 26808 | 06:01:41 INFO - PID 26808 | Cycle 1(1): loaded http://localhost:39254/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39254/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:01:41 INFO - PID 26808 | RSS: Main: 174792704 06:01:41 INFO - PID 26808 | 06:01:45 INFO - PID 26808 | Cycle 1(1): loaded http://localhost:39254/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39254/tests/kraken/driver.html?testName=imaging-darkroom) 06:01:45 INFO - PID 26808 | RSS: Main: 178888704 06:01:45 INFO - PID 26808 | 06:01:49 INFO - PID 26808 | Cycle 1(1): loaded http://localhost:39254/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39254/tests/kraken/driver.html?testName=imaging-desaturate) 06:01:49 INFO - PID 26808 | RSS: Main: 177754112 06:01:49 INFO - PID 26808 | 06:01:52 INFO - PID 26808 | Cycle 1(1): loaded http://localhost:39254/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39254/tests/kraken/driver.html?testName=json-parse-financial) 06:01:53 INFO - PID 26808 | RSS: Main: 179023872 06:01:53 INFO - PID 26808 | 06:01:55 INFO - PID 26808 | Cycle 1(1): loaded http://localhost:39254/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39254/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:01:55 INFO - PID 26808 | RSS: Main: 179781632 06:01:55 INFO - PID 26808 | 06:01:57 INFO - PID 26808 | Cycle 1(1): loaded http://localhost:39254/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39254/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:01:58 INFO - PID 26808 | RSS: Main: 180731904 06:01:58 INFO - PID 26808 | 06:02:00 INFO - PID 26808 | Cycle 1(1): loaded http://localhost:39254/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39254/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:02:00 INFO - PID 26808 | RSS: Main: 180363264 06:02:00 INFO - PID 26808 | 06:02:03 INFO - PID 26808 | Cycle 1(1): loaded http://localhost:39254/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39254/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:02:04 INFO - PID 26808 | RSS: Main: 180330496 06:02:04 INFO - PID 26808 | 06:02:07 INFO - PID 26808 | Cycle 1(1): loaded http://localhost:39254/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39254/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:02:08 INFO - PID 26808 | RSS: Main: 180461568 06:02:08 INFO - PID 26808 | 06:02:10 INFO - PID 26808 | Cycle 1(1): loaded http://localhost:39254/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39254/tests/kraken/driver.html?testName=ai-astar) 06:02:10 INFO - PID 26808 | RSS: Main: 182452224 06:02:10 INFO - PID 26808 | 06:02:10 INFO - PID 26808 | __start_tp_report 06:02:10 INFO - PID 26808 | _x_x_mozilla_page_load 06:02:10 INFO - PID 26808 | _x_x_mozilla_page_load_details 06:02:10 INFO - PID 26808 | |i|pagename|runs| 06:02:10 INFO - PID 26808 | |0;ai-astar;103;113;113;111;114;112;110;111;110;111 06:02:10 INFO - PID 26808 | |1;audio-beat-detection;149;123;123;165;123;129;123;123;143;121 06:02:10 INFO - PID 26808 | |2;audio-dft;164;164;164;162;166;167;167;163;164;161 06:02:10 INFO - PID 26808 | |3;audio-fft;74;76;78;113;75;76;77;77;91;75 06:02:10 INFO - PID 26808 | |4;audio-oscillator;83;83;108;84;83;83;97;83;82;106 06:02:10 INFO - PID 26808 | |5;imaging-gaussian-blur;115;114;113;115;114;113;114;115;114;114 06:02:10 INFO - PID 26808 | |6;imaging-darkroom;150;151;149;153;150;153;150;150;152;150 06:02:10 INFO - PID 26808 | |7;imaging-desaturate;95;95;94;94;94;94;95;95;95;94 06:02:10 INFO - PID 26808 | |8;json-parse-financial;60;53;55;61;59;55;56;55;55;55 06:02:10 INFO - PID 26808 | |9;json-stringify-tinderbox;55;57;57;56;56;56;55;56;56;56 06:02:10 INFO - PID 26808 | |10;stanford-crypto-aes;91;81;82;85;88;81;83;82;80;81 06:02:10 INFO - PID 26808 | |11;stanford-crypto-ccm;131;131;138;137;134;133;138;135;182;130 06:02:10 INFO - PID 26808 | |12;stanford-crypto-pbkdf2;186;199;205;190;193;192;191;190;193;204 06:02:10 INFO - PID 26808 | |13;stanford-crypto-sha256-iterative;76;77;73;77;73;73;73;73;75;72 06:02:10 INFO - PID 26808 | __end_tp_report 06:02:10 INFO - PID 26808 | __start_cc_report 06:02:10 INFO - PID 26808 | _x_x_mozilla_cycle_collect,836 06:02:10 INFO - PID 26808 | __end_cc_report 06:02:10 INFO - PID 26808 | __startTimestamp1494421330396__endTimestamp 06:02:10 INFO - PID 26808 | 06:02:10 INFO - PID 26808 | ------- Summary: start ------- 06:02:10 INFO - PID 26808 | Number of tests: 14 06:02:10 INFO - PID 26808 | 06:02:10 INFO - PID 26808 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:3.05 (2.7%) stddev-sans-first:1.41 06:02:10 INFO - PID 26808 | Values: 103.0 113.0 113.0 111.0 114.0 112.0 110.0 111.0 110.0 111.0 06:02:10 INFO - PID 26808 | 06:02:10 INFO - PID 26808 | [#1] audio-beat-detection Cycles:10 Average:132.20 Median:126.00 stddev:15.03 (11.9%) stddev-sans-first:14.66 06:02:10 INFO - PID 26808 | Values: 149.0 123.0 123.0 165.0 123.0 129.0 123.0 123.0 143.0 121.0 06:02:10 INFO - PID 26808 | 06:02:10 INFO - PID 26808 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:1.99 (1.2%) stddev-sans-first:2.11 06:02:10 INFO - PID 26808 | Values: 164.0 164.0 164.0 162.0 166.0 167.0 167.0 163.0 164.0 161.0 06:02:10 INFO - PID 26808 | 06:02:10 INFO - PID 26808 | [#3] audio-fft Cycles:10 Average:81.20 Median:76.50 stddev:12.18 (15.9%) stddev-sans-first:12.64 06:02:10 INFO - PID 26808 | Values: 74.0 76.0 78.0 113.0 75.0 76.0 77.0 77.0 91.0 75.0 06:02:10 INFO - PID 26808 | 06:02:10 INFO - PID 26808 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:83.00 stddev:10.37 (12.5%) stddev-sans-first:10.75 06:02:10 INFO - PID 26808 | Values: 83.0 83.0 108.0 84.0 83.0 83.0 97.0 83.0 82.0 106.0 06:02:10 INFO - PID 26808 | 06:02:10 INFO - PID 26808 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 06:02:10 INFO - PID 26808 | Values: 115.0 114.0 113.0 115.0 114.0 113.0 114.0 115.0 114.0 114.0 06:02:10 INFO - PID 26808 | 06:02:10 INFO - PID 26808 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:150.50 stddev:1.40 (0.9%) stddev-sans-first:1.45 06:02:10 INFO - PID 26808 | Values: 150.0 151.0 149.0 153.0 150.0 153.0 150.0 150.0 152.0 150.0 06:02:10 INFO - PID 26808 | 06:02:10 INFO - PID 26808 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 06:02:10 INFO - PID 26808 | Values: 95.0 95.0 94.0 94.0 94.0 94.0 95.0 95.0 95.0 94.0 06:02:10 INFO - PID 26808 | 06:02:10 INFO - PID 26808 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:55.50 stddev:2.63 (4.7%) stddev-sans-first:2.45 06:02:10 INFO - PID 26808 | Values: 60.0 53.0 55.0 61.0 59.0 55.0 56.0 55.0 55.0 55.0 06:02:10 INFO - PID 26808 | 06:02:10 INFO - PID 26808 | [#9] json-stringify-tinderbox Cycles:10 Average:56.00 Median:56.00 stddev:0.67 (1.2%) stddev-sans-first:0.60 06:02:10 INFO - PID 26808 | Values: 55.0 57.0 57.0 56.0 56.0 56.0 55.0 56.0 56.0 56.0 06:02:10 INFO - PID 26808 | 06:02:10 INFO - PID 26808 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:82.50 stddev:3.57 (4.3%) stddev-sans-first:2.51 06:02:10 INFO - PID 26808 | Values: 91.0 81.0 82.0 85.0 88.0 81.0 83.0 82.0 80.0 81.0 06:02:10 INFO - PID 26808 | 06:02:10 INFO - PID 26808 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:136.00 stddev:15.42 (11.3%) stddev-sans-first:16.09 06:02:10 INFO - PID 26808 | Values: 131.0 131.0 138.0 137.0 134.0 133.0 138.0 135.0 182.0 130.0 06:02:10 INFO - PID 26808 | 06:02:10 INFO - PID 26808 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.30 Median:193.00 stddev:6.29 (3.3%) stddev-sans-first:5.91 06:02:10 INFO - PID 26808 | Values: 186.0 199.0 205.0 190.0 193.0 192.0 191.0 190.0 193.0 204.0 06:02:10 INFO - PID 26808 | 06:02:10 INFO - PID 26808 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.20 Median:74.00 stddev:1.87 (2.5%) stddev-sans-first:1.87 06:02:10 INFO - PID 26808 | Values: 76.0 77.0 73.0 77.0 73.0 73.0 73.0 73.0 75.0 72.0 06:02:10 INFO - PID 26808 | -------- Summary: end -------- 06:02:10 INFO - PID 26808 | 06:02:11 INFO - TEST-INFO | 26808: exit 0 06:02:11 INFO - TEST-OK | kraken | took 63347ms 06:02:11 INFO - SUITE-END | took 1182s 06:02:12 INFO - Completed test suite (00:19:42) 06:02:12 INFO - javascript benchmark 06:02:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6766.088092264212, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2762.28180673025, 2775.6252905857705, 2800.747932686058, 2811.845348505832, 2817.7604903583197, 5196.246544251091, 5296.655717378372, 5328.706921119337, 5353.491418315254, 5373.1134362830135, 5271.736413179345, 5285.365756109272, 5301.7084060376665, 5393.460653934604, 5396.865078373043, 4703.176944034797, 4710.670253082286, 4724.4566874809325, 4739.573438390544, 4773.403324584427, 4767.261074533453, 4768.380110585619, 4798.016406636649, 4810.158222311082, 4816.518348165173, 4636.072785442925, 4642.605378542828, 4710.8351207707565, 4727.7163370197895, 4743.857684269477, 4727.338172655831, 4735.550122738368, 4743.976280118612, 4761.47623761386, 4787.16224660683, 4679.15775160471, 4711.646626502992, 4721.055788842245, 4721.551452611996, 4732.982408782128, 5051.595872330205, 5134.974325128388, 5141.997310524449, 5146.433892271884, 5193.506616871391, 5676.347220069703, 5688.516476099495, 5827.067669172954, 5828.766849326022, 5829.154772557956, 5807.622504537234, 5811.418858114154, 5823.155642431823, 5824.126381042835, 5878.794242201545, 5386.973065134649, 5398.163284690879, 5407.621466497308, 5411.134218525017, 5417.26866872975, 5670.7731690732735, 5825.563082768809, 5850.976079186125, 5935.347111817697, 5935.851603709942, 5595.524380427709, 5634.352049514358, 5650.7739690412745, 5690.7439165237665, 5693.0, 5710.057840456361, 5718.199452076713, 5721.998650236192, 5732.369439361667, 5738.225339579187, 5590.944090559124, 5615.494605485526, 5681.403452637496, 5689.516391106719, 5701.828945131652, 5573.3869274380595, 5627.465390787868, 5656.575756818255, 5667.404922483162, 5700.116481945305, 4769.475357710649, 4777.8327758528285, 4784.210605250164, 4799.6400269979895, 4827.155247831615, 4039.0, 4050.9392359114636, 4088.34586466164, 4110.219058378899, 4133.627973482341, 4868.172410690191, 4914.0908931847725, 4935.703857768545, 4939.629527785431, 4967.329410529533, 5763.740631671585, 5796.971015144897, 5797.971010145006, 5812.099124635688, 5816.912746308809, 4880.389951256093, 4933.950660493421, 4938.111139994764, 4942.703437793743, 4979.253112033224, 5010.0, 5012.097822392005, 5081.187010078444, 5085.160948443466, 5096.719680417613, 5324.281222034976, 5325.227841962971, 5325.281087053353, 5325.893482130258, 5328.413874473727, 5672.5745569081655, 5720.914186287292, 5736.569757268138, 5742.684152371659, 5743.167240750151, 5289.7355132244, 5293.523582877559, 5298.81454149103, 5300.920486192633, 5338.172583249602, 5576.553875690016, 5582.944170558405, 5606.0, 5642.407547207484, 5647.943520564741, 5648.435156484483, 5760.107183386582, 5760.481556659921, 5763.625364351304, 5786.594938354443, 5509.3664228612615, 5547.861303467445, 5553.222548843084, 5556.111022236423, 5559.305086864142, 5481.862953426196, 5483.835484935458, 5488.4237155098135, 5488.780448782164, 5496.0, 5418.45815418455, 5443.618946673695, 5465.207544906046, 5470.699111548903, 5472.069748142746, 5456.154296084113, 5552.639078459887, 5592.664440133605, 5599.132134519156, 5602.159676048625, 5456.399796022355, 5460.6996615186545, 5465.699386533779, 5520.337559492887, 5526.392096869422], "value": 5186.691509063217, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.2319947261441, 678.9083473731047, 1053.6680945502167, 1075.6181555547785, 1150.045462266319, 30099.849500752494, 32882.177945551346, 32937.67062329379, 32960.67039329606, 33068.66931330686, 30455.0, 30847.537286940715, 30956.0, 30979.38041239174, 31028.379432411395, 6255.90616140756, 6341.556091073615, 6397.488200943913, 6412.230532336126, 6424.71088801005, 6976.162860456752, 7035.577865328071, 7064.717411303542, 7071.292870712913, 7075.540089894166, 7031.226565077837, 7032.753853615124, 7070.116235470567, 7070.681819318117, 7118.323759242864, 6993.440524758058, 7019.754308599226, 7030.472714546404, 7092.397146242602, 7099.751508697171, 6884.827879303008, 6886.621235832027, 6917.412019978308, 6921.688524016431, 6932.306769323028, 31301.06096817099, 31760.04719858385, 31774.0, 31791.0, 31842.522362164586, 3077.123019939329, 3098.4577698902826, 3103.674114217997, 3122.9219269518217, 3129.1394866411692, 24300.0, 24341.0, 24434.389140271458, 24467.0, 24512.264632061066, 3152.133163380066, 3194.4250034993693, 3220.6618305077864, 3222.9033129006166, 3242.1408326793417, 140717.0, 141724.0, 141946.0, 141971.0, 142536.2873185638, 37955.0, 40210.79894600508, 41487.792561037, 41655.375169372484, 41940.0, 40817.79591102026, 40849.38725919054, 41370.586294137276, 41374.37938430926, 41444.37833432501, 12561.309127997865, 12719.300438475788, 12720.109592328448, 12743.0, 12743.745125097632, 9934.751631209278, 10019.949900250453, 10034.899651003543, 10077.496125193711, 10077.798444031077, 12611.180273282207, 12632.178908370926, 12715.109942304134, 12725.809112863315, 12842.935785321013, 5230.660007099526, 5280.973595132, 5319.414864364917, 5337.492938170868, 5346.893062138735, 894.1371576428647, 926.8007378413539, 929.4702019848621, 950.273041123541, 967.583938906277, 20606.0, 21275.0, 21318.147274108862, 21362.359129226148, 21560.56878862414, 1012.2762225009154, 1013.7465633591602, 1014.1582486536157, 1028.840529717895, 1040.1782591752583, 11003.26859450428, 11190.440477976068, 11310.773784524263, 11349.503109315938, 11491.655250342503, 166197.0, 166318.1684091596, 166550.0, 167099.0, 167667.0, 40008.39798448351, 40024.1995160101, 40342.79828600838, 40381.394279085835, 40457.59542404597, 1215.604928398274, 1261.0668105601972, 1261.8107283907304, 1267.1066897837002, 1277.271954985668, 19551.413457596296, 19694.50763730861, 19927.900360498104, 20852.582948340645, 20935.8953205233, 29571.704282957755, 29577.26056848596, 29605.703942960296, 29661.406771864873, 29720.554191686708, 148655.0, 148760.0, 149124.0, 149168.0, 149210.0, 28231.43537129287, 28332.0, 29539.704602953694, 30727.385452290382, 30984.0, 36439.45340819943, 36712.449313259785, 36970.63029369672, 37029.62970370369, 37040.62959370372, 26657.0, 27647.30881727973, 27914.86042569774, 27957.301067473476, 28677.13968580946, 27316.31709207286, 27371.452570948866, 28252.0, 28689.713102868704, 29029.12912612625, 30801.0, 30807.0, 30889.0, 30893.227669308446, 30994.84502577563, 26826.731732682423, 27039.72960270451, 27772.72227277782, 28020.859895700392, 29028.12915612535, 20118.0, 22799.544009119392, 22829.20097796569, 22834.657480137477, 22863.542729145658], "value": 14487.352535077145, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.7096917642238, 423.8791944295875, 427.57669906792285, 429.5125033087445, 444.34015487001795, 13911.79132313016, 16160.27278772455, 16878.662426751456, 16952.23714932828, 17308.30766769331, 17927.731084033716, 17941.372051978182, 18148.546286342847, 18255.54361140972, 18403.63192736148, 5393.59548033897, 5414.8917021659645, 5492.80775172869, 5547.3343198816, 5583.0, 5354.598405119632, 5449.264349312852, 5473.972630136844, 5475.479829416199, 5479.0, 5257.631965762398, 5433.293671822657, 5454.045542030149, 5468.808591699291, 5486.890262194754, 5445.754941027643, 5471.781128754845, 5492.972535137339, 5494.230807686887, 5507.421720719327, 4898.412190537123, 4901.068796928608, 4935.481774413671, 4939.678920870132, 4955.157623204064, 21584.676229856566, 21739.456513587127, 21767.020484078254, 21816.781832181634, 22115.115395384164, 1676.8490835824712, 1693.618935739461, 1696.5843368374703, 1699.2438364927611, 1700.7533907583331, 14995.475158369514, 15353.385864565404, 15374.154421506813, 15539.844601553952, 15627.374905003786, 1875.7467741854812, 1915.4062240705425, 1936.9612607747906, 1953.677643188872, 1962.519182800223, 89797.55101224517, 90845.09154908432, 91251.54374228153, 92134.5393273036, 92923.53538232333, 10958.0, 11141.660251347146, 11152.442377881074, 11401.0, 11463.88536114645, 15509.0, 15661.216939152997, 15797.447089351817, 15798.92100539513, 15848.68302633941, 7800.960995194988, 7955.363570914313, 8072.273495385443, 8082.19178082187, 8117.310028647513, 7138.0, 7173.6771845267085, 7213.675384607705, 7420.369268612229, 7449.664765085584, 7079.681414336367, 7121.537100088478, 7201.207867134611, 7222.244156664594, 7273.309035641606, 2085.4994801247894, 2095.6123117223365, 2113.8943052847294, 2123.9575208496053, 2197.143114185469, 878.8066625342415, 907.1880666803174, 913.0823522360118, 917.1745429113718, 939.8919124300656, 16856.74714879278, 19462.22151113968, 21262.362129136152, 21548.13807447716, 21672.13311467555, 900.4327273817453, 920.5443305563655, 923.958421871004, 930.2372054914905, 940.9529523523796, 9306.627734890664, 9746.805063898682, 9909.108180263811, 9915.256355773347, 9965.0, 353007.0, 353366.0, 362603.0, 370149.0, 370980.0, 72832.27167728361, 74212.62893685498, 74646.6267668669, 74668.62665686745, 75261.24738752542, 1057.8095942730383, 1114.164376717462, 1136.5283407386007, 1138.2942575603179, 1138.3397629374942, 17407.95552266868, 17417.0, 18072.63854722872, 18231.817681823013, 18241.179146938684, 39302.6069739299, 40412.79793601013, 40759.1848163041, 41446.79276603598, 42167.36748948829, 46931.296030560254, 48973.0, 49213.753931230116, 49254.75372623114, 51428.74285628548, 8179.182081791773, 8365.205305495969, 8434.662613495637, 8448.197421244971, 8510.106438823834, 12412.441440135397, 12982.0, 13137.277449740355, 13168.209907405586, 13363.331833408096, 11225.101991840469, 11312.83030754523, 11547.422628868355, 11800.2329848563, 11873.346965916611, 10719.464026798785, 10895.673129806119, 11237.0, 11249.381284029458, 11304.208705390873, 10731.517081731497, 10768.676939691823, 10793.514291856729, 10971.890281097087, 11094.334339939307, 8471.364647651573, 8744.69393571222, 8851.822963540564, 8914.86627700572, 9053.977357588814, 11257.0, 11567.248128871597, 11579.363135027317, 11695.473703683525, 12058.15592908488], "value": 9018.072338712604, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1306.7778477658799, 1354.3702178487008, 1365.706373129777, 1368.59626410209, 1369.4453746232775, 9873.950630246847, 10280.074793268604, 10291.588336466542, 10353.0, 10601.84097238542, 10363.481825908711, 10427.32222405545, 10482.790344193112, 10527.789444211112, 10529.420881851494, 2216.612092883743, 2245.4835387860803, 2247.202243203664, 2247.3819699582664, 2256.808171305441, 2171.5776166610895, 2198.2633719361766, 2205.184081889703, 2220.0897631970897, 2220.245116660335, 2206.6359050756605, 2215.2246713650256, 2229.643257078868, 2237.2169740590743, 2244.2145249162745, 2190.87950162741, 2206.1065268566176, 2240.2943072931976, 2243.8204943604474, 2253.5380247049316, 2095.224766836265, 2188.737351517828, 2237.44063984004, 2248.8650680959195, 2257.3340864444863, 10125.797484050352, 10187.0, 10194.59221631134, 10202.285839991204, 10215.438150901697, 5495.175723641446, 5634.267545219136, 5679.119736440858, 5690.573207009449, 5717.285339332583, 3297.96702032979, 3437.1407148212948, 3522.6125126236093, 3539.239063601338, 3620.25784714133, 1093.9507722152443, 1100.4717735486931, 1106.6016234155697, 1153.555880985818, 1156.0693641618493, 14996.775048374284, 15076.0, 15130.39478420873, 15189.088654680754, 15221.086734795948, 4780.450248221429, 4974.651774375831, 5000.499950004971, 5009.073321435546, 5075.187969924795, 10942.234043617029, 10947.233693641369, 10953.3427994319, 10957.780844383227, 10987.175961802897, 5688.0, 5712.942870571324, 5752.395998420189, 5753.827385178452, 5758.971205143947, 5146.150885103991, 5267.604929630293, 5318.574514038867, 5355.0, 5382.219578161144, 3810.2569998850513, 3957.6635985940943, 3960.386140148282, 4016.176683779818, 4036.798160091984, 1122.887711228887, 1128.8250321200228, 1141.303804679145, 1143.845580846575, 1150.5340337163461, 678.9762358317436, 711.2993701204309, 715.4562532475356, 718.2207305073949, 730.050933786076, 5216.66091704038, 5310.654807437581, 5355.973220133875, 5390.838274851761, 5441.755121019484, 545.3537557993711, 550.1884720037992, 552.1882832236606, 553.3442870198827, 554.692145859044, 3146.9625553177084, 3163.8892638757534, 3223.5325877747596, 3228.935421291561, 3303.075138961047, 12917.418716157796, 12950.093493455368, 13316.6670833228, 13499.527516536875, 13515.864841351657, 13020.348982550835, 13328.400221990034, 13447.327633618475, 13498.325083745773, 13527.053106282467, 7724.497907635986, 7794.805129871798, 7899.328557072713, 7938.801529961797, 7945.761627151194, 5399.649022813504, 5475.4250803665045, 5504.972475137599, 5582.0231459495235, 5663.915041274467, 11931.76136477283, 12057.819132713192, 12060.15578909503, 12351.19717218378, 12438.751224975631, 11925.76148477043, 12241.143119981516, 12325.075619328765, 12415.130940834417, 12415.44130514147, 7803.96098019529, 7920.168382319774, 7968.601569921365, 7996.520208787491, 8007.959960200162, 9432.905670943202, 9634.373765705206, 9692.224622030362, 9783.706488805346, 9792.657256995972, 8393.580320983805, 8461.280791132576, 8494.1081186477, 8546.871796922927, 8706.695265665672, 7924.20757924203, 7970.681172753025, 8097.473664211808, 8155.143709910374, 8312.293455056388, 7291.234420385783, 7452.664630091767, 7473.476856620202, 7482.663280152297, 7494.925050749423, 4815.6147508198555, 4860.562549370574, 4922.1140194765285, 5153.613478989166, 5158.871028224325, 5193.506616871391, 5219.243209734491, 5336.17289320156, 5349.491798279158, 5370.275012873212], "value": 4702.424875624619, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.92458432897746, 399.494639281309, 403.8465383154401, 409.62723921231685, 416.6520955002575, 5552.305961754781, 5589.972050139743, 5592.259792701572, 5603.159526071091, 5606.299212598426, 5289.153735402337, 5357.4374690657505, 5445.646033007862, 5448.782048718046, 5494.423085576017, 4267.253230684633, 4271.273883439822, 4280.914381712364, 4283.571642835707, 4290.42079319291, 4276.562359455112, 4282.207791558571, 4287.6569874410125, 4304.31131019037, 4315.4389929309145, 4179.6447301979215, 4247.171801498709, 4260.531341552427, 4262.97868510657, 4287.378330142127, 4246.023414614656, 4247.808848601805, 4253.043065310311, 4253.893652658678, 4271.188474189894, 3864.2271545690974, 3869.7097717671286, 3875.65119139276, 3879.262940041383, 3881.611838816124, 5157.53582177602, 5277.730575852382, 5318.840434786963, 5329.600279979017, 5338.62629615927, 5053.166227572447, 5059.139946209153, 5064.139096353629, 5092.210707340369, 5104.489551044903, 5832.562557808139, 5854.18041474194, 5855.033919403293, 5855.736491857877, 5873.500752436048, 4223.429836972, 4321.7775132669, 4327.459067616548, 4331.675124365685, 4352.0, 5934.0, 6003.459688628044, 6072.544559158081, 6080.817575472743, 6100.267967843798, 4043.353063509883, 4065.654419374386, 4083.3262511685834, 4088.2232375848494, 4115.238680844053, 4159.91680166395, 4163.417121602978, 4165.229432554987, 4173.227952828736, 4180.289350810309, 4725.432948046257, 4785.712857228577, 4791.904161916812, 4816.4220293564995, 4827.637927155477, 5798.710064496759, 5799.478046975708, 5802.303723553201, 5827.863566604557, 5831.650100993869, 1428.0, 1437.856214378554, 1439.9712005759827, 1442.1995792335144, 1447.3414596358632, 915.9725208243764, 959.7408699651055, 964.4165280005636, 973.9513024348754, 978.4031740638205, 5026.788213186186, 5046.041252162077, 5051.0, 5057.620678449131, 5062.670926389773, 5984.132300816357, 5987.970060149672, 6015.2781666200335, 6020.638761674313, 6028.156058151862, 4867.1969125093965, 5023.547880690755, 5045.84862454127, 5081.385069498225, 5098.2097774844215, 3150.8582113804932, 3153.952690709641, 3172.0959526534825, 3189.728873045771, 3194.552762613236, 5419.566434685215, 5561.916571251434, 5566.165075238666, 5566.276384070045, 5579.2746942897975, 6127.264728232641, 6157.599756015845, 6159.84600384994, 6160.661163635953, 6193.256809182927, 5565.632792160765, 5569.637973531708, 5576.442355764391, 5581.855719577396, 5586.245856809279, 5845.532357411312, 5986.700664966647, 6009.639421634716, 6016.7292471838, 6035.78874739382, 5942.970285148546, 5945.791897283574, 5961.0, 5969.194158788508, 5979.671118088547, 5397.514223719884, 5542.501174894118, 5579.828236070471, 5582.525485333792, 5604.663720176803, 4073.816678249427, 4094.242565125461, 4124.835006599702, 4125.938110928279, 4127.484064491939, 5886.146508756292, 6052.939470605237, 6055.636661800306, 6057.697115144137, 6062.666553339609, 5790.176094530209, 5823.9516886960755, 5827.251824452732, 5842.211301474246, 5847.795327163529, 5805.593608447368, 5825.155352473952, 5840.620359676607, 5842.766289348378, 5849.678267695147, 5534.944650553604, 5691.8861622768145, 5739.282589676291, 5744.339400968942, 5755.194272801895, 5877.0, 5885.911711324248, 5893.292804863272, 5898.439648233411, 5913.172155898092, 5504.0643090675485, 5694.974904517227, 5717.742701578522, 5763.135529670583, 5763.423657634371], "value": 4378.9096091490555, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.6551303643811, 768.4352001279059, 769.3114662377176, 781.7537475695156, 790.3440144679914, 12941.094123411365, 13296.401661925225, 13311.467541298349, 15711.842881571181, 15837.366505339773, 15533.689326213469, 15688.980216285934, 15761.60595985101, 15821.208939553035, 16352.672946541063, 876.0669886570813, 888.1074520107284, 891.7012800711769, 892.6830975003877, 893.7676204186926, 902.2285945516587, 902.6118768929358, 905.597009330848, 905.714699869539, 906.207068814787, 945.8250223708601, 947.393668052447, 948.2840455456121, 951.2247518272586, 951.509972364233, 934.3459578295186, 937.7702462896566, 941.8398872191743, 942.9669961551347, 943.0286804591248, 695.9095317608678, 695.9860802783967, 696.3976160621077, 697.6023666510091, 697.8255436140964, 14316.856831431656, 14721.779173312409, 14757.631059223499, 14762.114273143538, 14798.630034249123, 15746.842531574766, 15913.0, 15951.92024039884, 16051.438199662956, 16081.839181608268, 12435.3782310885, 12453.688657783538, 12506.74986500274, 12702.618921432279, 12703.364831758376, 2928.5167947288674, 2932.208303757973, 2944.661363943131, 2949.8348152479653, 2954.039937020477, 67966.0, 68167.0, 68562.65718671425, 68596.6570167146, 70322.0, 10068.848967265498, 10548.894511054792, 12883.29141897186, 12900.483980640669, 12915.677108072185, 22295.554088918456, 22906.541869162524, 22945.196918107787, 22945.426364341027, 22980.425489362566, 6346.777862774781, 6373.52198585108, 6427.421532062043, 6429.54993150475, 6476.481881449473, 2915.9125226243245, 2966.4363770883465, 2967.0802051364144, 2967.451021561018, 2969.8218106913223, 3551.9289614207573, 3555.2178520725397, 3609.639036096369, 3625.148090198801, 3646.1431563582537, 753.5968256982488, 756.5347311403557, 758.6548120605112, 765.3303359560384, 769.2960940739162, 619.5910698938679, 634.1185751804994, 636.1126228910643, 636.1412093673504, 641.0960545630732, 9657.32398732096, 9971.451570163566, 10473.423961682181, 10555.10281626055, 10774.622888198875, 616.6300219868133, 617.0971630396546, 620.8975519039399, 623.8845813524513, 637.5314144104173, 4612.630989520897, 4619.445666520039, 4630.652701047435, 4645.767711614473, 4667.789949452283, 63164.368356316765, 64105.03842442367, 64567.677161613894, 64582.67708661521, 65608.67195663991, 56124.71937640367, 56659.43340566624, 57025.429745702844, 57245.427545724844, 57460.0, 50405.74797125991, 50811.23783143256, 51318.48681513212, 52090.47909520856, 52804.73597631987, 9405.529723513933, 9483.241340692866, 9524.761880953032, 9595.520223988633, 9891.703248902544, 27164.592531112445, 27655.723442765317, 27740.861295694198, 27798.722012779614, 27871.0, 32496.512552311262, 32608.83695581507, 33147.50278745869, 33532.32935341328, 34340.656593434745, 11992.340421276913, 12194.268343899394, 12251.938740306241, 12307.507699691912, 12315.815262770886, 13547.119437236548, 13776.10455320401, 13823.308834558433, 13967.0, 14035.789463158266, 12503.499860005499, 12540.122191446511, 12631.178973366701, 12772.233665980071, 12842.87157128454, 12506.874931250935, 13980.650483737987, 14513.782293265398, 14808.851911480748, 14995.0, 14023.509177179158, 14024.719505610035, 14253.714925701635, 14297.64255893611, 14635.0, 10836.945815270874, 10965.725856853642, 11492.0, 11616.477258523219, 11670.88329116698, 11457.0, 12620.495180192689, 12750.68123296925, 12842.0, 12856.807147892601], "value": 6875.644974186228, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 113.0, 111.0, 114.0, 112.0, 110.0, 111.0, 110.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 123.0, 165.0, 123.0, 129.0, 123.0, 123.0, 143.0, 121.0], "value": 132.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 164.0, 162.0, 166.0, 167.0, 167.0, 163.0, 164.0, 161.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 78.0, 113.0, 75.0, 76.0, 77.0, 77.0, 91.0, 75.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 108.0, 84.0, 83.0, 83.0, 97.0, 83.0, 82.0, 106.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 113.0, 115.0, 114.0, 113.0, 114.0, 115.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 149.0, 153.0, 150.0, 153.0, 150.0, 150.0, 152.0, 150.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 53.0, 55.0, 61.0, 59.0, 55.0, 56.0, 55.0, 55.0, 55.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 57.0, 56.0, 56.0, 56.0, 55.0, 56.0, 56.0, 56.0], "value": 56.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 81.0, 82.0, 85.0, 88.0, 81.0, 83.0, 82.0, 80.0, 81.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 131.0, 138.0, 137.0, 134.0, 133.0, 138.0, 135.0, 182.0, 130.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 199.0, 205.0, 190.0, 193.0, 192.0, 191.0, 190.0, 193.0, 204.0], "value": 194.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 73.0, 77.0, 73.0, 73.0, 73.0, 73.0, 75.0, 72.0], "value": 74.2, "unit": "score"}]}]} 06:02:12 INFO - Return code: 0 06:02:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:02:12 INFO - # TBPL SUCCESS # 06:02:12 INFO - Running post-action listener: _resource_record_post_action 06:02:12 INFO - [mozharness: 2017-05-10 13:02:12.179829Z] Finished run-tests step (success) 06:02:12 INFO - Running post-run listener: _resource_record_post_run 06:02:12 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 374165504; Read time: 8; Write time: 258956 06:02:12 INFO - TinderboxPrint: CPU usage
13.3% 06:02:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 06:02:12 INFO - TinderboxPrint: I/O write bytes / time
374,165,504 / 258,956 06:02:12 INFO - TinderboxPrint: CPU idle
8,293.6 (86.7%) 06:02:12 INFO - TinderboxPrint: CPU user
1,220.8 (12.8%) 06:02:12 INFO - TinderboxPrint: Swap in / out
0 / 0 06:02:12 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 108044288; Read time: 0; Write time: 101652 06:02:12 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 266121216; Read time: 0; Write time: 157304 06:02:12 INFO - Running post-run listener: _upload_blobber_files 06:02:12 INFO - Blob upload gear active. 06:02:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:02:12 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 06:02:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:02:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:02:13 INFO - (blobuploader) - INFO - Open directory for files ... 06:02:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:02:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:02:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:02:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:02:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:02:13 INFO - (blobuploader) - INFO - Done attempting. 06:02:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:02:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:02:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:02:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:02:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:02:17 INFO - (blobuploader) - INFO - Done attempting. 06:02:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:02:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:02:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:02:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:02:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:02:18 INFO - (blobuploader) - INFO - Done attempting. 06:02:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:02:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:02:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:02:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:02:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:02:19 INFO - (blobuploader) - INFO - Done attempting. 06:02:19 INFO - (blobuploader) - INFO - Iteration through files over. 06:02:19 INFO - Return code: 0 06:02:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:02:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:02:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9fb1b263ce7abbbcf1725012849a0f122893833eb6420a816a0d817a26ad7d7ee2ceab2714111899dd15a40df0dcc80fcbd29d7f060a61ed8302702ecce408d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7e2581529630e0e269e8a3d9c0db0768f05117147fb24bfc39047a6fb48af129cec24deb8d5e3e0f8f4d20705af701c5f953ad3a440d9cb8799072d8a30cb8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e52c4ae50f211bc090b13d72c1d6a6f1e32c1f1cdb5794151d91460d80a3e9cf9d16c94b63bd2571afda0ad2f6249fa476b99d9879a11c17fbdf69abaa10befc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f65d0a498210f25b60de7d5bea00ca0e9a809996e1ec7846ec2c396b7c3aa04b2d935db7917eff54fb0b1484f748e3f0f9b3be56ad70f3bc2effa9ee5f226dad"} 06:02:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:02:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:02:19 INFO - Contents: 06:02:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9fb1b263ce7abbbcf1725012849a0f122893833eb6420a816a0d817a26ad7d7ee2ceab2714111899dd15a40df0dcc80fcbd29d7f060a61ed8302702ecce408d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7e2581529630e0e269e8a3d9c0db0768f05117147fb24bfc39047a6fb48af129cec24deb8d5e3e0f8f4d20705af701c5f953ad3a440d9cb8799072d8a30cb8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e52c4ae50f211bc090b13d72c1d6a6f1e32c1f1cdb5794151d91460d80a3e9cf9d16c94b63bd2571afda0ad2f6249fa476b99d9879a11c17fbdf69abaa10befc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f65d0a498210f25b60de7d5bea00ca0e9a809996e1ec7846ec2c396b7c3aa04b2d935db7917eff54fb0b1484f748e3f0f9b3be56ad70f3bc2effa9ee5f226dad"} 06:02:19 INFO - Running post-run listener: copy_logs_to_upload_dir 06:02:19 INFO - Copying logs to upload dir... 06:02:19 INFO - mkdir: /builds/slave/test/build/upload/logs 06:02:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.431537 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-10 06:02:18.355311) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 06:02:18.363015) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9fb1b263ce7abbbcf1725012849a0f122893833eb6420a816a0d817a26ad7d7ee2ceab2714111899dd15a40df0dcc80fcbd29d7f060a61ed8302702ecce408d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7e2581529630e0e269e8a3d9c0db0768f05117147fb24bfc39047a6fb48af129cec24deb8d5e3e0f8f4d20705af701c5f953ad3a440d9cb8799072d8a30cb8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e52c4ae50f211bc090b13d72c1d6a6f1e32c1f1cdb5794151d91460d80a3e9cf9d16c94b63bd2571afda0ad2f6249fa476b99d9879a11c17fbdf69abaa10befc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f65d0a498210f25b60de7d5bea00ca0e9a809996e1ec7846ec2c396b7c3aa04b2d935db7917eff54fb0b1484f748e3f0f9b3be56ad70f3bc2effa9ee5f226dad"} build_url:https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/Pkm2Oq24SfWtyt4E5GrX9w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9fb1b263ce7abbbcf1725012849a0f122893833eb6420a816a0d817a26ad7d7ee2ceab2714111899dd15a40df0dcc80fcbd29d7f060a61ed8302702ecce408d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7e2581529630e0e269e8a3d9c0db0768f05117147fb24bfc39047a6fb48af129cec24deb8d5e3e0f8f4d20705af701c5f953ad3a440d9cb8799072d8a30cb8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e52c4ae50f211bc090b13d72c1d6a6f1e32c1f1cdb5794151d91460d80a3e9cf9d16c94b63bd2571afda0ad2f6249fa476b99d9879a11c17fbdf69abaa10befc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f65d0a498210f25b60de7d5bea00ca0e9a809996e1ec7846ec2c396b7c3aa04b2d935db7917eff54fb0b1484f748e3f0f9b3be56ad70f3bc2effa9ee5f226dad"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 06:02:18.395090) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 06:02:18.398775) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1494416426.565660-343067071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004370 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 06:02:18.473326) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 06:02:18.475793) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 06:02:18.476144) ========= ========= Total master_lag: 0.17 =========