builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-067 starttime: 1500975165.99 results: success (0) revision: 131e19a573e901fb4d01b471b11b7916420b9fee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-25 02:32:45.994024) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-25 02:32:45.994544) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-25 02:32:45.994865) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-25 02:32:46.133756) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 02:32:46.134067) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-25 02:32:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2017-07-25 02:32:48 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.370751 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 02:32:46.522059) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 02:32:46.522449) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018971 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 02:32:46.575355) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-07-25 02:32:46.575733) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 131e19a573e901fb4d01b471b11b7916420b9fee --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 131e19a573e901fb4d01b471b11b7916420b9fee --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=e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-25 02:32:48,367 truncating revision to first 12 chars 2017-07-25 02:32:48,367 Setting DEBUG logging. 2017-07-25 02:32:48,367 attempt 1/10 2017-07-25 02:32:48,367 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/131e19a573e9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-25 02:32:49,206 attempt 1/10 2017-07-25 02:32:50,271 current task status: no status available at this point. state: STARTED 2017-07-25 02:32:50,271 sleeping for 11.00s (attempt 1/10) 2017-07-25 02:33:01,282 attempt 2/10 2017-07-25 02:33:01,600 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-07-25 02:33:01,793 unpacking tar archive at: mozilla-central-131e19a573e9/testing/mozharness/ program finished with exit code 0 elapsedTime=13.707432 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-07-25 02:33:00.296630) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-25 02:33:00.297008) ========= script_repo_revision: 131e19a573e901fb4d01b471b11b7916420b9fee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-25 02:33:00.297466) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-25 02:33:00.297769) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-25 02:33:00.306874) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-07-25 02:33:00.307276) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:33:02 INFO - MultiFileLogger online at 20170725 02:33:02 in /builds/slave/test 02:33:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:33:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:33:02 INFO - {'append_to_log': False, 02:33:02 INFO - 'base_work_dir': '/builds/slave/test', 02:33:02 INFO - 'blob_upload_branch': 'Firefox', 02:33:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:33:02 INFO - 'branch': 'Firefox', 02:33:02 INFO - 'buildbot_json_path': 'buildprops.json', 02:33:02 INFO - 'code_coverage': False, 02:33:02 INFO - 'config_files': ('talos/linux_config.py',), 02:33:02 INFO - 'default_actions': ('clobber', 02:33:02 INFO - 'read-buildbot-config', 02:33:02 INFO - 'download-and-extract', 02:33:02 INFO - 'populate-webroot', 02:33:02 INFO - 'create-virtualenv', 02:33:02 INFO - 'install', 02:33:02 INFO - 'setup-mitmproxy', 02:33:02 INFO - 'run-tests'), 02:33:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:33:02 INFO - 'disable_ccov_upload': False, 02:33:02 INFO - 'download_minidump_stackwalk': True, 02:33:02 INFO - 'download_symbols': 'ondemand', 02:33:02 INFO - 'enable_stylo': False, 02:33:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:33:02 INFO - 'tooltool.py': '/tools/tooltool.py', 02:33:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:33:02 INFO - '/tools/misc-python/virtualenv.py')}, 02:33:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:33:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:33:02 INFO - 'gecko_profile': False, 02:33:02 INFO - 'gecko_profile_interval': 0, 02:33:02 INFO - 'installer_path': 'installer.exe', 02:33:02 INFO - 'log_level': 'info', 02:33:02 INFO - 'log_name': 'talos', 02:33:02 INFO - 'log_to_console': True, 02:33:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:33:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:33:02 INFO - 'opt_config_files': (), 02:33:02 INFO - 'pip_index': False, 02:33:02 INFO - 'suite': 'dromaeojs-e10s', 02:33:02 INFO - 'system_bits': '32', 02:33:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:33:02 INFO - 'title': 'talos-linux64-ix-067', 02:33:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:33:02 INFO - 'use_talos_json': True, 02:33:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:33:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:33:02 INFO - 'work_dir': 'build'} 02:33:02 INFO - [mozharness: 2017-07-25 09:33:02.214512Z] Running clobber step. 02:33:02 INFO - Running pre-action listener: _resource_record_pre_action 02:33:02 INFO - Running main action method: clobber 02:33:02 INFO - rmtree: /builds/slave/test/build 02:33:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:33:03 INFO - Running post-action listener: _resource_record_post_action 02:33:03 INFO - [mozharness: 2017-07-25 09:33:03.786986Z] Finished clobber step (success) 02:33:03 INFO - [mozharness: 2017-07-25 09:33:03.787088Z] Running read-buildbot-config step. 02:33:03 INFO - Running pre-action listener: _resource_record_pre_action 02:33:03 INFO - Running main action method: read_buildbot_config 02:33:03 INFO - Using buildbot properties: 02:33:03 INFO - { 02:33:03 INFO - "project": "", 02:33:03 INFO - "product": "firefox", 02:33:03 INFO - "who": "cbook@mozilla.com", 02:33:03 INFO - "installer_path": "public/build/target.tar.bz2", 02:33:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 02:33:03 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:33:03 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 02:33:03 INFO - "stage_platform": "linux64-stylosequential", 02:33:03 INFO - "basedir": "/builds/slave/test", 02:33:03 INFO - "buildnumber": 147, 02:33:03 INFO - "platform": "ubuntu64_hw_styloseq", 02:33:03 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:33:03 INFO - "slavebuilddir": "test", 02:33:03 INFO - "taskId": "BTn7Xpl3QmuaCGmdmiAukA", 02:33:03 INFO - "branch": "mozilla-central", 02:33:03 INFO - "script_repo_revision": "production", 02:33:03 INFO - "revision": "131e19a573e901fb4d01b471b11b7916420b9fee", 02:33:03 INFO - "slavename": "talos-linux64-ix-067", 02:33:03 INFO - "repo_path": "mozilla-central" 02:33:03 INFO - } 02:33:03 INFO - Finding installer, test and symbols from parent task. 02:33:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BTn7Xpl3QmuaCGmdmiAukA'}, attempt #1 02:33:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BTn7Xpl3QmuaCGmdmiAukA'}, attempt #1 02:33:04 INFO - Task dependencies: PYRS21koSy2w95sKktp1zA 02:33:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA'}, attempt #1 02:33:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/target.tar.bz2 02:33:05 INFO - Set test_url: https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/test_packages.json 02:33:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/target.crashreporter-symbols.zip 02:33:05 INFO - Running post-action listener: _resource_record_post_action 02:33:05 INFO - [mozharness: 2017-07-25 09:33:05.124776Z] Finished read-buildbot-config step (success) 02:33:05 INFO - [mozharness: 2017-07-25 09:33:05.124997Z] Running download-and-extract step. 02:33:05 INFO - Running pre-action listener: _resource_record_pre_action 02:33:05 INFO - Running main action method: download_and_extract 02:33:05 INFO - mkdir: /builds/slave/test/build/tests 02:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:05 INFO - trying https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/target.test_packages.json 02:33:05 INFO - Downloading https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:33:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:33:05 INFO - Downloaded 989 bytes. 02:33:05 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:33:05 INFO - Using the following test package requirements: 02:33:05 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:33:05 INFO - u'common': [u'target.common.tests.zip'], 02:33:05 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:33:05 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:33:05 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:33:05 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:33:05 INFO - u'mozbase': [u'target.common.tests.zip'], 02:33:05 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:33:05 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:33:05 INFO - u'web-platform': [u'target.common.tests.zip', 02:33:05 INFO - u'target.web-platform.tests.tar.gz'], 02:33:05 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:33:05 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:33:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/target.common.tests.zip 02:33:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:33:05 INFO - Fetch https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/target.common.tests.zip into memory 02:33:06 INFO - Content-Length response header: 72761467 02:33:06 INFO - Bytes received: 72761467 02:33:18 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:33:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/target.common.tests.zip 02:33:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:33:18 INFO - Fetch https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/target.common.tests.zip into memory 02:33:19 INFO - Content-Length response header: 72761467 02:33:19 INFO - Bytes received: 72761467 02:33:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/target.talos.tests.zip 02:33:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:33:31 INFO - Fetch https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/target.talos.tests.zip into memory 02:33:32 INFO - Content-Length response header: 14498976 02:33:32 INFO - Bytes received: 14498976 02:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:32 INFO - trying https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/target.tar.bz2 02:33:32 INFO - Downloading https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:33:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:33:33 INFO - Downloaded 61989015 bytes. 02:33:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/target.tar.bz2 02:33:33 INFO - mkdir: /builds/slave/test/properties 02:33:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:33:33 INFO - Writing to file /builds/slave/test/properties/build_url 02:33:33 INFO - Contents: 02:33:33 INFO - build_url:https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/target.tar.bz2 02:33:33 INFO - Running post-action listener: _resource_record_post_action 02:33:33 INFO - Running post-action listener: set_extra_try_arguments 02:33:33 INFO - [mozharness: 2017-07-25 09:33:33.754730Z] Finished download-and-extract step (success) 02:33:33 INFO - [mozharness: 2017-07-25 09:33:33.754829Z] Running populate-webroot step. 02:33:33 INFO - Running pre-action listener: _resource_record_pre_action 02:33:33 INFO - Running main action method: populate_webroot 02:33:33 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:33:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:33:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:33:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:33:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:33:33 INFO - 'tests': ['damp', 'tps']}, 02:33:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:33:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:33:33 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:33:33 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:33:33 INFO - 'other-e10s': {'tests': ['a11yr', 02:33:33 INFO - 'ts_paint', 02:33:33 INFO - 'tpaint', 02:33:33 INFO - 'sessionrestore', 02:33:33 INFO - 'sessionrestore_many_windows', 02:33:33 INFO - 'sessionrestore_no_auto_restore', 02:33:33 INFO - 'tabpaint']}, 02:33:33 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:33:33 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:33:33 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:33:33 INFO - 'talos_options': ['--mitmproxy', 02:33:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:33:33 INFO - '--firstNonBlankPaint'], 02:33:33 INFO - 'tests': ['quantum_pageload_google', 02:33:33 INFO - 'quantum_pageload_youtube', 02:33:33 INFO - 'quantum_pageload_amazon', 02:33:33 INFO - 'quantum_pageload_facebook']}, 02:33:33 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:33:33 INFO - 'talos_options': ['--stylo', 02:33:33 INFO - '--mitmproxy', 02:33:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:33:33 INFO - '--firstNonBlankPaint'], 02:33:33 INFO - 'tests': ['quantum_pageload_google', 02:33:33 INFO - 'quantum_pageload_youtube', 02:33:33 INFO - 'quantum_pageload_amazon', 02:33:33 INFO - 'quantum_pageload_facebook']}, 02:33:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:33:33 INFO - 'tsvgr_opacity', 02:33:33 INFO - 'tart', 02:33:33 INFO - 'tscrollx', 02:33:33 INFO - 'cart', 02:33:33 INFO - 'tsvg_static']}, 02:33:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:33:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:33:33 INFO - 'talos_options': ['--xperf_path', 02:33:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:33:33 INFO - 'tests': ['tp5n']}}} 02:33:33 INFO - Running post-action listener: _resource_record_post_action 02:33:33 INFO - [mozharness: 2017-07-25 09:33:33.762207Z] Finished populate-webroot step (success) 02:33:33 INFO - [mozharness: 2017-07-25 09:33:33.762298Z] Running create-virtualenv step. 02:33:33 INFO - Running pre-action listener: _resource_record_pre_action 02:33:33 INFO - Running main action method: create_virtualenv 02:33:33 INFO - Creating virtualenv /builds/slave/test/build/venv 02:33:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:33:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:33:33 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:33:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:33:33 INFO - Using real prefix '/usr' 02:33:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:33:34 INFO - Installing distribute.............................................................................................................................................................................................done. 02:33:36 INFO - Installing pip.................done. 02:33:36 INFO - Return code: 0 02:33:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:33:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:33:36 INFO - Reading from file tmpfile_stdout 02:33:36 INFO - Output received: 02:33:36 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:33:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:36 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/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 0x221b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2587eb0>, '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 0x2588db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2589240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:33:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:33:36 INFO - Using env: {'DISPLAY': ':0', 02:33:36 INFO - 'HOME': '/home/cltbld', 02:33:36 INFO - 'LANG': 'en_US.UTF-8', 02:33:36 INFO - 'LANGUAGE': 'en_US:en', 02:33:36 INFO - 'LOGNAME': 'cltbld', 02:33:36 INFO - 'MAIL': '/var/mail/cltbld', 02:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:36 INFO - 'MOZ_NO_REMOTE': '1', 02:33:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:36 INFO - 'NO_EM_RESTART': '1', 02:33:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:36 INFO - 'PWD': '/builds/slave/test', 02:33:36 INFO - 'SHELL': '/bin/bash', 02:33:36 INFO - 'SHLVL': '1', 02:33:36 INFO - 'TERM': 'linux', 02:33:36 INFO - 'TMOUT': '86400', 02:33:36 INFO - 'USER': 'cltbld', 02:33:36 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362', 02:33:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:36 INFO - '_': '/tools/buildbot/bin/python'} 02:33:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:33:36 INFO - Cleaning up... 02:33:36 INFO - Return code: 0 02:33:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:36 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/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 0x221b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2587eb0>, '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 0x2588db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2589240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:33:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:33:36 INFO - Using env: {'DISPLAY': ':0', 02:33:36 INFO - 'HOME': '/home/cltbld', 02:33:36 INFO - 'LANG': 'en_US.UTF-8', 02:33:36 INFO - 'LANGUAGE': 'en_US:en', 02:33:36 INFO - 'LOGNAME': 'cltbld', 02:33:36 INFO - 'MAIL': '/var/mail/cltbld', 02:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:36 INFO - 'MOZ_NO_REMOTE': '1', 02:33:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:36 INFO - 'NO_EM_RESTART': '1', 02:33:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:36 INFO - 'PWD': '/builds/slave/test', 02:33:36 INFO - 'SHELL': '/bin/bash', 02:33:36 INFO - 'SHLVL': '1', 02:33:36 INFO - 'TERM': 'linux', 02:33:36 INFO - 'TMOUT': '86400', 02:33:36 INFO - 'USER': 'cltbld', 02:33:36 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362', 02:33:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:36 INFO - '_': '/tools/buildbot/bin/python'} 02:33:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:36 INFO - Downloading/unpacking psutil>=3.1.1 02:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:33:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:33:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:33:38 INFO - Installing collected packages: psutil 02:33:38 INFO - Running setup.py install for psutil 02:33:38 INFO - building 'psutil._psutil_linux' extension 02:33:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:33:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:33:38 INFO - building 'psutil._psutil_posix' extension 02:33:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:33:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:33:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:33:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:33:38 INFO - Successfully installed psutil 02:33:38 INFO - Cleaning up... 02:33:38 INFO - Return code: 0 02:33:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:38 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/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 0x221b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2587eb0>, '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 0x2588db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2589240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:33:38 INFO - Using env: {'DISPLAY': ':0', 02:33:38 INFO - 'HOME': '/home/cltbld', 02:33:38 INFO - 'LANG': 'en_US.UTF-8', 02:33:38 INFO - 'LANGUAGE': 'en_US:en', 02:33:38 INFO - 'LOGNAME': 'cltbld', 02:33:38 INFO - 'MAIL': '/var/mail/cltbld', 02:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:38 INFO - 'MOZ_NO_REMOTE': '1', 02:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:38 INFO - 'NO_EM_RESTART': '1', 02:33:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:38 INFO - 'PWD': '/builds/slave/test', 02:33:38 INFO - 'SHELL': '/bin/bash', 02:33:38 INFO - 'SHLVL': '1', 02:33:38 INFO - 'TERM': 'linux', 02:33:38 INFO - 'TMOUT': '86400', 02:33:38 INFO - 'USER': 'cltbld', 02:33:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362', 02:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:38 INFO - '_': '/tools/buildbot/bin/python'} 02:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:33:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:33:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:33:40 INFO - Installing collected packages: mozsystemmonitor 02:33:40 INFO - Running setup.py install for mozsystemmonitor 02:33:40 INFO - Successfully installed mozsystemmonitor 02:33:40 INFO - Cleaning up... 02:33:40 INFO - Return code: 0 02:33:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:40 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/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 0x221b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2587eb0>, '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 0x2588db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2589240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:33:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:33:40 INFO - Using env: {'DISPLAY': ':0', 02:33:40 INFO - 'HOME': '/home/cltbld', 02:33:40 INFO - 'LANG': 'en_US.UTF-8', 02:33:40 INFO - 'LANGUAGE': 'en_US:en', 02:33:40 INFO - 'LOGNAME': 'cltbld', 02:33:40 INFO - 'MAIL': '/var/mail/cltbld', 02:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:40 INFO - 'MOZ_NO_REMOTE': '1', 02:33:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:40 INFO - 'NO_EM_RESTART': '1', 02:33:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:40 INFO - 'PWD': '/builds/slave/test', 02:33:40 INFO - 'SHELL': '/bin/bash', 02:33:40 INFO - 'SHLVL': '1', 02:33:40 INFO - 'TERM': 'linux', 02:33:40 INFO - 'TMOUT': '86400', 02:33:40 INFO - 'USER': 'cltbld', 02:33:40 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362', 02:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:40 INFO - '_': '/tools/buildbot/bin/python'} 02:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:40 INFO - Downloading/unpacking jsonschema==2.5.1 02:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:33:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:41 INFO - Downloading functools32-3.2.3-2.tar.gz 02:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:33:41 INFO - warning: no files found matching '*.txt' 02:33:41 INFO - no previously-included directories found matching 'build' 02:33:41 INFO - no previously-included directories found matching 'dist' 02:33:41 INFO - no previously-included directories found matching '.git*' 02:33:41 INFO - Installing collected packages: jsonschema, functools32 02:33:41 INFO - Running setup.py install for functools32 02:33:41 INFO - warning: no files found matching '*.txt' 02:33:41 INFO - no previously-included directories found matching 'build' 02:33:41 INFO - no previously-included directories found matching 'dist' 02:33:41 INFO - no previously-included directories found matching '.git*' 02:33:41 INFO - Successfully installed jsonschema functools32 02:33:41 INFO - Cleaning up... 02:33:41 INFO - Return code: 0 02:33:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:41 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/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 0x221b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2587eb0>, '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 0x2588db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2589240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:33:41 INFO - Using env: {'DISPLAY': ':0', 02:33:41 INFO - 'HOME': '/home/cltbld', 02:33:41 INFO - 'LANG': 'en_US.UTF-8', 02:33:41 INFO - 'LANGUAGE': 'en_US:en', 02:33:41 INFO - 'LOGNAME': 'cltbld', 02:33:41 INFO - 'MAIL': '/var/mail/cltbld', 02:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:41 INFO - 'MOZ_NO_REMOTE': '1', 02:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:41 INFO - 'NO_EM_RESTART': '1', 02:33:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:41 INFO - 'PWD': '/builds/slave/test', 02:33:41 INFO - 'SHELL': '/bin/bash', 02:33:41 INFO - 'SHLVL': '1', 02:33:41 INFO - 'TERM': 'linux', 02:33:41 INFO - 'TMOUT': '86400', 02:33:41 INFO - 'USER': 'cltbld', 02:33:41 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362', 02:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:41 INFO - '_': '/tools/buildbot/bin/python'} 02:33:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:33:42 INFO - Cleaning up... 02:33:42 INFO - Return code: 0 02:33:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:42 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/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 0x221b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2587eb0>, '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 0x2588db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2589240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:33:42 INFO - Using env: {'DISPLAY': ':0', 02:33:42 INFO - 'HOME': '/home/cltbld', 02:33:42 INFO - 'LANG': 'en_US.UTF-8', 02:33:42 INFO - 'LANGUAGE': 'en_US:en', 02:33:42 INFO - 'LOGNAME': 'cltbld', 02:33:42 INFO - 'MAIL': '/var/mail/cltbld', 02:33:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:42 INFO - 'MOZ_NO_REMOTE': '1', 02:33:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:42 INFO - 'NO_EM_RESTART': '1', 02:33:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:42 INFO - 'PWD': '/builds/slave/test', 02:33:42 INFO - 'SHELL': '/bin/bash', 02:33:42 INFO - 'SHLVL': '1', 02:33:42 INFO - 'TERM': 'linux', 02:33:42 INFO - 'TMOUT': '86400', 02:33:42 INFO - 'USER': 'cltbld', 02:33:42 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362', 02:33:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:42 INFO - '_': '/tools/buildbot/bin/python'} 02:33:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:42 INFO - Downloading/unpacking blobuploader==1.2.4 02:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:43 INFO - Downloading blobuploader-1.2.4.tar.gz 02:33:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:33:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:33:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:43 INFO - Downloading docopt-0.6.1.tar.gz 02:33:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:33:44 INFO - Installing collected packages: blobuploader, requests, docopt 02:33:44 INFO - Running setup.py install for blobuploader 02:33:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:33:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:33:44 INFO - Running setup.py install for requests 02:33:44 INFO - Running setup.py install for docopt 02:33:44 INFO - Successfully installed blobuploader requests docopt 02:33:44 INFO - Cleaning up... 02:33:44 INFO - Return code: 0 02:33:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:44 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/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 0x221b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2587eb0>, '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 0x2588db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2589240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:44 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:33:44 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:33:44 INFO - Using env: {'DISPLAY': ':0', 02:33:44 INFO - 'HOME': '/home/cltbld', 02:33:44 INFO - 'LANG': 'en_US.UTF-8', 02:33:44 INFO - 'LANGUAGE': 'en_US:en', 02:33:44 INFO - 'LOGNAME': 'cltbld', 02:33:44 INFO - 'MAIL': '/var/mail/cltbld', 02:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:44 INFO - 'MOZ_NO_REMOTE': '1', 02:33:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:44 INFO - 'NO_EM_RESTART': '1', 02:33:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:44 INFO - 'PWD': '/builds/slave/test', 02:33:44 INFO - 'SHELL': '/bin/bash', 02:33:44 INFO - 'SHLVL': '1', 02:33:44 INFO - 'TERM': 'linux', 02:33:44 INFO - 'TMOUT': '86400', 02:33:44 INFO - 'USER': 'cltbld', 02:33:44 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362', 02:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:44 INFO - '_': '/tools/buildbot/bin/python'} 02:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:44 INFO - Running setup.py (path:/tmp/pip-9_CmWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:44 INFO - Running setup.py (path:/tmp/pip-Xczm5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:44 INFO - Running setup.py (path:/tmp/pip-DRNP7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:45 INFO - Running setup.py (path:/tmp/pip-A5XPp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:45 INFO - Running setup.py (path:/tmp/pip-vig6CW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:45 INFO - Running setup.py (path:/tmp/pip-0Wwgkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:45 INFO - Running setup.py (path:/tmp/pip-0mi24_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:45 INFO - Running setup.py (path:/tmp/pip-sJ3YfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:45 INFO - Running setup.py (path:/tmp/pip-sxT2em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:45 INFO - Running setup.py (path:/tmp/pip-AzClw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:45 INFO - Running setup.py (path:/tmp/pip-mBIcY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:45 INFO - Running setup.py (path:/tmp/pip-LRdswL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:45 INFO - Running setup.py (path:/tmp/pip-TwqHPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:45 INFO - Running setup.py (path:/tmp/pip-QSaNLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:45 INFO - Running setup.py (path:/tmp/pip-Pm6VYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:45 INFO - Running setup.py (path:/tmp/pip-qih8cE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:45 INFO - Running setup.py (path:/tmp/pip-wlB8oI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:33:46 INFO - Running setup.py install for manifestparser 02:33:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:33:46 INFO - Running setup.py install for mozcrash 02:33:46 INFO - Running setup.py install for mozdebug 02:33:46 INFO - Running setup.py install for mozdevice 02:33:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:33:46 INFO - Running setup.py install for mozfile 02:33:46 INFO - Running setup.py install for mozhttpd 02:33:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:33:46 INFO - Running setup.py install for mozinfo 02:33:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:33:46 INFO - Running setup.py install for mozInstall 02:33:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:33:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:33:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:33:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:33:46 INFO - Running setup.py install for mozleak 02:33:46 INFO - Running setup.py install for mozlog 02:33:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:33:47 INFO - Running setup.py install for moznetwork 02:33:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:33:47 INFO - Running setup.py install for mozprocess 02:33:47 INFO - Running setup.py install for mozprofile 02:33:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:33:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:33:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:33:47 INFO - Running setup.py install for mozrunner 02:33:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:33:47 INFO - Running setup.py install for mozscreenshot 02:33:47 INFO - Running setup.py install for moztest 02:33:47 INFO - Running setup.py install for mozversion 02:33:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:33:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:33:47 INFO - Cleaning up... 02:33:47 INFO - Return code: 0 02:33:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:47 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/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 0x221b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2587eb0>, '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 0x2588db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2589240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:47 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:33:47 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:33:47 INFO - Using env: {'DISPLAY': ':0', 02:33:47 INFO - 'HOME': '/home/cltbld', 02:33:47 INFO - 'LANG': 'en_US.UTF-8', 02:33:47 INFO - 'LANGUAGE': 'en_US:en', 02:33:47 INFO - 'LOGNAME': 'cltbld', 02:33:47 INFO - 'MAIL': '/var/mail/cltbld', 02:33:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:47 INFO - 'MOZ_NO_REMOTE': '1', 02:33:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:47 INFO - 'NO_EM_RESTART': '1', 02:33:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:47 INFO - 'PWD': '/builds/slave/test', 02:33:47 INFO - 'SHELL': '/bin/bash', 02:33:47 INFO - 'SHLVL': '1', 02:33:47 INFO - 'TERM': 'linux', 02:33:47 INFO - 'TMOUT': '86400', 02:33:47 INFO - 'USER': 'cltbld', 02:33:47 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362', 02:33:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:47 INFO - '_': '/tools/buildbot/bin/python'} 02:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:48 INFO - Running setup.py (path:/tmp/pip-ovTQP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:48 INFO - Running setup.py (path:/tmp/pip-bdF8zD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:48 INFO - Running setup.py (path:/tmp/pip-7yJee1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:48 INFO - Running setup.py (path:/tmp/pip-e9E95n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:48 INFO - Running setup.py (path:/tmp/pip-ZbLsK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:48 INFO - Running setup.py (path:/tmp/pip-6JAO__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:48 INFO - Running setup.py (path:/tmp/pip-SuSd57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:48 INFO - Running setup.py (path:/tmp/pip-KSQgla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:48 INFO - Running setup.py (path:/tmp/pip-RRHBjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:48 INFO - Running setup.py (path:/tmp/pip-dyL7if-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:48 INFO - Running setup.py (path:/tmp/pip-YSN30u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:48 INFO - Running setup.py (path:/tmp/pip-uknFHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:48 INFO - Running setup.py (path:/tmp/pip-NjXpW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:49 INFO - Running setup.py (path:/tmp/pip-C9ZRLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:49 INFO - Running setup.py (path:/tmp/pip-cMxCih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:49 INFO - Running setup.py (path:/tmp/pip-G0fQiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:49 INFO - Running setup.py (path:/tmp/pip-5_ZQxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:33:49 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:33:49 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:33:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:50 INFO - Downloading blessings-1.6.tar.gz 02:33:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:33:50 INFO - Installing collected packages: blessings 02:33:50 INFO - Running setup.py install for blessings 02:33:50 INFO - Successfully installed blessings 02:33:50 INFO - Cleaning up... 02:33:50 INFO - Return code: 0 02:33:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:33:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:50 INFO - Reading from file tmpfile_stdout 02:33:50 INFO - Current package versions: 02:33:50 INFO - argparse == 1.2.1 02:33:50 INFO - blessings == 1.6 02:33:50 INFO - blobuploader == 1.2.4 02:33:50 INFO - docopt == 0.6.1 02:33:50 INFO - functools32 == 3.2.3-2 02:33:50 INFO - jsonschema == 2.5.1 02:33:50 INFO - manifestparser == 1.1 02:33:50 INFO - mozInstall == 1.13 02:33:50 INFO - mozcrash == 1.0 02:33:50 INFO - mozdebug == 0.1 02:33:50 INFO - mozdevice == 0.51 02:33:50 INFO - mozfile == 1.2 02:33:50 INFO - mozhttpd == 0.7 02:33:50 INFO - mozinfo == 0.10 02:33:50 INFO - mozleak == 0.1 02:33:50 INFO - mozlog == 3.5 02:33:50 INFO - moznetwork == 0.27 02:33:50 INFO - mozprocess == 0.25 02:33:50 INFO - mozprofile == 0.28 02:33:50 INFO - mozrunner == 6.13 02:33:50 INFO - mozscreenshot == 0.1 02:33:50 INFO - mozsystemmonitor == 0.3 02:33:50 INFO - moztest == 0.8 02:33:50 INFO - mozversion == 1.4 02:33:50 INFO - psutil == 3.1.1 02:33:50 INFO - requests == 1.2.3 02:33:50 INFO - wsgiref == 0.1.2 02:33:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:50 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/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 0x221b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2587eb0>, '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 0x2588db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2589240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:50 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:33:50 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:33:50 INFO - Using env: {'DISPLAY': ':0', 02:33:50 INFO - 'HOME': '/home/cltbld', 02:33:50 INFO - 'LANG': 'en_US.UTF-8', 02:33:50 INFO - 'LANGUAGE': 'en_US:en', 02:33:50 INFO - 'LOGNAME': 'cltbld', 02:33:50 INFO - 'MAIL': '/var/mail/cltbld', 02:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:50 INFO - 'MOZ_NO_REMOTE': '1', 02:33:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:50 INFO - 'NO_EM_RESTART': '1', 02:33:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:50 INFO - 'PWD': '/builds/slave/test', 02:33:50 INFO - 'SHELL': '/bin/bash', 02:33:50 INFO - 'SHLVL': '1', 02:33:50 INFO - 'TERM': 'linux', 02:33:50 INFO - 'TMOUT': '86400', 02:33:50 INFO - 'USER': 'cltbld', 02:33:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362', 02:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:50 INFO - '_': '/tools/buildbot/bin/python'} 02:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:33:51 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:52 INFO - Downloading marionette_driver-1.4.0.tar.gz 02:33:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 02:33:52 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 02:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:33:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:33:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:33:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:33:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:33:52 INFO - Installing collected packages: marionette-driver, simplejson 02:33:52 INFO - Running setup.py install for marionette-driver 02:33:52 INFO - Running setup.py install for simplejson 02:33:52 INFO - building 'simplejson._speedups' extension 02:33:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 02:33:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 02:33:53 INFO - Successfully installed marionette-driver simplejson 02:33:53 INFO - Cleaning up... 02:33:53 INFO - Return code: 0 02:33:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:53 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/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 0x221b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2587eb0>, '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 0x2588db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2589240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:33:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:33:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:33:53 INFO - Using env: {'DISPLAY': ':0', 02:33:53 INFO - 'HOME': '/home/cltbld', 02:33:53 INFO - 'LANG': 'en_US.UTF-8', 02:33:53 INFO - 'LANGUAGE': 'en_US:en', 02:33:53 INFO - 'LOGNAME': 'cltbld', 02:33:53 INFO - 'MAIL': '/var/mail/cltbld', 02:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:53 INFO - 'MOZ_NO_REMOTE': '1', 02:33:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:53 INFO - 'NO_EM_RESTART': '1', 02:33:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:53 INFO - 'PWD': '/builds/slave/test', 02:33:53 INFO - 'SHELL': '/bin/bash', 02:33:53 INFO - 'SHLVL': '1', 02:33:53 INFO - 'TERM': 'linux', 02:33:53 INFO - 'TMOUT': '86400', 02:33:53 INFO - 'USER': 'cltbld', 02:33:53 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362', 02:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:53 INFO - '_': '/tools/buildbot/bin/python'} 02:33:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:33:53 INFO - Cleaning up... 02:33:53 INFO - Return code: 0 02:33:53 INFO - Running post-action listener: _resource_record_post_action 02:33:53 INFO - Running post-action listener: _start_resource_monitoring 02:33:53 INFO - Starting resource monitoring. 02:33:53 INFO - [mozharness: 2017-07-25 09:33:53.868767Z] Finished create-virtualenv step (success) 02:33:53 INFO - [mozharness: 2017-07-25 09:33:53.869294Z] Running install step. 02:33:53 INFO - Running pre-action listener: _resource_record_pre_action 02:33:53 INFO - Running main action method: install 02:33:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:54 INFO - Reading from file tmpfile_stdout 02:33:54 INFO - Detecting whether we're running mozinstall >=1.0... 02:33:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:33:54 INFO - Reading from file tmpfile_stdout 02:33:54 INFO - Output received: 02:33:54 INFO - Usage: mozinstall [options] installer 02:33:54 INFO - Options: 02:33:54 INFO - -h, --help show this help message and exit 02:33:54 INFO - -d DEST, --destination=DEST 02:33:54 INFO - Directory to install application into. [default: 02:33:54 INFO - "/builds/slave/test"] 02:33:54 INFO - --app=APP Application being installed. [default: firefox] 02:33:54 INFO - mkdir: /builds/slave/test/build/application 02:33:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:34:12 INFO - Reading from file tmpfile_stdout 02:34:12 INFO - Output received: 02:34:12 INFO - /builds/slave/test/build/application/firefox/firefox 02:34:12 INFO - Running post-action listener: _resource_record_post_action 02:34:12 INFO - [mozharness: 2017-07-25 09:34:12.196792Z] Finished install step (success) 02:34:12 INFO - [mozharness: 2017-07-25 09:34:12.196914Z] Running setup-mitmproxy step. 02:34:12 INFO - Running pre-action listener: _resource_record_pre_action 02:34:12 INFO - Running main action method: setup_mitmproxy 02:34:12 INFO - Skipping: mitmproxy is not required 02:34:12 INFO - Running post-action listener: _resource_record_post_action 02:34:12 INFO - [mozharness: 2017-07-25 09:34:12.197465Z] Finished setup-mitmproxy step (success) 02:34:12 INFO - [mozharness: 2017-07-25 09:34:12.197690Z] Running run-tests step. 02:34:12 INFO - Running pre-action listener: _resource_record_pre_action 02:34:12 INFO - Running pre-action listener: _set_gcov_prefix 02:34:12 INFO - Running main action method: run_tests 02:34:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:34:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:34:12 INFO - Python 2.7.3 02:34:12 INFO - Return code: 0 02:34:12 INFO - grabbing minidump binary from tooltool 02:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:12 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 0x2587eb0>, '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 0x2588db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2589240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:34:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:34:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:34:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:34:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:34:12 INFO - Return code: 0 02:34:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:34:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:34:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:34:12 INFO - ENV: RUST_BACKTRACE is now 1 02:34:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:34:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:34:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:34:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:34:12 INFO - Using env: {'DISPLAY': ':0', 02:34:12 INFO - 'HOME': '/home/cltbld', 02:34:12 INFO - 'LANG': 'en_US.UTF-8', 02:34:12 INFO - 'LANGUAGE': 'en_US:en', 02:34:12 INFO - 'LOGNAME': 'cltbld', 02:34:12 INFO - 'MAIL': '/var/mail/cltbld', 02:34:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:34:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:34:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:12 INFO - 'MOZ_NO_REMOTE': '1', 02:34:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:34:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:12 INFO - 'NO_EM_RESTART': '1', 02:34:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:12 INFO - 'PWD': '/builds/slave/test', 02:34:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:34:12 INFO - 'RUST_BACKTRACE': '1', 02:34:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:34:12 INFO - 'SHELL': '/bin/bash', 02:34:12 INFO - 'SHLVL': '1', 02:34:12 INFO - 'STYLO_FORCE_ENABLED': '1', 02:34:12 INFO - 'TERM': 'linux', 02:34:12 INFO - 'TMOUT': '86400', 02:34:12 INFO - 'USER': 'cltbld', 02:34:12 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362', 02:34:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:12 INFO - '_': '/tools/buildbot/bin/python'} 02:34:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:34:12 INFO - mozversion application_buildid: 20170725085032 02:34:12 INFO - mozversion application_changeset: 131e19a573e901fb4d01b471b11b7916420b9fee 02:34:12 INFO - mozversion application_display_name: Nightly 02:34:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:34:12 INFO - mozversion application_name: Firefox 02:34:12 INFO - mozversion application_remotingname: firefox 02:34:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:34:12 INFO - mozversion application_vendor: Mozilla 02:34:12 INFO - mozversion application_version: 56.0a1 02:34:12 INFO - mozversion platform_buildid: 20170725085032 02:34:12 INFO - mozversion platform_changeset: 131e19a573e901fb4d01b471b11b7916420b9fee 02:34:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:34:12 INFO - mozversion platform_version: 56.0a1 02:34:12 INFO - using testdate: 1500975252 02:34:12 INFO - actual date: 1500975252 02:34:12 INFO - starting webserver on 'localhost:52379' 02:34:12 INFO - SUITE-START | Running 2 tests 02:34:12 INFO - TEST-START | dromaeo_css 02:34:12 INFO - Initialising browser for dromaeo_css test... 02:34:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52379/getInfo.html -profile /tmp/tmpBhLdKN/profile 02:34:12 INFO - TEST-INFO | started process 9570 (/builds/slave/test/build/application/firefox/firefox http://localhost:52379/getInfo.html) 02:34:18 INFO - TEST-INFO | 9570: exit 0 02:34:18 INFO - Browser initialized. 02:34:18 INFO - Running cycle 1/1 for dromaeo_css test... 02:34:18 INFO - TEST-INFO | started process 9798 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBhLdKN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:34:29 INFO - PID 9798 | RSS: Main: 171626496 02:34:29 INFO - PID 9798 | 02:37:29 INFO - PID 9798 | Cycle 1(1): loaded http://localhost:52379/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52379/tests/dromaeo/cssquery-ext.html) 02:37:30 INFO - PID 9798 | RSS: Main: 174604288 02:37:30 INFO - PID 9798 | 02:40:32 INFO - PID 9798 | Cycle 1(1): loaded http://localhost:52379/tests/dromaeo/cssquery-ext.html (next: http://localhost:52379/tests/dromaeo/cssquery-jquery.html) 02:40:32 INFO - PID 9798 | RSS: Main: 175951872 02:40:32 INFO - PID 9798 | 02:43:34 INFO - PID 9798 | Cycle 1(1): loaded http://localhost:52379/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52379/tests/dromaeo/cssquery-mootools.html) 02:43:35 INFO - PID 9798 | RSS: Main: 174964736 02:43:35 INFO - PID 9798 | 02:46:37 INFO - PID 9798 | Cycle 1(1): loaded http://localhost:52379/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52379/tests/dromaeo/cssquery-prototype.html) 02:46:38 INFO - PID 9798 | RSS: Main: 175128576 02:46:38 INFO - PID 9798 | 02:49:41 INFO - PID 9798 | Cycle 1(1): loaded http://localhost:52379/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52379/tests/dromaeo/cssquery-yui.html) 02:49:42 INFO - PID 9798 | RSS: Main: 175271936 02:49:42 INFO - PID 9798 | 02:52:44 INFO - PID 9798 | Cycle 1(1): loaded http://localhost:52379/tests/dromaeo/cssquery-yui.html (next: http://localhost:52379/tests/dromaeo/cssquery-dojo.html) 02:52:44 INFO - PID 9798 | RSS: Main: 179073024 02:52:44 INFO - PID 9798 | 02:52:44 INFO - PID 9798 | __start_tp_report 02:52:44 INFO - PID 9798 | _x_x_mozilla_page_load 02:52:44 INFO - PID 9798 | _x_x_mozilla_page_load_details 02:52:44 INFO - PID 9798 | |i|pagename|runs| 02:52:44 INFO - PID 9798 | |0;dojo.html;3109.331493728848;3143.905682829513;3146.3549972255682;3182.2362632968093;3199.872005119795;6016.428439298265;6097.085437184424;6146.170267013952;6202.906956395657;6223.595466294688;5972.432618901208;6063.666498342589;6082.817515474543;6086.482648974842;6098.237720284965;5553.444655534435;5606.55147588192;5609.35492418371;5617.775288988436;5746.224259724925;5716;5726.198332233491;5727.541796656257;5775.075987841946;5779.913301300463;5582.91625625616;5641.971790141043;5684.573656975723;5740.4546568076175;5767.884642307151;5540.390557038722;5599.936012157677;5646.237757902672;5708.315002199721;5726;5574.331080270353;5578.693171875545;5649.830505084854;5671.319441666985;5679.062954612484;5919.822405327847;5934.1098835174635;6003.789867354665;6066.545009124334;6128.142060111588;6591.967040164816;6623.470122390246;6624.470042396597;6628.73485060597;6635.469162466991;6631.4363279121335;6686.431653309426;6726.461883049345;6731.831704207385;6739.797806065826;6126.417990290915;6169.938300616981;6243.843903902439;6260.248770147611;6262.405071518198;6548.148740663779;6650.268470468244;6773.525853190328;6780.254172041072;6835.624040677811;6455.7740479083;6515.055316979012;6518;6527.281998980108;6536.215654121535;6566.80299591013;6579.30917253691;6656.7670131545165;6668.266490686021;6671.199456065303;6335.334789847092;6520.510961677893;6524.184476940382;6595.835104122435;6604.900926486107;6408.327125651833;6514.413702766774;6570.868582628321;6600.768973085919;6619.669016549154;5377.7311134443125;5385.515303622693;5395.271638328853;5400.162974738922;5420.620556561082;4561.429821272341;4576.199165146086;4629.907401851944;4630.328602352707;4636.374089497942;5694.487496125369;5714.942850571524;5791.942080579224;5792.9710351447975;5812.38969908162;6451.838704032437;6517.250516190604;6519.054737063194;6529.934700652932;6533.901991470132;5625.09998400254;5703.230063941398;5766.250387449605;5769.826905192851;5806.912896306559;5764.13537969308;5857.973740117706;5924.289085309791;5928.525717942554;5940.910886336708;6114.571979961449;6277.435030847063;6419.486441084702;6492.35076492347;6534.444572211415;6494.642794646151;6539.771108011197;6591.307912669101;6706.362895524917;6721.059051732664;6402.423781859468;6462.030695395728;6481.060246264171;6489.643069631215;6508.9349106508325;6469.385408386196;6493.253275873335;6510;6576.53964222519;6614.437772789367;6478.805635830932;6575.769848055295;6615.4046135848;6694.765683201064;6744.055832183596;6363.268224154282;6400.199975003125;6413.967930160506;6420.26166990802;6421.068945003042;6240.126382306572;6296.181496405438;6338.936610634019;6375.489960803217;6462.386073323027;6266.874662506633;6291.402316779899;6297.055441683784;6345.96827015862;6421.8073457796345;6458.903116453163;6539.738410463528;6544.312847150981;6556.082148499118;6569.113169722217;6242.781502647385;6278.529110316836;6326.33573474797;6354.777582784581;6380 02:52:44 INFO - PID 9798 | |1;ext.html;666.819958611175;724.6811402982687;740.4372676765659;741.6254791330377;1148.5922497513388;30096.699033009692;30958.69041309586;41234.96912577183;42238.15523689525;42360.57639423605;42542;42547.78726106365;43029;43100.13799724004;43118.784406077924;7151.856962860739;7368.447366447511;7550.622468876548;7770.4172187085915;7786.649600767979;7475.73834915778;7529.20943300951;7556.50882692626;7615.5811430371305;7617.733379331725;7572.810679733023;7648.885266721004;7672.117706463744;7687.8078048048965;7696.846063078735;7521.28547787962;7612.581308028111;7663.578503182351;7667.616619169019;7678.155402905676;7590.8861367079535;7648.349890259279;7651.387888968869;7653.846923061563;7655.732049378245;39169.60830391688;39421.80289098536;39476.40785388193;39576.80211598924;39658.60341396607;3609.043603445089;3634.0551456621206;3662.926741465182;3669.669729724311;3679.3929001714687;31408;31486.212844678837;31500.842495787376;31503;31571.52642710361;4831.516848315176;4884.902301953941;4946.975265123688;4960.032793605248;4998.600111991068;187447;188363;189020.054899726;189620;190023;48952;48955.51044489581;49007.264891026665;49085.754571227626;49215;51884.48115518872;51914.48085519097;53785.46214537804;54379.45620543823;54450.727746361015;15944.601384965237;16010.839891600936;16043.919780401257;16070.75893861593;16090.919545402432;11390.088792896548;11423.314601123793;11574.6527604172;13061.542846000344;13274.269915154759;13363.1313964592;13376.933115334556;13406.195628262336;13493.865061349457;13672.93163534176;5476.780928762884;5486.835394938158;5493.587980901449;5567.415421380778;5600.719964001783;951.5622813505727;975.7414285214423;993.7118235711563;1019.4444028004755;1019.6431249062769;22152.335429937128;22188.304779708047;22321.776782232293;23009.477725346133;23280.65079023816;1092.2354351953663;1100.5872797700863;1103.7130346110068;1127.402476687357;1129.9378534180698;12037.398130093461;12050;12108.636740897788;12136.696582585506;12136.939315303543;233846;234520;235512;235806;236549;51908.740456298234;52083.73958130185;52092;52247.73876130595;52260;1454.0911930043724;1470.669099452636;1490.7987421697933;1513.8259100203397;1526.9541913742382;21943.780562194814;22051.11795528161;22209.22267720622;22227.777722223218;22536.5492690142;37180.628193718796;37192.25615487621;37287;37370.626293736714;37394.813025934694;193734;195142;195497;195553;196340;30991.380172395973;31309.8434507826;33866.830665846515;33957.151071222426;34188.31623367569;42889;42989.355159672006;43161.56838431575;43265.567344326155;43329.35005974976;29188.27029324284;31159;31885.883994060096;32241.838790805898;32347.514787277738;30189.698103018687;30869.69130308758;31141.8442907784;31611;31651.841740791147;34765.65234347624;34810;35056.47415288722;35214.823925880206;35590.466143008394;28600.427991440472;30209.848950755106;30276.24309392283;30480.84759576188;30582.235444114074;22341.888290558443;22920;24040.39899002469;24846.751532484443;25008.249752507454 02:52:44 INFO - PID 9798 | |2;jquery.html;552.1882832236611;556.9340779011541;568.9999999999998;571.9599628026037;599.8500374906273;21642.458938526546;22424.66363004556;22434.3269701909;22451.21420750274;22758.431039224026;25801.09696160635;26378.604320935152;26399;26405.20784376467;26443.206703798867;6415.422611964922;6602.471802255832;6621.6027038377615;6624.867502649944;6625.900611490832;5916.053431450969;6365.872682546346;6398.872022559546;6402.583832050902;6559.540832141752;6292.622442653433;6428.164338635971;6431.6784160792;6434.839129021765;6434.9678251608675;6375.617462952215;6379.968100159516;6385.201849768756;6395.360463953614;6407.103005579223;5944.286685597713;5988.19159413478;5989.101634754778;5990.011648078062;6002.159697642333;28204.717952820618;29451.410971780446;29940.70059299401;30166.84916575425;30259.546106808415;1871.737956686065;1937.2347922570507;1941.0973897137758;1943.6987266973642;1953.7264782930401;18703.158357873792;19222.711659325123;19287.90356048225;19309.710354344697;19317.61364772697;2329.974811083135;2346.62454007358;2366.9408264793346;2429.97570024301;2448.995911676222;136354;140528;141394;141485;141764.2911785445;13816.516421925184;14742.705145897022;15059;15118.976204758872;15437.691246175014;23008.539829203655;23301;23441.179558715365;23501.88249058744;24088.51822963531;10410.739731506621;10589.258751887293;10597.4701264938;10697.893021069689;10949.069329106957;9879.950600246953;9888.307818452784;9903.504824758733;10010.949945250228;10051.849222261671;9433.198178154797;9550.331476796697;9623.663171789094;9795.951020244853;9797.118259356692;2820.2244382794897;2884.163592558177;2884.639420072491;2903.7822163337833;2940.911772646824;944.471096186138;950.7337945375306;964.6523806242784;980.6469670918464;988.9703308900745;18813.529661758294;19516.70724939127;23092.65361019586;24844.254672359857;24959.251222463354;1015.8527013582989;1019.8827134879435;1024.1243736605095;1056.6724315462077;1063.4310643805527;11074.501647425885;11269.323840569592;11280.548778048786;11402.771944561062;11428.314301141958;494812;497776;531715;532498;543322;119051.80948190407;121842;124778;126527;128047;1206.1978784108644;1222.2849632964637;1258.5091814192472;1265.1839563481503;1275.64282001038;19070.42788716341;20175.79824201798;20258.392248232576;20499.43201068202;20551.177952881717;49446.258306126154;52083.73958130185;52821.7358913203;57505.424945750005;59354.406455936616;63861.680691596244;68969.65515172391;69434.65282673555;74315.62842185971;79654;14764.409423622934;15130.243487825344;15215.08709477435;15319.46381876629;15455.459058932884;23703.881480592485;23742.525149497258;23921.401964951016;24007.27978160658;24040.63939040951;18904.432867014013;18947;19069.141888615322;19194.13626386844;19331.710024349366;15598.610034748768;16089.67820643604;16932.15339233058;17010;17506.387276445774;18839.434816955512;19678.21287148498;19755.506112347306;19781.307654232034;19786.20855165777;12565.811512827133;13098.934505327412;14949.77575336349;15036.624084397978;15071.171085590398;16931.407400740914;17448;17529.474115776546;17603.823961760732;18098.90950545239 02:52:44 INFO - PID 9798 | |3;mootools.html;1333.4932725564283;1375.9518416855412;1388.1324172392256;1396.0646366934157;1400.0199860097935;13400.262985535805;13986.300684965749;13988.230647314407;13993.440262389493;14000;13493.190408575492;14011.019228653999;14178;14247.4301027959;14360.784588231185;2574.858382788946;2641.498115358085;2642.062067965873;2646.0474229277543;2656.256248250493;2558.7825034872058;2569.3319736868457;2621.8426894386303;2676.8260063095936;2692;2630.3424143964007;2644.7090820009785;2663.6004599310063;2665.586834040727;2668.906588269411;2552.310876063462;2569.704483984347;2590.171145233526;2591.1708253358934;2635.262126604535;2543.275166577535;2553.9361515962064;2554.897804087834;2580.342012786746;2581.8192726508964;13776.517821876287;13904.930475347659;13962.790558141636;14012.579622611338;14028.509002184977;7414.221506741768;7738.883916741253;7751.883721744179;7758.883616745753;7778.0666320041955;4904.950950490521;4989.426215985171;5048.495150484959;5132;5136.563392111638;1744.5464179313342;1749.80752117267;1766.2669991953323;1800.612868233336;1801.8198180182007;22139.778602213933;22267.220647277267;22401.77598224013;22425.66361504579;23303.417414564603;6009.939900601025;6040.486558642477;6196.318404975449;6212.347703491158;6267.310595834455;15646.921765391327;15779.684406312039;15832;15832.604184895239;15844.28700708471;7296.963515182496;7518.586477743776;7524.736634217886;7526.623668816537;7531.209223031612;6834.555753875982;6960.686769095301;7005.369516743517;7017.578945263301;7056.611886346198;4603.516630753789;4745.2882067690125;4752.833650822205;4789.066132104276;4938.75306234694;1272.287518989369;1288.890444312244;1310.2073245686413;1316.6510874618234;1371.8628137186402;883.2889523933295;896.4576431259125;901.9503927284062;914.4421902639384;924.3899026642383;8466.661333546712;8630;8690.304775618062;8725.432846864933;8758;969.6412327438893;976.9267304952157;980.2696990741942;1005.8340373838381;1007.9042490963493;4917.778699958439;4932.161532539477;4951.405831300267;5130.050940576006;5276.445973172838;18757.90621046886;19265.422037338903;19630.509237269183;19780.50548736293;19891.60216795656;18855.434336969913;19214.231430742893;19246.23015079409;19418.320358787376;19465.80534194668;10740.677779666623;10880.564777408816;10973.945130274298;11085.390303533382;11096.5561377544;7641.7707468776025;8030.718924837603;8203;8474.957625211835;8570.914290857261;16330.591735206239;16393.5081947537;17478.73781893298;17883.195256213243;17896.55258618545;17332.56668583245;17516.124193790514;17531.912340438215;17727.822721772616;17835.46493605194;12765.93617031909;13071.15037522558;13118.803217951547;13141.802872957105;13175.14361566495;12732.745345093232;12888.097833151964;13016.8047479286;13294.468221271041;13343.799843002169;10403.583856645952;10812.945935270272;11114;11296.774064518828;11423.257488263236;9923;10372.533236004549;10589.841152382567;10664.89335106639;10775.730606734895;9660.71017869465;9797.75505612337;9798.65704700332;9827.55775990068;9837.114659680663;6975.546589471668;6995.615241161785;7110.182329032227;7151;7260.636968151465;6991.650417479207;7037.472189585699;7080.079589653518;7139.464540159613;7144.67848946809 02:52:44 INFO - PID 9798 | |4;prototype.html;472.6880259029039;495.89338292267155;513.2250302043914;514.0669684522592;519.6440438299767;5995.942069544531;6163.907541386877;6181.134641150237;6195.1946246987945;6216.886258672056;5938.317093534245;6012.669303188323;6034.215551978236;6034.275886893579;6048.886757005234;4802.159622066142;4863.124637565228;4889.1932831083;4889.731064791435;4899.289603007562;4766.213574760178;4792.329073929635;4896.804127834882;4897.1674815281485;4920.532549407819;4788.329633851264;4808.639352048593;4817.638677099214;4821.30091136785;4871.926921096187;4870.220764677652;4872.56146946773;4887.340209071783;4901.411830580318;4916.704997700113;4420.823167073313;4431.158079964828;4433.583696885205;4433.800478978454;4439.311906654474;5927.2887253529425;5940.31686356066;5985.34161242263;5997.281685355064;6019.939800601982;5515.09001014832;5530.198121272393;5551.2228288039705;5605.803796867131;5621.18492818539;6298.2756982947085;6310.905336419957;6346.365363463663;6378.107065010902;6387.329330420285;4733.95266047342;4761.976190119027;4813.711177329336;4824.879378015543;4857.805687772485;6585.539012269143;6632.369924857179;6678.899816502756;6720.563163394364;6807.591544507296;4800.279958006257;4829.6860704054125;4858.66783943709;4859.854204373874;4882.438519570295;4890.682105663192;4913.582345500601;4927.768057985503;4960.875978100504;4964.280179373971;5495.697736624524;5527.226188333637;5538.418466061086;5624.6625202487985;5631.605787594911;6176.505879529627;6283.151774510474;6325.493960483151;6384.233891932905;6399.584027038228;1651.0918994552949;1686.8734844886683;1708.325211541434;1722.7157519009475;1725.9730460376056;966.8743063401854;1200.3878022208737;1206.6967674911075;1218.7257866979858;1223.8286639870425;5450.591205659592;5470.729647196369;5490.533304669068;5620;5755.510781583613;6483.7082331295205;6543.167912984277;6570.474362051024;6571.934280657228;6669.533132680665;5614.803481878114;5690.260266165372;5713.74288157034;5721.971390143106;5753.741081651336;3475.374432602156;3493.4235851084795;3500.4049311617086;3510.5606701252364;3557.7865328080397;6345.904811427832;6402.399400149962;6452.9677351612945;6457.483401327882;6494.805155845333;6626.933730662631;6655;6697.129373181455;6713.731450741916;6749.898751518731;6311.558190926591;6350.491960643138;6353.68231588428;6369.840753981188;6407.583507072025;6472.579282346821;6479.449246814073;6485.286618472059;6599.538032337882;6623.370779775913;6447.161868957193;6454.386833250834;6502.512311576556;6614.404703576702;6628.138342015507;6259.12372267892;6334.651594162366;6406.391392817675;6426.582272152295;6496.350364963466;4836.564709176191;4865.318855360323;4908.386451693538;4917.360743103373;4917.409910810726;6548.607083575001;6592.406683398517;6620.437262832713;6636.27001029896;6662.734080524685;6460.8707825842275;6464.741410343534;6482.384173503509;6501;6506.804795856132;6332.461740752087;6355.618662880242;6366.9044964326495;6451.967740161457;6457.773977910751;6272.68273662536;6291.968540157453;6295.905561416491;6341.841453963688;6377.7130029147875;6356.459700925473;6366.172397588284;6393.840153996187;6431.485481161402;6507;5656.456672460929;6183.288921773874;6246;6259.186305780219;6279.466245369012 02:52:44 INFO - PID 9798 | |5;yui.html;897.5601955042027;903.9412438191519;923.3674932671121;925.6945208081333;929.6467342409883;17987;19301.710474342897;19304.420867374;19332.51668708283;21140.682889756627;20602.1759129635;21646.783532164674;21687.67468487974;21712.565748685058;21872.781272187272;968.941863488193;1000.9399436033862;1003.64872294697;1007.2194049611536;1008.0977525115018;1054.978900421995;1079.2013909706839;1081.686310969818;1082.648139354709;1083.8753543342498;1050.816107181244;1063.6277302943986;1115.074488174813;1117.1174771930207;1124.7413094988158;1100.961466348682;1102.6526644107162;1108.8225883858545;1109.4452773613193;1111.660943412259;784.8783438567032;790.3558599741192;792.18405042806;792.7304716396395;794.0947320055142;19390.612187756167;19918.103685334194;19926.202951881907;19985.800141998683;20584.27955021582;20302.69545956812;20377.592448151103;20920.581588368146;20983.895080524653;21005.579888402146;15595.766063509056;15750;15933.521994340188;15951.680966380607;16369.91815040929;3527.0476971217886;3586.677199052098;3588.8743893963847;3591.2099338145567;3593.1735700788963;118789.40605297005;120279;122057.77942220552;124443;125802;15721.764173537405;16174.27215775293;16264.18679066042;16317.755233671505;16321.102339371211;29234.26914327116;30132.24669383283;30211.640476178625;30271.848640756656;30467.085987420414;7427.517211381243;7706.961465192639;8706.738797836075;8920.420172688755;8932.106789321017;4254.489461264668;4347.7173983690955;4351.717138385995;4375.5405682403525;4377.5403582624;5004.049230646166;5137;5172.19830926207;5203.9219411708855;5243.134882744381;1020.5713600287897;1047.8323468245044;1052.6157952347337;1066.3974854207347;1067.530286673861;646.2697152217963;666.6699983508195;688.896665500179;690.5131882023162;697.870893884633;10619.150467962545;12335.444904979298;13039.478420863059;13253.560057380886;13531;701.2987012987013;709.3722055980494;712.7291629180982;729.3800269770759;732.6959311885614;5313.787448502017;5718.971405143031;5762.855928601818;6347.0479428086155;6359.777407790705;99454;104742;105632;107275.46362268295;108205;84118.57940710257;87593;89629;90390.54804725935;94487.52756236312;79421.60289198633;82547;82748.58625706953;83928.58035709782;85636.57181714177;11934.343611101473;12196.75606487883;12600.180988235736;12658.303793291458;12775.80836287475;35313.68631368631;36875.70935017261;37026;38086.80956595199;38720.41919371268;60951.69524152351;67978.66010669916;69332.653336733;72156;72280.63859680668;16988.065656388524;17022.14889255557;17237.913810430866;17362.826371736628;17600.119993999993;18063.548411289823;20880.269190578256;21077.051532680758;21371.35885923425;21552;17984.19071141828;18056.90971545134;18084.367047153286;18142;18393.81606183921;18219.180136893607;18331.633367332313;18371.632567348846;18459.446216613524;18795.718064228775;16465.25906334194;16613.50159495217;16666.666666666843;16903.323867045674;16975.405860794814;11474.254173478697;11670.124740644316;11914.52341906314;12045.879541204826;12141.210821296587;12102.515899363927;12358.196717213352;12481.251124932533;12617;12725.23648581051 02:52:44 INFO - PID 9798 | __end_tp_report 02:52:44 INFO - PID 9798 | __start_cc_report 02:52:44 INFO - PID 9798 | _x_x_mozilla_cycle_collect,397 02:52:44 INFO - PID 9798 | __end_cc_report 02:52:44 INFO - PID 9798 | __startTimestamp1500976364634__endTimestamp 02:52:44 INFO - PID 9798 | 02:52:44 INFO - PID 9798 | ------- Summary: start ------- 02:52:44 INFO - PID 9798 | Number of tests: 6 02:52:44 INFO - PID 9798 | 02:52:44 INFO - PID 9798 | [#0] dojo.html Cycles:165 Average:6077.62 Median:6296.18 stddev:701.61 (11.1%) stddev-sans-first:664.00 02:52:44 INFO - PID 9798 | Values: 3109.3 3143.9 3146.4 3182.2 3199.9 6016.4 6097.1 6146.2 6202.9 6223.6 5972.4 6063.7 6082.8 6086.5 6098.2 5553.4 5606.6 5609.4 5617.8 5746.2 5716.0 5726.2 5727.5 5775.1 5779.9 5582.9 5642.0 5684.6 5740.5 5767.9 5540.4 5599.9 5646.2 5708.3 5726.0 5574.3 5578.7 5649.8 5671.3 5679.1 5919.8 5934.1 6003.8 6066.5 6128.1 6592.0 6623.5 6624.5 6628.7 6635.5 6631.4 6686.4 6726.5 6731.8 6739.8 6126.4 6169.9 6243.8 6260.2 6262.4 6548.1 6650.3 6773.5 6780.3 6835.6 6455.8 6515.1 6518.0 6527.3 6536.2 6566.8 6579.3 6656.8 6668.3 6671.2 6335.3 6520.5 6524.2 6595.8 6604.9 6408.3 6514.4 6570.9 6600.8 6619.7 5377.7 5385.5 5395.3 5400.2 5420.6 4561.4 4576.2 4629.9 4630.3 4636.4 5694.5 5714.9 5791.9 5793.0 5812.4 6451.8 6517.3 6519.1 6529.9 6533.9 5625.1 5703.2 5766.3 5769.8 5806.9 5764.1 5858.0 5924.3 5928.5 5940.9 6114.6 6277.4 6419.5 6492.4 6534.4 6494.6 6539.8 6591.3 6706.4 6721.1 6402.4 6462.0 6481.1 6489.6 6508.9 6469.4 6493.3 6510.0 6576.5 6614.4 6478.8 6575.8 6615.4 6694.8 6744.1 6363.3 6400.2 6414.0 6420.3 6421.1 6240.1 6296.2 6338.9 6375.5 6462.4 6266.9 6291.4 6297.1 6346.0 6421.8 6458.9 6539.7 6544.3 6556.1 6569.1 6242.8 6278.5 6326.3 6354.8 6380.0 02:52:44 INFO - PID 9798 | 02:52:44 INFO - PID 9798 | [#1] ext.html Cycles:180 Average:37354.04 Median:34787.83 stddev:53841.03 (154.8%) stddev-sans-first:53921.59 02:52:44 INFO - PID 9798 | Values: 666.8 724.7 740.4 741.6 1148.6 30096.7 30958.7 41235.0 42238.2 42360.6 42542.0 42547.8 43029.0 43100.1 43118.8 7151.9 7368.4 7550.6 7770.4 7786.6 7475.7 7529.2 7556.5 7615.6 7617.7 7572.8 7648.9 7672.1 7687.8 7696.8 7521.3 7612.6 7663.6 7667.6 7678.2 7590.9 7648.3 7651.4 7653.8 7655.7 39169.6 39421.8 39476.4 39576.8 39658.6 3609.0 3634.1 3662.9 3669.7 3679.4 31408.0 31486.2 31500.8 31503.0 31571.5 4831.5 4884.9 4947.0 4960.0 4998.6 187447.0 188363.0 189020.1 189620.0 190023.0 48952.0 48955.5 49007.3 49085.8 49215.0 51884.5 51914.5 53785.5 54379.5 54450.7 15944.6 16010.8 16043.9 16070.8 16090.9 11390.1 11423.3 11574.7 13061.5 13274.3 13363.1 13376.9 13406.2 13493.9 13672.9 5476.8 5486.8 5493.6 5567.4 5600.7 951.6 975.7 993.7 1019.4 1019.6 22152.3 22188.3 22321.8 23009.5 23280.7 1092.2 1100.6 1103.7 1127.4 1129.9 12037.4 12050.0 12108.6 12136.7 12136.9 233846.0 234520.0 235512.0 235806.0 236549.0 51908.7 52083.7 52092.0 52247.7 52260.0 1454.1 1470.7 1490.8 1513.8 1527.0 21943.8 22051.1 22209.2 22227.8 22536.5 37180.6 37192.3 37287.0 37370.6 37394.8 193734.0 195142.0 195497.0 195553.0 196340.0 30991.4 31309.8 33866.8 33957.2 34188.3 42889.0 42989.4 43161.6 43265.6 43329.4 29188.3 31159.0 31885.9 32241.8 32347.5 30189.7 30869.7 31141.8 31611.0 31651.8 34765.7 34810.0 35056.5 35214.8 35590.5 28600.4 30209.8 30276.2 30480.8 30582.2 22341.9 22920.0 24040.4 24846.8 25008.2 02:52:44 INFO - PID 9798 | 02:52:44 INFO - PID 9798 | [#2] jquery.html Cycles:180 Average:36060.21 Median:12711.31 stddev:87526.00 (688.6%) stddev-sans-first:87730.93 02:52:44 INFO - PID 9798 | Values: 552.2 556.9 569.0 572.0 599.9 21642.5 22424.7 22434.3 22451.2 22758.4 25801.1 26378.6 26399.0 26405.2 26443.2 6415.4 6602.5 6621.6 6624.9 6625.9 5916.1 6365.9 6398.9 6402.6 6559.5 6292.6 6428.2 6431.7 6434.8 6435.0 6375.6 6380.0 6385.2 6395.4 6407.1 5944.3 5988.2 5989.1 5990.0 6002.2 28204.7 29451.4 29940.7 30166.8 30259.5 1871.7 1937.2 1941.1 1943.7 1953.7 18703.2 19222.7 19287.9 19309.7 19317.6 2330.0 2346.6 2366.9 2430.0 2449.0 136354.0 140528.0 141394.0 141485.0 141764.3 13816.5 14742.7 15059.0 15119.0 15437.7 23008.5 23301.0 23441.2 23501.9 24088.5 10410.7 10589.3 10597.5 10697.9 10949.1 9880.0 9888.3 9903.5 10010.9 10051.8 9433.2 9550.3 9623.7 9796.0 9797.1 2820.2 2884.2 2884.6 2903.8 2940.9 944.5 950.7 964.7 980.6 989.0 18813.5 19516.7 23092.7 24844.3 24959.3 1015.9 1019.9 1024.1 1056.7 1063.4 11074.5 11269.3 11280.5 11402.8 11428.3 494812.0 497776.0 531715.0 532498.0 543322.0 119051.8 121842.0 124778.0 126527.0 128047.0 1206.2 1222.3 1258.5 1265.2 1275.6 19070.4 20175.8 20258.4 20499.4 20551.2 49446.3 52083.7 52821.7 57505.4 59354.4 63861.7 68969.7 69434.7 74315.6 79654.0 14764.4 15130.2 15215.1 15319.5 15455.5 23703.9 23742.5 23921.4 24007.3 24040.6 18904.4 18947.0 19069.1 19194.1 19331.7 15598.6 16089.7 16932.2 17010.0 17506.4 18839.4 19678.2 19755.5 19781.3 19786.2 12565.8 13098.9 14949.8 15036.6 15071.2 16931.4 17448.0 17529.5 17603.8 18098.9 02:52:44 INFO - PID 9798 | 02:52:44 INFO - PID 9798 | [#3] mootools.html Cycles:180 Average:8765.25 Median:2564.06 stddev:5973.68 (233.0%) stddev-sans-first:5964.33 02:52:44 INFO - PID 9798 | Values: 1333.5 1376.0 1388.1 1396.1 1400.0 13400.3 13986.3 13988.2 13993.4 14000.0 13493.2 14011.0 14178.0 14247.4 14360.8 2574.9 2641.5 2642.1 2646.0 2656.3 2558.8 2569.3 2621.8 2676.8 2692.0 2630.3 2644.7 2663.6 2665.6 2668.9 2552.3 2569.7 2590.2 2591.2 2635.3 2543.3 2553.9 2554.9 2580.3 2581.8 13776.5 13904.9 13962.8 14012.6 14028.5 7414.2 7738.9 7751.9 7758.9 7778.1 4905.0 4989.4 5048.5 5132.0 5136.6 1744.5 1749.8 1766.3 1800.6 1801.8 22139.8 22267.2 22401.8 22425.7 23303.4 6009.9 6040.5 6196.3 6212.3 6267.3 15646.9 15779.7 15832.0 15832.6 15844.3 7297.0 7518.6 7524.7 7526.6 7531.2 6834.6 6960.7 7005.4 7017.6 7056.6 4603.5 4745.3 4752.8 4789.1 4938.8 1272.3 1288.9 1310.2 1316.7 1371.9 883.3 896.5 902.0 914.4 924.4 8466.7 8630.0 8690.3 8725.4 8758.0 969.6 976.9 980.3 1005.8 1007.9 4917.8 4932.2 4951.4 5130.1 5276.4 18757.9 19265.4 19630.5 19780.5 19891.6 18855.4 19214.2 19246.2 19418.3 19465.8 10740.7 10880.6 10973.9 11085.4 11096.6 7641.8 8030.7 8203.0 8475.0 8570.9 16330.6 16393.5 17478.7 17883.2 17896.6 17332.6 17516.1 17531.9 17727.8 17835.5 12765.9 13071.2 13118.8 13141.8 13175.1 12732.7 12888.1 13016.8 13294.5 13343.8 10403.6 10812.9 11114.0 11296.8 11423.3 9923.0 10372.5 10589.8 10664.9 10775.7 9660.7 9797.8 9798.7 9827.6 9837.1 6975.5 6995.6 7110.2 7151.0 7260.6 6991.7 7037.5 7080.1 7139.5 7144.7 02:52:44 INFO - PID 9798 | 02:52:44 INFO - PID 9798 | [#4] prototype.html Cycles:180 Average:5386.16 Median:6004.98 stddev:1513.26 (25.2%) stddev-sans-first:1471.89 02:52:44 INFO - PID 9798 | Values: 472.7 495.9 513.2 514.1 519.6 5995.9 6163.9 6181.1 6195.2 6216.9 5938.3 6012.7 6034.2 6034.3 6048.9 4802.2 4863.1 4889.2 4889.7 4899.3 4766.2 4792.3 4896.8 4897.2 4920.5 4788.3 4808.6 4817.6 4821.3 4871.9 4870.2 4872.6 4887.3 4901.4 4916.7 4420.8 4431.2 4433.6 4433.8 4439.3 5927.3 5940.3 5985.3 5997.3 6019.9 5515.1 5530.2 5551.2 5605.8 5621.2 6298.3 6310.9 6346.4 6378.1 6387.3 4734.0 4762.0 4813.7 4824.9 4857.8 6585.5 6632.4 6678.9 6720.6 6807.6 4800.3 4829.7 4858.7 4859.9 4882.4 4890.7 4913.6 4927.8 4960.9 4964.3 5495.7 5527.2 5538.4 5624.7 5631.6 6176.5 6283.2 6325.5 6384.2 6399.6 1651.1 1686.9 1708.3 1722.7 1726.0 966.9 1200.4 1206.7 1218.7 1223.8 5450.6 5470.7 5490.5 5620.0 5755.5 6483.7 6543.2 6570.5 6571.9 6669.5 5614.8 5690.3 5713.7 5722.0 5753.7 3475.4 3493.4 3500.4 3510.6 3557.8 6345.9 6402.4 6453.0 6457.5 6494.8 6626.9 6655.0 6697.1 6713.7 6749.9 6311.6 6350.5 6353.7 6369.8 6407.6 6472.6 6479.4 6485.3 6599.5 6623.4 6447.2 6454.4 6502.5 6614.4 6628.1 6259.1 6334.7 6406.4 6426.6 6496.4 4836.6 4865.3 4908.4 4917.4 4917.4 6548.6 6592.4 6620.4 6636.3 6662.7 6460.9 6464.7 6482.4 6501.0 6506.8 6332.5 6355.6 6366.9 6452.0 6457.8 6272.7 6292.0 6295.9 6341.8 6377.7 6356.5 6366.2 6393.8 6431.5 6507.0 5656.5 6183.3 6246.0 6259.2 6279.5 02:52:44 INFO - PID 9798 | 02:52:44 INFO - PID 9798 | [#5] yui.html Cycles:180 Average:22918.82 Median:19956.00 stddev:30626.49 (153.5%) stddev-sans-first:30667.77 02:52:44 INFO - PID 9798 | Values: 897.6 903.9 923.4 925.7 929.6 17987.0 19301.7 19304.4 19332.5 21140.7 20602.2 21646.8 21687.7 21712.6 21872.8 968.9 1000.9 1003.6 1007.2 1008.1 1055.0 1079.2 1081.7 1082.6 1083.9 1050.8 1063.6 1115.1 1117.1 1124.7 1101.0 1102.7 1108.8 1109.4 1111.7 784.9 790.4 792.2 792.7 794.1 19390.6 19918.1 19926.2 19985.8 20584.3 20302.7 20377.6 20920.6 20983.9 21005.6 15595.8 15750.0 15933.5 15951.7 16369.9 3527.0 3586.7 3588.9 3591.2 3593.2 118789.4 120279.0 122057.8 124443.0 125802.0 15721.8 16174.3 16264.2 16317.8 16321.1 29234.3 30132.2 30211.6 30271.8 30467.1 7427.5 7707.0 8706.7 8920.4 8932.1 4254.5 4347.7 4351.7 4375.5 4377.5 5004.0 5137.0 5172.2 5203.9 5243.1 1020.6 1047.8 1052.6 1066.4 1067.5 646.3 666.7 688.9 690.5 697.9 10619.2 12335.4 13039.5 13253.6 13531.0 701.3 709.4 712.7 729.4 732.7 5313.8 5719.0 5762.9 6347.0 6359.8 99454.0 104742.0 105632.0 107275.5 108205.0 84118.6 87593.0 89629.0 90390.5 94487.5 79421.6 82547.0 82748.6 83928.6 85636.6 11934.3 12196.8 12600.2 12658.3 12775.8 35313.7 36875.7 37026.0 38086.8 38720.4 60951.7 67978.7 69332.7 72156.0 72280.6 16988.1 17022.1 17237.9 17362.8 17600.1 18063.5 20880.3 21077.1 21371.4 21552.0 17984.2 18056.9 18084.4 18142.0 18393.8 18219.2 18331.6 18371.6 18459.4 18795.7 16465.3 16613.5 16666.7 16903.3 16975.4 11474.3 11670.1 11914.5 12045.9 12141.2 12102.5 12358.2 12481.3 12617.0 12725.2 02:52:44 INFO - PID 9798 | -------- Summary: end -------- 02:52:44 INFO - PID 9798 | 02:52:45 INFO - TEST-INFO | 9798: exit 0 02:52:45 INFO - TEST-OK | dromaeo_css | took 1112786ms 02:52:45 INFO - TEST-START | kraken 02:52:45 INFO - Initialising browser for kraken test... 02:52:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52379/getInfo.html -profile /tmp/tmp8JjR6m/profile 02:52:45 INFO - TEST-INFO | started process 10184 (/builds/slave/test/build/application/firefox/firefox http://localhost:52379/getInfo.html) 02:52:50 INFO - TEST-INFO | 10184: exit 0 02:52:50 INFO - Browser initialized. 02:52:50 INFO - Running cycle 1/1 for kraken test... 02:52:50 INFO - TEST-INFO | started process 10412 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8JjR6m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:53:02 INFO - PID 10412 | RSS: Main: 171839488 02:53:02 INFO - PID 10412 | 02:53:04 INFO - PID 10412 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52379/tests/kraken/driver.html?testName=audio-beat-detection) 02:53:05 INFO - PID 10412 | RSS: Main: 177819648 02:53:05 INFO - PID 10412 | 02:53:08 INFO - PID 10412 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52379/tests/kraken/driver.html?testName=audio-dft) 02:53:08 INFO - PID 10412 | RSS: Main: 177815552 02:53:08 INFO - PID 10412 | 02:53:11 INFO - PID 10412 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52379/tests/kraken/driver.html?testName=audio-fft) 02:53:12 INFO - PID 10412 | RSS: Main: 172494848 02:53:12 INFO - PID 10412 | 02:53:14 INFO - PID 10412 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52379/tests/kraken/driver.html?testName=audio-oscillator) 02:53:15 INFO - PID 10412 | RSS: Main: 173154304 02:53:15 INFO - PID 10412 | 02:53:17 INFO - PID 10412 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52379/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:53:18 INFO - PID 10412 | RSS: Main: 173510656 02:53:18 INFO - PID 10412 | 02:53:21 INFO - PID 10412 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52379/tests/kraken/driver.html?testName=imaging-darkroom) 02:53:21 INFO - PID 10412 | RSS: Main: 175939584 02:53:21 INFO - PID 10412 | 02:53:25 INFO - PID 10412 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52379/tests/kraken/driver.html?testName=imaging-desaturate) 02:53:26 INFO - PID 10412 | RSS: Main: 175566848 02:53:26 INFO - PID 10412 | 02:53:28 INFO - PID 10412 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52379/tests/kraken/driver.html?testName=json-parse-financial) 02:53:29 INFO - PID 10412 | RSS: Main: 176812032 02:53:29 INFO - PID 10412 | 02:53:31 INFO - PID 10412 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52379/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:53:31 INFO - PID 10412 | RSS: Main: 176451584 02:53:31 INFO - PID 10412 | 02:53:33 INFO - PID 10412 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52379/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:53:34 INFO - PID 10412 | RSS: Main: 176275456 02:53:34 INFO - PID 10412 | 02:53:36 INFO - PID 10412 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52379/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:53:37 INFO - PID 10412 | RSS: Main: 176676864 02:53:37 INFO - PID 10412 | 02:53:39 INFO - PID 10412 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52379/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:53:40 INFO - PID 10412 | RSS: Main: 176910336 02:53:40 INFO - PID 10412 | 02:53:43 INFO - PID 10412 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52379/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:53:44 INFO - PID 10412 | RSS: Main: 177684480 02:53:44 INFO - PID 10412 | 02:53:46 INFO - PID 10412 | Cycle 1(1): loaded http://localhost:52379/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52379/tests/kraken/driver.html?testName=ai-astar) 02:53:46 INFO - PID 10412 | RSS: Main: 178704384 02:53:46 INFO - PID 10412 | 02:53:46 INFO - PID 10412 | __start_tp_report 02:53:46 INFO - PID 10412 | _x_x_mozilla_page_load 02:53:46 INFO - PID 10412 | _x_x_mozilla_page_load_details 02:53:46 INFO - PID 10412 | |i|pagename|runs| 02:53:46 INFO - PID 10412 | |0;ai-astar;100;111;108;110;109;111;113;103;109;109 02:53:46 INFO - PID 10412 | |1;audio-beat-detection;142;117;143;182;121;151;152;119;167;124 02:53:46 INFO - PID 10412 | |2;audio-dft;162;163;163;162;164;164;167;168;169;166 02:53:46 INFO - PID 10412 | |3;audio-fft;77;74;74;171;77;76;75;75;148;76 02:53:46 INFO - PID 10412 | |4;audio-oscillator;81;81;133;81;82;82;129;80;80;130 02:53:46 INFO - PID 10412 | |5;imaging-gaussian-blur;114;120;114;115;113;114;114;114;115;116 02:53:46 INFO - PID 10412 | |6;imaging-darkroom;153;151;151;151;151;152;151;157;159;151 02:53:46 INFO - PID 10412 | |7;imaging-desaturate;94;95;94;94;94;94;94;94;94;95 02:53:46 INFO - PID 10412 | |8;json-parse-financial;55;52;53;55;53;54;56;53;53;53 02:53:46 INFO - PID 10412 | |9;json-stringify-tinderbox;54;55;54;55;55;54;55;55;55;55 02:53:46 INFO - PID 10412 | |10;stanford-crypto-aes;80;86;78;77;87;80;86;80;88;79 02:53:46 INFO - PID 10412 | |11;stanford-crypto-ccm;136;127;138;132;133;127;125;125;132;179 02:53:46 INFO - PID 10412 | |12;stanford-crypto-pbkdf2;181;177;180;177;177;176;185;180;180;180 02:53:46 INFO - PID 10412 | |13;stanford-crypto-sha256-iterative;69;71;74;68;69;67;71;71;70;67 02:53:46 INFO - PID 10412 | __end_tp_report 02:53:46 INFO - PID 10412 | __start_cc_report 02:53:46 INFO - PID 10412 | _x_x_mozilla_cycle_collect,957 02:53:46 INFO - PID 10412 | __end_cc_report 02:53:46 INFO - PID 10412 | __startTimestamp1500976426291__endTimestamp 02:53:46 INFO - PID 10412 | 02:53:46 INFO - PID 10412 | ------- Summary: start ------- 02:53:46 INFO - PID 10412 | Number of tests: 14 02:53:46 INFO - PID 10412 | 02:53:46 INFO - PID 10412 | [#0] ai-astar Cycles:10 Average:108.30 Median:109.50 stddev:3.92 (3.6%) stddev-sans-first:2.77 02:53:46 INFO - PID 10412 | Values: 100.0 111.0 108.0 110.0 109.0 111.0 113.0 103.0 109.0 109.0 02:53:46 INFO - PID 10412 | 02:53:46 INFO - PID 10412 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:147.00 stddev:21.92 (14.9%) stddev-sans-first:23.25 02:53:46 INFO - PID 10412 | Values: 142.0 117.0 143.0 182.0 121.0 151.0 152.0 119.0 167.0 124.0 02:53:46 INFO - PID 10412 | 02:53:46 INFO - PID 10412 | [#2] audio-dft Cycles:10 Average:164.80 Median:165.00 stddev:2.53 (1.5%) stddev-sans-first:2.47 02:53:46 INFO - PID 10412 | Values: 162.0 163.0 163.0 162.0 164.0 164.0 167.0 168.0 169.0 166.0 02:53:46 INFO - PID 10412 | 02:53:46 INFO - PID 10412 | [#3] audio-fft Cycles:10 Average:92.30 Median:75.50 stddev:35.85 (47.5%) stddev-sans-first:37.59 02:53:46 INFO - PID 10412 | Values: 77.0 74.0 74.0 171.0 77.0 76.0 75.0 75.0 148.0 76.0 02:53:46 INFO - PID 10412 | 02:53:46 INFO - PID 10412 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:81.00 stddev:24.02 (29.7%) stddev-sans-first:24.87 02:53:46 INFO - PID 10412 | Values: 81.0 81.0 133.0 81.0 82.0 82.0 129.0 80.0 80.0 130.0 02:53:46 INFO - PID 10412 | 02:53:46 INFO - PID 10412 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:114.50 stddev:1.97 (1.7%) stddev-sans-first:2.06 02:53:46 INFO - PID 10412 | Values: 114.0 120.0 114.0 115.0 113.0 114.0 114.0 114.0 115.0 116.0 02:53:46 INFO - PID 10412 | 02:53:46 INFO - PID 10412 | [#6] imaging-darkroom Cycles:10 Average:152.70 Median:151.50 stddev:2.91 (1.9%) stddev-sans-first:3.08 02:53:46 INFO - PID 10412 | Values: 153.0 151.0 151.0 151.0 151.0 152.0 151.0 157.0 159.0 151.0 02:53:46 INFO - PID 10412 | 02:53:46 INFO - PID 10412 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:53:46 INFO - PID 10412 | Values: 94.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 02:53:46 INFO - PID 10412 | 02:53:46 INFO - PID 10412 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.50 stddev:1.25 (2.3%) stddev-sans-first:1.24 02:53:46 INFO - PID 10412 | Values: 55.0 52.0 53.0 55.0 53.0 54.0 56.0 53.0 53.0 53.0 02:53:46 INFO - PID 10412 | 02:53:46 INFO - PID 10412 | [#9] json-stringify-tinderbox Cycles:10 Average:54.70 Median:55.00 stddev:0.48 (0.9%) stddev-sans-first:0.44 02:53:46 INFO - PID 10412 | Values: 54.0 55.0 54.0 55.0 55.0 54.0 55.0 55.0 55.0 55.0 02:53:46 INFO - PID 10412 | 02:53:46 INFO - PID 10412 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:83.00 stddev:4.15 (5.0%) stddev-sans-first:4.33 02:53:46 INFO - PID 10412 | Values: 80.0 86.0 78.0 77.0 87.0 80.0 86.0 80.0 88.0 79.0 02:53:46 INFO - PID 10412 | 02:53:46 INFO - PID 10412 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:132.50 stddev:15.97 (12.1%) stddev-sans-first:16.93 02:53:46 INFO - PID 10412 | Values: 136.0 127.0 138.0 132.0 133.0 127.0 125.0 125.0 132.0 179.0 02:53:46 INFO - PID 10412 | 02:53:46 INFO - PID 10412 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.30 Median:180.00 stddev:2.67 (1.5%) stddev-sans-first:2.76 02:53:46 INFO - PID 10412 | Values: 181.0 177.0 180.0 177.0 177.0 176.0 185.0 180.0 180.0 180.0 02:53:46 INFO - PID 10412 | 02:53:46 INFO - PID 10412 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.50 stddev:2.16 (3.1%) stddev-sans-first:2.28 02:53:46 INFO - PID 10412 | Values: 69.0 71.0 74.0 68.0 69.0 67.0 71.0 71.0 70.0 67.0 02:53:46 INFO - PID 10412 | -------- Summary: end -------- 02:53:46 INFO - PID 10412 | 02:53:46 INFO - PID 10412 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 02:53:46 INFO - TEST-INFO | 10412: exit 0 02:53:46 INFO - TEST-OK | kraken | took 61614ms 02:53:46 INFO - SUITE-END | took 1174s 02:53:47 INFO - Completed test suite (00:19:34) 02:53:47 INFO - javascript benchmark 02:53:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8404.795300211817, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3109.331493728848, 3143.905682829513, 3146.3549972255682, 3182.2362632968093, 3199.872005119795, 6016.428439298265, 6097.085437184424, 6146.170267013952, 6202.906956395657, 6223.595466294688, 5972.432618901208, 6063.666498342589, 6082.817515474543, 6086.482648974842, 6098.237720284965, 5553.444655534435, 5606.55147588192, 5609.35492418371, 5617.775288988436, 5746.224259724925, 5716.0, 5726.198332233491, 5727.541796656257, 5775.075987841946, 5779.913301300463, 5582.91625625616, 5641.971790141043, 5684.573656975723, 5740.4546568076175, 5767.884642307151, 5540.390557038722, 5599.936012157677, 5646.237757902672, 5708.315002199721, 5726.0, 5574.331080270353, 5578.693171875545, 5649.830505084854, 5671.319441666985, 5679.062954612484, 5919.822405327847, 5934.1098835174635, 6003.789867354665, 6066.545009124334, 6128.142060111588, 6591.967040164816, 6623.470122390246, 6624.470042396597, 6628.73485060597, 6635.469162466991, 6631.4363279121335, 6686.431653309426, 6726.461883049345, 6731.831704207385, 6739.797806065826, 6126.417990290915, 6169.938300616981, 6243.843903902439, 6260.248770147611, 6262.405071518198, 6548.148740663779, 6650.268470468244, 6773.525853190328, 6780.254172041072, 6835.624040677811, 6455.7740479083, 6515.055316979012, 6518.0, 6527.281998980108, 6536.215654121535, 6566.80299591013, 6579.30917253691, 6656.7670131545165, 6668.266490686021, 6671.199456065303, 6335.334789847092, 6520.510961677893, 6524.184476940382, 6595.835104122435, 6604.900926486107, 6408.327125651833, 6514.413702766774, 6570.868582628321, 6600.768973085919, 6619.669016549154, 5377.7311134443125, 5385.515303622693, 5395.271638328853, 5400.162974738922, 5420.620556561082, 4561.429821272341, 4576.199165146086, 4629.907401851944, 4630.328602352707, 4636.374089497942, 5694.487496125369, 5714.942850571524, 5791.942080579224, 5792.9710351447975, 5812.38969908162, 6451.838704032437, 6517.250516190604, 6519.054737063194, 6529.934700652932, 6533.901991470132, 5625.09998400254, 5703.230063941398, 5766.250387449605, 5769.826905192851, 5806.912896306559, 5764.13537969308, 5857.973740117706, 5924.289085309791, 5928.525717942554, 5940.910886336708, 6114.571979961449, 6277.435030847063, 6419.486441084702, 6492.35076492347, 6534.444572211415, 6494.642794646151, 6539.771108011197, 6591.307912669101, 6706.362895524917, 6721.059051732664, 6402.423781859468, 6462.030695395728, 6481.060246264171, 6489.643069631215, 6508.9349106508325, 6469.385408386196, 6493.253275873335, 6510.0, 6576.53964222519, 6614.437772789367, 6478.805635830932, 6575.769848055295, 6615.4046135848, 6694.765683201064, 6744.055832183596, 6363.268224154282, 6400.199975003125, 6413.967930160506, 6420.26166990802, 6421.068945003042, 6240.126382306572, 6296.181496405438, 6338.936610634019, 6375.489960803217, 6462.386073323027, 6266.874662506633, 6291.402316779899, 6297.055441683784, 6345.96827015862, 6421.8073457796345, 6458.903116453163, 6539.738410463528, 6544.312847150981, 6556.082148499118, 6569.113169722217, 6242.781502647385, 6278.529110316836, 6326.33573474797, 6354.777582784581, 6380.0], "value": 6026.251941790031, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.819958611175, 724.6811402982687, 740.4372676765659, 741.6254791330377, 1148.5922497513388, 30096.699033009692, 30958.69041309586, 41234.96912577183, 42238.15523689525, 42360.57639423605, 42542.0, 42547.78726106365, 43029.0, 43100.13799724004, 43118.784406077924, 7151.856962860739, 7368.447366447511, 7550.622468876548, 7770.4172187085915, 7786.649600767979, 7475.73834915778, 7529.20943300951, 7556.50882692626, 7615.5811430371305, 7617.733379331725, 7572.810679733023, 7648.885266721004, 7672.117706463744, 7687.8078048048965, 7696.846063078735, 7521.28547787962, 7612.581308028111, 7663.578503182351, 7667.616619169019, 7678.155402905676, 7590.8861367079535, 7648.349890259279, 7651.387888968869, 7653.846923061563, 7655.732049378245, 39169.60830391688, 39421.80289098536, 39476.40785388193, 39576.80211598924, 39658.60341396607, 3609.043603445089, 3634.0551456621206, 3662.926741465182, 3669.669729724311, 3679.3929001714687, 31408.0, 31486.212844678837, 31500.842495787376, 31503.0, 31571.52642710361, 4831.516848315176, 4884.902301953941, 4946.975265123688, 4960.032793605248, 4998.600111991068, 187447.0, 188363.0, 189020.054899726, 189620.0, 190023.0, 48952.0, 48955.51044489581, 49007.264891026665, 49085.754571227626, 49215.0, 51884.48115518872, 51914.48085519097, 53785.46214537804, 54379.45620543823, 54450.727746361015, 15944.601384965237, 16010.839891600936, 16043.919780401257, 16070.75893861593, 16090.919545402432, 11390.088792896548, 11423.314601123793, 11574.6527604172, 13061.542846000344, 13274.269915154759, 13363.1313964592, 13376.933115334556, 13406.195628262336, 13493.865061349457, 13672.93163534176, 5476.780928762884, 5486.835394938158, 5493.587980901449, 5567.415421380778, 5600.719964001783, 951.5622813505727, 975.7414285214423, 993.7118235711563, 1019.4444028004755, 1019.6431249062769, 22152.335429937128, 22188.304779708047, 22321.776782232293, 23009.477725346133, 23280.65079023816, 1092.2354351953663, 1100.5872797700863, 1103.7130346110068, 1127.402476687357, 1129.9378534180698, 12037.398130093461, 12050.0, 12108.636740897788, 12136.696582585506, 12136.939315303543, 233846.0, 234520.0, 235512.0, 235806.0, 236549.0, 51908.740456298234, 52083.73958130185, 52092.0, 52247.73876130595, 52260.0, 1454.0911930043724, 1470.669099452636, 1490.7987421697933, 1513.8259100203397, 1526.9541913742382, 21943.780562194814, 22051.11795528161, 22209.22267720622, 22227.777722223218, 22536.5492690142, 37180.628193718796, 37192.25615487621, 37287.0, 37370.626293736714, 37394.813025934694, 193734.0, 195142.0, 195497.0, 195553.0, 196340.0, 30991.380172395973, 31309.8434507826, 33866.830665846515, 33957.151071222426, 34188.31623367569, 42889.0, 42989.355159672006, 43161.56838431575, 43265.567344326155, 43329.35005974976, 29188.27029324284, 31159.0, 31885.883994060096, 32241.838790805898, 32347.514787277738, 30189.698103018687, 30869.69130308758, 31141.8442907784, 31611.0, 31651.841740791147, 34765.65234347624, 34810.0, 35056.47415288722, 35214.823925880206, 35590.466143008394, 28600.427991440472, 30209.848950755106, 30276.24309392283, 30480.84759576188, 30582.235444114074, 22341.888290558443, 22920.0, 24040.39899002469, 24846.751532484443, 25008.249752507454], "value": 16905.81307679661, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.1882832236611, 556.9340779011541, 568.9999999999998, 571.9599628026037, 599.8500374906273, 21642.458938526546, 22424.66363004556, 22434.3269701909, 22451.21420750274, 22758.431039224026, 25801.09696160635, 26378.604320935152, 26399.0, 26405.20784376467, 26443.206703798867, 6415.422611964922, 6602.471802255832, 6621.6027038377615, 6624.867502649944, 6625.900611490832, 5916.053431450969, 6365.872682546346, 6398.872022559546, 6402.583832050902, 6559.540832141752, 6292.622442653433, 6428.164338635971, 6431.6784160792, 6434.839129021765, 6434.9678251608675, 6375.617462952215, 6379.968100159516, 6385.201849768756, 6395.360463953614, 6407.103005579223, 5944.286685597713, 5988.19159413478, 5989.101634754778, 5990.011648078062, 6002.159697642333, 28204.717952820618, 29451.410971780446, 29940.70059299401, 30166.84916575425, 30259.546106808415, 1871.737956686065, 1937.2347922570507, 1941.0973897137758, 1943.6987266973642, 1953.7264782930401, 18703.158357873792, 19222.711659325123, 19287.90356048225, 19309.710354344697, 19317.61364772697, 2329.974811083135, 2346.62454007358, 2366.9408264793346, 2429.97570024301, 2448.995911676222, 136354.0, 140528.0, 141394.0, 141485.0, 141764.2911785445, 13816.516421925184, 14742.705145897022, 15059.0, 15118.976204758872, 15437.691246175014, 23008.539829203655, 23301.0, 23441.179558715365, 23501.88249058744, 24088.51822963531, 10410.739731506621, 10589.258751887293, 10597.4701264938, 10697.893021069689, 10949.069329106957, 9879.950600246953, 9888.307818452784, 9903.504824758733, 10010.949945250228, 10051.849222261671, 9433.198178154797, 9550.331476796697, 9623.663171789094, 9795.951020244853, 9797.118259356692, 2820.2244382794897, 2884.163592558177, 2884.639420072491, 2903.7822163337833, 2940.911772646824, 944.471096186138, 950.7337945375306, 964.6523806242784, 980.6469670918464, 988.9703308900745, 18813.529661758294, 19516.70724939127, 23092.65361019586, 24844.254672359857, 24959.251222463354, 1015.8527013582989, 1019.8827134879435, 1024.1243736605095, 1056.6724315462077, 1063.4310643805527, 11074.501647425885, 11269.323840569592, 11280.548778048786, 11402.771944561062, 11428.314301141958, 494812.0, 497776.0, 531715.0, 532498.0, 543322.0, 119051.80948190407, 121842.0, 124778.0, 126527.0, 128047.0, 1206.1978784108644, 1222.2849632964637, 1258.5091814192472, 1265.1839563481503, 1275.64282001038, 19070.42788716341, 20175.79824201798, 20258.392248232576, 20499.43201068202, 20551.177952881717, 49446.258306126154, 52083.73958130185, 52821.7358913203, 57505.424945750005, 59354.406455936616, 63861.680691596244, 68969.65515172391, 69434.65282673555, 74315.62842185971, 79654.0, 14764.409423622934, 15130.243487825344, 15215.08709477435, 15319.46381876629, 15455.459058932884, 23703.881480592485, 23742.525149497258, 23921.401964951016, 24007.27978160658, 24040.63939040951, 18904.432867014013, 18947.0, 19069.141888615322, 19194.13626386844, 19331.710024349366, 15598.610034748768, 16089.67820643604, 16932.15339233058, 17010.0, 17506.387276445774, 18839.434816955512, 19678.21287148498, 19755.506112347306, 19781.307654232034, 19786.20855165777, 12565.811512827133, 13098.934505327412, 14949.77575336349, 15036.624084397978, 15071.171085590398, 16931.407400740914, 17448.0, 17529.474115776546, 17603.823961760732, 18098.90950545239], "value": 12156.046426021616, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.4932725564283, 1375.9518416855412, 1388.1324172392256, 1396.0646366934157, 1400.0199860097935, 13400.262985535805, 13986.300684965749, 13988.230647314407, 13993.440262389493, 14000.0, 13493.190408575492, 14011.019228653999, 14178.0, 14247.4301027959, 14360.784588231185, 2574.858382788946, 2641.498115358085, 2642.062067965873, 2646.0474229277543, 2656.256248250493, 2558.7825034872058, 2569.3319736868457, 2621.8426894386303, 2676.8260063095936, 2692.0, 2630.3424143964007, 2644.7090820009785, 2663.6004599310063, 2665.586834040727, 2668.906588269411, 2552.310876063462, 2569.704483984347, 2590.171145233526, 2591.1708253358934, 2635.262126604535, 2543.275166577535, 2553.9361515962064, 2554.897804087834, 2580.342012786746, 2581.8192726508964, 13776.517821876287, 13904.930475347659, 13962.790558141636, 14012.579622611338, 14028.509002184977, 7414.221506741768, 7738.883916741253, 7751.883721744179, 7758.883616745753, 7778.0666320041955, 4904.950950490521, 4989.426215985171, 5048.495150484959, 5132.0, 5136.563392111638, 1744.5464179313342, 1749.80752117267, 1766.2669991953323, 1800.612868233336, 1801.8198180182007, 22139.778602213933, 22267.220647277267, 22401.77598224013, 22425.66361504579, 23303.417414564603, 6009.939900601025, 6040.486558642477, 6196.318404975449, 6212.347703491158, 6267.310595834455, 15646.921765391327, 15779.684406312039, 15832.0, 15832.604184895239, 15844.28700708471, 7296.963515182496, 7518.586477743776, 7524.736634217886, 7526.623668816537, 7531.209223031612, 6834.555753875982, 6960.686769095301, 7005.369516743517, 7017.578945263301, 7056.611886346198, 4603.516630753789, 4745.2882067690125, 4752.833650822205, 4789.066132104276, 4938.75306234694, 1272.287518989369, 1288.890444312244, 1310.2073245686413, 1316.6510874618234, 1371.8628137186402, 883.2889523933295, 896.4576431259125, 901.9503927284062, 914.4421902639384, 924.3899026642383, 8466.661333546712, 8630.0, 8690.304775618062, 8725.432846864933, 8758.0, 969.6412327438893, 976.9267304952157, 980.2696990741942, 1005.8340373838381, 1007.9042490963493, 4917.778699958439, 4932.161532539477, 4951.405831300267, 5130.050940576006, 5276.445973172838, 18757.90621046886, 19265.422037338903, 19630.509237269183, 19780.50548736293, 19891.60216795656, 18855.434336969913, 19214.231430742893, 19246.23015079409, 19418.320358787376, 19465.80534194668, 10740.677779666623, 10880.564777408816, 10973.945130274298, 11085.390303533382, 11096.5561377544, 7641.7707468776025, 8030.718924837603, 8203.0, 8474.957625211835, 8570.914290857261, 16330.591735206239, 16393.5081947537, 17478.73781893298, 17883.195256213243, 17896.55258618545, 17332.56668583245, 17516.124193790514, 17531.912340438215, 17727.822721772616, 17835.46493605194, 12765.93617031909, 13071.15037522558, 13118.803217951547, 13141.802872957105, 13175.14361566495, 12732.745345093232, 12888.097833151964, 13016.8047479286, 13294.468221271041, 13343.799843002169, 10403.583856645952, 10812.945935270272, 11114.0, 11296.774064518828, 11423.257488263236, 9923.0, 10372.533236004549, 10589.841152382567, 10664.89335106639, 10775.730606734895, 9660.71017869465, 9797.75505612337, 9798.65704700332, 9827.55775990068, 9837.114659680663, 6975.546589471668, 6995.615241161785, 7110.182329032227, 7151.0, 7260.636968151465, 6991.650417479207, 7037.472189585699, 7080.079589653518, 7139.464540159613, 7144.67848946809], "value": 6363.102180333043, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.6880259029039, 495.89338292267155, 513.2250302043914, 514.0669684522592, 519.6440438299767, 5995.942069544531, 6163.907541386877, 6181.134641150237, 6195.1946246987945, 6216.886258672056, 5938.317093534245, 6012.669303188323, 6034.215551978236, 6034.275886893579, 6048.886757005234, 4802.159622066142, 4863.124637565228, 4889.1932831083, 4889.731064791435, 4899.289603007562, 4766.213574760178, 4792.329073929635, 4896.804127834882, 4897.1674815281485, 4920.532549407819, 4788.329633851264, 4808.639352048593, 4817.638677099214, 4821.30091136785, 4871.926921096187, 4870.220764677652, 4872.56146946773, 4887.340209071783, 4901.411830580318, 4916.704997700113, 4420.823167073313, 4431.158079964828, 4433.583696885205, 4433.800478978454, 4439.311906654474, 5927.2887253529425, 5940.31686356066, 5985.34161242263, 5997.281685355064, 6019.939800601982, 5515.09001014832, 5530.198121272393, 5551.2228288039705, 5605.803796867131, 5621.18492818539, 6298.2756982947085, 6310.905336419957, 6346.365363463663, 6378.107065010902, 6387.329330420285, 4733.95266047342, 4761.976190119027, 4813.711177329336, 4824.879378015543, 4857.805687772485, 6585.539012269143, 6632.369924857179, 6678.899816502756, 6720.563163394364, 6807.591544507296, 4800.279958006257, 4829.6860704054125, 4858.66783943709, 4859.854204373874, 4882.438519570295, 4890.682105663192, 4913.582345500601, 4927.768057985503, 4960.875978100504, 4964.280179373971, 5495.697736624524, 5527.226188333637, 5538.418466061086, 5624.6625202487985, 5631.605787594911, 6176.505879529627, 6283.151774510474, 6325.493960483151, 6384.233891932905, 6399.584027038228, 1651.0918994552949, 1686.8734844886683, 1708.325211541434, 1722.7157519009475, 1725.9730460376056, 966.8743063401854, 1200.3878022208737, 1206.6967674911075, 1218.7257866979858, 1223.8286639870425, 5450.591205659592, 5470.729647196369, 5490.533304669068, 5620.0, 5755.510781583613, 6483.7082331295205, 6543.167912984277, 6570.474362051024, 6571.934280657228, 6669.533132680665, 5614.803481878114, 5690.260266165372, 5713.74288157034, 5721.971390143106, 5753.741081651336, 3475.374432602156, 3493.4235851084795, 3500.4049311617086, 3510.5606701252364, 3557.7865328080397, 6345.904811427832, 6402.399400149962, 6452.9677351612945, 6457.483401327882, 6494.805155845333, 6626.933730662631, 6655.0, 6697.129373181455, 6713.731450741916, 6749.898751518731, 6311.558190926591, 6350.491960643138, 6353.68231588428, 6369.840753981188, 6407.583507072025, 6472.579282346821, 6479.449246814073, 6485.286618472059, 6599.538032337882, 6623.370779775913, 6447.161868957193, 6454.386833250834, 6502.512311576556, 6614.404703576702, 6628.138342015507, 6259.12372267892, 6334.651594162366, 6406.391392817675, 6426.582272152295, 6496.350364963466, 4836.564709176191, 4865.318855360323, 4908.386451693538, 4917.360743103373, 4917.409910810726, 6548.607083575001, 6592.406683398517, 6620.437262832713, 6636.27001029896, 6662.734080524685, 6460.8707825842275, 6464.741410343534, 6482.384173503509, 6501.0, 6506.804795856132, 6332.461740752087, 6355.618662880242, 6366.9044964326495, 6451.967740161457, 6457.773977910751, 6272.68273662536, 6291.968540157453, 6295.905561416491, 6341.841453963688, 6377.7130029147875, 6356.459700925473, 6366.172397588284, 6393.840153996187, 6431.485481161402, 6507.0, 5656.456672460929, 6183.288921773874, 6246.0, 6259.186305780219, 6279.466245369012], "value": 4938.676722221903, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [897.5601955042027, 903.9412438191519, 923.3674932671121, 925.6945208081333, 929.6467342409883, 17987.0, 19301.710474342897, 19304.420867374, 19332.51668708283, 21140.682889756627, 20602.1759129635, 21646.783532164674, 21687.67468487974, 21712.565748685058, 21872.781272187272, 968.941863488193, 1000.9399436033862, 1003.64872294697, 1007.2194049611536, 1008.0977525115018, 1054.978900421995, 1079.2013909706839, 1081.686310969818, 1082.648139354709, 1083.8753543342498, 1050.816107181244, 1063.6277302943986, 1115.074488174813, 1117.1174771930207, 1124.7413094988158, 1100.961466348682, 1102.6526644107162, 1108.8225883858545, 1109.4452773613193, 1111.660943412259, 784.8783438567032, 790.3558599741192, 792.18405042806, 792.7304716396395, 794.0947320055142, 19390.612187756167, 19918.103685334194, 19926.202951881907, 19985.800141998683, 20584.27955021582, 20302.69545956812, 20377.592448151103, 20920.581588368146, 20983.895080524653, 21005.579888402146, 15595.766063509056, 15750.0, 15933.521994340188, 15951.680966380607, 16369.91815040929, 3527.0476971217886, 3586.677199052098, 3588.8743893963847, 3591.2099338145567, 3593.1735700788963, 118789.40605297005, 120279.0, 122057.77942220552, 124443.0, 125802.0, 15721.764173537405, 16174.27215775293, 16264.18679066042, 16317.755233671505, 16321.102339371211, 29234.26914327116, 30132.24669383283, 30211.640476178625, 30271.848640756656, 30467.085987420414, 7427.517211381243, 7706.961465192639, 8706.738797836075, 8920.420172688755, 8932.106789321017, 4254.489461264668, 4347.7173983690955, 4351.717138385995, 4375.5405682403525, 4377.5403582624, 5004.049230646166, 5137.0, 5172.19830926207, 5203.9219411708855, 5243.134882744381, 1020.5713600287897, 1047.8323468245044, 1052.6157952347337, 1066.3974854207347, 1067.530286673861, 646.2697152217963, 666.6699983508195, 688.896665500179, 690.5131882023162, 697.870893884633, 10619.150467962545, 12335.444904979298, 13039.478420863059, 13253.560057380886, 13531.0, 701.2987012987013, 709.3722055980494, 712.7291629180982, 729.3800269770759, 732.6959311885614, 5313.787448502017, 5718.971405143031, 5762.855928601818, 6347.0479428086155, 6359.777407790705, 99454.0, 104742.0, 105632.0, 107275.46362268295, 108205.0, 84118.57940710257, 87593.0, 89629.0, 90390.54804725935, 94487.52756236312, 79421.60289198633, 82547.0, 82748.58625706953, 83928.58035709782, 85636.57181714177, 11934.343611101473, 12196.75606487883, 12600.180988235736, 12658.303793291458, 12775.80836287475, 35313.68631368631, 36875.70935017261, 37026.0, 38086.80956595199, 38720.41919371268, 60951.69524152351, 67978.66010669916, 69332.653336733, 72156.0, 72280.63859680668, 16988.065656388524, 17022.14889255557, 17237.913810430866, 17362.826371736628, 17600.119993999993, 18063.548411289823, 20880.269190578256, 21077.051532680758, 21371.35885923425, 21552.0, 17984.19071141828, 18056.90971545134, 18084.367047153286, 18142.0, 18393.81606183921, 18219.180136893607, 18331.633367332313, 18371.632567348846, 18459.446216613524, 18795.718064228775, 16465.25906334194, 16613.50159495217, 16666.666666666843, 16903.323867045674, 16975.405860794814, 11474.254173478697, 11670.124740644316, 11914.52341906314, 12045.879541204826, 12141.210821296587, 12102.515899363927, 12358.196717213352, 12481.251124932533, 12617.0, 12725.23648581051], "value": 9056.910296177715, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 108.0, 110.0, 109.0, 111.0, 113.0, 103.0, 109.0, 109.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 117.0, 143.0, 182.0, 121.0, 151.0, 152.0, 119.0, 167.0, 124.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 162.0, 164.0, 164.0, 167.0, 168.0, 169.0, 166.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 74.0, 171.0, 77.0, 76.0, 75.0, 75.0, 148.0, 76.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 133.0, 81.0, 82.0, 82.0, 129.0, 80.0, 80.0, 130.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 120.0, 114.0, 115.0, 113.0, 114.0, 114.0, 114.0, 115.0, 116.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 151.0, 151.0, 151.0, 151.0, 152.0, 151.0, 157.0, 159.0, 151.0], "value": 152.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 53.0, 55.0, 53.0, 54.0, 56.0, 53.0, 53.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 55.0, 55.0, 54.0, 55.0, 55.0, 55.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 86.0, 78.0, 77.0, 87.0, 80.0, 86.0, 80.0, 88.0, 79.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 127.0, 138.0, 132.0, 133.0, 127.0, 125.0, 125.0, 132.0, 179.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 177.0, 180.0, 177.0, 177.0, 176.0, 185.0, 180.0, 180.0, 180.0], "value": 179.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 74.0, 68.0, 69.0, 67.0, 71.0, 71.0, 70.0, 67.0], "value": 69.7, "unit": "score"}]}]} 02:53:47 INFO - Return code: 0 02:53:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:53:47 INFO - # TBPL SUCCESS # 02:53:47 INFO - Running post-action listener: _package_coverage_data 02:53:47 INFO - Running post-action listener: _resource_record_post_action 02:53:47 INFO - [mozharness: 2017-07-25 09:53:47.578240Z] Finished run-tests step (success) 02:53:47 INFO - Running post-run listener: _resource_record_post_run 02:53:47 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 446459904; Read time: 12; Write time: 321192 02:53:47 INFO - TinderboxPrint: CPU usage
13.1% 02:53:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 02:53:47 INFO - TinderboxPrint: I/O write bytes / time
446,459,904 / 321,192 02:53:47 INFO - TinderboxPrint: CPU idle
8,259.7 (86.8%) 02:53:47 INFO - TinderboxPrint: CPU user
1,203.5 (12.7%) 02:53:47 INFO - TinderboxPrint: Swap in / out
0 / 0 02:53:47 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 112705536; Read time: 0; Write time: 108032 02:53:47 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 02:53:47 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 333078528; Read time: 0; Write time: 213112 02:53:48 INFO - Running post-run listener: _upload_blobber_files 02:53:48 INFO - Blob upload gear active. 02:53:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:53:48 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 02:53:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:53:48 INFO - (blobuploader) - INFO - Open directory for files ... 02:53:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:53:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:53:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:49 INFO - (blobuploader) - INFO - Done attempting. 02:53:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:53:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:53:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:50 INFO - (blobuploader) - INFO - Done attempting. 02:53:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:53:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:53:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:54 INFO - (blobuploader) - INFO - Done attempting. 02:53:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:53:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:53:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:55 INFO - (blobuploader) - INFO - Done attempting. 02:53:55 INFO - (blobuploader) - INFO - Iteration through files over. 02:53:55 INFO - Return code: 0 02:53:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:53:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:53:55 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fef29a38d5c9a5b19fb4073f910a02e249ad38888a897703cf655be17dae81e5f314b457c2e9cc2ffde23345b539edb2500421ba65e36bf84d1a5aff9cae221", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b45d3ba53056d9dd791ea5c0822803329d7a99a5e0fc5f77f1b689ba6e6457663cf3dab2c2c49fe030303845e9dcc2cd80c890cd9cb974da2055c7564d679499", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38b7d771c3e7e0e22ac5ced352933895791d77a3162fbc00176d4a5186cd3025be5adf36d4b6d0c73d7eccde7bca8ba774dc5ea6c1ef226c241404ed40c78b65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89043606101e0455f6ae098d27129574fa58516cf3227edf30293345807e6b0d45f0698e41175a88aea176a784a2193c208a879e9ffa9984698965a53231b9fa"} 02:53:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:53:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:53:55 INFO - Contents: 02:53:55 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fef29a38d5c9a5b19fb4073f910a02e249ad38888a897703cf655be17dae81e5f314b457c2e9cc2ffde23345b539edb2500421ba65e36bf84d1a5aff9cae221", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b45d3ba53056d9dd791ea5c0822803329d7a99a5e0fc5f77f1b689ba6e6457663cf3dab2c2c49fe030303845e9dcc2cd80c890cd9cb974da2055c7564d679499", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38b7d771c3e7e0e22ac5ced352933895791d77a3162fbc00176d4a5186cd3025be5adf36d4b6d0c73d7eccde7bca8ba774dc5ea6c1ef226c241404ed40c78b65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89043606101e0455f6ae098d27129574fa58516cf3227edf30293345807e6b0d45f0698e41175a88aea176a784a2193c208a879e9ffa9984698965a53231b9fa"} 02:53:55 INFO - Running post-run listener: copy_logs_to_upload_dir 02:53:55 INFO - Copying logs to upload dir... 02:53:55 INFO - mkdir: /builds/slave/test/build/upload/logs 02:53:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.681208 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-07-25 02:53:54.002028) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-25 02:53:54.005369) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fef29a38d5c9a5b19fb4073f910a02e249ad38888a897703cf655be17dae81e5f314b457c2e9cc2ffde23345b539edb2500421ba65e36bf84d1a5aff9cae221", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b45d3ba53056d9dd791ea5c0822803329d7a99a5e0fc5f77f1b689ba6e6457663cf3dab2c2c49fe030303845e9dcc2cd80c890cd9cb974da2055c7564d679499", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38b7d771c3e7e0e22ac5ced352933895791d77a3162fbc00176d4a5186cd3025be5adf36d4b6d0c73d7eccde7bca8ba774dc5ea6c1ef226c241404ed40c78b65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89043606101e0455f6ae098d27129574fa58516cf3227edf30293345807e6b0d45f0698e41175a88aea176a784a2193c208a879e9ffa9984698965a53231b9fa"} build_url:https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/PYRS21koSy2w95sKktp1zA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fef29a38d5c9a5b19fb4073f910a02e249ad38888a897703cf655be17dae81e5f314b457c2e9cc2ffde23345b539edb2500421ba65e36bf84d1a5aff9cae221", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b45d3ba53056d9dd791ea5c0822803329d7a99a5e0fc5f77f1b689ba6e6457663cf3dab2c2c49fe030303845e9dcc2cd80c890cd9cb974da2055c7564d679499", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38b7d771c3e7e0e22ac5ced352933895791d77a3162fbc00176d4a5186cd3025be5adf36d4b6d0c73d7eccde7bca8ba774dc5ea6c1ef226c241404ed40c78b65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89043606101e0455f6ae098d27129574fa58516cf3227edf30293345807e6b0d45f0698e41175a88aea176a784a2193c208a879e9ffa9984698965a53231b9fa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-25 02:53:54.029271) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 02:53:54.029552) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1500969773.513762-760498362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 02:53:54.111863) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-25 02:53:54.112179) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-25 02:53:54.112455) ========= ========= Total master_lag: 0.17 =========