builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-071 starttime: 1500935637.06 results: success (0) revision: bf4634a50775537b4e791b6d294a275b83737472 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:57.061241) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:57.061694) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:57.062002) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:57.152035) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:57.152294) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-24 15:33:57-- 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% 45.7M=0s 2017-07-24 15:33:57 (45.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088941 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:57.288148) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:57.288462) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019186 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:57.359583) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-24 15:33:57.359921) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bf4634a50775537b4e791b6d294a275b83737472 --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 bf4634a50775537b4e791b6d294a275b83737472 --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=dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-24 15:33:58,053 truncating revision to first 12 chars 2017-07-24 15:33:58,053 Setting DEBUG logging. 2017-07-24 15:33:58,053 attempt 1/10 2017-07-24 15:33:58,053 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bf4634a50775?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-24 15:33:58,791 unpacking tar archive at: mozilla-central-bf4634a50775/testing/mozharness/ program finished with exit code 0 elapsedTime=1.031636 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-24 15:33:58.433428) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:58.433705) ========= script_repo_revision: bf4634a50775537b4e791b6d294a275b83737472 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:58.434061) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:58.434327) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 15:33:58.475470) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-07-24 15:33:58.475772) ========= /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=dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:33:59 INFO - MultiFileLogger online at 20170724 15:33:59 in /builds/slave/test 15:33:59 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 15:33:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:33:59 INFO - {'append_to_log': False, 15:33:59 INFO - 'base_work_dir': '/builds/slave/test', 15:33:59 INFO - 'blob_upload_branch': 'Firefox', 15:33:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:33:59 INFO - 'branch': 'Firefox', 15:33:59 INFO - 'buildbot_json_path': 'buildprops.json', 15:33:59 INFO - 'code_coverage': False, 15:33:59 INFO - 'config_files': ('talos/linux_config.py',), 15:33:59 INFO - 'default_actions': ('clobber', 15:33:59 INFO - 'read-buildbot-config', 15:33:59 INFO - 'download-and-extract', 15:33:59 INFO - 'populate-webroot', 15:33:59 INFO - 'create-virtualenv', 15:33:59 INFO - 'install', 15:33:59 INFO - 'setup-mitmproxy', 15:33:59 INFO - 'run-tests'), 15:33:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:33:59 INFO - 'disable_ccov_upload': False, 15:33:59 INFO - 'download_minidump_stackwalk': True, 15:33:59 INFO - 'download_symbols': 'ondemand', 15:33:59 INFO - 'enable_stylo': False, 15:33:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:33:59 INFO - 'tooltool.py': '/tools/tooltool.py', 15:33:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:33:59 INFO - '/tools/misc-python/virtualenv.py')}, 15:33:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:33:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:33:59 INFO - 'gecko_profile': False, 15:33:59 INFO - 'gecko_profile_interval': 0, 15:33:59 INFO - 'installer_path': 'installer.exe', 15:33:59 INFO - 'log_level': 'info', 15:33:59 INFO - 'log_name': 'talos', 15:33:59 INFO - 'log_to_console': True, 15:33:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:33:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:33:59 INFO - 'opt_config_files': (), 15:33:59 INFO - 'pip_index': False, 15:33:59 INFO - 'suite': 'dromaeojs-e10s', 15:33:59 INFO - 'system_bits': '32', 15:33:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:33:59 INFO - 'title': 'talos-linux64-ix-071', 15:33:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:33:59 INFO - 'use_talos_json': True, 15:33:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:33:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:33:59 INFO - 'work_dir': 'build'} 15:33:59 INFO - [mozharness: 2017-07-24 22:33:59.266843Z] Running clobber step. 15:33:59 INFO - Running pre-action listener: _resource_record_pre_action 15:33:59 INFO - Running main action method: clobber 15:33:59 INFO - rmtree: /builds/slave/test/build 15:33:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:34:00 INFO - Running post-action listener: _resource_record_post_action 15:34:00 INFO - [mozharness: 2017-07-24 22:34:00.315867Z] Finished clobber step (success) 15:34:00 INFO - [mozharness: 2017-07-24 22:34:00.315970Z] Running read-buildbot-config step. 15:34:00 INFO - Running pre-action listener: _resource_record_pre_action 15:34:00 INFO - Running main action method: read_buildbot_config 15:34:00 INFO - Using buildbot properties: 15:34:00 INFO - { 15:34:00 INFO - "project": "", 15:34:00 INFO - "product": "firefox", 15:34:00 INFO - "who": "kwierso@gmail.com", 15:34:00 INFO - "installer_path": "public/build/target.tar.bz2", 15:34:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 15:34:00 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 15:34:00 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 15:34:00 INFO - "stage_platform": "linux64-stylo", 15:34:00 INFO - "basedir": "/builds/slave/test", 15:34:00 INFO - "buildnumber": 46, 15:34:00 INFO - "platform": "ubuntu64_hw_stylo", 15:34:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:34:00 INFO - "slavebuilddir": "test", 15:34:00 INFO - "taskId": "flhQIzyyTx2N-mYILg2hdQ", 15:34:00 INFO - "branch": "mozilla-central", 15:34:00 INFO - "script_repo_revision": "production", 15:34:00 INFO - "revision": "bf4634a50775537b4e791b6d294a275b83737472", 15:34:00 INFO - "slavename": "talos-linux64-ix-071", 15:34:00 INFO - "repo_path": "mozilla-central" 15:34:00 INFO - } 15:34:00 INFO - Finding installer, test and symbols from parent task. 15:34:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/flhQIzyyTx2N-mYILg2hdQ'}, attempt #1 15:34:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/flhQIzyyTx2N-mYILg2hdQ'}, attempt #1 15:34:01 INFO - Task dependencies: S1EjXnT4TFqOlI6-AEiL3g 15:34:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g'}, attempt #1 15:34:01 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.tar.bz2 15:34:01 INFO - Set test_url: https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/test_packages.json 15:34:01 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.crashreporter-symbols.zip 15:34:01 INFO - Running post-action listener: _resource_record_post_action 15:34:01 INFO - [mozharness: 2017-07-24 22:34:01.705360Z] Finished read-buildbot-config step (success) 15:34:01 INFO - [mozharness: 2017-07-24 22:34:01.705618Z] Running download-and-extract step. 15:34:01 INFO - Running pre-action listener: _resource_record_pre_action 15:34:01 INFO - Running main action method: download_and_extract 15:34:01 INFO - mkdir: /builds/slave/test/build/tests 15:34:01 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')]} 15:34:01 INFO - trying https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.test_packages.json 15:34:01 INFO - Downloading https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:34:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:34:02 INFO - Downloaded 989 bytes. 15:34:02 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:34:02 INFO - Using the following test package requirements: 15:34:02 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:34:02 INFO - u'common': [u'target.common.tests.zip'], 15:34:02 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:34:02 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:34:02 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:34:02 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:34:02 INFO - u'mozbase': [u'target.common.tests.zip'], 15:34:02 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:34:02 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:34:02 INFO - u'web-platform': [u'target.common.tests.zip', 15:34:02 INFO - u'target.web-platform.tests.tar.gz'], 15:34:02 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:34:02 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:34:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.common.tests.zip 15:34:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:34:02 INFO - Fetch https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.common.tests.zip into memory 15:34:07 INFO - Content-Length response header: 72761346 15:34:07 INFO - Bytes received: 72761346 15:34:18 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:34:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.common.tests.zip 15:34:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:34:18 INFO - Fetch https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.common.tests.zip into memory 15:34:22 INFO - Content-Length response header: 72761346 15:34:22 INFO - Bytes received: 72761346 15:34:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.talos.tests.zip 15:34:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:34:34 INFO - Fetch https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.talos.tests.zip into memory 15:34:35 INFO - Content-Length response header: 14498976 15:34:35 INFO - Bytes received: 14498976 15:34:35 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')]} 15:34:35 INFO - trying https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.tar.bz2 15:34:35 INFO - Downloading https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:34:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:34:38 INFO - Downloaded 62039933 bytes. 15:34:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.tar.bz2 15:34:38 INFO - mkdir: /builds/slave/test/properties 15:34:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:34:38 INFO - Writing to file /builds/slave/test/properties/build_url 15:34:38 INFO - Contents: 15:34:38 INFO - build_url:https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.tar.bz2 15:34:38 INFO - Running post-action listener: _resource_record_post_action 15:34:38 INFO - Running post-action listener: set_extra_try_arguments 15:34:38 INFO - [mozharness: 2017-07-24 22:34:38.979349Z] Finished download-and-extract step (success) 15:34:38 INFO - [mozharness: 2017-07-24 22:34:38.979577Z] Running populate-webroot step. 15:34:38 INFO - Running pre-action listener: _resource_record_pre_action 15:34:38 INFO - Running main action method: populate_webroot 15:34:38 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:34:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:34:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:34:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:34:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:34:38 INFO - 'tests': ['damp', 'tps']}, 15:34:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:34:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:34:38 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:34:38 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:34:38 INFO - 'other-e10s': {'tests': ['a11yr', 15:34:38 INFO - 'ts_paint', 15:34:38 INFO - 'tpaint', 15:34:38 INFO - 'sessionrestore', 15:34:38 INFO - 'sessionrestore_many_windows', 15:34:38 INFO - 'sessionrestore_no_auto_restore', 15:34:38 INFO - 'tabpaint']}, 15:34:38 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:34:38 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:34:38 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:34:38 INFO - 'talos_options': ['--mitmproxy', 15:34:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:34:38 INFO - '--firstNonBlankPaint'], 15:34:38 INFO - 'tests': ['quantum_pageload_google', 15:34:38 INFO - 'quantum_pageload_youtube', 15:34:38 INFO - 'quantum_pageload_amazon', 15:34:38 INFO - 'quantum_pageload_facebook']}, 15:34:38 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:34:38 INFO - 'talos_options': ['--stylo', 15:34:38 INFO - '--mitmproxy', 15:34:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:34:38 INFO - '--firstNonBlankPaint'], 15:34:38 INFO - 'tests': ['quantum_pageload_google', 15:34:38 INFO - 'quantum_pageload_youtube', 15:34:38 INFO - 'quantum_pageload_amazon', 15:34:38 INFO - 'quantum_pageload_facebook']}, 15:34:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:34:38 INFO - 'tsvgr_opacity', 15:34:38 INFO - 'tart', 15:34:38 INFO - 'tscrollx', 15:34:38 INFO - 'cart', 15:34:38 INFO - 'tsvg_static']}, 15:34:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:34:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:34:38 INFO - 'talos_options': ['--xperf_path', 15:34:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:34:38 INFO - 'tests': ['tp5n']}}} 15:34:38 INFO - Running post-action listener: _resource_record_post_action 15:34:38 INFO - [mozharness: 2017-07-24 22:34:38.990755Z] Finished populate-webroot step (success) 15:34:38 INFO - [mozharness: 2017-07-24 22:34:38.990844Z] Running create-virtualenv step. 15:34:38 INFO - Running pre-action listener: _resource_record_pre_action 15:34:38 INFO - Running main action method: create_virtualenv 15:34:38 INFO - Creating virtualenv /builds/slave/test/build/venv 15:34:38 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 15:34:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:34:38 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:34:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:34:39 INFO - Using real prefix '/usr' 15:34:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:34:39 INFO - Installing distribute.............................................................................................................................................................................................done. 15:34:41 INFO - Installing pip.................done. 15:34:41 INFO - Return code: 0 15:34:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:34:41 INFO - Reading from file tmpfile_stdout 15:34:41 INFO - Output received: 15:34:41 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) 15:34:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:34: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')]} 15:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34: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')]} 15:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b2eb0>, '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 0x26b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b4240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981', '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 15:34: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', 'pip>=1.5'] in /builds/slave/test/build 15:34: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 pip>=1.5 15:34:41 INFO - Using env: {'DISPLAY': ':0', 15:34:41 INFO - 'HOME': '/home/cltbld', 15:34:41 INFO - 'LANG': 'en_US.UTF-8', 15:34:41 INFO - 'LANGUAGE': 'en_US:en', 15:34:41 INFO - 'LOGNAME': 'cltbld', 15:34:41 INFO - 'MAIL': '/var/mail/cltbld', 15:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:41 INFO - 'MOZ_NO_REMOTE': '1', 15:34:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:41 INFO - 'NO_EM_RESTART': '1', 15:34:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:41 INFO - 'PWD': '/builds/slave/test', 15:34:41 INFO - 'SHELL': '/bin/bash', 15:34:41 INFO - 'SHLVL': '1', 15:34:41 INFO - 'TERM': 'linux', 15:34:41 INFO - 'TMOUT': '86400', 15:34:41 INFO - 'USER': 'cltbld', 15:34:41 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981', 15:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:41 INFO - '_': '/tools/buildbot/bin/python'} 15:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:41 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 15:34:41 INFO - Cleaning up... 15:34:41 INFO - Return code: 0 15:34:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:34: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')]} 15:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34: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')]} 15:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34: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', '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 0x23461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b2eb0>, '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 0x26b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b4240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981', '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 15:34: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:34: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 psutil>=3.1.1 15:34:41 INFO - Using env: {'DISPLAY': ':0', 15:34:41 INFO - 'HOME': '/home/cltbld', 15:34:41 INFO - 'LANG': 'en_US.UTF-8', 15:34:41 INFO - 'LANGUAGE': 'en_US:en', 15:34:41 INFO - 'LOGNAME': 'cltbld', 15:34:41 INFO - 'MAIL': '/var/mail/cltbld', 15:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:41 INFO - 'MOZ_NO_REMOTE': '1', 15:34:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:41 INFO - 'NO_EM_RESTART': '1', 15:34:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:41 INFO - 'PWD': '/builds/slave/test', 15:34:41 INFO - 'SHELL': '/bin/bash', 15:34:41 INFO - 'SHLVL': '1', 15:34:41 INFO - 'TERM': 'linux', 15:34:41 INFO - 'TMOUT': '86400', 15:34:41 INFO - 'USER': 'cltbld', 15:34:41 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981', 15:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:41 INFO - '_': '/tools/buildbot/bin/python'} 15:34:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:42 INFO - Downloading/unpacking psutil>=3.1.1 15:34: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 15:34: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 15:34: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 15:34: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 15:34:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:34:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:34:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:34:43 INFO - Installing collected packages: psutil 15:34:43 INFO - Running setup.py install for psutil 15:34:43 INFO - building 'psutil._psutil_linux' extension 15:34:43 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 15:34:43 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 15:34:43 INFO - building 'psutil._psutil_posix' extension 15:34:43 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 15:34:43 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 15:34:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:34:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:34:43 INFO - Successfully installed psutil 15:34:43 INFO - Cleaning up... 15:34:43 INFO - Return code: 0 15:34:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:34:43 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')]} 15:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:43 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')]} 15:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:43 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 0x23461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b2eb0>, '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 0x26b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b4240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981', '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 15:34:43 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 15:34:43 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 15:34:43 INFO - Using env: {'DISPLAY': ':0', 15:34:43 INFO - 'HOME': '/home/cltbld', 15:34:43 INFO - 'LANG': 'en_US.UTF-8', 15:34:43 INFO - 'LANGUAGE': 'en_US:en', 15:34:43 INFO - 'LOGNAME': 'cltbld', 15:34:43 INFO - 'MAIL': '/var/mail/cltbld', 15:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:43 INFO - 'MOZ_NO_REMOTE': '1', 15:34:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:43 INFO - 'NO_EM_RESTART': '1', 15:34:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:43 INFO - 'PWD': '/builds/slave/test', 15:34:43 INFO - 'SHELL': '/bin/bash', 15:34:43 INFO - 'SHLVL': '1', 15:34:43 INFO - 'TERM': 'linux', 15:34:43 INFO - 'TMOUT': '86400', 15:34:43 INFO - 'USER': 'cltbld', 15:34:43 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981', 15:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:43 INFO - '_': '/tools/buildbot/bin/python'} 15:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:34:44 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 15:34:44 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 15:34:44 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 15:34:44 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 15:34:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:34:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:34:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:34:45 INFO - Installing collected packages: mozsystemmonitor 15:34:45 INFO - Running setup.py install for mozsystemmonitor 15:34:45 INFO - Successfully installed mozsystemmonitor 15:34:45 INFO - Cleaning up... 15:34:45 INFO - Return code: 0 15:34:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:34:45 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')]} 15:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:45 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')]} 15:34:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:45 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 0x23461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b2eb0>, '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 0x26b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b4240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981', '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 15:34:45 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 15:34:45 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 15:34:45 INFO - Using env: {'DISPLAY': ':0', 15:34:45 INFO - 'HOME': '/home/cltbld', 15:34:45 INFO - 'LANG': 'en_US.UTF-8', 15:34:45 INFO - 'LANGUAGE': 'en_US:en', 15:34:45 INFO - 'LOGNAME': 'cltbld', 15:34:45 INFO - 'MAIL': '/var/mail/cltbld', 15:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:45 INFO - 'MOZ_NO_REMOTE': '1', 15:34:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:45 INFO - 'NO_EM_RESTART': '1', 15:34:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:45 INFO - 'PWD': '/builds/slave/test', 15:34:45 INFO - 'SHELL': '/bin/bash', 15:34:45 INFO - 'SHLVL': '1', 15:34:45 INFO - 'TERM': 'linux', 15:34:45 INFO - 'TMOUT': '86400', 15:34:45 INFO - 'USER': 'cltbld', 15:34:45 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981', 15:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:45 INFO - '_': '/tools/buildbot/bin/python'} 15:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:45 INFO - Downloading/unpacking jsonschema==2.5.1 15:34:45 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 15:34:45 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 15:34:45 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 15:34:45 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 15:34:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:34:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:34:46 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 15:34:46 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 15:34:46 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 15:34:46 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 15:34:46 INFO - Downloading functools32-3.2.3-2.tar.gz 15:34:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:34:46 INFO - warning: no files found matching '*.txt' 15:34:46 INFO - no previously-included directories found matching 'build' 15:34:46 INFO - no previously-included directories found matching 'dist' 15:34:46 INFO - no previously-included directories found matching '.git*' 15:34:46 INFO - Installing collected packages: jsonschema, functools32 15:34:46 INFO - Running setup.py install for functools32 15:34:47 INFO - warning: no files found matching '*.txt' 15:34:47 INFO - no previously-included directories found matching 'build' 15:34:47 INFO - no previously-included directories found matching 'dist' 15:34:47 INFO - no previously-included directories found matching '.git*' 15:34:47 INFO - Successfully installed jsonschema functools32 15:34:47 INFO - Cleaning up... 15:34:47 INFO - Return code: 0 15:34:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:34: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')]} 15:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34: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')]} 15:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:47 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 0x23461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b2eb0>, '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 0x26b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b4240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981', '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 15:34:47 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 15:34:47 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 15:34:47 INFO - Using env: {'DISPLAY': ':0', 15:34:47 INFO - 'HOME': '/home/cltbld', 15:34:47 INFO - 'LANG': 'en_US.UTF-8', 15:34:47 INFO - 'LANGUAGE': 'en_US:en', 15:34:47 INFO - 'LOGNAME': 'cltbld', 15:34:47 INFO - 'MAIL': '/var/mail/cltbld', 15:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:47 INFO - 'MOZ_NO_REMOTE': '1', 15:34:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:47 INFO - 'NO_EM_RESTART': '1', 15:34:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:47 INFO - 'PWD': '/builds/slave/test', 15:34:47 INFO - 'SHELL': '/bin/bash', 15:34:47 INFO - 'SHLVL': '1', 15:34:47 INFO - 'TERM': 'linux', 15:34:47 INFO - 'TMOUT': '86400', 15:34:47 INFO - 'USER': 'cltbld', 15:34:47 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981', 15:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:47 INFO - '_': '/tools/buildbot/bin/python'} 15:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:34:47 INFO - Cleaning up... 15:34:47 INFO - Return code: 0 15:34:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:34: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')]} 15:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34: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')]} 15:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:47 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 0x23461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b2eb0>, '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 0x26b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b4240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981', '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 15:34:47 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 15:34:47 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 15:34:47 INFO - Using env: {'DISPLAY': ':0', 15:34:47 INFO - 'HOME': '/home/cltbld', 15:34:47 INFO - 'LANG': 'en_US.UTF-8', 15:34:47 INFO - 'LANGUAGE': 'en_US:en', 15:34:47 INFO - 'LOGNAME': 'cltbld', 15:34:47 INFO - 'MAIL': '/var/mail/cltbld', 15:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:47 INFO - 'MOZ_NO_REMOTE': '1', 15:34:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:47 INFO - 'NO_EM_RESTART': '1', 15:34:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:47 INFO - 'PWD': '/builds/slave/test', 15:34:47 INFO - 'SHELL': '/bin/bash', 15:34:47 INFO - 'SHLVL': '1', 15:34:47 INFO - 'TERM': 'linux', 15:34:47 INFO - 'TMOUT': '86400', 15:34:47 INFO - 'USER': 'cltbld', 15:34:47 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981', 15:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:47 INFO - '_': '/tools/buildbot/bin/python'} 15:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:47 INFO - Downloading/unpacking blobuploader==1.2.4 15:34:47 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 15:34:47 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 15:34:47 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 15:34:47 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 15:34:48 INFO - Downloading blobuploader-1.2.4.tar.gz 15:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:34:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:34:48 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 15:34:48 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 15:34:48 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 15:34:48 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 15:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:34:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:34: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 15:34: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 15:34: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 15:34: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 15:34:49 INFO - Downloading docopt-0.6.1.tar.gz 15:34:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:34:49 INFO - Installing collected packages: blobuploader, requests, docopt 15:34:49 INFO - Running setup.py install for blobuploader 15:34:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:34:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:34:49 INFO - Running setup.py install for requests 15:34:49 INFO - Running setup.py install for docopt 15:34:49 INFO - Successfully installed blobuploader requests docopt 15:34:49 INFO - Cleaning up... 15:34:49 INFO - Return code: 0 15:34:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34:49 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')]} 15:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:49 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')]} 15:34:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:49 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 0x23461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b2eb0>, '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 0x26b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b4240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981', '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 15:34:49 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 15:34:49 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 15:34:49 INFO - Using env: {'DISPLAY': ':0', 15:34:49 INFO - 'HOME': '/home/cltbld', 15:34:49 INFO - 'LANG': 'en_US.UTF-8', 15:34:49 INFO - 'LANGUAGE': 'en_US:en', 15:34:49 INFO - 'LOGNAME': 'cltbld', 15:34:49 INFO - 'MAIL': '/var/mail/cltbld', 15:34:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:49 INFO - 'MOZ_NO_REMOTE': '1', 15:34:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:49 INFO - 'NO_EM_RESTART': '1', 15:34:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:49 INFO - 'PWD': '/builds/slave/test', 15:34:49 INFO - 'SHELL': '/bin/bash', 15:34:49 INFO - 'SHLVL': '1', 15:34:49 INFO - 'TERM': 'linux', 15:34:49 INFO - 'TMOUT': '86400', 15:34:49 INFO - 'USER': 'cltbld', 15:34:49 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981', 15:34:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:49 INFO - '_': '/tools/buildbot/bin/python'} 15:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:34:50 INFO - Running setup.py (path:/tmp/pip-opz6EP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:34:50 INFO - Running setup.py (path:/tmp/pip-Le_Yfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:34:50 INFO - Running setup.py (path:/tmp/pip-4xf9s5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:34:50 INFO - Running setup.py (path:/tmp/pip-RUjyPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:34:50 INFO - Running setup.py (path:/tmp/pip-6Sns0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:34:50 INFO - Running setup.py (path:/tmp/pip-Rs5wig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:34:50 INFO - Running setup.py (path:/tmp/pip-6znsDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:34:50 INFO - Running setup.py (path:/tmp/pip-ynpdA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:34:50 INFO - Running setup.py (path:/tmp/pip-0YYA64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:34:50 INFO - Running setup.py (path:/tmp/pip-n0zDVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:34:50 INFO - Running setup.py (path:/tmp/pip-dbQhKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:34:50 INFO - Running setup.py (path:/tmp/pip-MOh0hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:34:50 INFO - Running setup.py (path:/tmp/pip-sOjuHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:34:51 INFO - Running setup.py (path:/tmp/pip-hdZa4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:51 INFO - Running setup.py (path:/tmp/pip-YRF_sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:34:51 INFO - Running setup.py (path:/tmp/pip-FPvvND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:34:51 INFO - Running setup.py (path:/tmp/pip-VCLvjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:34:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:34:51 INFO - Running setup.py install for manifestparser 15:34:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:34:51 INFO - Running setup.py install for mozcrash 15:34:51 INFO - Running setup.py install for mozdebug 15:34:51 INFO - Running setup.py install for mozdevice 15:34:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:34:51 INFO - Running setup.py install for mozfile 15:34:51 INFO - Running setup.py install for mozhttpd 15:34:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:34:51 INFO - Running setup.py install for mozinfo 15:34:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:34:51 INFO - Running setup.py install for mozInstall 15:34:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:34:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:34:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:34:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:34:52 INFO - Running setup.py install for mozleak 15:34:52 INFO - Running setup.py install for mozlog 15:34:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:34:52 INFO - Running setup.py install for moznetwork 15:34:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:34:52 INFO - Running setup.py install for mozprocess 15:34:52 INFO - Running setup.py install for mozprofile 15:34:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:34:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:34:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:34:52 INFO - Running setup.py install for mozrunner 15:34:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:34:52 INFO - Running setup.py install for mozscreenshot 15:34:52 INFO - Running setup.py install for moztest 15:34:52 INFO - Running setup.py install for mozversion 15:34:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:34:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:34:53 INFO - Cleaning up... 15:34:53 INFO - Return code: 0 15:34:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34: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')]} 15:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34: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')]} 15:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:53 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 0x23461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b2eb0>, '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 0x26b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b4240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981', '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 15:34:53 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 15:34:53 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 15:34:53 INFO - Using env: {'DISPLAY': ':0', 15:34:53 INFO - 'HOME': '/home/cltbld', 15:34:53 INFO - 'LANG': 'en_US.UTF-8', 15:34:53 INFO - 'LANGUAGE': 'en_US:en', 15:34:53 INFO - 'LOGNAME': 'cltbld', 15:34:53 INFO - 'MAIL': '/var/mail/cltbld', 15:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:53 INFO - 'MOZ_NO_REMOTE': '1', 15:34:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:53 INFO - 'NO_EM_RESTART': '1', 15:34:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:53 INFO - 'PWD': '/builds/slave/test', 15:34:53 INFO - 'SHELL': '/bin/bash', 15:34:53 INFO - 'SHLVL': '1', 15:34:53 INFO - 'TERM': 'linux', 15:34:53 INFO - 'TMOUT': '86400', 15:34:53 INFO - 'USER': 'cltbld', 15:34:53 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981', 15:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:53 INFO - '_': '/tools/buildbot/bin/python'} 15:34:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:34:53 INFO - Running setup.py (path:/tmp/pip-bhOV65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:34:53 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)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:34:53 INFO - Running setup.py (path:/tmp/pip-3XDN4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:34:53 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)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:34:53 INFO - Running setup.py (path:/tmp/pip-I6ivs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:34:53 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)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:34:53 INFO - Running setup.py (path:/tmp/pip-ejoONM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:34:53 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)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:34:53 INFO - Running setup.py (path:/tmp/pip-8w_fBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:34:53 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)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:34:53 INFO - Running setup.py (path:/tmp/pip-jKAndd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:34:53 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)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:34:53 INFO - Running setup.py (path:/tmp/pip-gwKqX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:34:53 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)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:34:53 INFO - Running setup.py (path:/tmp/pip-W1N9cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:34:53 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)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:34:53 INFO - Running setup.py (path:/tmp/pip-_vUnNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:34:53 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)) 15:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:34:53 INFO - Running setup.py (path:/tmp/pip-vjF46d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:34:54 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)) 15:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:34:54 INFO - Running setup.py (path:/tmp/pip-pyVtqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:34:54 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)) 15:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:34:54 INFO - Running setup.py (path:/tmp/pip-QL9Aoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:34:54 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)) 15:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:34:54 INFO - Running setup.py (path:/tmp/pip-xHOIrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:34:54 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)) 15:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:34:54 INFO - Running setup.py (path:/tmp/pip-yNMfmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:34:54 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)) 15:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:54 INFO - Running setup.py (path:/tmp/pip-76oTcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:54 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)) 15:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:34:54 INFO - Running setup.py (path:/tmp/pip-G7Lp2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:34:54 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)) 15:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:34:54 INFO - Running setup.py (path:/tmp/pip-KUB2pf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:34:54 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)) 15:34:54 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)) 15:34:54 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)) 15:34:54 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)) 15:34:54 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)) 15:34:54 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)) 15:34:54 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)) 15:34:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:34:54 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 15:34:54 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 15:34:54 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 15:34:54 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 15:34:55 INFO - Downloading blessings-1.6.tar.gz 15:34:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:34:55 INFO - Installing collected packages: blessings 15:34:55 INFO - Running setup.py install for blessings 15:34:55 INFO - Successfully installed blessings 15:34:55 INFO - Cleaning up... 15:34:55 INFO - Return code: 0 15:34:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:34:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:34:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:34:56 INFO - Reading from file tmpfile_stdout 15:34:56 INFO - Current package versions: 15:34:56 INFO - argparse == 1.2.1 15:34:56 INFO - blessings == 1.6 15:34:56 INFO - blobuploader == 1.2.4 15:34:56 INFO - docopt == 0.6.1 15:34:56 INFO - functools32 == 3.2.3-2 15:34:56 INFO - jsonschema == 2.5.1 15:34:56 INFO - manifestparser == 1.1 15:34:56 INFO - mozInstall == 1.13 15:34:56 INFO - mozcrash == 1.0 15:34:56 INFO - mozdebug == 0.1 15:34:56 INFO - mozdevice == 0.51 15:34:56 INFO - mozfile == 1.2 15:34:56 INFO - mozhttpd == 0.7 15:34:56 INFO - mozinfo == 0.10 15:34:56 INFO - mozleak == 0.1 15:34:56 INFO - mozlog == 3.5 15:34:56 INFO - moznetwork == 0.27 15:34:56 INFO - mozprocess == 0.25 15:34:56 INFO - mozprofile == 0.28 15:34:56 INFO - mozrunner == 6.13 15:34:56 INFO - mozscreenshot == 0.1 15:34:56 INFO - mozsystemmonitor == 0.3 15:34:56 INFO - moztest == 0.8 15:34:56 INFO - mozversion == 1.4 15:34:56 INFO - psutil == 3.1.1 15:34:56 INFO - requests == 1.2.3 15:34:56 INFO - wsgiref == 0.1.2 15:34:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34:56 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')]} 15:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:56 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')]} 15:34:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:56 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 0x23461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b2eb0>, '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 0x26b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b4240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981', '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 15:34:56 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 15:34:56 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 15:34:56 INFO - Using env: {'DISPLAY': ':0', 15:34:56 INFO - 'HOME': '/home/cltbld', 15:34:56 INFO - 'LANG': 'en_US.UTF-8', 15:34:56 INFO - 'LANGUAGE': 'en_US:en', 15:34:56 INFO - 'LOGNAME': 'cltbld', 15:34:56 INFO - 'MAIL': '/var/mail/cltbld', 15:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:56 INFO - 'MOZ_NO_REMOTE': '1', 15:34:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:56 INFO - 'NO_EM_RESTART': '1', 15:34:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:56 INFO - 'PWD': '/builds/slave/test', 15:34:56 INFO - 'SHELL': '/bin/bash', 15:34:56 INFO - 'SHLVL': '1', 15:34:56 INFO - 'TERM': 'linux', 15:34:56 INFO - 'TMOUT': '86400', 15:34:56 INFO - 'USER': 'cltbld', 15:34:56 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981', 15:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:56 INFO - '_': '/tools/buildbot/bin/python'} 15:34:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:56 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)) 15:34:56 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)) 15:34:56 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)) 15:34:56 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)) 15:34:56 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)) 15:34:56 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)) 15:34:56 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)) 15:34:56 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)) 15:34:56 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)) 15:34:56 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:57 INFO - Downloading marionette_driver-1.4.0.tar.gz 15:34:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 15:34:57 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 15:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:34:57 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)) 15:34:57 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)) 15:34:57 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)) 15:34:57 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)) 15:34:57 INFO - Installing collected packages: marionette-driver, simplejson 15:34:57 INFO - Running setup.py install for marionette-driver 15:34:57 INFO - Running setup.py install for simplejson 15:34:57 INFO - building 'simplejson._speedups' extension 15:34:57 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 15:34:58 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 15:34:58 INFO - Successfully installed marionette-driver simplejson 15:34:58 INFO - Cleaning up... 15:34:58 INFO - Return code: 0 15:34:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:34:58 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')]} 15:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:58 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')]} 15:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x23461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b2eb0>, '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 0x26b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b4240>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981', '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 15:34:58 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 15:34:58 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 15:34:58 INFO - Using env: {'DISPLAY': ':0', 15:34:58 INFO - 'HOME': '/home/cltbld', 15:34:58 INFO - 'LANG': 'en_US.UTF-8', 15:34:58 INFO - 'LANGUAGE': 'en_US:en', 15:34:58 INFO - 'LOGNAME': 'cltbld', 15:34:58 INFO - 'MAIL': '/var/mail/cltbld', 15:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:58 INFO - 'MOZ_NO_REMOTE': '1', 15:34:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:58 INFO - 'NO_EM_RESTART': '1', 15:34:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:58 INFO - 'PWD': '/builds/slave/test', 15:34:58 INFO - 'SHELL': '/bin/bash', 15:34:58 INFO - 'SHLVL': '1', 15:34:58 INFO - 'TERM': 'linux', 15:34:58 INFO - 'TMOUT': '86400', 15:34:58 INFO - 'USER': 'cltbld', 15:34:58 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981', 15:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:58 INFO - '_': '/tools/buildbot/bin/python'} 15:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:34:59 INFO - Cleaning up... 15:34:59 INFO - Return code: 0 15:34:59 INFO - Running post-action listener: _resource_record_post_action 15:34:59 INFO - Running post-action listener: _start_resource_monitoring 15:34:59 INFO - Starting resource monitoring. 15:34:59 INFO - [mozharness: 2017-07-24 22:34:59.099044Z] Finished create-virtualenv step (success) 15:34:59 INFO - [mozharness: 2017-07-24 22:34:59.099515Z] Running install step. 15:34:59 INFO - Running pre-action listener: _resource_record_pre_action 15:34:59 INFO - Running main action method: install 15:34:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:34:59 INFO - Reading from file tmpfile_stdout 15:34:59 INFO - Detecting whether we're running mozinstall >=1.0... 15:34:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:34:59 INFO - Reading from file tmpfile_stdout 15:34:59 INFO - Output received: 15:34:59 INFO - Usage: mozinstall [options] installer 15:34:59 INFO - Options: 15:34:59 INFO - -h, --help show this help message and exit 15:34:59 INFO - -d DEST, --destination=DEST 15:34:59 INFO - Directory to install application into. [default: 15:34:59 INFO - "/builds/slave/test"] 15:34:59 INFO - --app=APP Application being installed. [default: firefox] 15:34:59 INFO - mkdir: /builds/slave/test/build/application 15:34:59 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'] 15:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:35:17 INFO - Reading from file tmpfile_stdout 15:35:17 INFO - Output received: 15:35:17 INFO - /builds/slave/test/build/application/firefox/firefox 15:35:17 INFO - Running post-action listener: _resource_record_post_action 15:35:17 INFO - [mozharness: 2017-07-24 22:35:17.405079Z] Finished install step (success) 15:35:17 INFO - [mozharness: 2017-07-24 22:35:17.405335Z] Running setup-mitmproxy step. 15:35:17 INFO - Running pre-action listener: _resource_record_pre_action 15:35:17 INFO - Running main action method: setup_mitmproxy 15:35:17 INFO - Skipping: mitmproxy is not required 15:35:17 INFO - Running post-action listener: _resource_record_post_action 15:35:17 INFO - [mozharness: 2017-07-24 22:35:17.406548Z] Finished setup-mitmproxy step (success) 15:35:17 INFO - [mozharness: 2017-07-24 22:35:17.406770Z] Running run-tests step. 15:35:17 INFO - Running pre-action listener: _resource_record_pre_action 15:35:17 INFO - Running pre-action listener: _set_gcov_prefix 15:35:17 INFO - Running main action method: run_tests 15:35:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:35:17 INFO - Python 2.7.3 15:35:17 INFO - Return code: 0 15:35:17 INFO - grabbing minidump binary from tooltool 15:35:17 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')]} 15:35:17 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 0x26b2eb0>, '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 0x26b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b4240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:35:17 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 15:35:17 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 15:35:17 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 15:35:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:35:17 INFO - Return code: 0 15:35:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:35:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:35:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:35:17 INFO - ENV: RUST_BACKTRACE is now 1 15:35:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:35:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:35:17 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/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--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 15:35:17 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/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-071 --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 15:35:17 INFO - Using env: {'DISPLAY': ':0', 15:35:17 INFO - 'HOME': '/home/cltbld', 15:35:17 INFO - 'LANG': 'en_US.UTF-8', 15:35:17 INFO - 'LANGUAGE': 'en_US:en', 15:35:17 INFO - 'LOGNAME': 'cltbld', 15:35:17 INFO - 'MAIL': '/var/mail/cltbld', 15:35:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:35:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:17 INFO - 'MOZ_NO_REMOTE': '1', 15:35:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:35:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:17 INFO - 'NO_EM_RESTART': '1', 15:35:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:17 INFO - 'PWD': '/builds/slave/test', 15:35:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:35:17 INFO - 'RUST_BACKTRACE': '1', 15:35:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:35:17 INFO - 'SHELL': '/bin/bash', 15:35:17 INFO - 'SHLVL': '1', 15:35:17 INFO - 'STYLO_FORCE_ENABLED': '1', 15:35:17 INFO - 'TERM': 'linux', 15:35:17 INFO - 'TMOUT': '86400', 15:35:17 INFO - 'USER': 'cltbld', 15:35:17 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981', 15:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:17 INFO - '_': '/tools/buildbot/bin/python'} 15:35:17 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/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--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 15:35:17 INFO - mozversion application_buildid: 20170724215058 15:35:17 INFO - mozversion application_changeset: bf4634a50775537b4e791b6d294a275b83737472 15:35:17 INFO - mozversion application_display_name: Nightly 15:35:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:35:17 INFO - mozversion application_name: Firefox 15:35:17 INFO - mozversion application_remotingname: firefox 15:35:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:35:17 INFO - mozversion application_vendor: Mozilla 15:35:17 INFO - mozversion application_version: 56.0a1 15:35:17 INFO - mozversion platform_buildid: 20170724215058 15:35:17 INFO - mozversion platform_changeset: bf4634a50775537b4e791b6d294a275b83737472 15:35:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:35:17 INFO - mozversion platform_version: 56.0a1 15:35:17 INFO - using testdate: 1500935717 15:35:17 INFO - actual date: 1500935717 15:35:17 INFO - starting webserver on 'localhost:39106' 15:35:17 INFO - SUITE-START | Running 2 tests 15:35:17 INFO - TEST-START | dromaeo_css 15:35:17 INFO - Initialising browser for dromaeo_css test... 15:35:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39106/getInfo.html -profile /tmp/tmpaAVuf0/profile 15:35:17 INFO - TEST-INFO | started process 551 (/builds/slave/test/build/application/firefox/firefox http://localhost:39106/getInfo.html) 15:35:23 INFO - TEST-INFO | 551: exit 0 15:35:24 INFO - Browser initialized. 15:35:24 INFO - Running cycle 1/1 for dromaeo_css test... 15:35:24 INFO - TEST-INFO | started process 783 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaAVuf0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:35:35 INFO - PID 783 | RSS: Main: 179449856 15:35:35 INFO - PID 783 | 15:38:35 INFO - PID 783 | Cycle 1(1): loaded http://localhost:39106/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39106/tests/dromaeo/cssquery-ext.html) 15:38:36 INFO - PID 783 | RSS: Main: 181817344 15:38:36 INFO - PID 783 | 15:41:38 INFO - PID 783 | Cycle 1(1): loaded http://localhost:39106/tests/dromaeo/cssquery-ext.html (next: http://localhost:39106/tests/dromaeo/cssquery-jquery.html) 15:41:38 INFO - PID 783 | RSS: Main: 180350976 15:41:38 INFO - PID 783 | 15:44:40 INFO - PID 783 | Cycle 1(1): loaded http://localhost:39106/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39106/tests/dromaeo/cssquery-mootools.html) 15:44:41 INFO - PID 783 | RSS: Main: 181260288 15:44:41 INFO - PID 783 | 15:47:42 INFO - PID 783 | Cycle 1(1): loaded http://localhost:39106/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39106/tests/dromaeo/cssquery-prototype.html) 15:47:43 INFO - PID 783 | RSS: Main: 178196480 15:47:43 INFO - PID 783 | 15:50:47 INFO - PID 783 | Cycle 1(1): loaded http://localhost:39106/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39106/tests/dromaeo/cssquery-yui.html) 15:50:48 INFO - PID 783 | RSS: Main: 181534720 15:50:48 INFO - PID 783 | 15:53:50 INFO - PID 783 | Cycle 1(1): loaded http://localhost:39106/tests/dromaeo/cssquery-yui.html (next: http://localhost:39106/tests/dromaeo/cssquery-dojo.html) 15:53:50 INFO - PID 783 | RSS: Main: 182362112 15:53:50 INFO - PID 783 | 15:53:50 INFO - PID 783 | __start_tp_report 15:53:50 INFO - PID 783 | _x_x_mozilla_page_load 15:53:50 INFO - PID 783 | _x_x_mozilla_page_load_details 15:53:50 INFO - PID 783 | |i|pagename|runs| 15:53:50 INFO - PID 783 | |0;dojo.html;3052.8626211820465;3144.5440411140385;3159.320746039601;3159.541866429368;3184.0288711942862;5967.940320596793;5991.400859914012;6078.665673387962;6084.482818960388;6158.107074474198;6093.207882975218;6098.57309988301;6134.263888333395;6167.229096362955;6213.627182369061;5348.679079255237;5551.472610102034;5568.888622227563;5639.238702775114;5680.403557626451;5481.835544933659;5545.251391062196;5554.472325129126;5656.349519805234;5669.8299051028325;5538;5561.304836895388;5614.494695477406;5650.124230744241;5657.801976930808;5472.042392581282;5535.6955367454775;5615.578831587647;5621.494065534122;5637.943620563783;5482.479164479368;5489.258950041733;5522.6134170608075;5553.305836770403;5555.833325000256;6008.96995515024;6015.39846015395;6076.270847498285;6109.3890610939;6113.358097399753;6381.968090159566;6493.837654058686;6572.07990881277;6590.340965903371;6600.174978127734;6374.107624932513;6477.1579694639395;6571.277159512498;6611.140551728293;6620.834479138012;6082.118092876508;6086.847828804227;6131.540134489931;6153.692315384213;6162.137300777895;6600.141981542369;6712.0496894409935;6761.121054262914;6798.864022719518;6811.318868113248;6314.71583778731;6329.588576742497;6355.396237357444;6361.332060133619;6362.395572420613;6424.486041116699;6492.188476440445;6506.31683673217;6538.444232240313;6564.409203171737;6412.583182093149;6433;6455.935440645628;6499.38255865692;6503.447206987365;6321.683915804191;6414.903776443357;6468.6442245676;6574.243961944438;6576.572522786099;5290.391604965402;5386.461353864583;5401.4868587484125;5415.377231618336;5427.402985671573;4576.771161441915;4587.311903214478;4606.286025666027;4627.5603817637275;4628.907421851544;5519.69641669704;5701.543876489871;5724.627899186623;5759.85600359986;5791.218185544897;6464.41820236181;6480.384363485461;6481.09264702942;6515.837104072436;6558.606483610999;5655.349634792052;5717.628354156966;5723.599348045597;5726.341470730836;5737.225474560964;5735.082386818172;5759.107338362561;5765.308163020381;5851.444112809277;5851.736671849777;6233.812985610439;6292.2134733158355;6299.874002519924;6374.458171055512;6390.297067322591;6413.422791948747;6487.351264873475;6589.868202636017;6592.967035164794;6602.207735071822;6206.813795586139;6232.501399888089;6356.364363563606;6358.205224346957;6360.586561873463;6357.809265722036;6396.520260980352;6441.935580644134;6453.45145662624;6458.160439142881;6506.316836732264;6527.216733991761;6619.669016549057;6620.172478440195;6629.03878937561;6105.17580126695;6206.906896396648;6228.968855155696;6240.937590624218;6339.651319177489;6343.936560634519;6359.523035772243;6415.679216039272;6426.871462570629;6432.839179020562;6230.875382492234;6254.9687251563455;6260.060990851409;6366.172397588284;6390.7763228286785;6288.27684816252;6341.587796793194;6373.649449280334;6437.742490300523;6455.934770762771;6145.600535965327;6189.876202476015;6190.535709821871;6193.380661933951;6242.094896239929 15:53:50 INFO - PID 783 | |1;ext.html;826.7726375246806;861.0485413617951;883.7658020624532;885.1679421343935;1159.4550561236215;29141.41717165658;29719.554206686917;38740.61259387409;38875.61124388762;38991.41512877309;39231.21537569254;39643.801780991125;39726.80136599313;39761.801190994076;39771.602283977154;7093.751718689834;7285.7814265572115;7666.578338191397;7670.117936437297;7676.117246516638;7592.050993625797;7676.078870535515;7676.347510461617;7701.730439434621;7703.1526532081425;7624.847503049936;7694.538327700356;7697.191794861543;7699.307062364386;7707.576083315415;7629.2752188542;7680.615969201545;7695.076590809111;7714.267144621252;7732.45872788905;7532.133804612485;7578.0906291244855;7605.581693006882;7619;7625.237476252386;36366.818165909266;36677.44983825245;36704.449433258524;36736.08159796;36743.44884826703;3556.4309710446205;3562.590302115264;3574.5531808523933;3589.569251689814;3593.802340871251;29850.253743656584;29933.25166870824;30141.849290753624;30142.095737127922;30233.09300720982;4709.081729062834;4876.390451193601;4904.288878112689;4907.2639104134305;4936.950630493685;183879;184389;184875;184927;186119;46662;46744.2988355175;46759.06481870344;46846.06307873823;46999;48656.513434865905;48720.756396217796;49213.50786492161;49277.26084108741;49454.258186127234;13269;16049.759253611206;16445.91777041107;16502.42241521541;16559.83440165607;10933.453327333602;11947.462364193632;12036;12126.818097728541;12137.453814578364;14096.295185240697;14096.436142554388;14151.43394264218;14219.075760075562;14382.137071775727;5712.200291959129;5793.188953546507;5794.652320860761;5896.380880007623;6025.0661147522205;981.4700061966458;985.4579981010559;989.6288891665625;1014.7412409835445;1030.9432981185957;21825.92653697896;21875.781242187375;21986.780132198794;22787.202447914577;23058.65412018821;1051.8264486359817;1052.6947185316326;1062.9681109566725;1072.6942821295893;1076.838474228872;11650.475728592233;11876.643700688994;11910.106741994385;11946.402679865972;12028.338441385808;227907;228739;229208;229628;229642;49010.50989490059;49373.50626493761;49546.50453495491;49643.50356496461;49686.75156624194;1419.900606957503;1462.3565631122271;1478.209158100411;1483.8219413670429;1488.3302513868803;20138.496537586678;20753.688694669894;20952;21747.456313591654;22032.559348812614;36245;36367.454488183226;36506.26987460289;36511.45232821563;36513.087172820895;195456;196866;197270;197285;197451;28316.43367132687;28827.855860720563;31699;31730.524042138924;32154.19614509656;39197.21605567815;40524.79737601293;40642.79678601588;40684.38973415342;41228.38157427701;28343.858280708464;28807.855960720062;30310.69689303079;30518.620675870538;33443.83278083594;32342;33041.33917321688;33123.83438082794;33156.1710957228;33495.16262093467;35553.82223088868;36603;37011;37069.25861482809;37113.443298351085;30475.695243048172;31555.36889262248;32602.85889993839;32643;32997.67002329946;23244.418889527897;23479.765202347757;23753.52492950166;23803.64294535618;23866.761332386453 15:53:50 INFO - PID 783 | |2;jquery.html;574.2706762411735;576.3919065386021;584.1733946465752;584.5382148103001;599.7690889007732;21681.34955951322;22420.88789556052;22642.999999999978;22699.886500567474;22917.4270643234;27419.451610967768;28088.438231235363;28173.57739633907;28330.43339133216;28388.858055709745;6854.794356169323;6958.79123626292;7029.402500787439;7040.436765058783;7042.436605071582;6161.815145545641;6728.495362847806;6761.729530818761;6866.416354609864;6937.098177236978;6723.562968407038;6735.225449073346;6742.359475849787;6743.190817101955;6743.629100399476;6706.731730730789;6716.294789047153;6719.428848547855;6726.93273067268;6750;6601.339866013408;6610.537262391635;6615.966920165417;6622.2715501294815;6623.370779775962;31191.220219494466;31721;31895.36209275825;32764.836175819208;33018;2020.0202901592863;2037.836973042168;2044.437779610619;2044.9079791409422;2045.0490521907236;19546.902265488723;20120.29578964744;20147.496312592157;20152.39542813718;20173.092210850547;2434.3548959525738;2447.902083916659;2519.2442267319916;2522.1928982725535;2526.696796384427;134130.3293483536;137669;137947;138168.99999999898;138206;20462;21576.892115539635;22434.887825560767;22662.773372266067;23011.769882300963;22392.888035559718;24020.15929442496;24024.759752402602;46029.7698511512;46345;10062.446565438971;10095.24285678577;10283.177345812317;10317.94841025805;10500.684979450629;9474.526273686288;9554.570044348022;9623.56693948774;9682.419054856731;9724.805503889882;9453.101955314234;9701.951490242503;9718.173955213744;9780.706578802647;9843.163331116792;2928.824270543774;2939.1770304314828;2958.8076775009554;2961.452131355706;3044.605265129365;962.1436921140191;969.4038166527675;971.4317124482116;979.5934687104772;1000.1049061090283;19417.708734368996;19631.93858655232;19986.800131998494;20237.898810505852;20411.897940510204;1008.7831116309882;1011.6661501704419;1020.5560581147224;1034.99482502587;1044.8850626431085;11260.662180134608;12521.874781252252;13202.207867527979;13571.52499662507;13690.178589284675;461352;473584;475632;478030;481959;116562;119030;119867;120535.39732301458;120562.39718801349;1259.4647274908311;1260.9936950315189;1306.3207132291154;1307.7907534794388;1311.2919023727081;20376.28682996088;20883.791162088186;21178.503818624416;21257.78742212558;22075.889620552436;50741.49258507515;51973.22040169325;53443;55781.72109139428;55970;67919;70375.29624703892;70550.64724676344;71070.28929710844;71399;14737;15198.544043678707;15310.540683779505;15400.768988465406;15428.922855385652;23920;24073.879630601736;24410.755892440848;24463.38841528905;25283.494330112928;19107.61784764269;19136.13887375099;19162.329318473785;19173.61652766965;19450.416487505398;15988.8401115992;16195.514134575982;16386.67226655484;17345.47963561095;17949.37177198844;19197.136128874514;19302.517437064187;19356.61286774285;19504.122314496166;19672.50818729486;14813;15074.849251507345;15103;15219.239038047832;15462.226888655747;17942.282308707505;18203.54491137732;18276.817231828045;18435.631287373908;18581.16384762662 15:53:50 INFO - PID 783 | |3;mootools.html;1343.8253027106475;1383.3567391163108;1415.6126995544369;1422.3172877019038;1427.252538862689;13447;13878.722425551483;14116.92941535292;14152.858471415282;14164;14100.36548355324;14319.64200894978;14374.640633984156;14443.494477693283;14450.421983120663;2660.1088635307146;2731.207949694586;2733.425980544088;2739.301478123076;2740.671119465667;2607.9739202608016;2709.336212627899;2758.944821103577;2778.8888444462195;2781.0822428598512;2652.668416447944;2670.6528151340394;2698;2708.0251109600526;2723.2102690219813;2666.6266722658843;2668.5863691127906;2681.3430709476206;2705.3101459127993;2720.306321887906;2570.3959569501153;2618.869056547165;2663.267601409628;2664.427148163135;2668.7064422913463;13428.261445620486;13602.727945441135;13668.52160174389;13673.658158546115;13703.725925481534;7367.226441223702;7624.961875190644;7642.694292228304;7646.464747467679;7664.233576642347;4980.7509624518625;5158.845234642967;5275.815346462856;5281.441974617497;5282.630215884889;1839.347031803717;1867.1504465468179;1877.9906100469411;1930.8455323574221;1953.5702145527962;22438.88780556103;23014.53970920589;23027.424314392276;23049.654255186353;23064.538709225722;6790.456763458911;6797.898031529531;6827.2831352708245;6971.058907047585;6989.93010069903;18049.278028878696;18154.63690726178;18155.183016764277;18177.36379226747;18181.272749090153;7408.925910740932;7724.884126738103;7727.265909738566;7737.342325902248;7745.10931242903;6758.966205169041;6975.651217439107;7046.189688185822;7061.505694601431;7106.786796396116;5269.341332333458;5461.535769459561;5473.425290344536;5506.449355064461;5558.138023762004;1645.6215070533844;1649.5546202525252;1660.6346603747156;1673.414304993267;1705.3434427745408;856.6402111113347;860.6643409070467;867.4274978514151;879.7228872905015;911.7857303533664;6966.9303306967295;7089.858202835914;7181.245969173266;7199.460040496983;7295.124585049828;671.5634837355758;675.9391654751096;692.4979389942251;698.8742026435189;708.6563016936782;4186.623203911662;4814.903701926012;5122.948770512247;5188.662736922088;5260.789568417297;16631.91684041572;16843.578910527336;17286.22212000438;17406.042667653146;17546.561335966704;17400.303987840598;17499.562510937074;17530.211140498708;17562.560935976704;17573.47279581589;9779.413235206053;10087.394756314645;10222.795544089076;10222.795544089076;10301.072903438726;7365.558066516026;7397.778066658009;7900.3284720799375;7940.563269020259;7970.641321140679;15166.31751571204;15177.544673659808;15389.923050384676;15563.221838908235;15598.298076586354;15882.920585397;15951.042937423328;15998;16030.679386411974;16324.755128672841;10853.837192442277;10875.510602023087;10960.56157753681;11098.2786118902;11145.38700371455;12200.877991219973;12442.502299908265;12484.687882803002;12514.374281286082;12568.74862502763;9804.411735295906;10221;10456.47717614101;10470.424126672802;10576.629817956335;9617.086376794194;10040.096391324816;10083.445410502492;10115.949420252851;10259.179265658879;9150.222231110163;9187.494687792236;9193.126652967958;9248.630054798003;9286.674966376144;6225.501959843292;6272.560920735505;6470.126532917996;6597.80206593803;6622.403983641303;6531.608103513804;6680.899786503109;6845.247022827584;6922;6940.6529673515115 15:53:50 INFO - PID 783 | |4;prototype.html;488.7440758293838;497.3611948629266;527.3961314295132;529.0345120155716;534.2556552854929;6128.908066379002;6145.907811382827;6173.50611951044;6193.504519638429;6239.065889574235;5829.417058294169;5960;5989.101634754789;6034.517238620911;6065.848353791157;4839.225723884179;4846.7818948147415;4858.635602329822;4910.508949105097;4927.901441971158;4860.222364421693;4870.415550133989;4882.658213925027;4929.285253638221;4939.555440010398;4688.695234809744;4855.198892182786;4856.247281671346;4868.85581888256;4905.577382559053;4799.400074990626;4859.460215354498;4880.316755654176;4887.8044878204655;4948.975255123702;4396.1647287015685;4423.115376924596;4433.379326894237;4444.688871778977;4445.310976798602;5914.37899020601;6009.729562169713;6037.335893051761;6040.31540760136;6043.3956604339655;5523.25436066134;5602.579806514487;5612.747426365823;5621.7189140542805;5625.156226566007;6360.363963603649;6404.103425520431;6418.133551970518;6419;6467.482601391925;4809.398825146856;4850.490698476679;4882.267659851015;4895.828645997373;4904.313396124546;6587.934120658828;6641.66791660415;6750.966245168743;6761.154855643044;6856.451483881277;4824.589909857701;4860.465348811628;4869.172240719086;4871.585915197248;4918.213085906238;4934.210526315772;4973.079980203674;4976.178930476431;4981.90036199274;4987.975060124676;5463.508284254436;5509.944900551023;5556.444355564411;5582;5632.577556683265;6432.71052802625;6483.3516648335735;6484.19664400359;6530.706118224692;6569.408753212234;1675.4638515674867;1714.1857617631774;1720.7504911787971;1723.922423490946;1771.6279581287815;1164.4643464006651;1211.4185191108318;1224.7813425641543;1227.9447424865903;1233.617578550652;5642.238297829823;5695.515881150149;5727.083666613322;5732.828015159552;5783.7397317119985;6397.328280530477;6469.191351081115;6530.183727034121;6581.506387020992;6671.833204169838;5672.5745569081655;5675;5698.572607054404;5736.024875771129;5762.481376676035;3465;3518.1732292911147;3532.823358832048;3542.1321776165005;3554.0581745837376;6384.840378990562;6460.160179176677;6477.190351206099;6484.675766211765;6486.610803351814;6731.427828634523;6833.384995350343;6851.2806155353965;6879.449644028566;6886.827829304208;6305.806638585289;6332.050192471166;6344.889644312227;6350.872982540323;6479.866023445878;6612.636305003271;6614.239362473185;6630.76792312286;6645.800625981228;6719.428848547928;6492.513061520311;6593.7142257259375;6606.570572912745;6616.636085015178;6623.311055680771;6303.392634878077;6387.584806987531;6449.12936753551;6460.547761656639;6479.287278399278;4944.975275123601;4952.504749525018;4965.553100220997;4981.438271635798;5023.623228257969;6714.462842972648;6741.280973351764;6750.717363700881;6780.677168422764;6799.626020568916;6349.206349206349;6414.839629009312;6425.935740642721;6465.0948867157695;6515.250746164252;6419.646919419477;6424.807255782334;6462;6479.708413121515;6480.546361754632;6168.444839964424;6292.709994451218;6345.587536810092;6349.301576826638;6396.904046439214;6368.203974503187;6438.163038804925;6459.224893012869;6491.610503369813;6492;6227.283862355887;6254.593451425642;6290.402411770874;6315.515853774451;6371.649559274099 15:53:50 INFO - PID 783 | |5;yui.html;877.4647465046324;896.744427838066;896.8878590547723;909.7680091576651;914.9130832570905;17117.48647540574;17844.732329015074;17853.553661158447;17888;21826;19342.323018694347;19362.709559356586;19398.70901936472;19521.707174392395;19563.21747130113;980.3921568627461;1068.358984609236;1068.647346375694;1069.1446842525947;1071.919606029547;1064.9414282214475;1068.0334297460772;1068.5992752717732;1070.1011150633467;1070.3363914373099;1008.178334657252;1056.1867362131154;1062.9893701063006;1095.424901926491;1107.341132026443;1096.0464395975512;1096.177866600046;1097.1113398147486;1097.9670609881716;1098.3080659184743;793.5119901260741;796.466367533748;798.8801679748084;799.2287442617843;802.4543310548825;17837.910810445996;19299.324523641604;19397.709034364354;19670.70493942592;19673.213071477123;20303.187872485083;20513.589728205352;20608.27871024507;20929.790702092938;21018.369448916557;16053.438129665523;16246.18769061554;16336.264868080965;16401.83598164027;16426.507204783877;3536.9115772105647;3541.982290088559;3554.608993010767;3565.4830049642915;3569.5894972078286;118268;122027;124440;125348;125505;14886;15657.686846263012;16127.677446451005;16141.192940352936;16143.515694529184;29053.12840614785;29312.413751724845;29636.407271854874;29683.406331873673;29723.256918576775;7443.478956473104;8496.532690701946;8729;8785.560721964004;8786.648534058693;3569.268299998494;3995.4006898965386;4105.938410923838;4106.384042393605;4136.689748268892;4923.236898280772;5035.471275516018;5057.6459647824295;5068.923966140437;5113.079645663816;1064.4305296666246;1067.7757670889046;1071.8928107189374;1077.719792853848;1083.1605505732962;623.607127509666;690.4510913823523;693.327472351818;714.5855403865745;716.559316020654;11807.60930381259;11874.287542747463;12246.938765306295;12396.132270740962;12820.935895320463;627.4948666323562;652.774792696519;653.2552889705739;674.5177198303237;711.2709472790327;5286.577073834161;5390.757415916293;5489.286392768914;5601.215829783833;5609.80365687199;99054;101250;101601;103195;104404;85575.57212214023;87818.56090719506;88888.5555572218;91359.54320228356;94999.52500237593;70387;75159.62420187864;76787.61606191934;81364.59317703373;83529.58235208907;11758.176927615326;11855.940720296343;11881.346525941157;11911.80881911802;11989.34058626749;35783.284334312644;37030.6296937038;38259.234815304095;38811.41782873316;39991.80004099961;47583.76208118937;47900.520994791;48705.26942095801;48802.26796598125;49362.506374935794;17686.823131768517;17972.281108755502;18178.45464636063;18330.266789328278;18366;19320;19652.11565479528;19739.30912418116;20719.171233150504;21387;18860.05699715036;19198.94405807694;19260.32588859383;19340.226390944204;19498;17023.7446438306;17260.22328995173;18483.90758046255;18518.44444666662;18585.90707046456;17490.650186995936;17509.737353939956;18042.368517101837;18856.34002809895;19052.809471905104;12117.333546655018;12845.486180553047;13428.597142085753;13544.187348759106;13676;13986.720265594835;14083.788743168656;14248.786268206193;14974.550763477113;14975.550733478012 15:53:50 INFO - PID 783 | __end_tp_report 15:53:50 INFO - PID 783 | __start_cc_report 15:53:50 INFO - PID 783 | _x_x_mozilla_cycle_collect,365 15:53:50 INFO - PID 783 | __end_cc_report 15:53:50 INFO - PID 783 | __startTimestamp1500936830331__endTimestamp 15:53:50 INFO - PID 783 | 15:53:50 INFO - PID 783 | ------- Summary: start ------- 15:53:50 INFO - PID 783 | Number of tests: 6 15:53:50 INFO - PID 783 | 15:53:50 INFO - PID 783 | [#0] dojo.html Cycles:165 Average:6008.78 Median:6228.97 stddev:686.41 (11.0%) stddev-sans-first:648.16 15:53:50 INFO - PID 783 | Values: 3052.9 3144.5 3159.3 3159.5 3184.0 5967.9 5991.4 6078.7 6084.5 6158.1 6093.2 6098.6 6134.3 6167.2 6213.6 5348.7 5551.5 5568.9 5639.2 5680.4 5481.8 5545.3 5554.5 5656.3 5669.8 5538.0 5561.3 5614.5 5650.1 5657.8 5472.0 5535.7 5615.6 5621.5 5637.9 5482.5 5489.3 5522.6 5553.3 5555.8 6009.0 6015.4 6076.3 6109.4 6113.4 6382.0 6493.8 6572.1 6590.3 6600.2 6374.1 6477.2 6571.3 6611.1 6620.8 6082.1 6086.8 6131.5 6153.7 6162.1 6600.1 6712.0 6761.1 6798.9 6811.3 6314.7 6329.6 6355.4 6361.3 6362.4 6424.5 6492.2 6506.3 6538.4 6564.4 6412.6 6433.0 6455.9 6499.4 6503.4 6321.7 6414.9 6468.6 6574.2 6576.6 5290.4 5386.5 5401.5 5415.4 5427.4 4576.8 4587.3 4606.3 4627.6 4628.9 5519.7 5701.5 5724.6 5759.9 5791.2 6464.4 6480.4 6481.1 6515.8 6558.6 5655.3 5717.6 5723.6 5726.3 5737.2 5735.1 5759.1 5765.3 5851.4 5851.7 6233.8 6292.2 6299.9 6374.5 6390.3 6413.4 6487.4 6589.9 6593.0 6602.2 6206.8 6232.5 6356.4 6358.2 6360.6 6357.8 6396.5 6441.9 6453.5 6458.2 6506.3 6527.2 6619.7 6620.2 6629.0 6105.2 6206.9 6229.0 6240.9 6339.7 6343.9 6359.5 6415.7 6426.9 6432.8 6230.9 6255.0 6260.1 6366.2 6390.8 6288.3 6341.6 6373.6 6437.7 6455.9 6145.6 6189.9 6190.5 6193.4 6242.1 15:53:50 INFO - PID 783 | 15:53:50 INFO - PID 783 | [#1] ext.html Cycles:180 Average:36514.86 Median:19555.13 stddev:52950.79 (270.8%) stddev-sans-first:53031.52 15:53:50 INFO - PID 783 | Values: 826.8 861.0 883.8 885.2 1159.5 29141.4 29719.6 38740.6 38875.6 38991.4 39231.2 39643.8 39726.8 39761.8 39771.6 7093.8 7285.8 7666.6 7670.1 7676.1 7592.1 7676.1 7676.3 7701.7 7703.2 7624.8 7694.5 7697.2 7699.3 7707.6 7629.3 7680.6 7695.1 7714.3 7732.5 7532.1 7578.1 7605.6 7619.0 7625.2 36366.8 36677.4 36704.4 36736.1 36743.4 3556.4 3562.6 3574.6 3589.6 3593.8 29850.3 29933.3 30141.8 30142.1 30233.1 4709.1 4876.4 4904.3 4907.3 4937.0 183879.0 184389.0 184875.0 184927.0 186119.0 46662.0 46744.3 46759.1 46846.1 46999.0 48656.5 48720.8 49213.5 49277.3 49454.3 13269.0 16049.8 16445.9 16502.4 16559.8 10933.5 11947.5 12036.0 12126.8 12137.5 14096.3 14096.4 14151.4 14219.1 14382.1 5712.2 5793.2 5794.7 5896.4 6025.1 981.5 985.5 989.6 1014.7 1030.9 21825.9 21875.8 21986.8 22787.2 23058.7 1051.8 1052.7 1063.0 1072.7 1076.8 11650.5 11876.6 11910.1 11946.4 12028.3 227907.0 228739.0 229208.0 229628.0 229642.0 49010.5 49373.5 49546.5 49643.5 49686.8 1419.9 1462.4 1478.2 1483.8 1488.3 20138.5 20753.7 20952.0 21747.5 22032.6 36245.0 36367.5 36506.3 36511.5 36513.1 195456.0 196866.0 197270.0 197285.0 197451.0 28316.4 28827.9 31699.0 31730.5 32154.2 39197.2 40524.8 40642.8 40684.4 41228.4 28343.9 28807.9 30310.7 30518.6 33443.8 32342.0 33041.3 33123.8 33156.2 33495.2 35553.8 36603.0 37011.0 37069.3 37113.4 30475.7 31555.4 32602.9 32643.0 32997.7 23244.4 23479.8 23753.5 23803.6 23866.8 15:53:50 INFO - PID 783 | 15:53:50 INFO - PID 783 | [#2] jquery.html Cycles:180 Average:35246.16 Median:22964.60 stddev:80042.40 (348.5%) stddev-sans-first:80224.61 15:53:50 INFO - PID 783 | Values: 574.3 576.4 584.2 584.5 599.8 21681.3 22420.9 22643.0 22699.9 22917.4 27419.5 28088.4 28173.6 28330.4 28388.9 6854.8 6958.8 7029.4 7040.4 7042.4 6161.8 6728.5 6761.7 6866.4 6937.1 6723.6 6735.2 6742.4 6743.2 6743.6 6706.7 6716.3 6719.4 6726.9 6750.0 6601.3 6610.5 6616.0 6622.3 6623.4 31191.2 31721.0 31895.4 32764.8 33018.0 2020.0 2037.8 2044.4 2044.9 2045.0 19546.9 20120.3 20147.5 20152.4 20173.1 2434.4 2447.9 2519.2 2522.2 2526.7 134130.3 137669.0 137947.0 138169.0 138206.0 20462.0 21576.9 22434.9 22662.8 23011.8 22392.9 24020.2 24024.8 46029.8 46345.0 10062.4 10095.2 10283.2 10317.9 10500.7 9474.5 9554.6 9623.6 9682.4 9724.8 9453.1 9702.0 9718.2 9780.7 9843.2 2928.8 2939.2 2958.8 2961.5 3044.6 962.1 969.4 971.4 979.6 1000.1 19417.7 19631.9 19986.8 20237.9 20411.9 1008.8 1011.7 1020.6 1035.0 1044.9 11260.7 12521.9 13202.2 13571.5 13690.2 461352.0 473584.0 475632.0 478030.0 481959.0 116562.0 119030.0 119867.0 120535.4 120562.4 1259.5 1261.0 1306.3 1307.8 1311.3 20376.3 20883.8 21178.5 21257.8 22075.9 50741.5 51973.2 53443.0 55781.7 55970.0 67919.0 70375.3 70550.6 71070.3 71399.0 14737.0 15198.5 15310.5 15400.8 15428.9 23920.0 24073.9 24410.8 24463.4 25283.5 19107.6 19136.1 19162.3 19173.6 19450.4 15988.8 16195.5 16386.7 17345.5 17949.4 19197.1 19302.5 19356.6 19504.1 19672.5 14813.0 15074.8 15103.0 15219.2 15462.2 17942.3 18203.5 18276.8 18435.6 18581.2 15:53:50 INFO - PID 783 | 15:53:50 INFO - PID 783 | [#3] mootools.html Cycles:180 Average:8469.25 Median:2668.65 stddev:5692.14 (213.3%) stddev-sans-first:5682.92 15:53:50 INFO - PID 783 | Values: 1343.8 1383.4 1415.6 1422.3 1427.3 13447.0 13878.7 14116.9 14152.9 14164.0 14100.4 14319.6 14374.6 14443.5 14450.4 2660.1 2731.2 2733.4 2739.3 2740.7 2608.0 2709.3 2758.9 2778.9 2781.1 2652.7 2670.7 2698.0 2708.0 2723.2 2666.6 2668.6 2681.3 2705.3 2720.3 2570.4 2618.9 2663.3 2664.4 2668.7 13428.3 13602.7 13668.5 13673.7 13703.7 7367.2 7625.0 7642.7 7646.5 7664.2 4980.8 5158.8 5275.8 5281.4 5282.6 1839.3 1867.2 1878.0 1930.8 1953.6 22438.9 23014.5 23027.4 23049.7 23064.5 6790.5 6797.9 6827.3 6971.1 6989.9 18049.3 18154.6 18155.2 18177.4 18181.3 7408.9 7724.9 7727.3 7737.3 7745.1 6759.0 6975.7 7046.2 7061.5 7106.8 5269.3 5461.5 5473.4 5506.4 5558.1 1645.6 1649.6 1660.6 1673.4 1705.3 856.6 860.7 867.4 879.7 911.8 6966.9 7089.9 7181.2 7199.5 7295.1 671.6 675.9 692.5 698.9 708.7 4186.6 4814.9 5122.9 5188.7 5260.8 16631.9 16843.6 17286.2 17406.0 17546.6 17400.3 17499.6 17530.2 17562.6 17573.5 9779.4 10087.4 10222.8 10222.8 10301.1 7365.6 7397.8 7900.3 7940.6 7970.6 15166.3 15177.5 15389.9 15563.2 15598.3 15882.9 15951.0 15998.0 16030.7 16324.8 10853.8 10875.5 10960.6 11098.3 11145.4 12200.9 12442.5 12484.7 12514.4 12568.7 9804.4 10221.0 10456.5 10470.4 10576.6 9617.1 10040.1 10083.4 10115.9 10259.2 9150.2 9187.5 9193.1 9248.6 9286.7 6225.5 6272.6 6470.1 6597.8 6622.4 6531.6 6680.9 6845.2 6922.0 6940.7 15:53:50 INFO - PID 783 | 15:53:50 INFO - PID 783 | [#4] prototype.html Cycles:180 Average:5429.51 Median:6035.93 stddev:1524.23 (25.3%) stddev-sans-first:1482.71 15:53:50 INFO - PID 783 | Values: 488.7 497.4 527.4 529.0 534.3 6128.9 6145.9 6173.5 6193.5 6239.1 5829.4 5960.0 5989.1 6034.5 6065.8 4839.2 4846.8 4858.6 4910.5 4927.9 4860.2 4870.4 4882.7 4929.3 4939.6 4688.7 4855.2 4856.2 4868.9 4905.6 4799.4 4859.5 4880.3 4887.8 4949.0 4396.2 4423.1 4433.4 4444.7 4445.3 5914.4 6009.7 6037.3 6040.3 6043.4 5523.3 5602.6 5612.7 5621.7 5625.2 6360.4 6404.1 6418.1 6419.0 6467.5 4809.4 4850.5 4882.3 4895.8 4904.3 6587.9 6641.7 6751.0 6761.2 6856.5 4824.6 4860.5 4869.2 4871.6 4918.2 4934.2 4973.1 4976.2 4981.9 4988.0 5463.5 5509.9 5556.4 5582.0 5632.6 6432.7 6483.4 6484.2 6530.7 6569.4 1675.5 1714.2 1720.8 1723.9 1771.6 1164.5 1211.4 1224.8 1227.9 1233.6 5642.2 5695.5 5727.1 5732.8 5783.7 6397.3 6469.2 6530.2 6581.5 6671.8 5672.6 5675.0 5698.6 5736.0 5762.5 3465.0 3518.2 3532.8 3542.1 3554.1 6384.8 6460.2 6477.2 6484.7 6486.6 6731.4 6833.4 6851.3 6879.4 6886.8 6305.8 6332.1 6344.9 6350.9 6479.9 6612.6 6614.2 6630.8 6645.8 6719.4 6492.5 6593.7 6606.6 6616.6 6623.3 6303.4 6387.6 6449.1 6460.5 6479.3 4945.0 4952.5 4965.6 4981.4 5023.6 6714.5 6741.3 6750.7 6780.7 6799.6 6349.2 6414.8 6425.9 6465.1 6515.3 6419.6 6424.8 6462.0 6479.7 6480.5 6168.4 6292.7 6345.6 6349.3 6396.9 6368.2 6438.2 6459.2 6491.6 6492.0 6227.3 6254.6 6290.4 6315.5 6371.6 15:53:50 INFO - PID 783 | 15:53:50 INFO - PID 783 | [#5] yui.html Cycles:180 Average:22173.74 Median:19380.21 stddev:29533.78 (152.4%) stddev-sans-first:29573.33 15:53:50 INFO - PID 783 | Values: 877.5 896.7 896.9 909.8 914.9 17117.5 17844.7 17853.6 17888.0 21826.0 19342.3 19362.7 19398.7 19521.7 19563.2 980.4 1068.4 1068.6 1069.1 1071.9 1064.9 1068.0 1068.6 1070.1 1070.3 1008.2 1056.2 1063.0 1095.4 1107.3 1096.0 1096.2 1097.1 1098.0 1098.3 793.5 796.5 798.9 799.2 802.5 17837.9 19299.3 19397.7 19670.7 19673.2 20303.2 20513.6 20608.3 20929.8 21018.4 16053.4 16246.2 16336.3 16401.8 16426.5 3536.9 3542.0 3554.6 3565.5 3569.6 118268.0 122027.0 124440.0 125348.0 125505.0 14886.0 15657.7 16127.7 16141.2 16143.5 29053.1 29312.4 29636.4 29683.4 29723.3 7443.5 8496.5 8729.0 8785.6 8786.6 3569.3 3995.4 4105.9 4106.4 4136.7 4923.2 5035.5 5057.6 5068.9 5113.1 1064.4 1067.8 1071.9 1077.7 1083.2 623.6 690.5 693.3 714.6 716.6 11807.6 11874.3 12246.9 12396.1 12820.9 627.5 652.8 653.3 674.5 711.3 5286.6 5390.8 5489.3 5601.2 5609.8 99054.0 101250.0 101601.0 103195.0 104404.0 85575.6 87818.6 88888.6 91359.5 94999.5 70387.0 75159.6 76787.6 81364.6 83529.6 11758.2 11855.9 11881.3 11911.8 11989.3 35783.3 37030.6 38259.2 38811.4 39991.8 47583.8 47900.5 48705.3 48802.3 49362.5 17686.8 17972.3 18178.5 18330.3 18366.0 19320.0 19652.1 19739.3 20719.2 21387.0 18860.1 19198.9 19260.3 19340.2 19498.0 17023.7 17260.2 18483.9 18518.4 18585.9 17490.7 17509.7 18042.4 18856.3 19052.8 12117.3 12845.5 13428.6 13544.2 13676.0 13986.7 14083.8 14248.8 14974.6 14975.6 15:53:50 INFO - PID 783 | -------- Summary: end -------- 15:53:50 INFO - PID 783 | 15:53:51 INFO - TEST-INFO | 783: exit 0 15:53:51 INFO - TEST-OK | dromaeo_css | took 1113360ms 15:53:51 INFO - TEST-START | kraken 15:53:51 INFO - Initialising browser for kraken test... 15:53:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39106/getInfo.html -profile /tmp/tmpnr3wEP/profile 15:53:51 INFO - TEST-INFO | started process 1251 (/builds/slave/test/build/application/firefox/firefox http://localhost:39106/getInfo.html) 15:53:57 INFO - TEST-INFO | 1251: exit 0 15:53:57 INFO - Browser initialized. 15:53:57 INFO - Running cycle 1/1 for kraken test... 15:53:57 INFO - TEST-INFO | started process 1492 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnr3wEP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:54:08 INFO - PID 1492 | RSS: Main: 177319936 15:54:08 INFO - PID 1492 | 15:54:11 INFO - PID 1492 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39106/tests/kraken/driver.html?testName=audio-beat-detection) 15:54:12 INFO - PID 1492 | RSS: Main: 183099392 15:54:12 INFO - PID 1492 | 15:54:14 INFO - PID 1492 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39106/tests/kraken/driver.html?testName=audio-dft) 15:54:15 INFO - PID 1492 | RSS: Main: 183685120 15:54:15 INFO - PID 1492 | 15:54:18 INFO - PID 1492 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39106/tests/kraken/driver.html?testName=audio-fft) 15:54:19 INFO - PID 1492 | RSS: Main: 178249728 15:54:19 INFO - PID 1492 | 15:54:21 INFO - PID 1492 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39106/tests/kraken/driver.html?testName=audio-oscillator) 15:54:21 INFO - PID 1492 | RSS: Main: 178528256 15:54:21 INFO - PID 1492 | 15:54:24 INFO - PID 1492 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39106/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:54:24 INFO - PID 1492 | RSS: Main: 178991104 15:54:24 INFO - PID 1492 | 15:54:27 INFO - PID 1492 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39106/tests/kraken/driver.html?testName=imaging-darkroom) 15:54:28 INFO - PID 1492 | RSS: Main: 181784576 15:54:28 INFO - PID 1492 | 15:54:31 INFO - PID 1492 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39106/tests/kraken/driver.html?testName=imaging-desaturate) 15:54:32 INFO - PID 1492 | RSS: Main: 181280768 15:54:32 INFO - PID 1492 | 15:54:35 INFO - PID 1492 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39106/tests/kraken/driver.html?testName=json-parse-financial) 15:54:36 INFO - PID 1492 | RSS: Main: 182652928 15:54:36 INFO - PID 1492 | 15:54:37 INFO - PID 1492 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39106/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:54:38 INFO - PID 1492 | RSS: Main: 182743040 15:54:38 INFO - PID 1492 | 15:54:40 INFO - PID 1492 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39106/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:54:40 INFO - PID 1492 | RSS: Main: 179703808 15:54:40 INFO - PID 1492 | 15:54:42 INFO - PID 1492 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39106/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:54:43 INFO - PID 1492 | RSS: Main: 179769344 15:54:43 INFO - PID 1492 | 15:54:46 INFO - PID 1492 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:54:47 INFO - PID 1492 | RSS: Main: 179838976 15:54:47 INFO - PID 1492 | 15:54:50 INFO - PID 1492 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:54:50 INFO - PID 1492 | RSS: Main: 180404224 15:54:50 INFO - PID 1492 | 15:54:52 INFO - PID 1492 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39106/tests/kraken/driver.html?testName=ai-astar) 15:54:52 INFO - PID 1492 | RSS: Main: 181313536 15:54:52 INFO - PID 1492 | 15:54:52 INFO - PID 1492 | __start_tp_report 15:54:52 INFO - PID 1492 | _x_x_mozilla_page_load 15:54:52 INFO - PID 1492 | _x_x_mozilla_page_load_details 15:54:52 INFO - PID 1492 | |i|pagename|runs| 15:54:52 INFO - PID 1492 | |0;ai-astar;101;110;102;109;113;111;114;101;111;109 15:54:52 INFO - PID 1492 | |1;audio-beat-detection;149;119;148;179;118;145;152;120;176;120 15:54:52 INFO - PID 1492 | |2;audio-dft;164;165;163;164;164;161;162;165;168;167 15:54:52 INFO - PID 1492 | |3;audio-fft;75;76;73;170;80;74;76;89;101;79 15:54:52 INFO - PID 1492 | |4;audio-oscillator;81;81;127;82;80;80;132;81;80;133 15:54:52 INFO - PID 1492 | |5;imaging-gaussian-blur;118;114;114;114;114;114;114;114;114;118 15:54:52 INFO - PID 1492 | |6;imaging-darkroom;150;150;150;151;151;150;150;151;151;150 15:54:52 INFO - PID 1492 | |7;imaging-desaturate;94;100;99;93;94;94;94;94;95;93 15:54:52 INFO - PID 1492 | |8;json-parse-financial;55;55;55;55;56;56;58;57;56;56 15:54:52 INFO - PID 1492 | |9;json-stringify-tinderbox;58;54;55;55;54;54;54;54;54;55 15:54:52 INFO - PID 1492 | |10;stanford-crypto-aes;79;77;78;87;78;77;79;77;87;94 15:54:52 INFO - PID 1492 | |11;stanford-crypto-ccm;131;131;129;135;128;134;133;119;129;165 15:54:52 INFO - PID 1492 | |12;stanford-crypto-pbkdf2;194;179;188;173;178;177;175;184;174;187 15:54:52 INFO - PID 1492 | |13;stanford-crypto-sha256-iterative;68;69;67;70;71;72;68;68;71;67 15:54:52 INFO - PID 1492 | __end_tp_report 15:54:52 INFO - PID 1492 | __start_cc_report 15:54:52 INFO - PID 1492 | _x_x_mozilla_cycle_collect,994 15:54:52 INFO - PID 1492 | __end_cc_report 15:54:52 INFO - PID 1492 | __startTimestamp1500936892861__endTimestamp 15:54:52 INFO - PID 1492 | 15:54:52 INFO - PID 1492 | ------- Summary: start ------- 15:54:52 INFO - PID 1492 | Number of tests: 14 15:54:52 INFO - PID 1492 | 15:54:52 INFO - PID 1492 | [#0] ai-astar Cycles:10 Average:108.10 Median:110.50 stddev:4.93 (4.5%) stddev-sans-first:4.51 15:54:52 INFO - PID 1492 | Values: 101.0 110.0 102.0 109.0 113.0 111.0 114.0 101.0 111.0 109.0 15:54:52 INFO - PID 1492 | 15:54:52 INFO - PID 1492 | [#1] audio-beat-detection Cycles:10 Average:142.60 Median:148.50 stddev:23.07 (15.5%) stddev-sans-first:24.35 15:54:52 INFO - PID 1492 | Values: 149.0 119.0 148.0 179.0 118.0 145.0 152.0 120.0 176.0 120.0 15:54:52 INFO - PID 1492 | 15:54:52 INFO - PID 1492 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.50 stddev:2.11 (1.3%) stddev-sans-first:2.24 15:54:52 INFO - PID 1492 | Values: 164.0 165.0 163.0 164.0 164.0 161.0 162.0 165.0 168.0 167.0 15:54:52 INFO - PID 1492 | 15:54:52 INFO - PID 1492 | [#3] audio-fft Cycles:10 Average:89.30 Median:76.00 stddev:29.63 (39.0%) stddev-sans-first:30.97 15:54:52 INFO - PID 1492 | Values: 75.0 76.0 73.0 170.0 80.0 74.0 76.0 89.0 101.0 79.0 15:54:52 INFO - PID 1492 | 15:54:52 INFO - PID 1492 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:80.50 stddev:24.18 (30.0%) stddev-sans-first:25.06 15:54:52 INFO - PID 1492 | Values: 81.0 81.0 127.0 82.0 80.0 80.0 132.0 81.0 80.0 133.0 15:54:52 INFO - PID 1492 | 15:54:52 INFO - PID 1492 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:114.00 stddev:1.69 (1.5%) stddev-sans-first:1.33 15:54:52 INFO - PID 1492 | Values: 118.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 118.0 15:54:52 INFO - PID 1492 | 15:54:52 INFO - PID 1492 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.50 stddev:0.52 (0.3%) stddev-sans-first:0.53 15:54:52 INFO - PID 1492 | Values: 150.0 150.0 150.0 151.0 151.0 150.0 150.0 151.0 151.0 150.0 15:54:52 INFO - PID 1492 | 15:54:52 INFO - PID 1492 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:94.00 stddev:2.45 (2.6%) stddev-sans-first:2.57 15:54:52 INFO - PID 1492 | Values: 94.0 100.0 99.0 93.0 94.0 94.0 94.0 94.0 95.0 93.0 15:54:52 INFO - PID 1492 | 15:54:52 INFO - PID 1492 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:0.99 (1.8%) stddev-sans-first:1.00 15:54:52 INFO - PID 1492 | Values: 55.0 55.0 55.0 55.0 56.0 56.0 58.0 57.0 56.0 56.0 15:54:52 INFO - PID 1492 | 15:54:52 INFO - PID 1492 | [#9] json-stringify-tinderbox Cycles:10 Average:54.70 Median:54.50 stddev:1.25 (2.3%) stddev-sans-first:0.50 15:54:52 INFO - PID 1492 | Values: 58.0 54.0 55.0 55.0 54.0 54.0 54.0 54.0 54.0 55.0 15:54:52 INFO - PID 1492 | 15:54:52 INFO - PID 1492 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:79.00 stddev:5.91 (7.5%) stddev-sans-first:6.21 15:54:52 INFO - PID 1492 | Values: 79.0 77.0 78.0 87.0 78.0 77.0 79.0 77.0 87.0 94.0 15:54:52 INFO - PID 1492 | 15:54:52 INFO - PID 1492 | [#11] stanford-crypto-ccm Cycles:10 Average:133.40 Median:132.00 stddev:11.96 (9.1%) stddev-sans-first:12.66 15:54:52 INFO - PID 1492 | Values: 131.0 131.0 129.0 135.0 128.0 134.0 133.0 119.0 129.0 165.0 15:54:52 INFO - PID 1492 | 15:54:52 INFO - PID 1492 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.90 Median:181.50 stddev:7.00 (3.9%) stddev-sans-first:5.59 15:54:52 INFO - PID 1492 | Values: 194.0 179.0 188.0 173.0 178.0 177.0 175.0 184.0 174.0 187.0 15:54:52 INFO - PID 1492 | 15:54:52 INFO - PID 1492 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:1.79 (2.6%) stddev-sans-first:1.86 15:54:52 INFO - PID 1492 | Values: 68.0 69.0 67.0 70.0 71.0 72.0 68.0 68.0 71.0 67.0 15:54:52 INFO - PID 1492 | -------- Summary: end -------- 15:54:52 INFO - PID 1492 | 15:54:53 INFO - PID 1492 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:54:53 INFO - TEST-INFO | 1492: exit 0 15:54:53 INFO - TEST-OK | kraken | took 62512ms 15:54:53 INFO - SUITE-END | took 1175s 15:54:54 INFO - Completed test suite (00:19:36) 15:54:54 INFO - javascript benchmark 15:54:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8387.282157911934, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3052.8626211820465, 3144.5440411140385, 3159.320746039601, 3159.541866429368, 3184.0288711942862, 5967.940320596793, 5991.400859914012, 6078.665673387962, 6084.482818960388, 6158.107074474198, 6093.207882975218, 6098.57309988301, 6134.263888333395, 6167.229096362955, 6213.627182369061, 5348.679079255237, 5551.472610102034, 5568.888622227563, 5639.238702775114, 5680.403557626451, 5481.835544933659, 5545.251391062196, 5554.472325129126, 5656.349519805234, 5669.8299051028325, 5538.0, 5561.304836895388, 5614.494695477406, 5650.124230744241, 5657.801976930808, 5472.042392581282, 5535.6955367454775, 5615.578831587647, 5621.494065534122, 5637.943620563783, 5482.479164479368, 5489.258950041733, 5522.6134170608075, 5553.305836770403, 5555.833325000256, 6008.96995515024, 6015.39846015395, 6076.270847498285, 6109.3890610939, 6113.358097399753, 6381.968090159566, 6493.837654058686, 6572.07990881277, 6590.340965903371, 6600.174978127734, 6374.107624932513, 6477.1579694639395, 6571.277159512498, 6611.140551728293, 6620.834479138012, 6082.118092876508, 6086.847828804227, 6131.540134489931, 6153.692315384213, 6162.137300777895, 6600.141981542369, 6712.0496894409935, 6761.121054262914, 6798.864022719518, 6811.318868113248, 6314.71583778731, 6329.588576742497, 6355.396237357444, 6361.332060133619, 6362.395572420613, 6424.486041116699, 6492.188476440445, 6506.31683673217, 6538.444232240313, 6564.409203171737, 6412.583182093149, 6433.0, 6455.935440645628, 6499.38255865692, 6503.447206987365, 6321.683915804191, 6414.903776443357, 6468.6442245676, 6574.243961944438, 6576.572522786099, 5290.391604965402, 5386.461353864583, 5401.4868587484125, 5415.377231618336, 5427.402985671573, 4576.771161441915, 4587.311903214478, 4606.286025666027, 4627.5603817637275, 4628.907421851544, 5519.69641669704, 5701.543876489871, 5724.627899186623, 5759.85600359986, 5791.218185544897, 6464.41820236181, 6480.384363485461, 6481.09264702942, 6515.837104072436, 6558.606483610999, 5655.349634792052, 5717.628354156966, 5723.599348045597, 5726.341470730836, 5737.225474560964, 5735.082386818172, 5759.107338362561, 5765.308163020381, 5851.444112809277, 5851.736671849777, 6233.812985610439, 6292.2134733158355, 6299.874002519924, 6374.458171055512, 6390.297067322591, 6413.422791948747, 6487.351264873475, 6589.868202636017, 6592.967035164794, 6602.207735071822, 6206.813795586139, 6232.501399888089, 6356.364363563606, 6358.205224346957, 6360.586561873463, 6357.809265722036, 6396.520260980352, 6441.935580644134, 6453.45145662624, 6458.160439142881, 6506.316836732264, 6527.216733991761, 6619.669016549057, 6620.172478440195, 6629.03878937561, 6105.17580126695, 6206.906896396648, 6228.968855155696, 6240.937590624218, 6339.651319177489, 6343.936560634519, 6359.523035772243, 6415.679216039272, 6426.871462570629, 6432.839179020562, 6230.875382492234, 6254.9687251563455, 6260.060990851409, 6366.172397588284, 6390.7763228286785, 6288.27684816252, 6341.587796793194, 6373.649449280334, 6437.742490300523, 6455.934770762771, 6145.600535965327, 6189.876202476015, 6190.535709821871, 6193.380661933951, 6242.094896239929], "value": 5959.15190616171, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [826.7726375246806, 861.0485413617951, 883.7658020624532, 885.1679421343935, 1159.4550561236215, 29141.41717165658, 29719.554206686917, 38740.61259387409, 38875.61124388762, 38991.41512877309, 39231.21537569254, 39643.801780991125, 39726.80136599313, 39761.801190994076, 39771.602283977154, 7093.751718689834, 7285.7814265572115, 7666.578338191397, 7670.117936437297, 7676.117246516638, 7592.050993625797, 7676.078870535515, 7676.347510461617, 7701.730439434621, 7703.1526532081425, 7624.847503049936, 7694.538327700356, 7697.191794861543, 7699.307062364386, 7707.576083315415, 7629.2752188542, 7680.615969201545, 7695.076590809111, 7714.267144621252, 7732.45872788905, 7532.133804612485, 7578.0906291244855, 7605.581693006882, 7619.0, 7625.237476252386, 36366.818165909266, 36677.44983825245, 36704.449433258524, 36736.08159796, 36743.44884826703, 3556.4309710446205, 3562.590302115264, 3574.5531808523933, 3589.569251689814, 3593.802340871251, 29850.253743656584, 29933.25166870824, 30141.849290753624, 30142.095737127922, 30233.09300720982, 4709.081729062834, 4876.390451193601, 4904.288878112689, 4907.2639104134305, 4936.950630493685, 183879.0, 184389.0, 184875.0, 184927.0, 186119.0, 46662.0, 46744.2988355175, 46759.06481870344, 46846.06307873823, 46999.0, 48656.513434865905, 48720.756396217796, 49213.50786492161, 49277.26084108741, 49454.258186127234, 13269.0, 16049.759253611206, 16445.91777041107, 16502.42241521541, 16559.83440165607, 10933.453327333602, 11947.462364193632, 12036.0, 12126.818097728541, 12137.453814578364, 14096.295185240697, 14096.436142554388, 14151.43394264218, 14219.075760075562, 14382.137071775727, 5712.200291959129, 5793.188953546507, 5794.652320860761, 5896.380880007623, 6025.0661147522205, 981.4700061966458, 985.4579981010559, 989.6288891665625, 1014.7412409835445, 1030.9432981185957, 21825.92653697896, 21875.781242187375, 21986.780132198794, 22787.202447914577, 23058.65412018821, 1051.8264486359817, 1052.6947185316326, 1062.9681109566725, 1072.6942821295893, 1076.838474228872, 11650.475728592233, 11876.643700688994, 11910.106741994385, 11946.402679865972, 12028.338441385808, 227907.0, 228739.0, 229208.0, 229628.0, 229642.0, 49010.50989490059, 49373.50626493761, 49546.50453495491, 49643.50356496461, 49686.75156624194, 1419.900606957503, 1462.3565631122271, 1478.209158100411, 1483.8219413670429, 1488.3302513868803, 20138.496537586678, 20753.688694669894, 20952.0, 21747.456313591654, 22032.559348812614, 36245.0, 36367.454488183226, 36506.26987460289, 36511.45232821563, 36513.087172820895, 195456.0, 196866.0, 197270.0, 197285.0, 197451.0, 28316.43367132687, 28827.855860720563, 31699.0, 31730.524042138924, 32154.19614509656, 39197.21605567815, 40524.79737601293, 40642.79678601588, 40684.38973415342, 41228.38157427701, 28343.858280708464, 28807.855960720062, 30310.69689303079, 30518.620675870538, 33443.83278083594, 32342.0, 33041.33917321688, 33123.83438082794, 33156.1710957228, 33495.16262093467, 35553.82223088868, 36603.0, 37011.0, 37069.25861482809, 37113.443298351085, 30475.695243048172, 31555.36889262248, 32602.85889993839, 32643.0, 32997.67002329946, 23244.418889527897, 23479.765202347757, 23753.52492950166, 23803.64294535618, 23866.761332386453], "value": 16688.928305185098, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.2706762411735, 576.3919065386021, 584.1733946465752, 584.5382148103001, 599.7690889007732, 21681.34955951322, 22420.88789556052, 22642.999999999978, 22699.886500567474, 22917.4270643234, 27419.451610967768, 28088.438231235363, 28173.57739633907, 28330.43339133216, 28388.858055709745, 6854.794356169323, 6958.79123626292, 7029.402500787439, 7040.436765058783, 7042.436605071582, 6161.815145545641, 6728.495362847806, 6761.729530818761, 6866.416354609864, 6937.098177236978, 6723.562968407038, 6735.225449073346, 6742.359475849787, 6743.190817101955, 6743.629100399476, 6706.731730730789, 6716.294789047153, 6719.428848547855, 6726.93273067268, 6750.0, 6601.339866013408, 6610.537262391635, 6615.966920165417, 6622.2715501294815, 6623.370779775962, 31191.220219494466, 31721.0, 31895.36209275825, 32764.836175819208, 33018.0, 2020.0202901592863, 2037.836973042168, 2044.437779610619, 2044.9079791409422, 2045.0490521907236, 19546.902265488723, 20120.29578964744, 20147.496312592157, 20152.39542813718, 20173.092210850547, 2434.3548959525738, 2447.902083916659, 2519.2442267319916, 2522.1928982725535, 2526.696796384427, 134130.3293483536, 137669.0, 137947.0, 138168.99999999898, 138206.0, 20462.0, 21576.892115539635, 22434.887825560767, 22662.773372266067, 23011.769882300963, 22392.888035559718, 24020.15929442496, 24024.759752402602, 46029.7698511512, 46345.0, 10062.446565438971, 10095.24285678577, 10283.177345812317, 10317.94841025805, 10500.684979450629, 9474.526273686288, 9554.570044348022, 9623.56693948774, 9682.419054856731, 9724.805503889882, 9453.101955314234, 9701.951490242503, 9718.173955213744, 9780.706578802647, 9843.163331116792, 2928.824270543774, 2939.1770304314828, 2958.8076775009554, 2961.452131355706, 3044.605265129365, 962.1436921140191, 969.4038166527675, 971.4317124482116, 979.5934687104772, 1000.1049061090283, 19417.708734368996, 19631.93858655232, 19986.800131998494, 20237.898810505852, 20411.897940510204, 1008.7831116309882, 1011.6661501704419, 1020.5560581147224, 1034.99482502587, 1044.8850626431085, 11260.662180134608, 12521.874781252252, 13202.207867527979, 13571.52499662507, 13690.178589284675, 461352.0, 473584.0, 475632.0, 478030.0, 481959.0, 116562.0, 119030.0, 119867.0, 120535.39732301458, 120562.39718801349, 1259.4647274908311, 1260.9936950315189, 1306.3207132291154, 1307.7907534794388, 1311.2919023727081, 20376.28682996088, 20883.791162088186, 21178.503818624416, 21257.78742212558, 22075.889620552436, 50741.49258507515, 51973.22040169325, 53443.0, 55781.72109139428, 55970.0, 67919.0, 70375.29624703892, 70550.64724676344, 71070.28929710844, 71399.0, 14737.0, 15198.544043678707, 15310.540683779505, 15400.768988465406, 15428.922855385652, 23920.0, 24073.879630601736, 24410.755892440848, 24463.38841528905, 25283.494330112928, 19107.61784764269, 19136.13887375099, 19162.329318473785, 19173.61652766965, 19450.416487505398, 15988.8401115992, 16195.514134575982, 16386.67226655484, 17345.47963561095, 17949.37177198844, 19197.136128874514, 19302.517437064187, 19356.61286774285, 19504.122314496166, 19672.50818729486, 14813.0, 15074.849251507345, 15103.0, 15219.239038047832, 15462.226888655747, 17942.282308707505, 18203.54491137732, 18276.817231828045, 18435.631287373908, 18581.16384762662], "value": 12633.906231066025, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.8253027106475, 1383.3567391163108, 1415.6126995544369, 1422.3172877019038, 1427.252538862689, 13447.0, 13878.722425551483, 14116.92941535292, 14152.858471415282, 14164.0, 14100.36548355324, 14319.64200894978, 14374.640633984156, 14443.494477693283, 14450.421983120663, 2660.1088635307146, 2731.207949694586, 2733.425980544088, 2739.301478123076, 2740.671119465667, 2607.9739202608016, 2709.336212627899, 2758.944821103577, 2778.8888444462195, 2781.0822428598512, 2652.668416447944, 2670.6528151340394, 2698.0, 2708.0251109600526, 2723.2102690219813, 2666.6266722658843, 2668.5863691127906, 2681.3430709476206, 2705.3101459127993, 2720.306321887906, 2570.3959569501153, 2618.869056547165, 2663.267601409628, 2664.427148163135, 2668.7064422913463, 13428.261445620486, 13602.727945441135, 13668.52160174389, 13673.658158546115, 13703.725925481534, 7367.226441223702, 7624.961875190644, 7642.694292228304, 7646.464747467679, 7664.233576642347, 4980.7509624518625, 5158.845234642967, 5275.815346462856, 5281.441974617497, 5282.630215884889, 1839.347031803717, 1867.1504465468179, 1877.9906100469411, 1930.8455323574221, 1953.5702145527962, 22438.88780556103, 23014.53970920589, 23027.424314392276, 23049.654255186353, 23064.538709225722, 6790.456763458911, 6797.898031529531, 6827.2831352708245, 6971.058907047585, 6989.93010069903, 18049.278028878696, 18154.63690726178, 18155.183016764277, 18177.36379226747, 18181.272749090153, 7408.925910740932, 7724.884126738103, 7727.265909738566, 7737.342325902248, 7745.10931242903, 6758.966205169041, 6975.651217439107, 7046.189688185822, 7061.505694601431, 7106.786796396116, 5269.341332333458, 5461.535769459561, 5473.425290344536, 5506.449355064461, 5558.138023762004, 1645.6215070533844, 1649.5546202525252, 1660.6346603747156, 1673.414304993267, 1705.3434427745408, 856.6402111113347, 860.6643409070467, 867.4274978514151, 879.7228872905015, 911.7857303533664, 6966.9303306967295, 7089.858202835914, 7181.245969173266, 7199.460040496983, 7295.124585049828, 671.5634837355758, 675.9391654751096, 692.4979389942251, 698.8742026435189, 708.6563016936782, 4186.623203911662, 4814.903701926012, 5122.948770512247, 5188.662736922088, 5260.789568417297, 16631.91684041572, 16843.578910527336, 17286.22212000438, 17406.042667653146, 17546.561335966704, 17400.303987840598, 17499.562510937074, 17530.211140498708, 17562.560935976704, 17573.47279581589, 9779.413235206053, 10087.394756314645, 10222.795544089076, 10222.795544089076, 10301.072903438726, 7365.558066516026, 7397.778066658009, 7900.3284720799375, 7940.563269020259, 7970.641321140679, 15166.31751571204, 15177.544673659808, 15389.923050384676, 15563.221838908235, 15598.298076586354, 15882.920585397, 15951.042937423328, 15998.0, 16030.679386411974, 16324.755128672841, 10853.837192442277, 10875.510602023087, 10960.56157753681, 11098.2786118902, 11145.38700371455, 12200.877991219973, 12442.502299908265, 12484.687882803002, 12514.374281286082, 12568.74862502763, 9804.411735295906, 10221.0, 10456.47717614101, 10470.424126672802, 10576.629817956335, 9617.086376794194, 10040.096391324816, 10083.445410502492, 10115.949420252851, 10259.179265658879, 9150.222231110163, 9187.494687792236, 9193.126652967958, 9248.630054798003, 9286.674966376144, 6225.501959843292, 6272.560920735505, 6470.126532917996, 6597.80206593803, 6622.403983641303, 6531.608103513804, 6680.899786503109, 6845.247022827584, 6922.0, 6940.6529673515115], "value": 6226.685413350143, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.7440758293838, 497.3611948629266, 527.3961314295132, 529.0345120155716, 534.2556552854929, 6128.908066379002, 6145.907811382827, 6173.50611951044, 6193.504519638429, 6239.065889574235, 5829.417058294169, 5960.0, 5989.101634754789, 6034.517238620911, 6065.848353791157, 4839.225723884179, 4846.7818948147415, 4858.635602329822, 4910.508949105097, 4927.901441971158, 4860.222364421693, 4870.415550133989, 4882.658213925027, 4929.285253638221, 4939.555440010398, 4688.695234809744, 4855.198892182786, 4856.247281671346, 4868.85581888256, 4905.577382559053, 4799.400074990626, 4859.460215354498, 4880.316755654176, 4887.8044878204655, 4948.975255123702, 4396.1647287015685, 4423.115376924596, 4433.379326894237, 4444.688871778977, 4445.310976798602, 5914.37899020601, 6009.729562169713, 6037.335893051761, 6040.31540760136, 6043.3956604339655, 5523.25436066134, 5602.579806514487, 5612.747426365823, 5621.7189140542805, 5625.156226566007, 6360.363963603649, 6404.103425520431, 6418.133551970518, 6419.0, 6467.482601391925, 4809.398825146856, 4850.490698476679, 4882.267659851015, 4895.828645997373, 4904.313396124546, 6587.934120658828, 6641.66791660415, 6750.966245168743, 6761.154855643044, 6856.451483881277, 4824.589909857701, 4860.465348811628, 4869.172240719086, 4871.585915197248, 4918.213085906238, 4934.210526315772, 4973.079980203674, 4976.178930476431, 4981.90036199274, 4987.975060124676, 5463.508284254436, 5509.944900551023, 5556.444355564411, 5582.0, 5632.577556683265, 6432.71052802625, 6483.3516648335735, 6484.19664400359, 6530.706118224692, 6569.408753212234, 1675.4638515674867, 1714.1857617631774, 1720.7504911787971, 1723.922423490946, 1771.6279581287815, 1164.4643464006651, 1211.4185191108318, 1224.7813425641543, 1227.9447424865903, 1233.617578550652, 5642.238297829823, 5695.515881150149, 5727.083666613322, 5732.828015159552, 5783.7397317119985, 6397.328280530477, 6469.191351081115, 6530.183727034121, 6581.506387020992, 6671.833204169838, 5672.5745569081655, 5675.0, 5698.572607054404, 5736.024875771129, 5762.481376676035, 3465.0, 3518.1732292911147, 3532.823358832048, 3542.1321776165005, 3554.0581745837376, 6384.840378990562, 6460.160179176677, 6477.190351206099, 6484.675766211765, 6486.610803351814, 6731.427828634523, 6833.384995350343, 6851.2806155353965, 6879.449644028566, 6886.827829304208, 6305.806638585289, 6332.050192471166, 6344.889644312227, 6350.872982540323, 6479.866023445878, 6612.636305003271, 6614.239362473185, 6630.76792312286, 6645.800625981228, 6719.428848547928, 6492.513061520311, 6593.7142257259375, 6606.570572912745, 6616.636085015178, 6623.311055680771, 6303.392634878077, 6387.584806987531, 6449.12936753551, 6460.547761656639, 6479.287278399278, 4944.975275123601, 4952.504749525018, 4965.553100220997, 4981.438271635798, 5023.623228257969, 6714.462842972648, 6741.280973351764, 6750.717363700881, 6780.677168422764, 6799.626020568916, 6349.206349206349, 6414.839629009312, 6425.935740642721, 6465.0948867157695, 6515.250746164252, 6419.646919419477, 6424.807255782334, 6462.0, 6479.708413121515, 6480.546361754632, 6168.444839964424, 6292.709994451218, 6345.587536810092, 6349.301576826638, 6396.904046439214, 6368.203974503187, 6438.163038804925, 6459.224893012869, 6491.610503369813, 6492.0, 6227.283862355887, 6254.593451425642, 6290.402411770874, 6315.515853774451, 6371.649559274099], "value": 4983.526465893938, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [877.4647465046324, 896.744427838066, 896.8878590547723, 909.7680091576651, 914.9130832570905, 17117.48647540574, 17844.732329015074, 17853.553661158447, 17888.0, 21826.0, 19342.323018694347, 19362.709559356586, 19398.70901936472, 19521.707174392395, 19563.21747130113, 980.3921568627461, 1068.358984609236, 1068.647346375694, 1069.1446842525947, 1071.919606029547, 1064.9414282214475, 1068.0334297460772, 1068.5992752717732, 1070.1011150633467, 1070.3363914373099, 1008.178334657252, 1056.1867362131154, 1062.9893701063006, 1095.424901926491, 1107.341132026443, 1096.0464395975512, 1096.177866600046, 1097.1113398147486, 1097.9670609881716, 1098.3080659184743, 793.5119901260741, 796.466367533748, 798.8801679748084, 799.2287442617843, 802.4543310548825, 17837.910810445996, 19299.324523641604, 19397.709034364354, 19670.70493942592, 19673.213071477123, 20303.187872485083, 20513.589728205352, 20608.27871024507, 20929.790702092938, 21018.369448916557, 16053.438129665523, 16246.18769061554, 16336.264868080965, 16401.83598164027, 16426.507204783877, 3536.9115772105647, 3541.982290088559, 3554.608993010767, 3565.4830049642915, 3569.5894972078286, 118268.0, 122027.0, 124440.0, 125348.0, 125505.0, 14886.0, 15657.686846263012, 16127.677446451005, 16141.192940352936, 16143.515694529184, 29053.12840614785, 29312.413751724845, 29636.407271854874, 29683.406331873673, 29723.256918576775, 7443.478956473104, 8496.532690701946, 8729.0, 8785.560721964004, 8786.648534058693, 3569.268299998494, 3995.4006898965386, 4105.938410923838, 4106.384042393605, 4136.689748268892, 4923.236898280772, 5035.471275516018, 5057.6459647824295, 5068.923966140437, 5113.079645663816, 1064.4305296666246, 1067.7757670889046, 1071.8928107189374, 1077.719792853848, 1083.1605505732962, 623.607127509666, 690.4510913823523, 693.327472351818, 714.5855403865745, 716.559316020654, 11807.60930381259, 11874.287542747463, 12246.938765306295, 12396.132270740962, 12820.935895320463, 627.4948666323562, 652.774792696519, 653.2552889705739, 674.5177198303237, 711.2709472790327, 5286.577073834161, 5390.757415916293, 5489.286392768914, 5601.215829783833, 5609.80365687199, 99054.0, 101250.0, 101601.0, 103195.0, 104404.0, 85575.57212214023, 87818.56090719506, 88888.5555572218, 91359.54320228356, 94999.52500237593, 70387.0, 75159.62420187864, 76787.61606191934, 81364.59317703373, 83529.58235208907, 11758.176927615326, 11855.940720296343, 11881.346525941157, 11911.80881911802, 11989.34058626749, 35783.284334312644, 37030.6296937038, 38259.234815304095, 38811.41782873316, 39991.80004099961, 47583.76208118937, 47900.520994791, 48705.26942095801, 48802.26796598125, 49362.506374935794, 17686.823131768517, 17972.281108755502, 18178.45464636063, 18330.266789328278, 18366.0, 19320.0, 19652.11565479528, 19739.30912418116, 20719.171233150504, 21387.0, 18860.05699715036, 19198.94405807694, 19260.32588859383, 19340.226390944204, 19498.0, 17023.7446438306, 17260.22328995173, 18483.90758046255, 18518.44444666662, 18585.90707046456, 17490.650186995936, 17509.737353939956, 18042.368517101837, 18856.34002809895, 19052.809471905104, 12117.333546655018, 12845.486180553047, 13428.597142085753, 13544.187348759106, 13676.0, 13986.720265594835, 14083.788743168656, 14248.786268206193, 14974.550763477113, 14975.550733478012], "value": 8928.019822977052, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 102.0, 109.0, 113.0, 111.0, 114.0, 101.0, 111.0, 109.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 119.0, 148.0, 179.0, 118.0, 145.0, 152.0, 120.0, 176.0, 120.0], "value": 142.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 163.0, 164.0, 164.0, 161.0, 162.0, 165.0, 168.0, 167.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 73.0, 170.0, 80.0, 74.0, 76.0, 89.0, 101.0, 79.0], "value": 89.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 127.0, 82.0, 80.0, 80.0, 132.0, 81.0, 80.0, 133.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 118.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 151.0, 151.0, 150.0, 150.0, 151.0, 151.0, 150.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 100.0, 99.0, 93.0, 94.0, 94.0, 94.0, 94.0, 95.0, 93.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 56.0, 56.0, 58.0, 57.0, 56.0, 56.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 55.0, 55.0, 54.0, 54.0, 54.0, 54.0, 54.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 78.0, 87.0, 78.0, 77.0, 79.0, 77.0, 87.0, 94.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 131.0, 129.0, 135.0, 128.0, 134.0, 133.0, 119.0, 129.0, 165.0], "value": 133.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 179.0, 188.0, 173.0, 178.0, 177.0, 175.0, 184.0, 174.0, 187.0], "value": 180.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 67.0, 70.0, 71.0, 72.0, 68.0, 68.0, 71.0, 67.0], "value": 69.1, "unit": "score"}]}]} 15:54:54 INFO - Return code: 0 15:54:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:54:54 INFO - # TBPL SUCCESS # 15:54:54 INFO - Running post-action listener: _package_coverage_data 15:54:54 INFO - Running post-action listener: _resource_record_post_action 15:54:54 INFO - [mozharness: 2017-07-24 22:54:54.137535Z] Finished run-tests step (success) 15:54:54 INFO - Running post-run listener: _resource_record_post_run 15:54:54 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 8192; Write bytes: 437899264; Read time: 164; Write time: 245192 15:54:54 INFO - TinderboxPrint: CPU usage
13.2% 15:54:54 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 164 15:54:54 INFO - TinderboxPrint: I/O write bytes / time
437,899,264 / 245,192 15:54:54 INFO - TinderboxPrint: CPU idle
8,272.6 (86.8%) 15:54:54 INFO - TinderboxPrint: CPU user
1,204.0 (12.6%) 15:54:54 INFO - TinderboxPrint: Swap in / out
0 / 0 15:54:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106713088; Read time: 0; Write time: 55228 15:54:54 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:54:54 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 329662464; Read time: 156; Write time: 189776 15:54:54 INFO - Running post-run listener: _upload_blobber_files 15:54:54 INFO - Blob upload gear active. 15:54:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:54:54 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 15:54:54 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'] 15:54:54 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 15:54:55 INFO - (blobuploader) - INFO - Open directory for files ... 15:54:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:54:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:54:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:56 INFO - (blobuploader) - INFO - Done attempting. 15:54:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:54:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:54:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:56 INFO - (blobuploader) - INFO - Done attempting. 15:54:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:54:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:54:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:59 INFO - (blobuploader) - INFO - Done attempting. 15:54:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:54:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:55:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:55:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:55:00 INFO - (blobuploader) - INFO - Done attempting. 15:55:00 INFO - (blobuploader) - INFO - Iteration through files over. 15:55:00 INFO - Return code: 0 15:55:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:55:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:55:00 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61aafbebd8dfa2a6e0e1b14dc343ebc616ad533839f27ce2a543e7b4f1198b621058482fd9cf8cf79aaac7e561b5bc68e093b5c7d68fc669b0d37dcdcd9b6e81", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3cabdfff09b4a19dfe409ffa29d2d498d3f8d514432505722fca13dfc92f63cb9a44e8079e4e4423c1e60d893f03d31146ac3921256d6a8b6752ea2b8523eb4a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc46edfa65cc9c826299b8aac8cd4448d965e6695e82a64506357d95a7d0c132e01d693e93d6a48cef2d9323bfdc9281573730f34de3a964ae9e69e08cc65bec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdd8a31989eda79ac89108995047205463d17b26f1cd2d66456c58ce16574d6deb72a4c054782df9b97c3a1aac1f6a077248bb22bdff68d3fa32ce20d0819e96"} 15:55:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:55:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:55:00 INFO - Contents: 15:55:00 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61aafbebd8dfa2a6e0e1b14dc343ebc616ad533839f27ce2a543e7b4f1198b621058482fd9cf8cf79aaac7e561b5bc68e093b5c7d68fc669b0d37dcdcd9b6e81", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3cabdfff09b4a19dfe409ffa29d2d498d3f8d514432505722fca13dfc92f63cb9a44e8079e4e4423c1e60d893f03d31146ac3921256d6a8b6752ea2b8523eb4a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc46edfa65cc9c826299b8aac8cd4448d965e6695e82a64506357d95a7d0c132e01d693e93d6a48cef2d9323bfdc9281573730f34de3a964ae9e69e08cc65bec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdd8a31989eda79ac89108995047205463d17b26f1cd2d66456c58ce16574d6deb72a4c054782df9b97c3a1aac1f6a077248bb22bdff68d3fa32ce20d0819e96"} 15:55:00 INFO - Running post-run listener: copy_logs_to_upload_dir 15:55:00 INFO - Copying logs to upload dir... 15:55:00 INFO - mkdir: /builds/slave/test/build/upload/logs 15:55:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.586332 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-07-24 15:55:00.181345) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 15:55:00.185464) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981 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/61aafbebd8dfa2a6e0e1b14dc343ebc616ad533839f27ce2a543e7b4f1198b621058482fd9cf8cf79aaac7e561b5bc68e093b5c7d68fc669b0d37dcdcd9b6e81", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3cabdfff09b4a19dfe409ffa29d2d498d3f8d514432505722fca13dfc92f63cb9a44e8079e4e4423c1e60d893f03d31146ac3921256d6a8b6752ea2b8523eb4a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc46edfa65cc9c826299b8aac8cd4448d965e6695e82a64506357d95a7d0c132e01d693e93d6a48cef2d9323bfdc9281573730f34de3a964ae9e69e08cc65bec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdd8a31989eda79ac89108995047205463d17b26f1cd2d66456c58ce16574d6deb72a4c054782df9b97c3a1aac1f6a077248bb22bdff68d3fa32ce20d0819e96"} build_url:https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011191 build_url: 'https://queue.taskcluster.net/v1/task/S1EjXnT4TFqOlI6-AEiL3g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61aafbebd8dfa2a6e0e1b14dc343ebc616ad533839f27ce2a543e7b4f1198b621058482fd9cf8cf79aaac7e561b5bc68e093b5c7d68fc669b0d37dcdcd9b6e81", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3cabdfff09b4a19dfe409ffa29d2d498d3f8d514432505722fca13dfc92f63cb9a44e8079e4e4423c1e60d893f03d31146ac3921256d6a8b6752ea2b8523eb4a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc46edfa65cc9c826299b8aac8cd4448d965e6695e82a64506357d95a7d0c132e01d693e93d6a48cef2d9323bfdc9281573730f34de3a964ae9e69e08cc65bec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdd8a31989eda79ac89108995047205463d17b26f1cd2d66456c58ce16574d6deb72a4c054782df9b97c3a1aac1f6a077248bb22bdff68d3fa32ce20d0819e96"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 15:55:00.241560) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-07-24 15:55:00.241844) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1500935622.200639-958006981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 1.81 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-07-24 15:55:02.051888) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 15:55:02.059807) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 15:55:02.071271) ========= ========= Total master_lag: 2.11 =========