builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-045 starttime: 1490283270.89 results: success (0) revision: 439ee2e4fc4ed4a82102608639d9751e376d5536 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 08:34:30.893070) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 08:34:30.893738) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 08:34:30.894088) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 08:34:30.910575) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 08:34:30.910902) ========= 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=4300f881736b422476174874000001bc-1490283270.328525-1073658576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-23 08:34:30-- 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% 222M=0s 2017-03-23 08:34:31 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093137 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 08:34:31.018443) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 08:34:31.018811) ========= 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=4300f881736b422476174874000001bc-1490283270.328525-1073658576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020355 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 08:34:31.070132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 08:34:31.070604) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 439ee2e4fc4ed4a82102608639d9751e376d5536 --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 439ee2e4fc4ed4a82102608639d9751e376d5536 --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=4300f881736b422476174874000001bc-1490283270.328525-1073658576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-23 08:34:31,191 truncating revision to first 12 chars 2017-03-23 08:34:31,191 Setting DEBUG logging. 2017-03-23 08:34:31,192 attempt 1/10 2017-03-23 08:34:31,192 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/439ee2e4fc4e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-23 08:34:32,532 unpacking tar archive at: mozilla-central-439ee2e4fc4e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.685885 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 08:34:32.769127) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 08:34:32.769427) ========= script_repo_revision: 439ee2e4fc4ed4a82102608639d9751e376d5536 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 08:34:32.769800) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 08:34:32.770060) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 08:34:33.037602) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-03-23 08:34:33.038086) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1490283270.328525-1073658576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:34:33 INFO - MultiFileLogger online at 20170323 08:34:33 in /builds/slave/test 08:34:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:34:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:34:33 INFO - {'append_to_log': False, 08:34:33 INFO - 'base_work_dir': '/builds/slave/test', 08:34:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:34:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:34:33 INFO - 'branch': 'Firefox-Non-PGO', 08:34:33 INFO - 'buildbot_json_path': 'buildprops.json', 08:34:33 INFO - 'config_files': ('talos/linux_config.py',), 08:34:33 INFO - 'default_actions': ('clobber', 08:34:33 INFO - 'read-buildbot-config', 08:34:33 INFO - 'download-and-extract', 08:34:33 INFO - 'populate-webroot', 08:34:33 INFO - 'create-virtualenv', 08:34:33 INFO - 'install', 08:34:33 INFO - 'run-tests'), 08:34:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:34:33 INFO - 'download_minidump_stackwalk': True, 08:34:33 INFO - 'download_symbols': 'ondemand', 08:34:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:34:33 INFO - 'tooltool.py': '/tools/tooltool.py', 08:34:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:34:33 INFO - '/tools/misc-python/virtualenv.py')}, 08:34:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:34:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:34:33 INFO - 'gecko_profile': False, 08:34:33 INFO - 'gecko_profile_interval': 0, 08:34:33 INFO - 'installer_path': 'installer.exe', 08:34:33 INFO - 'log_level': 'info', 08:34:33 INFO - 'log_name': 'talos', 08:34:33 INFO - 'log_to_console': True, 08:34:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:34:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:34:33 INFO - 'opt_config_files': (), 08:34:33 INFO - 'pip_index': False, 08:34:33 INFO - 'suite': 'dromaeojs-e10s', 08:34:33 INFO - 'system_bits': '32', 08:34:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:34:33 INFO - 'title': 'talos-linux64-ix-045', 08:34:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:34:33 INFO - 'use_talos_json': True, 08:34:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:34:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:34:33 INFO - 'work_dir': 'build'} 08:34:33 INFO - [mozharness: 2017-03-23 15:34:33.265281Z] Running clobber step. 08:34:33 INFO - Running pre-action listener: _resource_record_pre_action 08:34:33 INFO - Running main action method: clobber 08:34:33 INFO - rmtree: /builds/slave/test/build 08:34:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:34:34 INFO - Running post-action listener: _resource_record_post_action 08:34:34 INFO - [mozharness: 2017-03-23 15:34:34.220461Z] Finished clobber step (success) 08:34:34 INFO - [mozharness: 2017-03-23 15:34:34.220561Z] Running read-buildbot-config step. 08:34:34 INFO - Running pre-action listener: _resource_record_pre_action 08:34:34 INFO - Running main action method: read_buildbot_config 08:34:34 INFO - Using buildbot properties: 08:34:34 INFO - { 08:34:34 INFO - "project": "", 08:34:34 INFO - "product": "firefox", 08:34:34 INFO - "who": "jyavenard@mozilla.com", 08:34:34 INFO - "installer_path": "public/build/target.tar.bz2", 08:34:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:34:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:34:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:34:34 INFO - "stage_platform": "linux64", 08:34:34 INFO - "basedir": "/builds/slave/test", 08:34:34 INFO - "buildnumber": 768, 08:34:34 INFO - "platform": "ubuntu64_hw", 08:34:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:34:34 INFO - "slavebuilddir": "test", 08:34:34 INFO - "taskId": "Sn6vLmZKQX2qpmd9rTH-3Q", 08:34:34 INFO - "branch": "mozilla-central", 08:34:34 INFO - "script_repo_revision": "production", 08:34:34 INFO - "revision": "439ee2e4fc4ed4a82102608639d9751e376d5536", 08:34:34 INFO - "slavename": "talos-linux64-ix-045", 08:34:34 INFO - "repo_path": "mozilla-central" 08:34:34 INFO - } 08:34:34 INFO - Finding installer, test and symbols from parent task. 08:34:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sn6vLmZKQX2qpmd9rTH-3Q'}, attempt #1 08:34:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sn6vLmZKQX2qpmd9rTH-3Q'}, attempt #1 08:34:35 INFO - Task dependencies: JzD_l16pRq2tcIikmBN-2A 08:34:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A'}, attempt #1 08:34:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/target.tar.bz2 08:34:35 INFO - Set test_url: https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/test_packages.json 08:34:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/target.crashreporter-symbols.zip 08:34:35 INFO - Running post-action listener: _resource_record_post_action 08:34:35 INFO - [mozharness: 2017-03-23 15:34:35.613577Z] Finished read-buildbot-config step (success) 08:34:35 INFO - [mozharness: 2017-03-23 15:34:35.613795Z] Running download-and-extract step. 08:34:35 INFO - Running pre-action listener: _resource_record_pre_action 08:34:35 INFO - Running main action method: download_and_extract 08:34:35 INFO - mkdir: /builds/slave/test/build/tests 08:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:35 INFO - trying https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/target.test_packages.json 08:34:35 INFO - Downloading https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:34:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:34:36 INFO - Downloaded 986 bytes. 08:34:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:34:36 INFO - Using the following test package requirements: 08:34:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:34:36 INFO - u'common': [u'target.common.tests.zip'], 08:34:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:34:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:34:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:34:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:34:36 INFO - u'mozbase': [u'target.common.tests.zip'], 08:34:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:34:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:34:36 INFO - u'web-platform': [u'target.common.tests.zip', 08:34:36 INFO - u'target.web-platform.tests.zip'], 08:34:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:34:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:34:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/target.common.tests.zip 08:34:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:34:36 INFO - Fetch https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/target.common.tests.zip into memory 08:34:37 INFO - Expected file size: 58125557 08:34:37 INFO - Obtained file size: 58125557 08:34:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:34:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/target.common.tests.zip 08:34:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:34:47 INFO - Fetch https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/target.common.tests.zip into memory 08:34:48 INFO - Expected file size: 58125557 08:34:48 INFO - Obtained file size: 58125557 08:34:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/target.talos.tests.zip 08:34:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:34:59 INFO - Fetch https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/target.talos.tests.zip into memory 08:35:00 INFO - Expected file size: 14404171 08:35:00 INFO - Obtained file size: 14404171 08:35:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:00 INFO - trying https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/target.tar.bz2 08:35:00 INFO - Downloading https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:35:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:35:01 INFO - Downloaded 62415565 bytes. 08:35:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/target.tar.bz2 08:35:01 INFO - mkdir: /builds/slave/test/properties 08:35:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:35:01 INFO - Writing to file /builds/slave/test/properties/build_url 08:35:01 INFO - Contents: 08:35:01 INFO - build_url:https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/target.tar.bz2 08:35:01 INFO - Running post-action listener: _resource_record_post_action 08:35:01 INFO - Running post-action listener: set_extra_try_arguments 08:35:01 INFO - [mozharness: 2017-03-23 15:35:01.448708Z] Finished download-and-extract step (success) 08:35:01 INFO - [mozharness: 2017-03-23 15:35:01.448805Z] Running populate-webroot step. 08:35:01 INFO - Running pre-action listener: _resource_record_pre_action 08:35:01 INFO - Running main action method: populate_webroot 08:35:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:35:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:35:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:35:01 INFO - '--tppagecycles', 08:35:01 INFO - '7'], 08:35:01 INFO - 'tests': ['tsvgm']}}, 08:35:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:35:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:35:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:35:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:35:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:35:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:35:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:35:01 INFO - 'talos_options': ['--disable-e10s'], 08:35:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:35:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:35:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:35:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:35:01 INFO - 'talos_options': ['--disable-e10s'], 08:35:01 INFO - 'tests': ['damp', 'tps']}, 08:35:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:35:01 INFO - 'tests': ['damp', 'tps']}, 08:35:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:35:01 INFO - 'tests': ['dromaeo_dom']}, 08:35:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:35:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:35:01 INFO - 'tests': ['basic_compositor_video']}, 08:35:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:35:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:35:01 INFO - 'tests': ['a11yr', 08:35:01 INFO - 'ts_paint', 08:35:01 INFO - 'tpaint', 08:35:01 INFO - 'sessionrestore', 08:35:01 INFO - 'sessionrestore_no_auto_restore', 08:35:01 INFO - 'tabpaint']}, 08:35:01 INFO - 'other-e10s': {'tests': ['a11yr', 08:35:01 INFO - 'ts_paint', 08:35:01 INFO - 'tpaint', 08:35:01 INFO - 'sessionrestore', 08:35:01 INFO - 'sessionrestore_no_auto_restore', 08:35:01 INFO - 'tabpaint']}, 08:35:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:35:01 INFO - 'ts_paint', 08:35:01 INFO - 'tpaint', 08:35:01 INFO - 'sessionrestore', 08:35:01 INFO - 'sessionrestore_no_auto_restore', 08:35:01 INFO - 'tabpaint']}, 08:35:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:35:01 INFO - 'ts_paint', 08:35:01 INFO - 'tpaint', 08:35:01 INFO - 'sessionrestore', 08:35:01 INFO - 'sessionrestore_no_auto_restore', 08:35:01 INFO - 'tabpaint']}, 08:35:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:35:01 INFO - 'tests': ['a11yr', 08:35:01 INFO - 'ts_paint', 08:35:01 INFO - 'tpaint', 08:35:01 INFO - 'sessionrestore', 08:35:01 INFO - 'sessionrestore_no_auto_restore', 08:35:01 INFO - 'tabpaint']}, 08:35:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:35:01 INFO - 'tests': ['a11yr', 08:35:01 INFO - 'ts_paint', 08:35:01 INFO - 'tpaint', 08:35:01 INFO - 'sessionrestore', 08:35:01 INFO - 'sessionrestore_no_auto_restore', 08:35:01 INFO - 'tabpaint']}, 08:35:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:35:01 INFO - 'tests': ['tsvgx', 08:35:01 INFO - 'tsvgr_opacity', 08:35:01 INFO - 'tart', 08:35:01 INFO - 'tscrollx', 08:35:01 INFO - 'cart', 08:35:01 INFO - 'tsvg_static']}, 08:35:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:35:01 INFO - 'tsvgr_opacity', 08:35:01 INFO - 'tart', 08:35:01 INFO - 'tscrollx', 08:35:01 INFO - 'cart', 08:35:01 INFO - 'tsvg_static']}, 08:35:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:35:01 INFO - 'talos_options': ['--disable-e10s'], 08:35:01 INFO - 'tests': ['tp5o']}, 08:35:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:35:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:35:01 INFO - 'talos_options': ['--disable-e10s', 08:35:01 INFO - '--xperf_path', 08:35:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:35:01 INFO - 'tests': ['tp5n']}, 08:35:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:35:01 INFO - 'talos_options': ['--xperf_path', 08:35:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:35:01 INFO - 'tests': ['tp5n']}}, 08:35:01 INFO - 'talos.zip': {'path': '', 08:35:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:35:01 INFO - Running post-action listener: _resource_record_post_action 08:35:01 INFO - [mozharness: 2017-03-23 15:35:01.461956Z] Finished populate-webroot step (success) 08:35:01 INFO - [mozharness: 2017-03-23 15:35:01.462045Z] Running create-virtualenv step. 08:35:01 INFO - Running pre-action listener: _resource_record_pre_action 08:35:01 INFO - Running main action method: create_virtualenv 08:35:01 INFO - Creating virtualenv /builds/slave/test/build/venv 08:35:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:35:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:35:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:35:01 INFO - Using real prefix '/usr' 08:35:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:35:02 INFO - Installing distribute.............................................................................................................................................................................................done. 08:35:04 INFO - Installing pip.................done. 08:35:04 INFO - Return code: 0 08:35:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:35:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:35:04 INFO - Reading from file tmpfile_stdout 08:35:04 INFO - Output received: 08:35:04 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:35:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:04 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 0xd651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1002b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1000290>, '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 0x1000b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1001040>, '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': '4300f881736b422476174874000001bc-1490283270.328525-1073658576', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:35:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:35:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:35:04 INFO - Using env: {'DISPLAY': ':0', 08:35:04 INFO - 'HOME': '/home/cltbld', 08:35:04 INFO - 'LANG': 'en_US.UTF-8', 08:35:04 INFO - 'LANGUAGE': 'en_US:en', 08:35:04 INFO - 'LOGNAME': 'cltbld', 08:35:04 INFO - 'MAIL': '/var/mail/cltbld', 08:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:04 INFO - 'MOZ_NO_REMOTE': '1', 08:35:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:04 INFO - 'NO_EM_RESTART': '1', 08:35:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:04 INFO - 'PWD': '/builds/slave/test', 08:35:04 INFO - 'SHELL': '/bin/bash', 08:35:04 INFO - 'SHLVL': '1', 08:35:04 INFO - 'TERM': 'linux', 08:35:04 INFO - 'TMOUT': '86400', 08:35:04 INFO - 'USER': 'cltbld', 08:35:04 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490283270.328525-1073658576', 08:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:04 INFO - '_': '/tools/buildbot/bin/python'} 08:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:35:04 INFO - Cleaning up... 08:35:04 INFO - Return code: 0 08:35:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:04 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 0xd651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1002b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1000290>, '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 0x1000b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1001040>, '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': '4300f881736b422476174874000001bc-1490283270.328525-1073658576', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:35:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:35:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:35:04 INFO - Using env: {'DISPLAY': ':0', 08:35:04 INFO - 'HOME': '/home/cltbld', 08:35:04 INFO - 'LANG': 'en_US.UTF-8', 08:35:04 INFO - 'LANGUAGE': 'en_US:en', 08:35:04 INFO - 'LOGNAME': 'cltbld', 08:35:04 INFO - 'MAIL': '/var/mail/cltbld', 08:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:04 INFO - 'MOZ_NO_REMOTE': '1', 08:35:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:04 INFO - 'NO_EM_RESTART': '1', 08:35:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:04 INFO - 'PWD': '/builds/slave/test', 08:35:04 INFO - 'SHELL': '/bin/bash', 08:35:04 INFO - 'SHLVL': '1', 08:35:04 INFO - 'TERM': 'linux', 08:35:04 INFO - 'TMOUT': '86400', 08:35:04 INFO - 'USER': 'cltbld', 08:35:04 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490283270.328525-1073658576', 08:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:04 INFO - '_': '/tools/buildbot/bin/python'} 08:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:04 INFO - Downloading/unpacking psutil>=3.1.1 08:35: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 08:35: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 08:35: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 08:35: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 08:35: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 08:35: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 08:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:35:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:35:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:35:06 INFO - Installing collected packages: psutil 08:35:06 INFO - Running setup.py install for psutil 08:35:06 INFO - building 'psutil._psutil_linux' extension 08:35:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:35:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:35:07 INFO - building 'psutil._psutil_posix' extension 08:35:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:35:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:35:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:35:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:35:07 INFO - Successfully installed psutil 08:35:07 INFO - Cleaning up... 08:35:07 INFO - Return code: 0 08:35:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1002b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1000290>, '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 0x1000b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1001040>, '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': '4300f881736b422476174874000001bc-1490283270.328525-1073658576', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:35:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:35:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:35:07 INFO - Using env: {'DISPLAY': ':0', 08:35:07 INFO - 'HOME': '/home/cltbld', 08:35:07 INFO - 'LANG': 'en_US.UTF-8', 08:35:07 INFO - 'LANGUAGE': 'en_US:en', 08:35:07 INFO - 'LOGNAME': 'cltbld', 08:35:07 INFO - 'MAIL': '/var/mail/cltbld', 08:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:07 INFO - 'MOZ_NO_REMOTE': '1', 08:35:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:07 INFO - 'NO_EM_RESTART': '1', 08:35:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:07 INFO - 'PWD': '/builds/slave/test', 08:35:07 INFO - 'SHELL': '/bin/bash', 08:35:07 INFO - 'SHLVL': '1', 08:35:07 INFO - 'TERM': 'linux', 08:35:07 INFO - 'TMOUT': '86400', 08:35:07 INFO - 'USER': 'cltbld', 08:35:07 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490283270.328525-1073658576', 08:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:07 INFO - '_': '/tools/buildbot/bin/python'} 08:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:35:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:35:09 INFO - Installing collected packages: mozsystemmonitor 08:35:09 INFO - Running setup.py install for mozsystemmonitor 08:35:09 INFO - Successfully installed mozsystemmonitor 08:35:09 INFO - Cleaning up... 08:35:09 INFO - Return code: 0 08:35:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1002b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1000290>, '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 0x1000b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1001040>, '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': '4300f881736b422476174874000001bc-1490283270.328525-1073658576', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:35:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:35:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:35:09 INFO - Using env: {'DISPLAY': ':0', 08:35:09 INFO - 'HOME': '/home/cltbld', 08:35:09 INFO - 'LANG': 'en_US.UTF-8', 08:35:09 INFO - 'LANGUAGE': 'en_US:en', 08:35:09 INFO - 'LOGNAME': 'cltbld', 08:35:09 INFO - 'MAIL': '/var/mail/cltbld', 08:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:09 INFO - 'MOZ_NO_REMOTE': '1', 08:35:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:09 INFO - 'NO_EM_RESTART': '1', 08:35:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:09 INFO - 'PWD': '/builds/slave/test', 08:35:09 INFO - 'SHELL': '/bin/bash', 08:35:09 INFO - 'SHLVL': '1', 08:35:09 INFO - 'TERM': 'linux', 08:35:09 INFO - 'TMOUT': '86400', 08:35:09 INFO - 'USER': 'cltbld', 08:35:09 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490283270.328525-1073658576', 08:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:09 INFO - '_': '/tools/buildbot/bin/python'} 08:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:10 INFO - Downloading/unpacking jsonschema==2.5.1 08:35: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 08:35: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 08:35: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 08:35: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 08:35: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 08:35: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 08:35:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:35:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:12 INFO - Downloading functools32-3.2.3-2.tar.gz 08:35:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:35:12 INFO - warning: no files found matching '*.txt' 08:35:12 INFO - no previously-included directories found matching 'build' 08:35:12 INFO - no previously-included directories found matching 'dist' 08:35:12 INFO - no previously-included directories found matching '.git*' 08:35:12 INFO - Installing collected packages: jsonschema, functools32 08:35:12 INFO - Running setup.py install for functools32 08:35:12 INFO - warning: no files found matching '*.txt' 08:35:12 INFO - no previously-included directories found matching 'build' 08:35:12 INFO - no previously-included directories found matching 'dist' 08:35:12 INFO - no previously-included directories found matching '.git*' 08:35:12 INFO - Successfully installed jsonschema functools32 08:35:12 INFO - Cleaning up... 08:35:12 INFO - Return code: 0 08:35:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:35: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')]} 08:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35: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')]} 08:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1002b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1000290>, '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 0x1000b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1001040>, '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': '4300f881736b422476174874000001bc-1490283270.328525-1073658576', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:35:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:35:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:35:12 INFO - Using env: {'DISPLAY': ':0', 08:35:12 INFO - 'HOME': '/home/cltbld', 08:35:12 INFO - 'LANG': 'en_US.UTF-8', 08:35:12 INFO - 'LANGUAGE': 'en_US:en', 08:35:12 INFO - 'LOGNAME': 'cltbld', 08:35:12 INFO - 'MAIL': '/var/mail/cltbld', 08:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:12 INFO - 'MOZ_NO_REMOTE': '1', 08:35:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:12 INFO - 'NO_EM_RESTART': '1', 08:35:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:12 INFO - 'PWD': '/builds/slave/test', 08:35:12 INFO - 'SHELL': '/bin/bash', 08:35:12 INFO - 'SHLVL': '1', 08:35:12 INFO - 'TERM': 'linux', 08:35:12 INFO - 'TMOUT': '86400', 08:35:12 INFO - 'USER': 'cltbld', 08:35:12 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490283270.328525-1073658576', 08:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:12 INFO - '_': '/tools/buildbot/bin/python'} 08:35:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:35:12 INFO - Cleaning up... 08:35:12 INFO - Return code: 0 08:35:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:35: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')]} 08:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35: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')]} 08:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1002b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1000290>, '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 0x1000b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1001040>, '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': '4300f881736b422476174874000001bc-1490283270.328525-1073658576', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:35:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:35:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:35:12 INFO - Using env: {'DISPLAY': ':0', 08:35:12 INFO - 'HOME': '/home/cltbld', 08:35:12 INFO - 'LANG': 'en_US.UTF-8', 08:35:12 INFO - 'LANGUAGE': 'en_US:en', 08:35:12 INFO - 'LOGNAME': 'cltbld', 08:35:12 INFO - 'MAIL': '/var/mail/cltbld', 08:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:12 INFO - 'MOZ_NO_REMOTE': '1', 08:35:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:12 INFO - 'NO_EM_RESTART': '1', 08:35:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:12 INFO - 'PWD': '/builds/slave/test', 08:35:12 INFO - 'SHELL': '/bin/bash', 08:35:12 INFO - 'SHLVL': '1', 08:35:12 INFO - 'TERM': 'linux', 08:35:12 INFO - 'TMOUT': '86400', 08:35:12 INFO - 'USER': 'cltbld', 08:35:12 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490283270.328525-1073658576', 08:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:12 INFO - '_': '/tools/buildbot/bin/python'} 08:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:13 INFO - Downloading/unpacking blobuploader==1.2.4 08:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:15 INFO - Downloading blobuploader-1.2.4.tar.gz 08:35:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:35:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:35:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:15 INFO - Downloading docopt-0.6.1.tar.gz 08:35:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:35:15 INFO - Installing collected packages: blobuploader, requests, docopt 08:35:15 INFO - Running setup.py install for blobuploader 08:35:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:35:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:35:16 INFO - Running setup.py install for requests 08:35:16 INFO - Running setup.py install for docopt 08:35:16 INFO - Successfully installed blobuploader requests docopt 08:35:16 INFO - Cleaning up... 08:35:16 INFO - Return code: 0 08:35:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:16 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 0xd651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1002b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1000290>, '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 0x1000b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1001040>, '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': '4300f881736b422476174874000001bc-1490283270.328525-1073658576', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:35:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:35:16 INFO - Using env: {'DISPLAY': ':0', 08:35:16 INFO - 'HOME': '/home/cltbld', 08:35:16 INFO - 'LANG': 'en_US.UTF-8', 08:35:16 INFO - 'LANGUAGE': 'en_US:en', 08:35:16 INFO - 'LOGNAME': 'cltbld', 08:35:16 INFO - 'MAIL': '/var/mail/cltbld', 08:35:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:16 INFO - 'MOZ_NO_REMOTE': '1', 08:35:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:16 INFO - 'NO_EM_RESTART': '1', 08:35:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:16 INFO - 'PWD': '/builds/slave/test', 08:35:16 INFO - 'SHELL': '/bin/bash', 08:35:16 INFO - 'SHLVL': '1', 08:35:16 INFO - 'TERM': 'linux', 08:35:16 INFO - 'TMOUT': '86400', 08:35:16 INFO - 'USER': 'cltbld', 08:35:16 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490283270.328525-1073658576', 08:35:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:16 INFO - '_': '/tools/buildbot/bin/python'} 08:35:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:35:16 INFO - Running setup.py (path:/tmp/pip-TUbCLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:35:16 INFO - Running setup.py (path:/tmp/pip-YEBuCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:35:16 INFO - Running setup.py (path:/tmp/pip-NzrfHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:35:16 INFO - Running setup.py (path:/tmp/pip-nmJQYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:35:17 INFO - Running setup.py (path:/tmp/pip-DndPP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:35:17 INFO - Running setup.py (path:/tmp/pip-1JfAY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:35:17 INFO - Running setup.py (path:/tmp/pip-E3Vsk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:35:17 INFO - Running setup.py (path:/tmp/pip-PRAd23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:35:17 INFO - Running setup.py (path:/tmp/pip-j1igJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:35:17 INFO - Running setup.py (path:/tmp/pip-HeucoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:35:17 INFO - Running setup.py (path:/tmp/pip-HGSnAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:35:17 INFO - Running setup.py (path:/tmp/pip-ExU7up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:35:17 INFO - Running setup.py (path:/tmp/pip-sFfJAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:35:17 INFO - Running setup.py (path:/tmp/pip-ZP4T7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:17 INFO - Running setup.py (path:/tmp/pip-oHFZsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:35:17 INFO - Running setup.py (path:/tmp/pip-bbrJ6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:35:17 INFO - Running setup.py (path:/tmp/pip-UOYysF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:35:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:35:17 INFO - Running setup.py install for manifestparser 08:35:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:35:18 INFO - Running setup.py install for mozcrash 08:35:18 INFO - Running setup.py install for mozdebug 08:35:18 INFO - Running setup.py install for mozdevice 08:35:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:35:18 INFO - Running setup.py install for mozfile 08:35:18 INFO - Running setup.py install for mozhttpd 08:35:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:35:18 INFO - Running setup.py install for mozinfo 08:35:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:35:18 INFO - Running setup.py install for mozInstall 08:35:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:35:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:35:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:35:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:35:18 INFO - Running setup.py install for mozleak 08:35:18 INFO - Running setup.py install for mozlog 08:35:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:35:18 INFO - Running setup.py install for moznetwork 08:35:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:35:19 INFO - Running setup.py install for mozprocess 08:35:19 INFO - Running setup.py install for mozprofile 08:35:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:35:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:35:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:35:19 INFO - Running setup.py install for mozrunner 08:35:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:35:19 INFO - Running setup.py install for mozscreenshot 08:35:19 INFO - Running setup.py install for moztest 08:35:19 INFO - Running setup.py install for mozversion 08:35:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:35:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:35:19 INFO - Cleaning up... 08:35:19 INFO - Return code: 0 08:35:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:35:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:19 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 0xd651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1002b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1000290>, '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 0x1000b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1001040>, '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': '4300f881736b422476174874000001bc-1490283270.328525-1073658576', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:35:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:35:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:35:19 INFO - Using env: {'DISPLAY': ':0', 08:35:19 INFO - 'HOME': '/home/cltbld', 08:35:19 INFO - 'LANG': 'en_US.UTF-8', 08:35:19 INFO - 'LANGUAGE': 'en_US:en', 08:35:19 INFO - 'LOGNAME': 'cltbld', 08:35:19 INFO - 'MAIL': '/var/mail/cltbld', 08:35:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:19 INFO - 'MOZ_NO_REMOTE': '1', 08:35:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:19 INFO - 'NO_EM_RESTART': '1', 08:35:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:19 INFO - 'PWD': '/builds/slave/test', 08:35:19 INFO - 'SHELL': '/bin/bash', 08:35:19 INFO - 'SHLVL': '1', 08:35:19 INFO - 'TERM': 'linux', 08:35:19 INFO - 'TMOUT': '86400', 08:35:19 INFO - 'USER': 'cltbld', 08:35:19 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490283270.328525-1073658576', 08:35:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:19 INFO - '_': '/tools/buildbot/bin/python'} 08:35:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:35:19 INFO - Running setup.py (path:/tmp/pip-Fy27T7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:35:20 INFO - Running setup.py (path:/tmp/pip-3Ym0dR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:35:20 INFO - Running setup.py (path:/tmp/pip-ZvDUZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:35:20 INFO - Running setup.py (path:/tmp/pip-A63tM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:35:20 INFO - Running setup.py (path:/tmp/pip-Cda54M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:35:20 INFO - Running setup.py (path:/tmp/pip-2Tj7ta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:35:20 INFO - Running setup.py (path:/tmp/pip-zwam7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:35:20 INFO - Running setup.py (path:/tmp/pip-U3Uv1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:35:20 INFO - Running setup.py (path:/tmp/pip-QWqTDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:35:20 INFO - Running setup.py (path:/tmp/pip-ErmaJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:35:20 INFO - Running setup.py (path:/tmp/pip-qzCabZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:35:20 INFO - Running setup.py (path:/tmp/pip-lbF3CJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:35:20 INFO - Running setup.py (path:/tmp/pip-LChHUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:35:20 INFO - Running setup.py (path:/tmp/pip-UzkeqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:20 INFO - Running setup.py (path:/tmp/pip-ohcBTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:35:21 INFO - Running setup.py (path:/tmp/pip-mwI6lE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:35:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:35:21 INFO - Running setup.py (path:/tmp/pip-GDRk4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:35:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:35:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:35:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:35:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:35:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:35:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:35:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:23 INFO - Downloading blessings-1.6.tar.gz 08:35:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:35:23 INFO - Installing collected packages: blessings 08:35:23 INFO - Running setup.py install for blessings 08:35:23 INFO - Successfully installed blessings 08:35:23 INFO - Cleaning up... 08:35:23 INFO - Return code: 0 08:35:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:35:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:35:23 INFO - Reading from file tmpfile_stdout 08:35:23 INFO - Current package versions: 08:35:23 INFO - argparse == 1.2.1 08:35:23 INFO - blessings == 1.6 08:35:23 INFO - blobuploader == 1.2.4 08:35:23 INFO - docopt == 0.6.1 08:35:23 INFO - functools32 == 3.2.3-2 08:35:23 INFO - jsonschema == 2.5.1 08:35:23 INFO - manifestparser == 1.1 08:35:23 INFO - mozInstall == 1.12 08:35:23 INFO - mozcrash == 1.0 08:35:23 INFO - mozdebug == 0.1 08:35:23 INFO - mozdevice == 0.49 08:35:23 INFO - mozfile == 1.2 08:35:23 INFO - mozhttpd == 0.7 08:35:23 INFO - mozinfo == 0.9 08:35:23 INFO - mozleak == 0.1 08:35:23 INFO - mozlog == 3.4 08:35:23 INFO - moznetwork == 0.27 08:35:23 INFO - mozprocess == 0.25 08:35:23 INFO - mozprofile == 0.28 08:35:23 INFO - mozrunner == 6.13 08:35:23 INFO - mozscreenshot == 0.1 08:35:23 INFO - mozsystemmonitor == 0.3 08:35:23 INFO - moztest == 0.8 08:35:23 INFO - mozversion == 1.4 08:35:23 INFO - psutil == 3.1.1 08:35:23 INFO - requests == 1.2.3 08:35:23 INFO - wsgiref == 0.1.2 08:35:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:23 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 0xd651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1002b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1000290>, '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 0x1000b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1001040>, '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': '4300f881736b422476174874000001bc-1490283270.328525-1073658576', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:35:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:35:23 INFO - Using env: {'DISPLAY': ':0', 08:35:23 INFO - 'HOME': '/home/cltbld', 08:35:23 INFO - 'LANG': 'en_US.UTF-8', 08:35:23 INFO - 'LANGUAGE': 'en_US:en', 08:35:23 INFO - 'LOGNAME': 'cltbld', 08:35:23 INFO - 'MAIL': '/var/mail/cltbld', 08:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:23 INFO - 'MOZ_NO_REMOTE': '1', 08:35:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:23 INFO - 'NO_EM_RESTART': '1', 08:35:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:23 INFO - 'PWD': '/builds/slave/test', 08:35:23 INFO - 'SHELL': '/bin/bash', 08:35:23 INFO - 'SHLVL': '1', 08:35:23 INFO - 'TERM': 'linux', 08:35:23 INFO - 'TMOUT': '86400', 08:35:23 INFO - 'USER': 'cltbld', 08:35:23 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490283270.328525-1073658576', 08:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:23 INFO - '_': '/tools/buildbot/bin/python'} 08:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:35:23 INFO - Cleaning up... 08:35:23 INFO - Return code: 0 08:35:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:23 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 0xd651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1002b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1000290>, '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 0x1000b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1001040>, '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': '4300f881736b422476174874000001bc-1490283270.328525-1073658576', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:35:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:35:23 INFO - Using env: {'DISPLAY': ':0', 08:35:23 INFO - 'HOME': '/home/cltbld', 08:35:23 INFO - 'LANG': 'en_US.UTF-8', 08:35:23 INFO - 'LANGUAGE': 'en_US:en', 08:35:23 INFO - 'LOGNAME': 'cltbld', 08:35:23 INFO - 'MAIL': '/var/mail/cltbld', 08:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:23 INFO - 'MOZ_NO_REMOTE': '1', 08:35:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:23 INFO - 'NO_EM_RESTART': '1', 08:35:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:23 INFO - 'PWD': '/builds/slave/test', 08:35:23 INFO - 'SHELL': '/bin/bash', 08:35:23 INFO - 'SHLVL': '1', 08:35:23 INFO - 'TERM': 'linux', 08:35:23 INFO - 'TMOUT': '86400', 08:35:23 INFO - 'USER': 'cltbld', 08:35:23 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490283270.328525-1073658576', 08:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:23 INFO - '_': '/tools/buildbot/bin/python'} 08:35:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:35:24 INFO - Cleaning up... 08:35:24 INFO - Return code: 0 08:35:24 INFO - Running post-action listener: _resource_record_post_action 08:35:24 INFO - Running post-action listener: _start_resource_monitoring 08:35:24 INFO - Starting resource monitoring. 08:35:24 INFO - [mozharness: 2017-03-23 15:35:24.177458Z] Finished create-virtualenv step (success) 08:35:24 INFO - [mozharness: 2017-03-23 15:35:24.177922Z] Running install step. 08:35:24 INFO - Running pre-action listener: _resource_record_pre_action 08:35:24 INFO - Running main action method: install 08:35:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:35:24 INFO - Reading from file tmpfile_stdout 08:35:24 INFO - Detecting whether we're running mozinstall >=1.0... 08:35:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:35:24 INFO - Reading from file tmpfile_stdout 08:35:24 INFO - Output received: 08:35:24 INFO - Usage: mozinstall [options] installer 08:35:24 INFO - Options: 08:35:24 INFO - -h, --help show this help message and exit 08:35:24 INFO - -d DEST, --destination=DEST 08:35:24 INFO - Directory to install application into. [default: 08:35:24 INFO - "/builds/slave/test"] 08:35:24 INFO - --app=APP Application being installed. [default: firefox] 08:35:24 INFO - mkdir: /builds/slave/test/build/application 08:35:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:35:40 INFO - Reading from file tmpfile_stdout 08:35:40 INFO - Output received: 08:35:40 INFO - /builds/slave/test/build/application/firefox/firefox 08:35:40 INFO - Running post-action listener: _resource_record_post_action 08:35:40 INFO - [mozharness: 2017-03-23 15:35:40.140220Z] Finished install step (success) 08:35:40 INFO - [mozharness: 2017-03-23 15:35:40.140494Z] Running run-tests step. 08:35:40 INFO - Running pre-action listener: _resource_record_pre_action 08:35:40 INFO - Running main action method: run_tests 08:35:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:35:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:35:40 INFO - Python 2.7.3 08:35:40 INFO - Return code: 0 08:35:40 INFO - grabbing minidump binary from tooltool 08:35:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:40 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 0x1000290>, '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 0x1000b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1001040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:35:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:35:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:35:40 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:35:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:35:40 INFO - Return code: 0 08:35:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:35:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:35:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:35:40 INFO - ENV: RUST_BACKTRACE is now 1 08:35:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:35:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:35:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:35:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:35:40 INFO - Using env: {'DISPLAY': ':0', 08:35:40 INFO - 'HOME': '/home/cltbld', 08:35:40 INFO - 'LANG': 'en_US.UTF-8', 08:35:40 INFO - 'LANGUAGE': 'en_US:en', 08:35:40 INFO - 'LOGNAME': 'cltbld', 08:35:40 INFO - 'MAIL': '/var/mail/cltbld', 08:35:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:35:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:35:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:40 INFO - 'MOZ_NO_REMOTE': '1', 08:35:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:35:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:40 INFO - 'NO_EM_RESTART': '1', 08:35:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:40 INFO - 'PWD': '/builds/slave/test', 08:35:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:35:40 INFO - 'RUST_BACKTRACE': '1', 08:35:40 INFO - 'SHELL': '/bin/bash', 08:35:40 INFO - 'SHLVL': '1', 08:35:40 INFO - 'TERM': 'linux', 08:35:40 INFO - 'TMOUT': '86400', 08:35:40 INFO - 'USER': 'cltbld', 08:35:40 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490283270.328525-1073658576', 08:35:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:40 INFO - '_': '/tools/buildbot/bin/python'} 08:35:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:35:40 INFO - mozversion application_buildid: 20170323150529 08:35:40 INFO - mozversion application_changeset: 439ee2e4fc4ed4a82102608639d9751e376d5536 08:35:40 INFO - mozversion application_display_name: Nightly 08:35:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:35:40 INFO - mozversion application_name: Firefox 08:35:40 INFO - mozversion application_remotingname: firefox 08:35:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:35:40 INFO - mozversion application_vendor: Mozilla 08:35:40 INFO - mozversion application_version: 55.0a1 08:35:40 INFO - mozversion platform_buildid: 20170323150529 08:35:40 INFO - mozversion platform_changeset: 439ee2e4fc4ed4a82102608639d9751e376d5536 08:35:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:35:40 INFO - mozversion platform_version: 55.0a1 08:35:40 INFO - using testdate: 1490283340 08:35:40 INFO - actual date: 1490283340 08:35:40 INFO - starting webserver on 'localhost:52222' 08:35:40 INFO - SUITE-START | Running 2 tests 08:35:40 INFO - TEST-START | dromaeo_css 08:35:40 INFO - operating with platform_type : linux_ 08:35:40 INFO - Initialising browser for dromaeo_css test... 08:35:40 INFO - TEST-INFO | started process 6958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqy8aTR/profile http://localhost:52222/getInfo.html) 08:35:45 INFO - PID 6958 | __metrics Screen width/height:1600/1200 08:35:45 INFO - PID 6958 | colorDepth:24 08:35:45 INFO - PID 6958 | Browser inner width/height: 1024/697 08:35:45 INFO - PID 6958 | __metrics 08:35:46 ERROR - PID 6958 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3388: TypeError: this.tabs is undefined 08:35:47 INFO - TEST-INFO | 6958: exit 0 08:35:47 INFO - Browser initialized. 08:35:47 INFO - Running cycle 1/1 for dromaeo_css test... 08:35:47 INFO - TEST-INFO | started process 7095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqy8aTR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:35:59 INFO - PID 7095 | RSS: Main: 155787264 08:35:59 INFO - PID 7095 | 08:39:04 INFO - PID 7095 | Cycle 1(1): loaded http://localhost:52222/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52222/tests/dromaeo/cssquery-ext.html) 08:39:05 INFO - PID 7095 | RSS: Main: 167374848 08:39:05 INFO - PID 7095 | 08:40:47 INFO - PID 7095 | ************************* 08:40:47 INFO - PID 7095 | A coding exception was thrown and uncaught in a Task. 08:40:47 INFO - PID 7095 | 08:40:47 ERROR - PID 7095 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:40:47 INFO - PID 7095 | Full stack: 08:40:47 INFO - PID 7095 | ************************* 08:42:08 INFO - PID 7095 | Cycle 1(1): loaded http://localhost:52222/tests/dromaeo/cssquery-ext.html (next: http://localhost:52222/tests/dromaeo/cssquery-jquery.html) 08:42:08 INFO - PID 7095 | RSS: Main: 161525760 08:42:08 INFO - PID 7095 | 08:45:10 INFO - PID 7095 | Cycle 1(1): loaded http://localhost:52222/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52222/tests/dromaeo/cssquery-mootools.html) 08:45:11 INFO - PID 7095 | RSS: Main: 168919040 08:45:11 INFO - PID 7095 | 08:48:13 INFO - PID 7095 | Cycle 1(1): loaded http://localhost:52222/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52222/tests/dromaeo/cssquery-prototype.html) 08:48:14 INFO - PID 7095 | RSS: Main: 160346112 08:48:14 INFO - PID 7095 | 08:51:16 INFO - PID 7095 | Cycle 1(1): loaded http://localhost:52222/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52222/tests/dromaeo/cssquery-yui.html) 08:51:17 INFO - PID 7095 | RSS: Main: 168779776 08:51:17 INFO - PID 7095 | 08:54:20 INFO - PID 7095 | Cycle 1(1): loaded http://localhost:52222/tests/dromaeo/cssquery-yui.html (next: http://localhost:52222/tests/dromaeo/cssquery-dojo.html) 08:54:20 INFO - PID 7095 | RSS: Main: 163557376 08:54:20 INFO - PID 7095 | 08:54:20 INFO - PID 7095 | __start_tp_report 08:54:20 INFO - PID 7095 | _x_x_mozilla_page_load 08:54:20 INFO - PID 7095 | _x_x_mozilla_page_load_details 08:54:20 INFO - PID 7095 | |i|pagename|runs| 08:54:20 INFO - PID 7095 | |0;dojo.html;2672.839629622224;2678.5714285714284;2682.10149599884;2708.6072519484665;2715.932101697457;5008.49915008499;5083.6949783013;5117.155669314563;5160.225966105086;5177.741112944352;5116.539511443969;5144.614153938451;5171.948280517194;5234.50272224139;5241.659292146008;4687.789049492772;4717.952820471803;4731.195696731546;4753.096911586805;4753.809847606091;4798.49615790344;4801.519848015206;4807.61539076873;4808.038392321532;4821.783019764119;4595.517470665599;4643.117807616542;4658.394408726877;4719.646026547988;4740.905181896343;4695.107929493385;4696.436427628672;4709.293605959099;4725.338452616602;4756.191447453906;4533.682642215046;4612.331211974279;4665.743384113873;4682.508336624674;4707.482176960531;4956.826511072131;5026.623003274769;5057.924131138036;5133.691978481265;5159.097157997373;5538.695371754552;5562.02664533705;5578.665280083208;5583.190437386556;5607.803726869581;5591.776328946838;5593.133064374988;5595.720213989325;5601.411851755588;5605.80379686709;5051.898962020812;5100.056489549445;5179.14544100223;5191.169412893919;5249.186376111708;5690.430956904359;5708.885822283531;5733.397993210736;5733.77064917407;5750.1949727038245;5299.49654782795;5318.468153184728;5417.8103766367985;5454.563634909197;5464.0711079116645;5359.624826262202;5471.316085489314;5472.042392581282;5505.03661859173;5522.806701765419;5181.663191892515;5476.479734425223;5483.698396588226;5486.506214440719;5494.5054945054335;5387.649802762808;5389.487998640201;5389.892202155935;5390.110631745796;5392.703401312887;4525.570070843265;4530.6602004849765;4531.705439146445;4534.750588717587;4535.25168347219;3972.960270397259;3980.3034468967817;3980.900477488028;3982.1438390745548;3985.6412922837085;4793.664443488922;4801.063792560487;4804.375431193923;4805.447373552086;4805.927911081337;5490.176473529003;5534.916976245359;5544.528715059185;5545.694986775686;5546.77812887488;4801.735904525215;4801.735904525215;4803.135435621552;4807.78364973577;4813.663043586916;4834.250691142878;4855.271709243571;4867;4868.342773725572;4896.265560165933;5188.325517682677;5189.636725429184;5199.11615025439;5199.246109314204;5203.19350500673;5429.212764149255;5487.560995120461;5534.142207957773;5574.749136288796;5578.135389014709;5169.121249387688;5174.767135478988;5179.585633149263;5197.324347834758;5227.398849132398;5468.4531546845;5475.698836563868;5476.288082549243;5480.424555421783;5534.86162845916;5314.256004159498;5362.65142765719;5373.838784836461;5531.2532808072;5541.418151094077;5230.058589453783;5230.241614965885;5239.659422137549;5252.0546301664535;5336.706481143419;5355.410904800391;5362.919556206738;5388.54197393226;5427.891442171213;5445.346558412857;5241.47585241488;5268.1834315681135;5299.33758280215;5310.362756469249;5362.597805164551;5207.5833933286;5256.027634887558;5377.327834020747;5393.244945707525;5444.564434845123;5166.4316925137455;5223.947760522498;5292.364916210079;5314.707691077027;5322.973385133049 08:54:20 INFO - PID 7095 | |1;ext.html;566.1422944239478;625.6746491824251;643.5173619785161;1167.16547668417;1172.7068232941765;32126.35747285053;32685.346293074184;32720.836395818016;32746.345073098524;32809.50785738216;32829.17927051825;33132;33168;33217.501737473896;33318.50022249668;7077.7522786702475;7218.747343842967;7338.70645174195;7509.211532789061;7544.132424771139;7476.588787616679;7697.884531732028;7743.419243556756;7750.922490775077;7758.7672369828715;7736.690532378698;7799.493032952868;7814.76555703327;7816.687332506693;7843.764687059369;7766.06807183136;7771.339436147934;7798.454108212399;7799.8440031199625;7801.609919504059;7614.2005089465365;7666.578338191397;7684.807879803049;7691.192424795372;7707.460477766558;34951.9514414568;35096.47355289673;35195.472067919;35200.47199291987;35279.82360088209;2665.3869609989615;2666.386731051869;2669.9466010679675;2682.135542033578;2732.5901114832736;23964.40088997789;24311.78441077939;24487.632685509732;24722.381940451633;25047.62428563573;2995.2362147652425;3001.774866884992;3016.1403999860154;3032.5906002689794;3066.47869862124;110071.44964275208;111026.44486777515;153049;153762;153992.23003885022;36966.815165924534;37243.4413483798;37286.06784830401;37368.626313737055;40829.59170408258;42828.35757463641;42865.57134428678;42965;43069.56930430718;43070.56929430728;12372.566960156351;12504.124711270306;12507.624771256877;12542.372881355896;12553.435095420728;9995.900040999642;10024.79950400988;10046.799064018825;10055.69832905014;10093.596256149818;12679.556215532411;12863;12880.190949697402;12942;13012.609621711365;5348.465153484621;5405.918911216335;5427.43011983744;5449.64577302474;5457.126859702428;807.6809660184194;809.5871105736117;841.8105926166563;852.4885068958699;866.7789713623112;19668.21327146898;20577.58844823125;21071.894640527007;21111.472213194487;21417.57164856694;911.4941207629696;916.2669864108686;934.5887809363858;938.8122375524786;942.0532364973158;10589.894101059044;10706.839397408889;10913.345199287909;11059.272505669487;11206;228519;228607;228789;229459;230464;42187;42393.15213695709;42478.57521424808;42601;42638.57361426346;1192.6642160779809;1227.1226073357413;1241.9937900310622;1242.9067819913723;1245.7570773699224;19755.308564200182;19943;20852.214880322892;20873.26943556968;21068.367948961557;31031;31098.53352199764;31159.84420077885;31180.688193118687;31189.68810311868;223855;224240;225195;225292;225733;27983.58024629673;28041;28233;28516.287092822844;28620.14139575816;34581.65418345885;34638.30723385569;37095.62904370922;37373.2525349486;38363.80818095891;27963.161105166877;28336.291592710346;28856.71143288624;28959.42081158407;29116.56325155082;28074.2981425466;28100.43799124047;28303.575446368734;28623.284417889718;28648.14055578336;30494;30912.69087309188;31373.372532549678;31539.52690709595;31541.684583153874;27322.180334589993;27629.861850690617;27673;27951.580726288714;28751;20650.380488585368;22613.07788837967;22754.31737047891;22836.657450138595;22875.656865147368 08:54:20 INFO - PID 7095 | |2;jquery.html;411.2843652045438;424.7480146609652;426.4349736599007;437.763607651868;445.56112229454004;16866.66266674666;17017.91744429123;17035.318587256494;17385;17502.12489375531;17544.210510527024;17575.82424175758;18395.81604183958;18860.717089243637;19066.904665476653;5488.780448782044;5629.915551266724;5663.348714897798;5712.171735098408;5813.157092221625;5569.443055694418;5588.552915766729;5594.104943209088;5594.944050559503;5624.268845050137;5531.115021596545;5563.471470210344;5702.629329093616;5714.771409143629;5716.971415142919;5648.74580643872;5725.885482290372;5745.569082318801;5751.079827227644;5773.855653608673;5140;5195.116830138885;5201.297824793643;5226.97386513065;5228.424873263938;22171.778282217132;22203.333899983027;22669.773302267095;22762.089516419488;22868.428289292733;1569.2310767723848;1573.834747351523;1590.1174847959378;1606.4859245041591;1633.0365084600144;13592.592222233348;14068.912002148842;14250.714985700331;14530.92734536331;14567.708645827024;1671.189473105543;1679.6808606364752;1682.6214101827113;1692.7968643762704;1729.2909906938096;88029;89511.10488895093;90345.54827225888;91456.54271728665;92159;10872.565097396173;11109.888901111048;11217.775644487065;11242.606508772154;11245.212835101463;15438.614034649;15514.45699400538;15533.145676987875;15562.144082075594;15635.452759153375;7188.6046267455795;7402.703891844373;7461.738839140604;7602.201768814305;7629;6820.181578210647;6821.691787382964;7004.334588214111;7011.579305241702;7032.789016329519;6933.826654333581;6967.33810288032;7016.473764467685;7048.859022819515;7071.7878463646175;1990.114399092419;1999.8800071995727;2026.8378529717588;2036.8472364572717;2172.4351668566287;827.8716798896181;839.9076101628816;868.8132051608808;883.5289243409779;886.5035580075179;16378.836211637969;17382.739258911126;17699.823001770073;17835;17858.107094645216;868.5092922498768;874.7900503879023;878.3061381508664;880.0935036911991;904.1862323908535;9125.224355929688;9435.716928492157;9652.27607929408;9744.902550974399;9840.507974601242;440753;441072;441888;444271;449037;74927;76442.23557764351;78452.21547784563;89817.34977318536;91629;1083.8320060390652;1088.0370871778375;1139.6524060161564;1146.7305183281921;1147.3632134165618;15735.685286293981;16129.435469758502;16629.168541573115;16734.916325418297;16799.496015119566;31401.11593304409;33671.831640841636;39427.40858887062;40235.59764402318;41282;53669.97475189298;53877.73061134669;54149.45850541444;54425.72787136039;56235;7455.813604659927;8325.875111873447;8405.53769542681;8431.28334091609;8546.188112129337;11398.94300528492;11520.654380368602;11632.069434445055;12109.878901210875;12116;10166.18670506343;10274.640387586398;10366.637167699095;10390.324628899098;10809.243352965532;9950.601975921172;10194.235432342455;10203.285769996326;10234.437105959243;10284.691459256233;9925.851112233468;10013.899861001297;10052.849207262043;10326.01902819231;10402.531886065297;7647.464677472523;7807.258310460497;7909.881351779843;7984.920150798418;7991.160928102466;10123.341982771097;10129.392236465836;10144;10306.536205870603;10582.365058096539 08:54:20 INFO - PID 7095 | |3;mootools.html;1192.6302846117703;1216.2276954134127;1218.8049912014076;1220.0239808153485;1238.19517313746;9109.3168012399;9570.42577445353;9574.329796914219;9676.709698709032;9870.851937220947;9845.753856153582;10033.448160351178;10043.19654427646;10044.04581564752;10045.547950342234;2154.202944910385;2194.4075099723145;2196.670499425091;2199.3951663292564;2200.4388880835445;2118.8410869184872;2132.76539580646;2139.9786002139936;2153.257126291427;2163.210428193706;2081.812636862682;2136.316378758798;2141.1970511058353;2151.4621344663833;2151.8170955468804;2045.3454894433787;2046.6316063108634;2058.557410156816;2061.2167376396874;2068.4518602570256;1698.1169791708367;1750.5448583368288;2017.0620661392377;2065.3390914907236;2078.6570215914358;9406.200472959807;9632.084951929555;9641.132298093205;9679.951600241953;9696.272779541563;5055.949440505621;5254.264402983547;5277.208418737182;5285.207218917155;5288.92066619001;3167.7782555221143;3201.9679803202134;3265.314284000363;3280.3931272714385;3299.2411745298477;1099.0987390339924;1099.483242875847;1103.9448027598587;1111.4387234446633;1121.9887801122047;13826.23955682437;13836.23900685462;13858.099223550538;13883.375248113758;13946.442142314296;4550.271956486946;4619.353290539327;4771;4812.06164797861;4828.565429111327;10730;10735.355878647306;10738.838917416246;10745.462726863625;10752.247342686092;5243.711595862264;5244.056069907377;5248.711320877388;5255.106631872591;5277.577793776489;4607.6083532900075;4731.361266229083;4817.710937343771;4834.444038935497;4876.975615121902;3744.8314825832904;3789.2232092420986;3808.847646094125;3896.0649444133205;3908.785016824102;1108.5560461501059;1113.1540029577418;1123.1015187849687;1125.7467069909205;1135.0522313867848;654.9181352330959;669.1969636436296;675.598019178588;684.2780866186122;689.3313485918651;5514.6691198527415;5550.4449555044175;5599.160125981135;5644.481466886783;5833.008388573952;798.5288679679018;814.8981377327834;841.3984001439001;842.0905422144069;847.9533625650525;3392.1350055736125;3477.443609022544;3538.5576802899636;3587.5694916610173;3620.8008559528953;12250.203736757083;12671.113022088366;12771.361431928366;12822.871771282167;12847.293398863152;11861.940690296493;12130.575429859913;12297;12559.686007849694;12626.494940202288;8862.86705699415;8868.379213454997;8921.776955576162;9191.770205744777;9192.402493837879;5804.9709751452665;5909.793157239476;5971.402859713994;6213.9067913982235;6471.158749362553;11462.94268528652;11471.598494052669;11569.01663358624;11654.184207105422;11803.350815705218;11468.4265786712;11694.590689325832;11812.586559470377;11919.46362413676;12162.513499459923;8049.315808156372;8214.876776848472;8272.793180170544;8325.833483330178;8332.541710205996;9297.395669281475;9312.534373281173;9364.906350936404;9374.812503750023;9383.483908385104;8083;8135.959320203361;8334.791630209293;8454.281386082252;8510;7966.800829979297;8014.198580142172;8030.5181689098845;8177.918220817954;8307.958460207661;7121.287871213044;7134.072570565793;7140.107486564179;7232.63836808147;7258.891116633149;5084.237364395371;5144.151215049475;5168.767405466688;5242.5281724644965;5251.9474805252985;5119.129747942784;5236.450172731808;5384.515393614593;5404.027275090364;5429.104197807317 08:54:20 INFO - PID 7095 | |4;prototype.html;372.76515795049113;384.8249046683759;386.8413950280382;390.2838291734665;397.61431411530816;5582.162675598663;5616.803411880585;5636.943630563693;5640.238567793347;5649.531121908308;5455.5908306877045;5489.286392768944;5502.202180683798;5530.861728456791;5548.44515548445;4365.541618130098;4370.781460926957;4388.626966707834;4397.318415645564;4398.736075835444;4376.234159022174;4378.321360189176;4379.146066517031;4395.186890425265;4426.756528390937;4247.8300867965245;4337.739735615857;4367.650587952972;4389.495208051083;4390.846320378788;4351.717138385995;4359.564043595647;4366.956330436687;4371.650267978554;4382.386465894777;3939.684825213976;3957.56466788653;3958.920821583581;3960.9009774755573;3968;5172.19830926207;5432.592555558309;5440.183972404131;5446.455354464561;5452.672839629595;5090.821821236276;5121.359830021247;5126.154184559543;5126.794928202868;5133.101707201225;5872.7357268923;5884.175905469276;5888.97055514724;5892.793752218695;5908.881822363572;4206.0326124991425;4352.717073390219;4354.346847972798;4368.934465983013;4383.890402739925;5875.383084776123;6088.573799834014;6123.448889599913;6159.137720719058;6192.473639740628;4400.515943246241;4499.257622492318;4511.533751530766;4513.458384993756;4534.035231421588;4561.452625684873;4567.132244873464;4569.543045695404;4579;4583.358329833826;4643.44278686553;4903.41159060915;5078.720670363092;5095.878906640533;5107.565856902131;5854.063349864001;5891.558133140032;5894.882102358015;5930.762769489258;5960.850978725566;1462.978055329171;1484.5991582272725;1486.702659468089;1489.8137732783402;1489.9255037248095;941.5762906692016;995.6764051683232;997.4264797741328;999.8450240212778;1002.5638847101534;5186.455422180692;5187.22483471341;5194;5207.765650545734;5226.137687281632;6147.815565533041;6163.537734669918;6177.444030037228;6179.589959915636;6183.81448556544;4850.393700787402;5082.466341034138;5186.740662966837;5191.792328306901;5205.193195054772;3221.5650887130405;3253.219227385458;3264.5592844965627;3266.1344743642953;3273.379677059823;5445.591580631469;5644.6330988485615;5645.350784659817;5652.152177173457;5654.74553645087;6140;6208.50331973441;6240.126382306481;6255.624662520263;6274.372562743781;5603.439656034446;5631.239782629293;5649.802256920988;5660.320761508646;5663.716814159276;5963.314218864886;6057.939420605738;6078.179445774764;6114.419130182626;6126.938730612636;5975.043992961106;6007.579469437097;6016.87966240664;6019.668918209541;6024.156618073561;5321.36143662763;5405.459454054563;5477.287952566141;5567.552436366493;5639.520640745419;4141.213169497786;4165.562615925284;4170.979145104255;4176.185643799551;4185.4513829883135;5859.326177489473;5959.67221802805;6057.394260573908;6066.241719785027;6084.227778777186;5745.712714364181;5788.247527821524;5845.912311315248;5851.590388672922;5866.735996880236;5831.1544826000845;5857.560682948882;5860.677662728421;5875.441833025856;5892;5599.300087489064;5754.769809207585;5756.280464941882;5759.56803239767;5791.131330300489;5877.324107727495;5886.264216972879;5887.911681324869;5909.468147866713;5915.556333275108;5381.8923621526565;5747.597668163188;5749.511291540266;5770.942290577041;5806.82579522615 08:54:20 INFO - PID 7095 | |5;yui.html;662.5891946992865;669.8693754717829;671.83540032692;681.543365944817;688.6419062087713;10676.35941843489;11525.596604118868;11543.480543375546;11544.595939142131;11572.363520006418;11423.200375973685;11563.24838885474;11858.940705296462;11874.287542747441;12213.755724885497;810.5015415519457;814.1492140712969;825.7976795685065;827.6399766101765;831.1439217605875;832.937529685273;842.6166094427051;844.3203221406765;844.4595458906305;845.3490812074699;872.215006494154;872.2890843962182;873.772819067044;875.6191056890241;879.705298724928;862.4307956748515;865.35098675993;868.071163854679;868.9131086891324;872.489593587752;641.8459569703284;641.9775307864203;643.9871202575922;644.4972921121532;646.4828137490036;12509.186902851377;12651.051171162107;12894.935525322408;12934.223946563236;12960.287184204864;12227.572034978823;13323.733525329537;13834;14038.71922561543;14130.50543230982;9630;9742.853857192147;9846.704598861974;10090.394576325443;10461.476926153662;2623.8819253133656;2639.300585344866;2645.193216069098;2650.3639126609473;2717.361420066283;56902.14646780302;58103.70948145232;67386.32613673898;68644.31355686429;69744.3025569748;10359.564026760485;10729.141668666489;10775.78448431027;10795;10893.400862952456;20625.587488250152;20956.58086838285;20963.79036209649;20969.475763106046;21042.789572104084;6663.267040625527;6694.866102677919;6722.731090756412;6774.559653622498;7118.466115041289;3261.1031966209484;3312.254742682877;3347.4644056951256;3394.8302584870657;3449.9482507762405;3414.726821854246;3437.4500079987583;3437.6218615952225;3460.463628137643;3507.2108775525303;662.7746566167526;663.9302873198342;668.1748041169152;683.9931600684029;685.044363113454;508.10826998617927;528.7594144664246;532.2761044978826;534.2627174499166;545.5444703672399;7908.090569584571;7952.602369881482;8118.176361751411;8600.440971336842;8608.311335093178;516.9198774190006;539.0781763184998;539.4740128374882;546.2461802712311;546.2952790899695;3865.5168103987003;3867.8839634811;3892.065904182976;4039.293123703399;4067;59470;62139;62159.067613985826;64603.35396646067;64637.70724585482;54304.185437218475;54385.45614543883;54574.454255456934;55193.724031379585;57333.14000289999;48718.51281487282;48995.51004489909;49088.75455622699;49446.25830612543;49735.50264497309;7916.129225785274;8006.599670016592;8162.387820913574;8181.918180818354;8273.172682731678;25489;25718.87140564285;26319.34201644974;26469.867650662392;26976.595351070144;31698.366032679678;31928.84035579807;31948.520772188902;32016;32610.51084233691;9541.522923853918;9653.131218190396;9690.51547422612;9703.07820757027;9826.263030272616;10533.57865685364;10601;10711.839322410326;10783.24517283814;10940.124790016938;9094.317926155432;9109.954450227706;9154.58804353819;9242.537873106183;9310.255179585753;10054.64808731691;10061.547230374505;10075.496225188564;10111.949440252753;10193.082622564005;9750.171235444783;9858.30991830565;9937.950310248403;10032.899671003197;10279.126274266771;7004.614746188805;7208.35124838767;7248.927510725036;7283.344498995116;7298.051253337245;9884.604615815575;10124.291299608956;10141.746456338355;10187.796244074929;10591.682249532527 08:54:20 INFO - PID 7095 | __end_tp_report 08:54:20 INFO - PID 7095 | __start_cc_report 08:54:20 INFO - PID 7095 | _x_x_mozilla_cycle_collect,380 08:54:20 INFO - PID 7095 | __end_cc_report 08:54:20 INFO - PID 7095 | __startTimestamp1490284460724__endTimestamp 08:54:20 INFO - PID 7095 | 08:54:20 INFO - PID 7095 | ------- Summary: start ------- 08:54:20 INFO - PID 7095 | Number of tests: 6 08:54:20 INFO - PID 7095 | 08:54:20 INFO - PID 7095 | [#0] dojo.html Cycles:165 Average:5067.26 Median:5203.19 stddev:567.57 (10.9%) stddev-sans-first:537.33 08:54:20 INFO - PID 7095 | Values: 2672.8 2678.6 2682.1 2708.6 2715.9 5008.5 5083.7 5117.2 5160.2 5177.7 5116.5 5144.6 5171.9 5234.5 5241.7 4687.8 4718.0 4731.2 4753.1 4753.8 4798.5 4801.5 4807.6 4808.0 4821.8 4595.5 4643.1 4658.4 4719.6 4740.9 4695.1 4696.4 4709.3 4725.3 4756.2 4533.7 4612.3 4665.7 4682.5 4707.5 4956.8 5026.6 5057.9 5133.7 5159.1 5538.7 5562.0 5578.7 5583.2 5607.8 5591.8 5593.1 5595.7 5601.4 5605.8 5051.9 5100.1 5179.1 5191.2 5249.2 5690.4 5708.9 5733.4 5733.8 5750.2 5299.5 5318.5 5417.8 5454.6 5464.1 5359.6 5471.3 5472.0 5505.0 5522.8 5181.7 5476.5 5483.7 5486.5 5494.5 5387.6 5389.5 5389.9 5390.1 5392.7 4525.6 4530.7 4531.7 4534.8 4535.3 3973.0 3980.3 3980.9 3982.1 3985.6 4793.7 4801.1 4804.4 4805.4 4805.9 5490.2 5534.9 5544.5 5545.7 5546.8 4801.7 4801.7 4803.1 4807.8 4813.7 4834.3 4855.3 4867.0 4868.3 4896.3 5188.3 5189.6 5199.1 5199.2 5203.2 5429.2 5487.6 5534.1 5574.7 5578.1 5169.1 5174.8 5179.6 5197.3 5227.4 5468.5 5475.7 5476.3 5480.4 5534.9 5314.3 5362.7 5373.8 5531.3 5541.4 5230.1 5230.2 5239.7 5252.1 5336.7 5355.4 5362.9 5388.5 5427.9 5445.3 5241.5 5268.2 5299.3 5310.4 5362.6 5207.6 5256.0 5377.3 5393.2 5444.6 5166.4 5223.9 5292.4 5314.7 5323.0 08:54:20 INFO - PID 7095 | 08:54:20 INFO - PID 7095 | [#1] ext.html Cycles:180 Average:33727.48 Median:16780.24 stddev:52578.68 (313.3%) stddev-sans-first:52667.22 08:54:20 INFO - PID 7095 | Values: 566.1 625.7 643.5 1167.2 1172.7 32126.4 32685.3 32720.8 32746.3 32809.5 32829.2 33132.0 33168.0 33217.5 33318.5 7077.8 7218.7 7338.7 7509.2 7544.1 7476.6 7697.9 7743.4 7750.9 7758.8 7736.7 7799.5 7814.8 7816.7 7843.8 7766.1 7771.3 7798.5 7799.8 7801.6 7614.2 7666.6 7684.8 7691.2 7707.5 34952.0 35096.5 35195.5 35200.5 35279.8 2665.4 2666.4 2669.9 2682.1 2732.6 23964.4 24311.8 24487.6 24722.4 25047.6 2995.2 3001.8 3016.1 3032.6 3066.5 110071.4 111026.4 153049.0 153762.0 153992.2 36966.8 37243.4 37286.1 37368.6 40829.6 42828.4 42865.6 42965.0 43069.6 43070.6 12372.6 12504.1 12507.6 12542.4 12553.4 9995.9 10024.8 10046.8 10055.7 10093.6 12679.6 12863.0 12880.2 12942.0 13012.6 5348.5 5405.9 5427.4 5449.6 5457.1 807.7 809.6 841.8 852.5 866.8 19668.2 20577.6 21071.9 21111.5 21417.6 911.5 916.3 934.6 938.8 942.1 10589.9 10706.8 10913.3 11059.3 11206.0 228519.0 228607.0 228789.0 229459.0 230464.0 42187.0 42393.2 42478.6 42601.0 42638.6 1192.7 1227.1 1242.0 1242.9 1245.8 19755.3 19943.0 20852.2 20873.3 21068.4 31031.0 31098.5 31159.8 31180.7 31189.7 223855.0 224240.0 225195.0 225292.0 225733.0 27983.6 28041.0 28233.0 28516.3 28620.1 34581.7 34638.3 37095.6 37373.3 38363.8 27963.2 28336.3 28856.7 28959.4 29116.6 28074.3 28100.4 28303.6 28623.3 28648.1 30494.0 30912.7 31373.4 31539.5 31541.7 27322.2 27629.9 27673.0 27951.6 28751.0 20650.4 22613.1 22754.3 22836.7 22875.7 08:54:20 INFO - PID 7095 | 08:54:20 INFO - PID 7095 | [#2] jquery.html Cycles:180 Average:27127.20 Median:432.10 stddev:73393.75 (16985.4%) stddev-sans-first:73572.23 08:54:20 INFO - PID 7095 | Values: 411.3 424.7 426.4 437.8 445.6 16866.7 17017.9 17035.3 17385.0 17502.1 17544.2 17575.8 18395.8 18860.7 19066.9 5488.8 5629.9 5663.3 5712.2 5813.2 5569.4 5588.6 5594.1 5594.9 5624.3 5531.1 5563.5 5702.6 5714.8 5717.0 5648.7 5725.9 5745.6 5751.1 5773.9 5140.0 5195.1 5201.3 5227.0 5228.4 22171.8 22203.3 22669.8 22762.1 22868.4 1569.2 1573.8 1590.1 1606.5 1633.0 13592.6 14068.9 14250.7 14530.9 14567.7 1671.2 1679.7 1682.6 1692.8 1729.3 88029.0 89511.1 90345.5 91456.5 92159.0 10872.6 11109.9 11217.8 11242.6 11245.2 15438.6 15514.5 15533.1 15562.1 15635.5 7188.6 7402.7 7461.7 7602.2 7629.0 6820.2 6821.7 7004.3 7011.6 7032.8 6933.8 6967.3 7016.5 7048.9 7071.8 1990.1 1999.9 2026.8 2036.8 2172.4 827.9 839.9 868.8 883.5 886.5 16378.8 17382.7 17699.8 17835.0 17858.1 868.5 874.8 878.3 880.1 904.2 9125.2 9435.7 9652.3 9744.9 9840.5 440753.0 441072.0 441888.0 444271.0 449037.0 74927.0 76442.2 78452.2 89817.3 91629.0 1083.8 1088.0 1139.7 1146.7 1147.4 15735.7 16129.4 16629.2 16734.9 16799.5 31401.1 33671.8 39427.4 40235.6 41282.0 53670.0 53877.7 54149.5 54425.7 56235.0 7455.8 8325.9 8405.5 8431.3 8546.2 11398.9 11520.7 11632.1 12109.9 12116.0 10166.2 10274.6 10366.6 10390.3 10809.2 9950.6 10194.2 10203.3 10234.4 10284.7 9925.9 10013.9 10052.8 10326.0 10402.5 7647.5 7807.3 7909.9 7984.9 7991.2 10123.3 10129.4 10144.0 10306.5 10582.4 08:54:20 INFO - PID 7095 | 08:54:20 INFO - PID 7095 | [#3] mootools.html Cycles:180 Average:6124.64 Median:4613.48 stddev:3876.47 (84.0%) stddev-sans-first:3869.63 08:54:20 INFO - PID 7095 | Values: 1192.6 1216.2 1218.8 1220.0 1238.2 9109.3 9570.4 9574.3 9676.7 9870.9 9845.8 10033.4 10043.2 10044.0 10045.5 2154.2 2194.4 2196.7 2199.4 2200.4 2118.8 2132.8 2140.0 2153.3 2163.2 2081.8 2136.3 2141.2 2151.5 2151.8 2045.3 2046.6 2058.6 2061.2 2068.5 1698.1 1750.5 2017.1 2065.3 2078.7 9406.2 9632.1 9641.1 9680.0 9696.3 5055.9 5254.3 5277.2 5285.2 5288.9 3167.8 3202.0 3265.3 3280.4 3299.2 1099.1 1099.5 1103.9 1111.4 1122.0 13826.2 13836.2 13858.1 13883.4 13946.4 4550.3 4619.4 4771.0 4812.1 4828.6 10730.0 10735.4 10738.8 10745.5 10752.2 5243.7 5244.1 5248.7 5255.1 5277.6 4607.6 4731.4 4817.7 4834.4 4877.0 3744.8 3789.2 3808.8 3896.1 3908.8 1108.6 1113.2 1123.1 1125.7 1135.1 654.9 669.2 675.6 684.3 689.3 5514.7 5550.4 5599.2 5644.5 5833.0 798.5 814.9 841.4 842.1 848.0 3392.1 3477.4 3538.6 3587.6 3620.8 12250.2 12671.1 12771.4 12822.9 12847.3 11861.9 12130.6 12297.0 12559.7 12626.5 8862.9 8868.4 8921.8 9191.8 9192.4 5805.0 5909.8 5971.4 6213.9 6471.2 11462.9 11471.6 11569.0 11654.2 11803.4 11468.4 11694.6 11812.6 11919.5 12162.5 8049.3 8214.9 8272.8 8325.8 8332.5 9297.4 9312.5 9364.9 9374.8 9383.5 8083.0 8136.0 8334.8 8454.3 8510.0 7966.8 8014.2 8030.5 8177.9 8308.0 7121.3 7134.1 7140.1 7232.6 7258.9 5084.2 5144.2 5168.8 5242.5 5251.9 5119.1 5236.5 5384.5 5404.0 5429.1 08:54:20 INFO - PID 7095 | 08:54:20 INFO - PID 7095 | [#4] prototype.html Cycles:180 Average:4892.38 Median:5466.44 stddev:1405.53 (25.7%) stddev-sans-first:1367.92 08:54:20 INFO - PID 7095 | Values: 372.8 384.8 386.8 390.3 397.6 5582.2 5616.8 5636.9 5640.2 5649.5 5455.6 5489.3 5502.2 5530.9 5548.4 4365.5 4370.8 4388.6 4397.3 4398.7 4376.2 4378.3 4379.1 4395.2 4426.8 4247.8 4337.7 4367.7 4389.5 4390.8 4351.7 4359.6 4367.0 4371.7 4382.4 3939.7 3957.6 3958.9 3960.9 3968.0 5172.2 5432.6 5440.2 5446.5 5452.7 5090.8 5121.4 5126.2 5126.8 5133.1 5872.7 5884.2 5889.0 5892.8 5908.9 4206.0 4352.7 4354.3 4368.9 4383.9 5875.4 6088.6 6123.4 6159.1 6192.5 4400.5 4499.3 4511.5 4513.5 4534.0 4561.5 4567.1 4569.5 4579.0 4583.4 4643.4 4903.4 5078.7 5095.9 5107.6 5854.1 5891.6 5894.9 5930.8 5960.9 1463.0 1484.6 1486.7 1489.8 1489.9 941.6 995.7 997.4 999.8 1002.6 5186.5 5187.2 5194.0 5207.8 5226.1 6147.8 6163.5 6177.4 6179.6 6183.8 4850.4 5082.5 5186.7 5191.8 5205.2 3221.6 3253.2 3264.6 3266.1 3273.4 5445.6 5644.6 5645.4 5652.2 5654.7 6140.0 6208.5 6240.1 6255.6 6274.4 5603.4 5631.2 5649.8 5660.3 5663.7 5963.3 6057.9 6078.2 6114.4 6126.9 5975.0 6007.6 6016.9 6019.7 6024.2 5321.4 5405.5 5477.3 5567.6 5639.5 4141.2 4165.6 4171.0 4176.2 4185.5 5859.3 5959.7 6057.4 6066.2 6084.2 5745.7 5788.2 5845.9 5851.6 5866.7 5831.2 5857.6 5860.7 5875.4 5892.0 5599.3 5754.8 5756.3 5759.6 5791.1 5877.3 5886.3 5887.9 5909.5 5915.6 5381.9 5747.6 5749.5 5770.9 5806.8 08:54:20 INFO - PID 7095 | 08:54:20 INFO - PID 7095 | [#5] yui.html Cycles:180 Average:13623.36 Median:54344.82 stddev:17297.69 (31.8%) stddev-sans-first:17318.84 08:54:20 INFO - PID 7095 | Values: 662.6 669.9 671.8 681.5 688.6 10676.4 11525.6 11543.5 11544.6 11572.4 11423.2 11563.2 11858.9 11874.3 12213.8 810.5 814.1 825.8 827.6 831.1 832.9 842.6 844.3 844.5 845.3 872.2 872.3 873.8 875.6 879.7 862.4 865.4 868.1 868.9 872.5 641.8 642.0 644.0 644.5 646.5 12509.2 12651.1 12894.9 12934.2 12960.3 12227.6 13323.7 13834.0 14038.7 14130.5 9630.0 9742.9 9846.7 10090.4 10461.5 2623.9 2639.3 2645.2 2650.4 2717.4 56902.1 58103.7 67386.3 68644.3 69744.3 10359.6 10729.1 10775.8 10795.0 10893.4 20625.6 20956.6 20963.8 20969.5 21042.8 6663.3 6694.9 6722.7 6774.6 7118.5 3261.1 3312.3 3347.5 3394.8 3449.9 3414.7 3437.5 3437.6 3460.5 3507.2 662.8 663.9 668.2 684.0 685.0 508.1 528.8 532.3 534.3 545.5 7908.1 7952.6 8118.2 8600.4 8608.3 516.9 539.1 539.5 546.2 546.3 3865.5 3867.9 3892.1 4039.3 4067.0 59470.0 62139.0 62159.1 64603.4 64637.7 54304.2 54385.5 54574.5 55193.7 57333.1 48718.5 48995.5 49088.8 49446.3 49735.5 7916.1 8006.6 8162.4 8181.9 8273.2 25489.0 25718.9 26319.3 26469.9 26976.6 31698.4 31928.8 31948.5 32016.0 32610.5 9541.5 9653.1 9690.5 9703.1 9826.3 10533.6 10601.0 10711.8 10783.2 10940.1 9094.3 9110.0 9154.6 9242.5 9310.3 10054.6 10061.5 10075.5 10111.9 10193.1 9750.2 9858.3 9938.0 10032.9 10279.1 7004.6 7208.4 7248.9 7283.3 7298.1 9884.6 10124.3 10141.7 10187.8 10591.7 08:54:20 INFO - PID 7095 | -------- Summary: end -------- 08:54:20 INFO - PID 7095 | 08:54:21 INFO - TEST-INFO | 7095: exit 0 08:54:21 INFO - TEST-OK | dromaeo_css | took 1121164ms 08:54:21 INFO - TEST-START | kraken 08:54:21 INFO - operating with platform_type : linux_ 08:54:21 INFO - Initialising browser for kraken test... 08:54:21 INFO - TEST-INFO | started process 7473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp72cMjt/profile http://localhost:52222/getInfo.html) 08:54:26 INFO - PID 7473 | __metrics Screen width/height:1600/1200 08:54:26 INFO - PID 7473 | colorDepth:24 08:54:26 INFO - PID 7473 | Browser inner width/height: 1024/697 08:54:26 INFO - PID 7473 | __metrics 08:54:27 ERROR - PID 7473 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3388: TypeError: this.tabs is undefined 08:54:28 INFO - TEST-INFO | 7473: exit 0 08:54:28 INFO - Browser initialized. 08:54:28 INFO - Running cycle 1/1 for kraken test... 08:54:28 INFO - TEST-INFO | started process 7604 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp72cMjt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:40 INFO - PID 7604 | RSS: Main: 156139520 08:54:40 INFO - PID 7604 | 08:54:43 INFO - PID 7604 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52222/tests/kraken/driver.html?testName=audio-beat-detection) 08:54:44 INFO - PID 7604 | RSS: Main: 162099200 08:54:44 INFO - PID 7604 | 08:54:46 INFO - PID 7604 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52222/tests/kraken/driver.html?testName=audio-dft) 08:54:47 INFO - PID 7604 | RSS: Main: 160985088 08:54:47 INFO - PID 7604 | 08:54:50 INFO - PID 7604 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52222/tests/kraken/driver.html?testName=audio-fft) 08:54:51 INFO - PID 7604 | RSS: Main: 157417472 08:54:51 INFO - PID 7604 | 08:54:53 INFO - PID 7604 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52222/tests/kraken/driver.html?testName=audio-oscillator) 08:54:53 INFO - PID 7604 | RSS: Main: 158425088 08:54:53 INFO - PID 7604 | 08:54:55 INFO - PID 7604 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52222/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:54:56 INFO - PID 7604 | RSS: Main: 159059968 08:54:56 INFO - PID 7604 | 08:54:59 INFO - PID 7604 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52222/tests/kraken/driver.html?testName=imaging-darkroom) 08:55:00 INFO - PID 7604 | RSS: Main: 163766272 08:55:00 INFO - PID 7604 | 08:55:03 INFO - PID 7604 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52222/tests/kraken/driver.html?testName=imaging-desaturate) 08:55:04 INFO - PID 7604 | RSS: Main: 161611776 08:55:04 INFO - PID 7604 | 08:55:07 INFO - PID 7604 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52222/tests/kraken/driver.html?testName=json-parse-financial) 08:55:08 INFO - PID 7604 | RSS: Main: 162443264 08:55:08 INFO - PID 7604 | 08:55:09 INFO - PID 7604 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52222/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:55:10 INFO - PID 7604 | RSS: Main: 163123200 08:55:10 INFO - PID 7604 | 08:55:12 INFO - PID 7604 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:55:13 INFO - PID 7604 | RSS: Main: 162807808 08:55:13 INFO - PID 7604 | 08:55:15 INFO - PID 7604 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:55:15 INFO - PID 7604 | RSS: Main: 163553280 08:55:15 INFO - PID 7604 | 08:55:18 INFO - PID 7604 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:55:19 INFO - PID 7604 | RSS: Main: 164085760 08:55:19 INFO - PID 7604 | 08:55:22 INFO - PID 7604 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:55:23 INFO - PID 7604 | RSS: Main: 163606528 08:55:23 INFO - PID 7604 | 08:55:25 INFO - PID 7604 | Cycle 1(1): loaded http://localhost:52222/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52222/tests/kraken/driver.html?testName=ai-astar) 08:55:25 INFO - PID 7604 | RSS: Main: 165277696 08:55:25 INFO - PID 7604 | 08:55:25 INFO - PID 7604 | __start_tp_report 08:55:25 INFO - PID 7604 | _x_x_mozilla_page_load 08:55:25 INFO - PID 7604 | _x_x_mozilla_page_load_details 08:55:25 INFO - PID 7604 | |i|pagename|runs| 08:55:25 INFO - PID 7604 | |0;ai-astar;107;112;112;112;111;112;111;111;113;113 08:55:25 INFO - PID 7604 | |1;audio-beat-detection;150;129;127;165;125;128;126;125;152;124 08:55:25 INFO - PID 7604 | |2;audio-dft;165;166;168;171;169;168;165;165;163;171 08:55:25 INFO - PID 7604 | |3;audio-fft;77;76;76;109;76;75;75;75;94;75 08:55:25 INFO - PID 7604 | |4;audio-oscillator;85;85;104;88;84;85;103;86;84;111 08:55:25 INFO - PID 7604 | |5;imaging-gaussian-blur;113;114;114;114;117;114;114;115;114;114 08:55:25 INFO - PID 7604 | |6;imaging-darkroom;151;150;150;151;150;151;150;150;149;151 08:55:25 INFO - PID 7604 | |7;imaging-desaturate;96;96;94;99;95;95;95;95;95;96 08:55:25 INFO - PID 7604 | |8;json-parse-financial;68;68;69;71;71;71;71;70;70;71 08:55:25 INFO - PID 7604 | |9;json-stringify-tinderbox;55;55;55;56;55;55;56;56;55;56 08:55:25 INFO - PID 7604 | |10;stanford-crypto-aes;84;83;84;82;83;83;82;83;84;85 08:55:25 INFO - PID 7604 | |11;stanford-crypto-ccm;139;142;138;141;136;136;141;135;179;141 08:55:25 INFO - PID 7604 | |12;stanford-crypto-pbkdf2;199;200;197;196;203;196;199;201;187;185 08:55:25 INFO - PID 7604 | |13;stanford-crypto-sha256-iterative;72;72;72;75;73;72;73;73;78;72 08:55:25 INFO - PID 7604 | __end_tp_report 08:55:25 INFO - PID 7604 | __start_cc_report 08:55:25 INFO - PID 7604 | _x_x_mozilla_cycle_collect,871 08:55:25 INFO - PID 7604 | __end_cc_report 08:55:25 INFO - PID 7604 | __startTimestamp1490284525470__endTimestamp 08:55:25 INFO - PID 7604 | 08:55:25 INFO - PID 7604 | ------- Summary: start ------- 08:55:25 INFO - PID 7604 | Number of tests: 14 08:55:25 INFO - PID 7604 | 08:55:25 INFO - PID 7604 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:1.71 (1.5%) stddev-sans-first:0.78 08:55:25 INFO - PID 7604 | Values: 107.0 112.0 112.0 112.0 111.0 112.0 111.0 111.0 113.0 113.0 08:55:25 INFO - PID 7604 | 08:55:25 INFO - PID 7604 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:128.50 stddev:14.78 (11.5%) stddev-sans-first:14.66 08:55:25 INFO - PID 7604 | Values: 150.0 129.0 127.0 165.0 125.0 128.0 126.0 125.0 152.0 124.0 08:55:25 INFO - PID 7604 | 08:55:25 INFO - PID 7604 | [#2] audio-dft Cycles:10 Average:167.10 Median:168.00 stddev:2.73 (1.6%) stddev-sans-first:2.78 08:55:25 INFO - PID 7604 | Values: 165.0 166.0 168.0 171.0 169.0 168.0 165.0 165.0 163.0 171.0 08:55:25 INFO - PID 7604 | 08:55:25 INFO - PID 7604 | [#3] audio-fft Cycles:10 Average:80.80 Median:76.00 stddev:11.49 (15.1%) stddev-sans-first:12.10 08:55:25 INFO - PID 7604 | Values: 77.0 76.0 76.0 109.0 76.0 75.0 75.0 75.0 94.0 75.0 08:55:25 INFO - PID 7604 | 08:55:25 INFO - PID 7604 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:85.00 stddev:10.28 (12.1%) stddev-sans-first:10.63 08:55:25 INFO - PID 7604 | Values: 85.0 85.0 104.0 88.0 84.0 85.0 103.0 86.0 84.0 111.0 08:55:25 INFO - PID 7604 | 08:55:25 INFO - PID 7604 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:1.06 (0.9%) stddev-sans-first:1.01 08:55:25 INFO - PID 7604 | Values: 113.0 114.0 114.0 114.0 117.0 114.0 114.0 115.0 114.0 114.0 08:55:25 INFO - PID 7604 | 08:55:25 INFO - PID 7604 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 08:55:25 INFO - PID 7604 | Values: 151.0 150.0 150.0 151.0 150.0 151.0 150.0 150.0 149.0 151.0 08:55:25 INFO - PID 7604 | 08:55:25 INFO - PID 7604 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.50 stddev:1.35 (1.4%) stddev-sans-first:1.42 08:55:25 INFO - PID 7604 | Values: 96.0 96.0 94.0 99.0 95.0 95.0 95.0 95.0 95.0 96.0 08:55:25 INFO - PID 7604 | 08:55:25 INFO - PID 7604 | [#8] json-parse-financial Cycles:10 Average:70.00 Median:71.00 stddev:1.25 (1.8%) stddev-sans-first:1.09 08:55:25 INFO - PID 7604 | Values: 68.0 68.0 69.0 71.0 71.0 71.0 71.0 70.0 70.0 71.0 08:55:25 INFO - PID 7604 | 08:55:25 INFO - PID 7604 | [#9] json-stringify-tinderbox Cycles:10 Average:55.40 Median:55.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 08:55:25 INFO - PID 7604 | Values: 55.0 55.0 55.0 56.0 55.0 55.0 56.0 56.0 55.0 56.0 08:55:25 INFO - PID 7604 | 08:55:25 INFO - PID 7604 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.50 stddev:0.95 (1.1%) stddev-sans-first:0.97 08:55:25 INFO - PID 7604 | Values: 84.0 83.0 84.0 82.0 83.0 83.0 82.0 83.0 84.0 85.0 08:55:25 INFO - PID 7604 | 08:55:25 INFO - PID 7604 | [#11] stanford-crypto-ccm Cycles:10 Average:142.80 Median:141.00 stddev:12.96 (9.2%) stddev-sans-first:13.67 08:55:25 INFO - PID 7604 | Values: 139.0 142.0 138.0 141.0 136.0 136.0 141.0 135.0 179.0 141.0 08:55:25 INFO - PID 7604 | 08:55:25 INFO - PID 7604 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.30 Median:199.00 stddev:5.87 (2.9%) stddev-sans-first:6.14 08:55:25 INFO - PID 7604 | Values: 199.0 200.0 197.0 196.0 203.0 196.0 199.0 201.0 187.0 185.0 08:55:25 INFO - PID 7604 | 08:55:25 INFO - PID 7604 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:73.00 stddev:1.93 (2.6%) stddev-sans-first:2.00 08:55:25 INFO - PID 7604 | Values: 72.0 72.0 72.0 75.0 73.0 72.0 73.0 73.0 78.0 72.0 08:55:25 INFO - PID 7604 | -------- Summary: end -------- 08:55:25 INFO - PID 7604 | 08:55:26 INFO - TEST-INFO | 7604: exit 0 08:55:26 INFO - TEST-OK | kraken | took 65051ms 08:55:26 INFO - SUITE-END | took 1186s 08:55:27 INFO - Completed test suite (00:19:46) 08:55:27 INFO - javascript benchmark 08:55:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6573.953401074482, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2672.839629622224, 2678.5714285714284, 2682.10149599884, 2708.6072519484665, 2715.932101697457, 5008.49915008499, 5083.6949783013, 5117.155669314563, 5160.225966105086, 5177.741112944352, 5116.539511443969, 5144.614153938451, 5171.948280517194, 5234.50272224139, 5241.659292146008, 4687.789049492772, 4717.952820471803, 4731.195696731546, 4753.096911586805, 4753.809847606091, 4798.49615790344, 4801.519848015206, 4807.61539076873, 4808.038392321532, 4821.783019764119, 4595.517470665599, 4643.117807616542, 4658.394408726877, 4719.646026547988, 4740.905181896343, 4695.107929493385, 4696.436427628672, 4709.293605959099, 4725.338452616602, 4756.191447453906, 4533.682642215046, 4612.331211974279, 4665.743384113873, 4682.508336624674, 4707.482176960531, 4956.826511072131, 5026.623003274769, 5057.924131138036, 5133.691978481265, 5159.097157997373, 5538.695371754552, 5562.02664533705, 5578.665280083208, 5583.190437386556, 5607.803726869581, 5591.776328946838, 5593.133064374988, 5595.720213989325, 5601.411851755588, 5605.80379686709, 5051.898962020812, 5100.056489549445, 5179.14544100223, 5191.169412893919, 5249.186376111708, 5690.430956904359, 5708.885822283531, 5733.397993210736, 5733.77064917407, 5750.1949727038245, 5299.49654782795, 5318.468153184728, 5417.8103766367985, 5454.563634909197, 5464.0711079116645, 5359.624826262202, 5471.316085489314, 5472.042392581282, 5505.03661859173, 5522.806701765419, 5181.663191892515, 5476.479734425223, 5483.698396588226, 5486.506214440719, 5494.5054945054335, 5387.649802762808, 5389.487998640201, 5389.892202155935, 5390.110631745796, 5392.703401312887, 4525.570070843265, 4530.6602004849765, 4531.705439146445, 4534.750588717587, 4535.25168347219, 3972.960270397259, 3980.3034468967817, 3980.900477488028, 3982.1438390745548, 3985.6412922837085, 4793.664443488922, 4801.063792560487, 4804.375431193923, 4805.447373552086, 4805.927911081337, 5490.176473529003, 5534.916976245359, 5544.528715059185, 5545.694986775686, 5546.77812887488, 4801.735904525215, 4801.735904525215, 4803.135435621552, 4807.78364973577, 4813.663043586916, 4834.250691142878, 4855.271709243571, 4867.0, 4868.342773725572, 4896.265560165933, 5188.325517682677, 5189.636725429184, 5199.11615025439, 5199.246109314204, 5203.19350500673, 5429.212764149255, 5487.560995120461, 5534.142207957773, 5574.749136288796, 5578.135389014709, 5169.121249387688, 5174.767135478988, 5179.585633149263, 5197.324347834758, 5227.398849132398, 5468.4531546845, 5475.698836563868, 5476.288082549243, 5480.424555421783, 5534.86162845916, 5314.256004159498, 5362.65142765719, 5373.838784836461, 5531.2532808072, 5541.418151094077, 5230.058589453783, 5230.241614965885, 5239.659422137549, 5252.0546301664535, 5336.706481143419, 5355.410904800391, 5362.919556206738, 5388.54197393226, 5427.891442171213, 5445.346558412857, 5241.47585241488, 5268.1834315681135, 5299.33758280215, 5310.362756469249, 5362.597805164551, 5207.5833933286, 5256.027634887558, 5377.327834020747, 5393.244945707525, 5444.564434845123, 5166.4316925137455, 5223.947760522498, 5292.364916210079, 5314.707691077027, 5322.973385133049], "value": 5027.419845632391, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.1422944239478, 625.6746491824251, 643.5173619785161, 1167.16547668417, 1172.7068232941765, 32126.35747285053, 32685.346293074184, 32720.836395818016, 32746.345073098524, 32809.50785738216, 32829.17927051825, 33132.0, 33168.0, 33217.501737473896, 33318.50022249668, 7077.7522786702475, 7218.747343842967, 7338.70645174195, 7509.211532789061, 7544.132424771139, 7476.588787616679, 7697.884531732028, 7743.419243556756, 7750.922490775077, 7758.7672369828715, 7736.690532378698, 7799.493032952868, 7814.76555703327, 7816.687332506693, 7843.764687059369, 7766.06807183136, 7771.339436147934, 7798.454108212399, 7799.8440031199625, 7801.609919504059, 7614.2005089465365, 7666.578338191397, 7684.807879803049, 7691.192424795372, 7707.460477766558, 34951.9514414568, 35096.47355289673, 35195.472067919, 35200.47199291987, 35279.82360088209, 2665.3869609989615, 2666.386731051869, 2669.9466010679675, 2682.135542033578, 2732.5901114832736, 23964.40088997789, 24311.78441077939, 24487.632685509732, 24722.381940451633, 25047.62428563573, 2995.2362147652425, 3001.774866884992, 3016.1403999860154, 3032.5906002689794, 3066.47869862124, 110071.44964275208, 111026.44486777515, 153049.0, 153762.0, 153992.23003885022, 36966.815165924534, 37243.4413483798, 37286.06784830401, 37368.626313737055, 40829.59170408258, 42828.35757463641, 42865.57134428678, 42965.0, 43069.56930430718, 43070.56929430728, 12372.566960156351, 12504.124711270306, 12507.624771256877, 12542.372881355896, 12553.435095420728, 9995.900040999642, 10024.79950400988, 10046.799064018825, 10055.69832905014, 10093.596256149818, 12679.556215532411, 12863.0, 12880.190949697402, 12942.0, 13012.609621711365, 5348.465153484621, 5405.918911216335, 5427.43011983744, 5449.64577302474, 5457.126859702428, 807.6809660184194, 809.5871105736117, 841.8105926166563, 852.4885068958699, 866.7789713623112, 19668.21327146898, 20577.58844823125, 21071.894640527007, 21111.472213194487, 21417.57164856694, 911.4941207629696, 916.2669864108686, 934.5887809363858, 938.8122375524786, 942.0532364973158, 10589.894101059044, 10706.839397408889, 10913.345199287909, 11059.272505669487, 11206.0, 228519.0, 228607.0, 228789.0, 229459.0, 230464.0, 42187.0, 42393.15213695709, 42478.57521424808, 42601.0, 42638.57361426346, 1192.6642160779809, 1227.1226073357413, 1241.9937900310622, 1242.9067819913723, 1245.7570773699224, 19755.308564200182, 19943.0, 20852.214880322892, 20873.26943556968, 21068.367948961557, 31031.0, 31098.53352199764, 31159.84420077885, 31180.688193118687, 31189.68810311868, 223855.0, 224240.0, 225195.0, 225292.0, 225733.0, 27983.58024629673, 28041.0, 28233.0, 28516.287092822844, 28620.14139575816, 34581.65418345885, 34638.30723385569, 37095.62904370922, 37373.2525349486, 38363.80818095891, 27963.161105166877, 28336.291592710346, 28856.71143288624, 28959.42081158407, 29116.56325155082, 28074.2981425466, 28100.43799124047, 28303.575446368734, 28623.284417889718, 28648.14055578336, 30494.0, 30912.69087309188, 31373.372532549678, 31539.52690709595, 31541.684583153874, 27322.180334589993, 27629.861850690617, 27673.0, 27951.580726288714, 28751.0, 20650.380488585368, 22613.07788837967, 22754.31737047891, 22836.657450138595, 22875.656865147368], "value": 14867.164077176622, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.2843652045438, 424.7480146609652, 426.4349736599007, 437.763607651868, 445.56112229454004, 16866.66266674666, 17017.91744429123, 17035.318587256494, 17385.0, 17502.12489375531, 17544.210510527024, 17575.82424175758, 18395.81604183958, 18860.717089243637, 19066.904665476653, 5488.780448782044, 5629.915551266724, 5663.348714897798, 5712.171735098408, 5813.157092221625, 5569.443055694418, 5588.552915766729, 5594.104943209088, 5594.944050559503, 5624.268845050137, 5531.115021596545, 5563.471470210344, 5702.629329093616, 5714.771409143629, 5716.971415142919, 5648.74580643872, 5725.885482290372, 5745.569082318801, 5751.079827227644, 5773.855653608673, 5140.0, 5195.116830138885, 5201.297824793643, 5226.97386513065, 5228.424873263938, 22171.778282217132, 22203.333899983027, 22669.773302267095, 22762.089516419488, 22868.428289292733, 1569.2310767723848, 1573.834747351523, 1590.1174847959378, 1606.4859245041591, 1633.0365084600144, 13592.592222233348, 14068.912002148842, 14250.714985700331, 14530.92734536331, 14567.708645827024, 1671.189473105543, 1679.6808606364752, 1682.6214101827113, 1692.7968643762704, 1729.2909906938096, 88029.0, 89511.10488895093, 90345.54827225888, 91456.54271728665, 92159.0, 10872.565097396173, 11109.888901111048, 11217.775644487065, 11242.606508772154, 11245.212835101463, 15438.614034649, 15514.45699400538, 15533.145676987875, 15562.144082075594, 15635.452759153375, 7188.6046267455795, 7402.703891844373, 7461.738839140604, 7602.201768814305, 7629.0, 6820.181578210647, 6821.691787382964, 7004.334588214111, 7011.579305241702, 7032.789016329519, 6933.826654333581, 6967.33810288032, 7016.473764467685, 7048.859022819515, 7071.7878463646175, 1990.114399092419, 1999.8800071995727, 2026.8378529717588, 2036.8472364572717, 2172.4351668566287, 827.8716798896181, 839.9076101628816, 868.8132051608808, 883.5289243409779, 886.5035580075179, 16378.836211637969, 17382.739258911126, 17699.823001770073, 17835.0, 17858.107094645216, 868.5092922498768, 874.7900503879023, 878.3061381508664, 880.0935036911991, 904.1862323908535, 9125.224355929688, 9435.716928492157, 9652.27607929408, 9744.902550974399, 9840.507974601242, 440753.0, 441072.0, 441888.0, 444271.0, 449037.0, 74927.0, 76442.23557764351, 78452.21547784563, 89817.34977318536, 91629.0, 1083.8320060390652, 1088.0370871778375, 1139.6524060161564, 1146.7305183281921, 1147.3632134165618, 15735.685286293981, 16129.435469758502, 16629.168541573115, 16734.916325418297, 16799.496015119566, 31401.11593304409, 33671.831640841636, 39427.40858887062, 40235.59764402318, 41282.0, 53669.97475189298, 53877.73061134669, 54149.45850541444, 54425.72787136039, 56235.0, 7455.813604659927, 8325.875111873447, 8405.53769542681, 8431.28334091609, 8546.188112129337, 11398.94300528492, 11520.654380368602, 11632.069434445055, 12109.878901210875, 12116.0, 10166.18670506343, 10274.640387586398, 10366.637167699095, 10390.324628899098, 10809.243352965532, 9950.601975921172, 10194.235432342455, 10203.285769996326, 10234.437105959243, 10284.691459256233, 9925.851112233468, 10013.899861001297, 10052.849207262043, 10326.01902819231, 10402.531886065297, 7647.464677472523, 7807.258310460497, 7909.881351779843, 7984.920150798418, 7991.160928102466, 10123.341982771097, 10129.392236465836, 10144.0, 10306.536205870603, 10582.365058096539], "value": 8808.822176150645, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1192.6302846117703, 1216.2276954134127, 1218.8049912014076, 1220.0239808153485, 1238.19517313746, 9109.3168012399, 9570.42577445353, 9574.329796914219, 9676.709698709032, 9870.851937220947, 9845.753856153582, 10033.448160351178, 10043.19654427646, 10044.04581564752, 10045.547950342234, 2154.202944910385, 2194.4075099723145, 2196.670499425091, 2199.3951663292564, 2200.4388880835445, 2118.8410869184872, 2132.76539580646, 2139.9786002139936, 2153.257126291427, 2163.210428193706, 2081.812636862682, 2136.316378758798, 2141.1970511058353, 2151.4621344663833, 2151.8170955468804, 2045.3454894433787, 2046.6316063108634, 2058.557410156816, 2061.2167376396874, 2068.4518602570256, 1698.1169791708367, 1750.5448583368288, 2017.0620661392377, 2065.3390914907236, 2078.6570215914358, 9406.200472959807, 9632.084951929555, 9641.132298093205, 9679.951600241953, 9696.272779541563, 5055.949440505621, 5254.264402983547, 5277.208418737182, 5285.207218917155, 5288.92066619001, 3167.7782555221143, 3201.9679803202134, 3265.314284000363, 3280.3931272714385, 3299.2411745298477, 1099.0987390339924, 1099.483242875847, 1103.9448027598587, 1111.4387234446633, 1121.9887801122047, 13826.23955682437, 13836.23900685462, 13858.099223550538, 13883.375248113758, 13946.442142314296, 4550.271956486946, 4619.353290539327, 4771.0, 4812.06164797861, 4828.565429111327, 10730.0, 10735.355878647306, 10738.838917416246, 10745.462726863625, 10752.247342686092, 5243.711595862264, 5244.056069907377, 5248.711320877388, 5255.106631872591, 5277.577793776489, 4607.6083532900075, 4731.361266229083, 4817.710937343771, 4834.444038935497, 4876.975615121902, 3744.8314825832904, 3789.2232092420986, 3808.847646094125, 3896.0649444133205, 3908.785016824102, 1108.5560461501059, 1113.1540029577418, 1123.1015187849687, 1125.7467069909205, 1135.0522313867848, 654.9181352330959, 669.1969636436296, 675.598019178588, 684.2780866186122, 689.3313485918651, 5514.6691198527415, 5550.4449555044175, 5599.160125981135, 5644.481466886783, 5833.008388573952, 798.5288679679018, 814.8981377327834, 841.3984001439001, 842.0905422144069, 847.9533625650525, 3392.1350055736125, 3477.443609022544, 3538.5576802899636, 3587.5694916610173, 3620.8008559528953, 12250.203736757083, 12671.113022088366, 12771.361431928366, 12822.871771282167, 12847.293398863152, 11861.940690296493, 12130.575429859913, 12297.0, 12559.686007849694, 12626.494940202288, 8862.86705699415, 8868.379213454997, 8921.776955576162, 9191.770205744777, 9192.402493837879, 5804.9709751452665, 5909.793157239476, 5971.402859713994, 6213.9067913982235, 6471.158749362553, 11462.94268528652, 11471.598494052669, 11569.01663358624, 11654.184207105422, 11803.350815705218, 11468.4265786712, 11694.590689325832, 11812.586559470377, 11919.46362413676, 12162.513499459923, 8049.315808156372, 8214.876776848472, 8272.793180170544, 8325.833483330178, 8332.541710205996, 9297.395669281475, 9312.534373281173, 9364.906350936404, 9374.812503750023, 9383.483908385104, 8083.0, 8135.959320203361, 8334.791630209293, 8454.281386082252, 8510.0, 7966.800829979297, 8014.198580142172, 8030.5181689098845, 8177.918220817954, 8307.958460207661, 7121.287871213044, 7134.072570565793, 7140.107486564179, 7232.63836808147, 7258.891116633149, 5084.237364395371, 5144.151215049475, 5168.767405466688, 5242.5281724644965, 5251.9474805252985, 5119.129747942784, 5236.450172731808, 5384.515393614593, 5404.027275090364, 5429.104197807317], "value": 4618.4026508275765, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.76515795049113, 384.8249046683759, 386.8413950280382, 390.2838291734665, 397.61431411530816, 5582.162675598663, 5616.803411880585, 5636.943630563693, 5640.238567793347, 5649.531121908308, 5455.5908306877045, 5489.286392768944, 5502.202180683798, 5530.861728456791, 5548.44515548445, 4365.541618130098, 4370.781460926957, 4388.626966707834, 4397.318415645564, 4398.736075835444, 4376.234159022174, 4378.321360189176, 4379.146066517031, 4395.186890425265, 4426.756528390937, 4247.8300867965245, 4337.739735615857, 4367.650587952972, 4389.495208051083, 4390.846320378788, 4351.717138385995, 4359.564043595647, 4366.956330436687, 4371.650267978554, 4382.386465894777, 3939.684825213976, 3957.56466788653, 3958.920821583581, 3960.9009774755573, 3968.0, 5172.19830926207, 5432.592555558309, 5440.183972404131, 5446.455354464561, 5452.672839629595, 5090.821821236276, 5121.359830021247, 5126.154184559543, 5126.794928202868, 5133.101707201225, 5872.7357268923, 5884.175905469276, 5888.97055514724, 5892.793752218695, 5908.881822363572, 4206.0326124991425, 4352.717073390219, 4354.346847972798, 4368.934465983013, 4383.890402739925, 5875.383084776123, 6088.573799834014, 6123.448889599913, 6159.137720719058, 6192.473639740628, 4400.515943246241, 4499.257622492318, 4511.533751530766, 4513.458384993756, 4534.035231421588, 4561.452625684873, 4567.132244873464, 4569.543045695404, 4579.0, 4583.358329833826, 4643.44278686553, 4903.41159060915, 5078.720670363092, 5095.878906640533, 5107.565856902131, 5854.063349864001, 5891.558133140032, 5894.882102358015, 5930.762769489258, 5960.850978725566, 1462.978055329171, 1484.5991582272725, 1486.702659468089, 1489.8137732783402, 1489.9255037248095, 941.5762906692016, 995.6764051683232, 997.4264797741328, 999.8450240212778, 1002.5638847101534, 5186.455422180692, 5187.22483471341, 5194.0, 5207.765650545734, 5226.137687281632, 6147.815565533041, 6163.537734669918, 6177.444030037228, 6179.589959915636, 6183.81448556544, 4850.393700787402, 5082.466341034138, 5186.740662966837, 5191.792328306901, 5205.193195054772, 3221.5650887130405, 3253.219227385458, 3264.5592844965627, 3266.1344743642953, 3273.379677059823, 5445.591580631469, 5644.6330988485615, 5645.350784659817, 5652.152177173457, 5654.74553645087, 6140.0, 6208.50331973441, 6240.126382306481, 6255.624662520263, 6274.372562743781, 5603.439656034446, 5631.239782629293, 5649.802256920988, 5660.320761508646, 5663.716814159276, 5963.314218864886, 6057.939420605738, 6078.179445774764, 6114.419130182626, 6126.938730612636, 5975.043992961106, 6007.579469437097, 6016.87966240664, 6019.668918209541, 6024.156618073561, 5321.36143662763, 5405.459454054563, 5477.287952566141, 5567.552436366493, 5639.520640745419, 4141.213169497786, 4165.562615925284, 4170.979145104255, 4176.185643799551, 4185.4513829883135, 5859.326177489473, 5959.67221802805, 6057.394260573908, 6066.241719785027, 6084.227778777186, 5745.712714364181, 5788.247527821524, 5845.912311315248, 5851.590388672922, 5866.735996880236, 5831.1544826000845, 5857.560682948882, 5860.677662728421, 5875.441833025856, 5892.0, 5599.300087489064, 5754.769809207585, 5756.280464941882, 5759.56803239767, 5791.131330300489, 5877.324107727495, 5886.264216972879, 5887.911681324869, 5909.468147866713, 5915.556333275108, 5381.8923621526565, 5747.597668163188, 5749.511291540266, 5770.942290577041, 5806.82579522615], "value": 4453.796956571655, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.5891946992865, 669.8693754717829, 671.83540032692, 681.543365944817, 688.6419062087713, 10676.35941843489, 11525.596604118868, 11543.480543375546, 11544.595939142131, 11572.363520006418, 11423.200375973685, 11563.24838885474, 11858.940705296462, 11874.287542747441, 12213.755724885497, 810.5015415519457, 814.1492140712969, 825.7976795685065, 827.6399766101765, 831.1439217605875, 832.937529685273, 842.6166094427051, 844.3203221406765, 844.4595458906305, 845.3490812074699, 872.215006494154, 872.2890843962182, 873.772819067044, 875.6191056890241, 879.705298724928, 862.4307956748515, 865.35098675993, 868.071163854679, 868.9131086891324, 872.489593587752, 641.8459569703284, 641.9775307864203, 643.9871202575922, 644.4972921121532, 646.4828137490036, 12509.186902851377, 12651.051171162107, 12894.935525322408, 12934.223946563236, 12960.287184204864, 12227.572034978823, 13323.733525329537, 13834.0, 14038.71922561543, 14130.50543230982, 9630.0, 9742.853857192147, 9846.704598861974, 10090.394576325443, 10461.476926153662, 2623.8819253133656, 2639.300585344866, 2645.193216069098, 2650.3639126609473, 2717.361420066283, 56902.14646780302, 58103.70948145232, 67386.32613673898, 68644.31355686429, 69744.3025569748, 10359.564026760485, 10729.141668666489, 10775.78448431027, 10795.0, 10893.400862952456, 20625.587488250152, 20956.58086838285, 20963.79036209649, 20969.475763106046, 21042.789572104084, 6663.267040625527, 6694.866102677919, 6722.731090756412, 6774.559653622498, 7118.466115041289, 3261.1031966209484, 3312.254742682877, 3347.4644056951256, 3394.8302584870657, 3449.9482507762405, 3414.726821854246, 3437.4500079987583, 3437.6218615952225, 3460.463628137643, 3507.2108775525303, 662.7746566167526, 663.9302873198342, 668.1748041169152, 683.9931600684029, 685.044363113454, 508.10826998617927, 528.7594144664246, 532.2761044978826, 534.2627174499166, 545.5444703672399, 7908.090569584571, 7952.602369881482, 8118.176361751411, 8600.440971336842, 8608.311335093178, 516.9198774190006, 539.0781763184998, 539.4740128374882, 546.2461802712311, 546.2952790899695, 3865.5168103987003, 3867.8839634811, 3892.065904182976, 4039.293123703399, 4067.0, 59470.0, 62139.0, 62159.067613985826, 64603.35396646067, 64637.70724585482, 54304.185437218475, 54385.45614543883, 54574.454255456934, 55193.724031379585, 57333.14000289999, 48718.51281487282, 48995.51004489909, 49088.75455622699, 49446.25830612543, 49735.50264497309, 7916.129225785274, 8006.599670016592, 8162.387820913574, 8181.918180818354, 8273.172682731678, 25489.0, 25718.87140564285, 26319.34201644974, 26469.867650662392, 26976.595351070144, 31698.366032679678, 31928.84035579807, 31948.520772188902, 32016.0, 32610.51084233691, 9541.522923853918, 9653.131218190396, 9690.51547422612, 9703.07820757027, 9826.263030272616, 10533.57865685364, 10601.0, 10711.839322410326, 10783.24517283814, 10940.124790016938, 9094.317926155432, 9109.954450227706, 9154.58804353819, 9242.537873106183, 9310.255179585753, 10054.64808731691, 10061.547230374505, 10075.496225188564, 10111.949440252753, 10193.082622564005, 9750.171235444783, 9858.30991830565, 9937.950310248403, 10032.899671003197, 10279.126274266771, 7004.614746188805, 7208.35124838767, 7248.927510725036, 7283.344498995116, 7298.051253337245, 9884.604615815575, 10124.291299608956, 10141.746456338355, 10187.796244074929, 10591.682249532527], "value": 5959.549820674181, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1567.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 112.0, 112.0, 112.0, 111.0, 112.0, 111.0, 111.0, 113.0, 113.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 129.0, 127.0, 165.0, 125.0, 128.0, 126.0, 125.0, 152.0, 124.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 168.0, 171.0, 169.0, 168.0, 165.0, 165.0, 163.0, 171.0], "value": 167.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 109.0, 76.0, 75.0, 75.0, 75.0, 94.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 104.0, 88.0, 84.0, 85.0, 103.0, 86.0, 84.0, 111.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 117.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 151.0, 150.0, 151.0, 150.0, 150.0, 149.0, 151.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 94.0, 99.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 71.0, 71.0, 71.0, 71.0, 70.0, 70.0, 71.0], "value": 70.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 56.0, 55.0, 55.0, 56.0, 56.0, 55.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 84.0, 82.0, 83.0, 83.0, 82.0, 83.0, 84.0, 85.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 142.0, 138.0, 141.0, 136.0, 136.0, 141.0, 135.0, 179.0, 141.0], "value": 142.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 200.0, 197.0, 196.0, 203.0, 196.0, 199.0, 201.0, 187.0, 185.0], "value": 196.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 75.0, 73.0, 72.0, 73.0, 73.0, 78.0, 72.0], "value": 73.2, "unit": "score"}]}]} 08:55:27 INFO - Return code: 0 08:55:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:55:27 ERROR - # TBPL SUCCESS # 08:55:27 INFO - Running post-action listener: _resource_record_post_action 08:55:27 INFO - [mozharness: 2017-03-23 15:55:27.295419Z] Finished run-tests step (success) 08:55:27 INFO - Running post-run listener: _resource_record_post_run 08:55:27 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 366497792; Read time: 16; Write time: 285428 08:55:27 INFO - TinderboxPrint: CPU usage
13.3% 08:55:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:55:27 INFO - TinderboxPrint: I/O write bytes / time
366,497,792 / 285,428 08:55:27 INFO - TinderboxPrint: CPU idle
8,322.2 (86.7%) 08:55:27 INFO - TinderboxPrint: CPU user
1,219.8 (12.7%) 08:55:27 INFO - TinderboxPrint: Swap in / out
0 / 0 08:55:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108060672; Read time: 0; Write time: 123860 08:55:27 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 258437120; Read time: 16; Write time: 161568 08:55:27 INFO - Running post-run listener: _upload_blobber_files 08:55:27 INFO - Blob upload gear active. 08:55:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:55:27 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 08:55:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:55:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:55:28 INFO - (blobuploader) - INFO - Open directory for files ... 08:55:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:55:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:55:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:29 INFO - (blobuploader) - INFO - Done attempting. 08:55:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:55:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:55:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:32 INFO - (blobuploader) - INFO - Done attempting. 08:55:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:55:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:55:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:33 INFO - (blobuploader) - INFO - Done attempting. 08:55:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:55:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:55:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:34 INFO - (blobuploader) - INFO - Done attempting. 08:55:34 INFO - (blobuploader) - INFO - Iteration through files over. 08:55:34 INFO - Return code: 0 08:55:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:55:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:55:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c22d5d21181a2c218d8382e0f780ac58bc43c8012dc2b6de1fcec05e0c39c7834600e8d01a01179e270f1f035db2b9de8f747bcdcf2651a9d9ad5ba06b6cc31f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62067eebad6cf058063b918547c610c3d792c97d279843f79a8ee733769ad74a36f971824cd69d806313d6d315adfeec653e7f802d29527d616b9d0bc5e9ac57", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ce3021fff3bc9364cee13ee74087cefe7079a646fcdc5d4937932e847ad68fea5be77c7c71f14686f71b65fdc325270701f49175ff665418efa727b88caf40c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c7d995125dfa11f8490b3ec938b34979790aa85d47df4c2aa523f7bd728a97c5c0f37a0e9da05c78c55b6d808c3c13a2bc1d0a6f0959a91fad75d1fe69d68d6"} 08:55:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:55:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:55:34 INFO - Contents: 08:55:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c22d5d21181a2c218d8382e0f780ac58bc43c8012dc2b6de1fcec05e0c39c7834600e8d01a01179e270f1f035db2b9de8f747bcdcf2651a9d9ad5ba06b6cc31f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62067eebad6cf058063b918547c610c3d792c97d279843f79a8ee733769ad74a36f971824cd69d806313d6d315adfeec653e7f802d29527d616b9d0bc5e9ac57", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ce3021fff3bc9364cee13ee74087cefe7079a646fcdc5d4937932e847ad68fea5be77c7c71f14686f71b65fdc325270701f49175ff665418efa727b88caf40c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c7d995125dfa11f8490b3ec938b34979790aa85d47df4c2aa523f7bd728a97c5c0f37a0e9da05c78c55b6d808c3c13a2bc1d0a6f0959a91fad75d1fe69d68d6"} 08:55:34 INFO - Running post-run listener: copy_logs_to_upload_dir 08:55:34 INFO - Copying logs to upload dir... 08:55:34 INFO - mkdir: /builds/slave/test/build/upload/logs 08:55:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.012742 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-03-23 08:55:34.067840) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 08:55:34.070850) ========= 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=4300f881736b422476174874000001bc-1490283270.328525-1073658576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c22d5d21181a2c218d8382e0f780ac58bc43c8012dc2b6de1fcec05e0c39c7834600e8d01a01179e270f1f035db2b9de8f747bcdcf2651a9d9ad5ba06b6cc31f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62067eebad6cf058063b918547c610c3d792c97d279843f79a8ee733769ad74a36f971824cd69d806313d6d315adfeec653e7f802d29527d616b9d0bc5e9ac57", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ce3021fff3bc9364cee13ee74087cefe7079a646fcdc5d4937932e847ad68fea5be77c7c71f14686f71b65fdc325270701f49175ff665418efa727b88caf40c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c7d995125dfa11f8490b3ec938b34979790aa85d47df4c2aa523f7bd728a97c5c0f37a0e9da05c78c55b6d808c3c13a2bc1d0a6f0959a91fad75d1fe69d68d6"} build_url:https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/JzD_l16pRq2tcIikmBN-2A/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c22d5d21181a2c218d8382e0f780ac58bc43c8012dc2b6de1fcec05e0c39c7834600e8d01a01179e270f1f035db2b9de8f747bcdcf2651a9d9ad5ba06b6cc31f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62067eebad6cf058063b918547c610c3d792c97d279843f79a8ee733769ad74a36f971824cd69d806313d6d315adfeec653e7f802d29527d616b9d0bc5e9ac57", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ce3021fff3bc9364cee13ee74087cefe7079a646fcdc5d4937932e847ad68fea5be77c7c71f14686f71b65fdc325270701f49175ff665418efa727b88caf40c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c7d995125dfa11f8490b3ec938b34979790aa85d47df4c2aa523f7bd728a97c5c0f37a0e9da05c78c55b6d808c3c13a2bc1d0a6f0959a91fad75d1fe69d68d6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 08:55:34.095817) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 08:55:34.096117) ========= 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=4300f881736b422476174874000001bc-1490283270.328525-1073658576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004365 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 08:55:34.179205) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 08:55:34.179548) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 08:55:34.179810) ========= ========= Total master_lag: 0.17 =========