builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-025 starttime: 1495232674.61 results: success (0) revision: 979f11deabd01d6cb897d064d3d9ed11ea8baa93 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-19 15:24:34.609323) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-19 15:24:34.609954) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-19 15:24:34.610551) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-19 15:24:34.702242) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 15:24:34.702499) ========= 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=232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-19 15:24:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 22.2M=0.001s 2017-05-19 15:24:35 (22.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.160064 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 15:24:34.900667) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 15:24:34.900947) ========= 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=232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019071 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 15:24:34.956271) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 15:24:34.956559) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 979f11deabd01d6cb897d064d3d9ed11ea8baa93 --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 979f11deabd01d6cb897d064d3d9ed11ea8baa93 --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=232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-19 15:24:35,266 truncating revision to first 12 chars 2017-05-19 15:24:35,266 Setting DEBUG logging. 2017-05-19 15:24:35,266 attempt 1/10 2017-05-19 15:24:35,266 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/979f11deabd0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-19 15:24:35,572 unpacking tar archive at: mozilla-central-979f11deabd0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.627077 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 15:24:35.595246) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-19 15:24:35.595515) ========= script_repo_revision: 979f11deabd01d6cb897d064d3d9ed11ea8baa93 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-19 15:24:35.595875) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-19 15:24:35.597623) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-19 15:24:35.609840) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-05-19 15:24:35.610106) ========= /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=232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:24:36 INFO - MultiFileLogger online at 20170519 15:24:36 in /builds/slave/test 15:24:36 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:24:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:24:36 INFO - {'append_to_log': False, 15:24:36 INFO - 'base_work_dir': '/builds/slave/test', 15:24:36 INFO - 'blob_upload_branch': 'Firefox', 15:24:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:24:36 INFO - 'branch': 'Firefox', 15:24:36 INFO - 'buildbot_json_path': 'buildprops.json', 15:24:36 INFO - 'config_files': ('talos/linux_config.py',), 15:24:36 INFO - 'default_actions': ('clobber', 15:24:36 INFO - 'read-buildbot-config', 15:24:36 INFO - 'download-and-extract', 15:24:36 INFO - 'populate-webroot', 15:24:36 INFO - 'create-virtualenv', 15:24:36 INFO - 'install', 15:24:36 INFO - 'run-tests'), 15:24:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:24:36 INFO - 'download_minidump_stackwalk': True, 15:24:36 INFO - 'download_symbols': 'ondemand', 15:24:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:24:36 INFO - 'tooltool.py': '/tools/tooltool.py', 15:24:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:24:36 INFO - '/tools/misc-python/virtualenv.py')}, 15:24:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:24:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:24:36 INFO - 'gecko_profile': False, 15:24:36 INFO - 'gecko_profile_interval': 0, 15:24:36 INFO - 'installer_path': 'installer.exe', 15:24:36 INFO - 'log_level': 'info', 15:24:36 INFO - 'log_name': 'talos', 15:24:36 INFO - 'log_to_console': True, 15:24:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:24:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:24:36 INFO - 'opt_config_files': (), 15:24:36 INFO - 'pip_index': False, 15:24:36 INFO - 'suite': 'dromaeojs-e10s', 15:24:36 INFO - 'system_bits': '32', 15:24:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:24:36 INFO - 'title': 'talos-linux64-ix-025', 15:24:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:24:36 INFO - 'use_talos_json': True, 15:24:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:24:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:24:36 INFO - 'work_dir': 'build'} 15:24:36 INFO - [mozharness: 2017-05-19 22:24:36.105845Z] Running clobber step. 15:24:36 INFO - Running pre-action listener: _resource_record_pre_action 15:24:36 INFO - Running main action method: clobber 15:24:36 INFO - rmtree: /builds/slave/test/build 15:24:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:24:37 INFO - Running post-action listener: _resource_record_post_action 15:24:37 INFO - [mozharness: 2017-05-19 22:24:37.085266Z] Finished clobber step (success) 15:24:37 INFO - [mozharness: 2017-05-19 22:24:37.085435Z] Running read-buildbot-config step. 15:24:37 INFO - Running pre-action listener: _resource_record_pre_action 15:24:37 INFO - Running main action method: read_buildbot_config 15:24:37 INFO - Using buildbot properties: 15:24:37 INFO - { 15:24:37 INFO - "project": "", 15:24:37 INFO - "product": "firefox", 15:24:37 INFO - "who": "kwierso@gmail.com", 15:24:37 INFO - "installer_path": "public/build/target.tar.bz2", 15:24:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 15:24:37 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 15:24:37 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 15:24:37 INFO - "stage_platform": "linux64-stylo", 15:24:37 INFO - "basedir": "/builds/slave/test", 15:24:37 INFO - "buildnumber": 102, 15:24:37 INFO - "platform": "ubuntu64_hw_stylo", 15:24:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:24:37 INFO - "slavebuilddir": "test", 15:24:37 INFO - "taskId": "RlaqeDcPSAuAlYz8s3Sm3g", 15:24:37 INFO - "branch": "mozilla-central", 15:24:37 INFO - "script_repo_revision": "production", 15:24:37 INFO - "revision": "979f11deabd01d6cb897d064d3d9ed11ea8baa93", 15:24:37 INFO - "slavename": "talos-linux64-ix-025", 15:24:37 INFO - "repo_path": "mozilla-central" 15:24:37 INFO - } 15:24:37 INFO - Finding installer, test and symbols from parent task. 15:24:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RlaqeDcPSAuAlYz8s3Sm3g'}, attempt #1 15:24:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RlaqeDcPSAuAlYz8s3Sm3g'}, attempt #1 15:24:38 INFO - Task dependencies: aj4kEjOJSEW7bo4yDl4uBQ 15:24:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aj4kEjOJSEW7bo4yDl4uBQ'}, attempt #1 15:24:38 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/target.tar.bz2 15:24:38 INFO - Set test_url: https://queue.taskcluster.net/v1/task/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/test_packages.json 15:24:38 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/target.crashreporter-symbols.zip 15:24:38 INFO - Running post-action listener: _resource_record_post_action 15:24:38 INFO - [mozharness: 2017-05-19 22:24:38.456861Z] Finished read-buildbot-config step (success) 15:24:38 INFO - [mozharness: 2017-05-19 22:24:38.457082Z] Running download-and-extract step. 15:24:38 INFO - Running pre-action listener: _resource_record_pre_action 15:24:38 INFO - Running main action method: download_and_extract 15:24:38 INFO - mkdir: /builds/slave/test/build/tests 15:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:38 INFO - trying https://queue.taskcluster.net/v1/task/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/target.test_packages.json 15:24:38 INFO - Downloading https://queue.taskcluster.net/v1/task/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:24:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:24:39 INFO - Downloaded 986 bytes. 15:24:39 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:24:39 INFO - Using the following test package requirements: 15:24:39 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:24:39 INFO - u'common': [u'target.common.tests.zip'], 15:24:39 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:24:39 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:24:39 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:24:39 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:24:39 INFO - u'mozbase': [u'target.common.tests.zip'], 15:24:39 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:24:39 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:24:39 INFO - u'web-platform': [u'target.common.tests.zip', 15:24:39 INFO - u'target.web-platform.tests.zip'], 15:24:39 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:24:39 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:24:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/target.common.tests.zip 15:24:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:24:39 INFO - Fetch https://queue.taskcluster.net/v1/task/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/target.common.tests.zip into memory 15:24:41 INFO - Content-Length response header: 63520976 15:24:41 INFO - Bytes received: 63520976 15:24:53 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:24:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/target.common.tests.zip 15:24:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:24:53 INFO - Fetch https://queue.taskcluster.net/v1/task/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/target.common.tests.zip into memory 15:24:54 INFO - Content-Length response header: 63520976 15:24:54 INFO - Bytes received: 63520976 15:25:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/target.talos.tests.zip 15:25:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:25:07 INFO - Fetch https://queue.taskcluster.net/v1/task/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/target.talos.tests.zip into memory 15:25:07 INFO - Content-Length response header: 14410000 15:25:07 INFO - Bytes received: 14410000 15:25:08 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:25:08 INFO - trying https://queue.taskcluster.net/v1/task/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/target.tar.bz2 15:25:08 INFO - Downloading https://queue.taskcluster.net/v1/task/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:25:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:25:10 INFO - Downloaded 56521685 bytes. 15:25:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/target.tar.bz2 15:25:10 INFO - mkdir: /builds/slave/test/properties 15:25:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:25:10 INFO - Writing to file /builds/slave/test/properties/build_url 15:25:10 INFO - Contents: 15:25:10 INFO - build_url:https://queue.taskcluster.net/v1/task/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/target.tar.bz2 15:25:10 INFO - Running post-action listener: _resource_record_post_action 15:25:10 INFO - Running post-action listener: set_extra_try_arguments 15:25:10 INFO - [mozharness: 2017-05-19 22:25:10.934962Z] Finished download-and-extract step (success) 15:25:10 INFO - [mozharness: 2017-05-19 22:25:10.935188Z] Running populate-webroot step. 15:25:10 INFO - Running pre-action listener: _resource_record_pre_action 15:25:10 INFO - Running main action method: populate_webroot 15:25:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:25:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:25:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:25:10 INFO - '--tppagecycles', 15:25:10 INFO - '7'], 15:25:10 INFO - 'tests': ['tsvgm']}}, 15:25:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:25:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:25:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:25:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:25:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:25:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:25:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:25:10 INFO - 'talos_options': ['--disable-e10s'], 15:25:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:25:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:25:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:25:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:25:10 INFO - 'talos_options': ['--disable-e10s'], 15:25:10 INFO - 'tests': ['damp', 'tps']}, 15:25:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:25:10 INFO - 'tests': ['damp', 'tps']}, 15:25:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:25:10 INFO - 'tests': ['dromaeo_dom']}, 15:25:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:25:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:25:10 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 15:25:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:25:10 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:25:10 INFO - 'tests': ['ts_paint', 'tp5o']}, 15:25:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:25:10 INFO - 'tests': ['a11yr', 15:25:10 INFO - 'ts_paint', 15:25:10 INFO - 'tpaint', 15:25:10 INFO - 'sessionrestore', 15:25:10 INFO - 'sessionrestore_no_auto_restore', 15:25:10 INFO - 'tabpaint']}, 15:25:10 INFO - 'other-e10s': {'tests': ['a11yr', 15:25:10 INFO - 'ts_paint', 15:25:10 INFO - 'tpaint', 15:25:10 INFO - 'sessionrestore', 15:25:10 INFO - 'sessionrestore_no_auto_restore', 15:25:10 INFO - 'tabpaint']}, 15:25:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:25:10 INFO - 'ts_paint', 15:25:10 INFO - 'tpaint', 15:25:10 INFO - 'sessionrestore', 15:25:10 INFO - 'sessionrestore_no_auto_restore', 15:25:10 INFO - 'tabpaint']}, 15:25:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:25:10 INFO - 'ts_paint', 15:25:10 INFO - 'tpaint', 15:25:10 INFO - 'sessionrestore', 15:25:10 INFO - 'sessionrestore_no_auto_restore', 15:25:10 INFO - 'tabpaint']}, 15:25:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:25:10 INFO - 'tests': ['a11yr', 15:25:10 INFO - 'ts_paint', 15:25:10 INFO - 'tpaint', 15:25:10 INFO - 'sessionrestore', 15:25:10 INFO - 'sessionrestore_no_auto_restore', 15:25:10 INFO - 'tabpaint']}, 15:25:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:25:10 INFO - 'tests': ['a11yr', 15:25:10 INFO - 'ts_paint', 15:25:10 INFO - 'tpaint', 15:25:10 INFO - 'sessionrestore', 15:25:10 INFO - 'sessionrestore_no_auto_restore', 15:25:10 INFO - 'tabpaint']}, 15:25:10 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 15:25:10 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 15:25:10 INFO - 'bloom_basic_ref']}, 15:25:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:25:10 INFO - 'tests': ['tsvgx', 15:25:10 INFO - 'tsvgr_opacity', 15:25:10 INFO - 'tart', 15:25:10 INFO - 'tscrollx', 15:25:10 INFO - 'cart', 15:25:10 INFO - 'tsvg_static']}, 15:25:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:25:10 INFO - 'tsvgr_opacity', 15:25:10 INFO - 'tart', 15:25:10 INFO - 'tscrollx', 15:25:10 INFO - 'cart', 15:25:10 INFO - 'tsvg_static']}, 15:25:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:25:10 INFO - 'talos_options': ['--disable-e10s'], 15:25:10 INFO - 'tests': ['tp5o']}, 15:25:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:25:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:25:10 INFO - 'talos_options': ['--disable-e10s', 15:25:10 INFO - '--xperf_path', 15:25:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:25:10 INFO - 'tests': ['tp5n']}, 15:25:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:25:10 INFO - 'talos_options': ['--xperf_path', 15:25:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:25:10 INFO - 'tests': ['tp5n']}}, 15:25:10 INFO - 'talos.zip': {'path': '', 15:25:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:25:10 INFO - Running post-action listener: _resource_record_post_action 15:25:10 INFO - [mozharness: 2017-05-19 22:25:10.952858Z] Finished populate-webroot step (success) 15:25:10 INFO - [mozharness: 2017-05-19 22:25:10.952946Z] Running create-virtualenv step. 15:25:10 INFO - Running pre-action listener: _resource_record_pre_action 15:25:10 INFO - Running main action method: create_virtualenv 15:25:10 INFO - Creating virtualenv /builds/slave/test/build/venv 15:25:10 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:25:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:25:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:25:11 INFO - Using real prefix '/usr' 15:25:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:25:11 INFO - Installing distribute.............................................................................................................................................................................................done. 15:25:13 INFO - Installing pip.................done. 15:25:13 INFO - Return code: 0 15:25:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:25:13 INFO - Reading from file tmpfile_stdout 15:25:13 INFO - Output received: 15:25:13 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:25:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:25:13 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:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:13 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:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:13 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 0x113a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ad5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa7a0>, '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 0x14ab6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14abb30>, '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': '232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070', '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:25:13 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:25:13 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:25:13 INFO - Using env: {'DISPLAY': ':0', 15:25:13 INFO - 'HOME': '/home/cltbld', 15:25:13 INFO - 'LANG': 'en_US.UTF-8', 15:25:13 INFO - 'LANGUAGE': 'en_US:en', 15:25:13 INFO - 'LOGNAME': 'cltbld', 15:25:13 INFO - 'MAIL': '/var/mail/cltbld', 15:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:13 INFO - 'MOZ_NO_REMOTE': '1', 15:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:13 INFO - 'NO_EM_RESTART': '1', 15:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:13 INFO - 'PWD': '/builds/slave/test', 15:25:13 INFO - 'SHELL': '/bin/bash', 15:25:13 INFO - 'SHLVL': '1', 15:25:13 INFO - 'TERM': 'linux', 15:25:13 INFO - 'TMOUT': '86400', 15:25:13 INFO - 'USER': 'cltbld', 15:25:13 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070', 15:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:13 INFO - '_': '/tools/buildbot/bin/python'} 15:25:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:14 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:25:14 INFO - Cleaning up... 15:25:14 INFO - Return code: 0 15:25:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:25:14 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:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:14 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:25:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:14 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 0x113a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ad5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa7a0>, '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 0x14ab6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14abb30>, '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': '232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070', '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:25:14 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:25:14 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:25:14 INFO - Using env: {'DISPLAY': ':0', 15:25:14 INFO - 'HOME': '/home/cltbld', 15:25:14 INFO - 'LANG': 'en_US.UTF-8', 15:25:14 INFO - 'LANGUAGE': 'en_US:en', 15:25:14 INFO - 'LOGNAME': 'cltbld', 15:25:14 INFO - 'MAIL': '/var/mail/cltbld', 15:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:14 INFO - 'MOZ_NO_REMOTE': '1', 15:25:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:14 INFO - 'NO_EM_RESTART': '1', 15:25:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:14 INFO - 'PWD': '/builds/slave/test', 15:25:14 INFO - 'SHELL': '/bin/bash', 15:25:14 INFO - 'SHLVL': '1', 15:25:14 INFO - 'TERM': 'linux', 15:25:14 INFO - 'TMOUT': '86400', 15:25:14 INFO - 'USER': 'cltbld', 15:25:14 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070', 15:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:14 INFO - '_': '/tools/buildbot/bin/python'} 15:25:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:14 INFO - Downloading/unpacking psutil>=3.1.1 15:25:14 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:25:14 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:25:14 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:25:14 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:25:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:25:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:25:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:25:15 INFO - Installing collected packages: psutil 15:25:15 INFO - Running setup.py install for psutil 15:25:15 INFO - building 'psutil._psutil_linux' extension 15:25:15 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:25:16 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:25:16 INFO - building 'psutil._psutil_posix' extension 15:25:16 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:25:16 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:25:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:25:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:25:17 INFO - Successfully installed psutil 15:25:17 INFO - Cleaning up... 15:25:17 INFO - Return code: 0 15:25:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:25: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:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25: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:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:17 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 0x113a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ad5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa7a0>, '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 0x14ab6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14abb30>, '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': '232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070', '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:25:17 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:25:17 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:25:17 INFO - Using env: {'DISPLAY': ':0', 15:25:17 INFO - 'HOME': '/home/cltbld', 15:25:17 INFO - 'LANG': 'en_US.UTF-8', 15:25:17 INFO - 'LANGUAGE': 'en_US:en', 15:25:17 INFO - 'LOGNAME': 'cltbld', 15:25:17 INFO - 'MAIL': '/var/mail/cltbld', 15:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:17 INFO - 'MOZ_NO_REMOTE': '1', 15:25:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:17 INFO - 'NO_EM_RESTART': '1', 15:25:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:17 INFO - 'PWD': '/builds/slave/test', 15:25:17 INFO - 'SHELL': '/bin/bash', 15:25:17 INFO - 'SHLVL': '1', 15:25:17 INFO - 'TERM': 'linux', 15:25:17 INFO - 'TMOUT': '86400', 15:25:17 INFO - 'USER': 'cltbld', 15:25:17 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070', 15:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:17 INFO - '_': '/tools/buildbot/bin/python'} 15:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:25:17 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:25:17 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:25:17 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:25:17 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:25:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:25:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:25:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:25:18 INFO - Installing collected packages: mozsystemmonitor 15:25:18 INFO - Running setup.py install for mozsystemmonitor 15:25:18 INFO - Successfully installed mozsystemmonitor 15:25:18 INFO - Cleaning up... 15:25:18 INFO - Return code: 0 15:25:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:25:18 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:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:18 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:25:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:18 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 0x113a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ad5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa7a0>, '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 0x14ab6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14abb30>, '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': '232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070', '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:25:18 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:25:18 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:25:18 INFO - Using env: {'DISPLAY': ':0', 15:25:18 INFO - 'HOME': '/home/cltbld', 15:25:18 INFO - 'LANG': 'en_US.UTF-8', 15:25:18 INFO - 'LANGUAGE': 'en_US:en', 15:25:18 INFO - 'LOGNAME': 'cltbld', 15:25:18 INFO - 'MAIL': '/var/mail/cltbld', 15:25:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:18 INFO - 'MOZ_NO_REMOTE': '1', 15:25:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:18 INFO - 'NO_EM_RESTART': '1', 15:25:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:18 INFO - 'PWD': '/builds/slave/test', 15:25:18 INFO - 'SHELL': '/bin/bash', 15:25:18 INFO - 'SHLVL': '1', 15:25:18 INFO - 'TERM': 'linux', 15:25:18 INFO - 'TMOUT': '86400', 15:25:18 INFO - 'USER': 'cltbld', 15:25:18 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070', 15:25:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:18 INFO - '_': '/tools/buildbot/bin/python'} 15:25:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:18 INFO - Downloading/unpacking jsonschema==2.5.1 15:25:18 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:25:18 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:25:18 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:25:18 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:25:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:25:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:25:19 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:25:19 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:25:19 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:25:19 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:25:19 INFO - Downloading functools32-3.2.3-2.tar.gz 15:25:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:25:20 INFO - warning: no files found matching '*.txt' 15:25:20 INFO - no previously-included directories found matching 'build' 15:25:20 INFO - no previously-included directories found matching 'dist' 15:25:20 INFO - no previously-included directories found matching '.git*' 15:25:20 INFO - Installing collected packages: jsonschema, functools32 15:25:20 INFO - Running setup.py install for functools32 15:25:20 INFO - warning: no files found matching '*.txt' 15:25:20 INFO - no previously-included directories found matching 'build' 15:25:20 INFO - no previously-included directories found matching 'dist' 15:25:20 INFO - no previously-included directories found matching '.git*' 15:25:20 INFO - Successfully installed jsonschema functools32 15:25:20 INFO - Cleaning up... 15:25:20 INFO - Return code: 0 15:25:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:25:20 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:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:20 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:25:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:20 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 0x113a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ad5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa7a0>, '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 0x14ab6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14abb30>, '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': '232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070', '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:25:20 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:25:20 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:25:20 INFO - Using env: {'DISPLAY': ':0', 15:25:20 INFO - 'HOME': '/home/cltbld', 15:25:20 INFO - 'LANG': 'en_US.UTF-8', 15:25:20 INFO - 'LANGUAGE': 'en_US:en', 15:25:20 INFO - 'LOGNAME': 'cltbld', 15:25:20 INFO - 'MAIL': '/var/mail/cltbld', 15:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:20 INFO - 'MOZ_NO_REMOTE': '1', 15:25:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:20 INFO - 'NO_EM_RESTART': '1', 15:25:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:20 INFO - 'PWD': '/builds/slave/test', 15:25:20 INFO - 'SHELL': '/bin/bash', 15:25:20 INFO - 'SHLVL': '1', 15:25:20 INFO - 'TERM': 'linux', 15:25:20 INFO - 'TMOUT': '86400', 15:25:20 INFO - 'USER': 'cltbld', 15:25:20 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070', 15:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:20 INFO - '_': '/tools/buildbot/bin/python'} 15:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:25:20 INFO - Cleaning up... 15:25:20 INFO - Return code: 0 15:25:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:25:20 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:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:20 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:25:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:20 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 0x113a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ad5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa7a0>, '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 0x14ab6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14abb30>, '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': '232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070', '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:25:20 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:25:20 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:25:20 INFO - Using env: {'DISPLAY': ':0', 15:25:20 INFO - 'HOME': '/home/cltbld', 15:25:20 INFO - 'LANG': 'en_US.UTF-8', 15:25:20 INFO - 'LANGUAGE': 'en_US:en', 15:25:20 INFO - 'LOGNAME': 'cltbld', 15:25:20 INFO - 'MAIL': '/var/mail/cltbld', 15:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:20 INFO - 'MOZ_NO_REMOTE': '1', 15:25:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:20 INFO - 'NO_EM_RESTART': '1', 15:25:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:20 INFO - 'PWD': '/builds/slave/test', 15:25:20 INFO - 'SHELL': '/bin/bash', 15:25:20 INFO - 'SHLVL': '1', 15:25:20 INFO - 'TERM': 'linux', 15:25:20 INFO - 'TMOUT': '86400', 15:25:20 INFO - 'USER': 'cltbld', 15:25:20 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070', 15:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:20 INFO - '_': '/tools/buildbot/bin/python'} 15:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:20 INFO - Downloading/unpacking blobuploader==1.2.4 15:25:20 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:25:20 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:25:20 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:25:20 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:25:21 INFO - Downloading blobuploader-1.2.4.tar.gz 15:25:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:25:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:25:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:25:22 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:25:22 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:25:22 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:25:22 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:25:22 INFO - Downloading docopt-0.6.1.tar.gz 15:25:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:25:22 INFO - Installing collected packages: blobuploader, requests, docopt 15:25:22 INFO - Running setup.py install for blobuploader 15:25:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:25:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:25:22 INFO - Running setup.py install for requests 15:25:22 INFO - Running setup.py install for docopt 15:25:22 INFO - Successfully installed blobuploader requests docopt 15:25:22 INFO - Cleaning up... 15:25:22 INFO - Return code: 0 15:25:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25:22 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:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:22 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:25:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:22 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 0x113a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ad5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa7a0>, '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 0x14ab6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14abb30>, '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': '232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070', '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:25:22 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:25:22 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:25:22 INFO - Using env: {'DISPLAY': ':0', 15:25:22 INFO - 'HOME': '/home/cltbld', 15:25:22 INFO - 'LANG': 'en_US.UTF-8', 15:25:22 INFO - 'LANGUAGE': 'en_US:en', 15:25:22 INFO - 'LOGNAME': 'cltbld', 15:25:22 INFO - 'MAIL': '/var/mail/cltbld', 15:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:22 INFO - 'MOZ_NO_REMOTE': '1', 15:25:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:22 INFO - 'NO_EM_RESTART': '1', 15:25:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:22 INFO - 'PWD': '/builds/slave/test', 15:25:22 INFO - 'SHELL': '/bin/bash', 15:25:22 INFO - 'SHLVL': '1', 15:25:22 INFO - 'TERM': 'linux', 15:25:22 INFO - 'TMOUT': '86400', 15:25:22 INFO - 'USER': 'cltbld', 15:25:22 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070', 15:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:22 INFO - '_': '/tools/buildbot/bin/python'} 15:25:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:25:23 INFO - Running setup.py (path:/tmp/pip-3k5eQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:25:23 INFO - Running setup.py (path:/tmp/pip-_iUKFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:25:23 INFO - Running setup.py (path:/tmp/pip-3UKoE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:25:23 INFO - Running setup.py (path:/tmp/pip-P1Pw0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:25:23 INFO - Running setup.py (path:/tmp/pip-C79Ppj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:25:23 INFO - Running setup.py (path:/tmp/pip-v4mu2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:25:23 INFO - Running setup.py (path:/tmp/pip-iYvyhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:25:23 INFO - Running setup.py (path:/tmp/pip-ohqnQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:25:23 INFO - Running setup.py (path:/tmp/pip-EudGDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:25:23 INFO - Running setup.py (path:/tmp/pip-fSfiHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:25:23 INFO - Running setup.py (path:/tmp/pip-5MBxYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:25:23 INFO - Running setup.py (path:/tmp/pip-vYhZws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:25:24 INFO - Running setup.py (path:/tmp/pip-1iTrRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:25:24 INFO - Running setup.py (path:/tmp/pip-Pr0yf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:24 INFO - Running setup.py (path:/tmp/pip-fY_NVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:25:24 INFO - Running setup.py (path:/tmp/pip-Uw5ucr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:25:24 INFO - Running setup.py (path:/tmp/pip-ySCLPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:25:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:25:24 INFO - Running setup.py install for manifestparser 15:25:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:25:24 INFO - Running setup.py install for mozcrash 15:25:24 INFO - Running setup.py install for mozdebug 15:25:24 INFO - Running setup.py install for mozdevice 15:25:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:25:24 INFO - Running setup.py install for mozfile 15:25:24 INFO - Running setup.py install for mozhttpd 15:25:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:25:25 INFO - Running setup.py install for mozinfo 15:25:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:25:25 INFO - Running setup.py install for mozInstall 15:25:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:25:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:25:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:25:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:25:25 INFO - Running setup.py install for mozleak 15:25:25 INFO - Running setup.py install for mozlog 15:25:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:25:25 INFO - Running setup.py install for moznetwork 15:25:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:25:25 INFO - Running setup.py install for mozprocess 15:25:25 INFO - Running setup.py install for mozprofile 15:25:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:25:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:25:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:25:25 INFO - Running setup.py install for mozrunner 15:25:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:25:25 INFO - Running setup.py install for mozscreenshot 15:25:25 INFO - Running setup.py install for moztest 15:25:26 INFO - Running setup.py install for mozversion 15:25:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:25:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:25:26 INFO - Cleaning up... 15:25:26 INFO - Return code: 0 15:25:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25:26 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:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:26 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:25:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:26 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 0x113a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ad5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa7a0>, '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 0x14ab6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14abb30>, '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': '232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070', '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:25:26 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:25:26 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:25:26 INFO - Using env: {'DISPLAY': ':0', 15:25:26 INFO - 'HOME': '/home/cltbld', 15:25:26 INFO - 'LANG': 'en_US.UTF-8', 15:25:26 INFO - 'LANGUAGE': 'en_US:en', 15:25:26 INFO - 'LOGNAME': 'cltbld', 15:25:26 INFO - 'MAIL': '/var/mail/cltbld', 15:25:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:26 INFO - 'MOZ_NO_REMOTE': '1', 15:25:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:26 INFO - 'NO_EM_RESTART': '1', 15:25:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:26 INFO - 'PWD': '/builds/slave/test', 15:25:26 INFO - 'SHELL': '/bin/bash', 15:25:26 INFO - 'SHLVL': '1', 15:25:26 INFO - 'TERM': 'linux', 15:25:26 INFO - 'TMOUT': '86400', 15:25:26 INFO - 'USER': 'cltbld', 15:25:26 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070', 15:25:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:26 INFO - '_': '/tools/buildbot/bin/python'} 15:25:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:25:26 INFO - Running setup.py (path:/tmp/pip-oKCwnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:25:26 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:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:25:26 INFO - Running setup.py (path:/tmp/pip-3Kz_Sr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:25:26 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:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:25:26 INFO - Running setup.py (path:/tmp/pip-2nfaXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:25:26 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:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:25:26 INFO - Running setup.py (path:/tmp/pip-wMZ8nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:25:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:25:26 INFO - Running setup.py (path:/tmp/pip-hCT3Qj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:25:26 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:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:25:26 INFO - Running setup.py (path:/tmp/pip-0d6m56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:25:26 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:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:25:26 INFO - Running setup.py (path:/tmp/pip-CyhCzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:25:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:25:26 INFO - Running setup.py (path:/tmp/pip-TcVG1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:25:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:25:26 INFO - Running setup.py (path:/tmp/pip-iaKkMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:25:27 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:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:25:27 INFO - Running setup.py (path:/tmp/pip-fcbzZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:25:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:25:27 INFO - Running setup.py (path:/tmp/pip-iuNYuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:25:27 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:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:25:27 INFO - Running setup.py (path:/tmp/pip-KxSi2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:25:27 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:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:25:27 INFO - Running setup.py (path:/tmp/pip-XvjO59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:25:27 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:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:25:27 INFO - Running setup.py (path:/tmp/pip-tgafJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:25:27 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:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:27 INFO - Running setup.py (path:/tmp/pip-Wi2q69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:27 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:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:25:27 INFO - Running setup.py (path:/tmp/pip-VzSqsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:25:27 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:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:25:27 INFO - Running setup.py (path:/tmp/pip-6x_OSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:25:27 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:25:27 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:25:27 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:25:27 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:25:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:25:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:25:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:25:27 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:25:27 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:25:27 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:25:27 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:25:28 INFO - Downloading blessings-1.6.tar.gz 15:25:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:25:28 INFO - Installing collected packages: blessings 15:25:28 INFO - Running setup.py install for blessings 15:25:28 INFO - Successfully installed blessings 15:25:28 INFO - Cleaning up... 15:25:28 INFO - Return code: 0 15:25:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:25:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:25:29 INFO - Reading from file tmpfile_stdout 15:25:29 INFO - Current package versions: 15:25:29 INFO - argparse == 1.2.1 15:25:29 INFO - blessings == 1.6 15:25:29 INFO - blobuploader == 1.2.4 15:25:29 INFO - docopt == 0.6.1 15:25:29 INFO - functools32 == 3.2.3-2 15:25:29 INFO - jsonschema == 2.5.1 15:25:29 INFO - manifestparser == 1.1 15:25:29 INFO - mozInstall == 1.12 15:25:29 INFO - mozcrash == 1.0 15:25:29 INFO - mozdebug == 0.1 15:25:29 INFO - mozdevice == 0.50 15:25:29 INFO - mozfile == 1.2 15:25:29 INFO - mozhttpd == 0.7 15:25:29 INFO - mozinfo == 0.9 15:25:29 INFO - mozleak == 0.1 15:25:29 INFO - mozlog == 3.4 15:25:29 INFO - moznetwork == 0.27 15:25:29 INFO - mozprocess == 0.25 15:25:29 INFO - mozprofile == 0.28 15:25:29 INFO - mozrunner == 6.13 15:25:29 INFO - mozscreenshot == 0.1 15:25:29 INFO - mozsystemmonitor == 0.3 15:25:29 INFO - moztest == 0.8 15:25:29 INFO - mozversion == 1.4 15:25:29 INFO - psutil == 3.1.1 15:25:29 INFO - requests == 1.2.3 15:25:29 INFO - wsgiref == 0.1.2 15:25:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25:29 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:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:29 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:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:29 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 0x113a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ad5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa7a0>, '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 0x14ab6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14abb30>, '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': '232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070', '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:25:29 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:25:29 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:25:29 INFO - Using env: {'DISPLAY': ':0', 15:25:29 INFO - 'HOME': '/home/cltbld', 15:25:29 INFO - 'LANG': 'en_US.UTF-8', 15:25:29 INFO - 'LANGUAGE': 'en_US:en', 15:25:29 INFO - 'LOGNAME': 'cltbld', 15:25:29 INFO - 'MAIL': '/var/mail/cltbld', 15:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:29 INFO - 'MOZ_NO_REMOTE': '1', 15:25:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:29 INFO - 'NO_EM_RESTART': '1', 15:25:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:29 INFO - 'PWD': '/builds/slave/test', 15:25:29 INFO - 'SHELL': '/bin/bash', 15:25:29 INFO - 'SHLVL': '1', 15:25:29 INFO - 'TERM': 'linux', 15:25:29 INFO - 'TMOUT': '86400', 15:25:29 INFO - 'USER': 'cltbld', 15:25:29 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070', 15:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:29 INFO - '_': '/tools/buildbot/bin/python'} 15:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:29 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:25:29 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:25:29 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:25:29 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:25:29 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:25:29 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:25:29 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:25:29 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:25:29 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:25:29 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:25:29 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:25:29 INFO - Cleaning up... 15:25:29 INFO - Return code: 0 15:25:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:25:29 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:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:29 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:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:29 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 0x113a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ad5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14aa7a0>, '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 0x14ab6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14abb30>, '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': '232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070', '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:25:29 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:25:29 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:25:29 INFO - Using env: {'DISPLAY': ':0', 15:25:29 INFO - 'HOME': '/home/cltbld', 15:25:29 INFO - 'LANG': 'en_US.UTF-8', 15:25:29 INFO - 'LANGUAGE': 'en_US:en', 15:25:29 INFO - 'LOGNAME': 'cltbld', 15:25:29 INFO - 'MAIL': '/var/mail/cltbld', 15:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:29 INFO - 'MOZ_NO_REMOTE': '1', 15:25:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:29 INFO - 'NO_EM_RESTART': '1', 15:25:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:29 INFO - 'PWD': '/builds/slave/test', 15:25:29 INFO - 'SHELL': '/bin/bash', 15:25:29 INFO - 'SHLVL': '1', 15:25:29 INFO - 'TERM': 'linux', 15:25:29 INFO - 'TMOUT': '86400', 15:25:29 INFO - 'USER': 'cltbld', 15:25:29 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070', 15:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:29 INFO - '_': '/tools/buildbot/bin/python'} 15:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:25:29 INFO - Cleaning up... 15:25:29 INFO - Return code: 0 15:25:29 INFO - Running post-action listener: _resource_record_post_action 15:25:29 INFO - Running post-action listener: _start_resource_monitoring 15:25:29 INFO - Starting resource monitoring. 15:25:29 INFO - [mozharness: 2017-05-19 22:25:29.666394Z] Finished create-virtualenv step (success) 15:25:29 INFO - [mozharness: 2017-05-19 22:25:29.667335Z] Running install step. 15:25:29 INFO - Running pre-action listener: _resource_record_pre_action 15:25:29 INFO - Running main action method: install 15:25:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:25:29 INFO - Reading from file tmpfile_stdout 15:25:29 INFO - Detecting whether we're running mozinstall >=1.0... 15:25:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:25:29 INFO - Reading from file tmpfile_stdout 15:25:29 INFO - Output received: 15:25:29 INFO - Usage: mozinstall [options] installer 15:25:29 INFO - Options: 15:25:29 INFO - -h, --help show this help message and exit 15:25:29 INFO - -d DEST, --destination=DEST 15:25:29 INFO - Directory to install application into. [default: 15:25:29 INFO - "/builds/slave/test"] 15:25:29 INFO - --app=APP Application being installed. [default: firefox] 15:25:29 INFO - mkdir: /builds/slave/test/build/application 15:25:29 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:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:25:46 INFO - Reading from file tmpfile_stdout 15:25:46 INFO - Output received: 15:25:46 INFO - /builds/slave/test/build/application/firefox/firefox 15:25:46 INFO - Running post-action listener: _resource_record_post_action 15:25:46 INFO - [mozharness: 2017-05-19 22:25:46.084707Z] Finished install step (success) 15:25:46 INFO - [mozharness: 2017-05-19 22:25:46.084971Z] Running run-tests step. 15:25:46 INFO - Running pre-action listener: _resource_record_pre_action 15:25:46 INFO - Running main action method: run_tests 15:25:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:25:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:25:46 INFO - Python 2.7.3 15:25:46 INFO - Return code: 0 15:25:46 INFO - grabbing minidump binary from tooltool 15:25:46 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:25:46 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 0x14aa7a0>, '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 0x14ab6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14abb30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:25:46 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:25:46 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:25:46 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:25:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:25:46 INFO - Return code: 0 15:25:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:25:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:25:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:25:46 INFO - ENV: RUST_BACKTRACE is now 1 15:25:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:25:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:25:46 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/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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:25:46 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/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-025 --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:25:46 INFO - Using env: {'DISPLAY': ':0', 15:25:46 INFO - 'HOME': '/home/cltbld', 15:25:46 INFO - 'LANG': 'en_US.UTF-8', 15:25:46 INFO - 'LANGUAGE': 'en_US:en', 15:25:46 INFO - 'LOGNAME': 'cltbld', 15:25:46 INFO - 'MAIL': '/var/mail/cltbld', 15:25:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:25:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:46 INFO - 'MOZ_NO_REMOTE': '1', 15:25:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:25:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:46 INFO - 'NO_EM_RESTART': '1', 15:25:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:46 INFO - 'PWD': '/builds/slave/test', 15:25:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:25:46 INFO - 'RUST_BACKTRACE': '1', 15:25:46 INFO - 'SHELL': '/bin/bash', 15:25:46 INFO - 'SHLVL': '1', 15:25:46 INFO - 'TERM': 'linux', 15:25:46 INFO - 'TMOUT': '86400', 15:25:46 INFO - 'USER': 'cltbld', 15:25:46 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070', 15:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:46 INFO - '_': '/tools/buildbot/bin/python'} 15:25:46 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/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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:25:46 INFO - mozversion application_buildid: 20170519214727 15:25:46 INFO - mozversion application_changeset: 979f11deabd01d6cb897d064d3d9ed11ea8baa93 15:25:46 INFO - mozversion application_display_name: Nightly 15:25:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:25:46 INFO - mozversion application_name: Firefox 15:25:46 INFO - mozversion application_remotingname: firefox 15:25:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:25:46 INFO - mozversion application_vendor: Mozilla 15:25:46 INFO - mozversion application_version: 55.0a1 15:25:46 INFO - mozversion platform_buildid: 20170519214727 15:25:46 INFO - mozversion platform_changeset: 979f11deabd01d6cb897d064d3d9ed11ea8baa93 15:25:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:25:46 INFO - mozversion platform_version: 55.0a1 15:25:46 INFO - using testdate: 1495232746 15:25:46 INFO - actual date: 1495232746 15:25:46 INFO - starting webserver on 'localhost:43390' 15:25:46 INFO - SUITE-START | Running 2 tests 15:25:46 INFO - TEST-START | dromaeo_css 15:25:46 INFO - operating with platform_type : linux_ 15:25:46 INFO - Initialising browser for dromaeo_css test... 15:25:46 INFO - TEST-INFO | started process 3376 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphQdQJs/profile http://localhost:43390/getInfo.html) 15:25:47 INFO - PID 3376 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2963: String.localeCompare is deprecated; use String.prototype.localeCompare instead 15:25:53 INFO - PID 3376 | __metrics Screen width/height:1600/1200 15:25:53 INFO - PID 3376 | colorDepth:24 15:25:53 INFO - PID 3376 | Browser inner width/height: 1024/695 15:25:53 INFO - PID 3376 | __metrics 15:25:55 INFO - TEST-INFO | 3376: exit 0 15:25:55 INFO - Browser initialized. 15:25:55 INFO - Running cycle 1/1 for dromaeo_css test... 15:25:55 INFO - TEST-INFO | started process 3558 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphQdQJs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:26:06 INFO - PID 3558 | RSS: Main: 169676800 15:26:06 INFO - PID 3558 | 15:29:12 INFO - PID 3558 | Cycle 1(1): loaded http://localhost:43390/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43390/tests/dromaeo/cssquery-ext.html) 15:29:13 INFO - PID 3558 | RSS: Main: 175558656 15:29:13 INFO - PID 3558 | 15:32:15 INFO - PID 3558 | Cycle 1(1): loaded http://localhost:43390/tests/dromaeo/cssquery-ext.html (next: http://localhost:43390/tests/dromaeo/cssquery-jquery.html) 15:32:16 INFO - PID 3558 | RSS: Main: 171552768 15:32:16 INFO - PID 3558 | 15:35:18 INFO - PID 3558 | Cycle 1(1): loaded http://localhost:43390/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43390/tests/dromaeo/cssquery-mootools.html) 15:35:18 INFO - PID 3558 | RSS: Main: 174571520 15:35:18 INFO - PID 3558 | 15:38:20 INFO - PID 3558 | Cycle 1(1): loaded http://localhost:43390/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43390/tests/dromaeo/cssquery-prototype.html) 15:38:21 INFO - PID 3558 | RSS: Main: 172552192 15:38:21 INFO - PID 3558 | 15:41:24 INFO - PID 3558 | Cycle 1(1): loaded http://localhost:43390/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43390/tests/dromaeo/cssquery-yui.html) 15:41:24 INFO - PID 3558 | RSS: Main: 172638208 15:41:24 INFO - PID 3558 | 15:44:26 INFO - PID 3558 | Cycle 1(1): loaded http://localhost:43390/tests/dromaeo/cssquery-yui.html (next: http://localhost:43390/tests/dromaeo/cssquery-dojo.html) 15:44:26 INFO - PID 3558 | RSS: Main: 178323456 15:44:26 INFO - PID 3558 | 15:44:26 INFO - PID 3558 | __start_tp_report 15:44:26 INFO - PID 3558 | _x_x_mozilla_page_load 15:44:26 INFO - PID 3558 | _x_x_mozilla_page_load_details 15:44:26 INFO - PID 3558 | |i|pagename|runs| 15:44:26 INFO - PID 3558 | |0;dojo.html;2712.6066720325553;2726.5501192303273;2763.6269103670998;2771.2240572639657;2794.077954275089;5269.314989051418;5330.573554115671;5372.328458942632;5393.811216607414;5421.756020979055;5329.893402131955;5357.249985002103;5365.114756065244;5397.649152805065;5426.67439953603;4679.953200468003;4704.317873908281;4742.478327383985;4757.785899634508;4799.400074990626;4749.548792864673;4750.287456881478;4844.5882100021545;4872.585830204437;4919.877003074916;4687.179743544866;4790.688605240648;4839.7338146401935;4855.56299933006;4869.147899117658;4748.810047598092;4749.905001899942;4799.992001679651;4801.73590452525;4816.879578010543;4669.112868554964;4755.239161734141;4762.714237145782;4782.234842425195;4815.253635686474;5329.866753331159;5334.306540149794;5359.303290572239;5365.114756065244;5373.113436283009;5654.264945557093;5724.055530837407;5763.279590051244;5826;5831.008728516163;5877.794277200277;5904.940950590482;5908.97045514774;5924.496417804492;5949.9107513387335;5470.343558772973;5478.808241711521;5488.615796894259;5494.066008778517;5497.312835895513;5860.033094539439;5935.52515798735;5954.940450595525;5955.404459554096;6048.123022161762;5692.260006199251;5698.3162020556965;5705.372409035002;5705.800296989585;5706.144078388275;5771.480566749013;5785.595008349375;5794.478496935296;5847.44449277318;5860.794872179454;5733.283339582552;5785.8553536161935;5800.39095894925;5800.8259752207505;5806.506446952057;5771.769129234867;5787.797427090031;5806.187133801272;5809.82570522885;5820.185174075633;4781.9043619128115;4841.661083724176;4861.052094841542;4896.975515122402;4905.190643543775;4205.158968206371;4225.471816022997;4264.850730224427;4269.893252668709;4276.358546218092;4851.975740121276;4861;4861.0277944411255;4876.317315575822;4914;5765.308163020464;5798.6810725410505;5814.680192589448;5816.970915145482;5820.650760954356;4792.496787837296;4839.080574690797;4864.464908860023;4882.804687812519;4891.33966914462;5177.58579313654;5187.662801917863;5192.299039629677;5197.558207552324;5222.817201398009;5429.972850135724;5430.70131142791;5434.456554344534;5437.997271541481;5494.066008778437;5680.6591604503865;5787.884242315215;5793.044147715748;5793.681347525927;5869.8239052828485;5350.9732451337495;5374.785008599612;5430.782768689366;5435.211894275387;5443.7822487100075;5767.134929760569;5776.249087618583;5776.277965254343;5780.901628690535;5823.213866128019;5762.30852297727;5861.9706901465215;5872.29532456108;5877.206577112035;5888;5447.536959358499;5539;5648.745806438638;5686.4029276926985;5686.971565142313;5592;5592.245046918614;5654.038813401649;5672.744726487401;5675.716214189357;5466.863328416822;5502.0371434997915;5530.7511161997;5541.3904470507405;5542.972285138549;5552.194931734956;5669.064604340238;5673.06394444912;5675.858103547444;5677.8864422710485;5387.86530336729;5439.102548079522;5452;5466.8906621866545;5479.780808767764 15:44:26 INFO - PID 3558 | |1;ext.html;622.9719662615182;668.15144766147;691.3017851969511;1129.5989923577135;1173.9823902641456;32616.510752338705;33992.32015359694;34058.48912266315;34084.48873266903;34161;31709.841450792715;31960.200994975137;32017.519737203904;32053.67946320536;32108.518372224436;6416.005519144528;6504.967475162617;6728;6918.0314755934205;6919.757808476705;6715.731370745164;6749.527533072687;6772.695228714695;6797.830054248659;6808.046873437723;6707.02748101525;6853.657317134148;6853.828654283658;6876.793696189123;6886.793396198122;6781.152355955505;6802.795916122524;6809.5233333666665;6819.829504262409;6846.554973926729;6839.350261725128;6868.7252509900045;6889.655517224119;6895.310468953115;6898.862022759517;31260.218494537592;31307.06078817639;31590.526142107658;31720.682793172004;31739.52390714141;3032.2267821705545;3042.087373787877;3044.9695503045127;3068.1562570293127;3070.8925187618324;24445.533268003976;24455.755442445527;24486.87756561206;24502.387440313956;24511.264662060166;2928.3996780659913;2985.596944412498;3004;3009.8043627164166;3010.668826429113;145069.2746536271;145333.27333363265;145946;152627;158172;38685.80657096753;39103;39136.608633913296;39153;39224.411633824944;40096.39855402171;40223.396649050286;40227.79886100551;42661.36007959883;43748.3437748434;12754.553590624284;12874.16317939331;12875.356232188353;12901.225926444444;12902.935485322514;10138.188944884392;10208.285420020527;10262.58949642006;10276.691699249035;10302.124319432782;12479;12562.623121306375;12622.412405457042;12680.619581412573;12749.745005099847;5224.320838291073;5298;5343.946560534423;5351.705656188947;5426.267453893753;855.5422848775875;885.1856292211181;888.9644414223488;903.4443817052465;914.6981496106268;20238;23940;25541;25880.741192588208;25913.740862591134;974.6686126716809;976.2434113562047;980.1864452504404;993.1955116355775;995.0447570332417;11127;11556.711082222844;11621.24461909973;11677.124215683858;11781.057515398748;164209;167376;168019;168292;180312;44190.558094419284;44841.55158448439;44842.551574483834;44858.55141448609;44880;1243.0863315463127;1254.4982007197011;1257.4844313831468;1267.0876968582606;1270.12361470585;24539.14113006036;24716.876415617808;25782.871085644452;25973.740262597134;25984.610230846174;29979.400411991202;30203.848980754956;30212.546811798282;30234.697653023188;30260.54609180908;162229.18885405498;162665.18667406586;162710.186449067;162755;162835;28472.715272847006;28684.42631147407;28742.281442963256;28929;28967.420651586428;35314.646853531136;35615.46576801298;35690.821545892104;35861.64138358583;35928.4610730834;25566;26994.32514187161;27200.591991120546;27273.454530908875;27727.029553965513;26346;27184.72815271822;27671.169864904085;27779.583306250017;28332.291692707848;30618.234544136576;30618.540721888745;30652.386952261277;30705.078847634606;30799.2300192497;26111.608325875506;26318.60522092132;26416.603750944134;26952.32619184536;27663.056725981092;20968.161273549496;21681.241156559445;21761.34715958524;21965.121395144015;22129.33611991643 15:44:26 INFO - PID 3558 | |2;jquery.html;410.39876580809107;415.2919272640149;424.33803266903624;428.9978550107249;437.70892356582874;14122.364493597786;16954.745678814827;17634.559136021606;17643.73534396985;17739.55651108723;17810.109494525288;18161.273549058056;18173;18225.270989160417;18277.634447311048;5328.8401347959625;5356.758945847427;5477;5551;5599.272094627693;5425.13197888338;5508.531774799147;5518.696471694056;5529.866377392625;5542.279503664538;5234.581233501311;5410.8917821643545;5441.619086663935;5471.562275017989;5484.506394424501;5458;5467.863303417406;5468.26178465908;5485.533729632966;5491.313585801775;4748.762561871893;4878.438979517366;4899.412070551521;4902.338184345103;4974.477679843637;21144.471388215265;21309.573808523743;21439.35681929529;21733.13067477299;21806.89096554507;1600;1648.6949914265779;1663.9084850333227;1673.1968655045525;1675.790526184227;13845.30773461333;14246;14618.415263389452;14631.41474341025;14674.266286685623;2028.655128628122;2055.1882006607457;2078.625847347477;2085.728855248823;2142.4001279641725;87934;90836.5458172705;91166.08833911708;91532;91831.54084229536;10484.842727358942;10510.4774854036;10586.57653693859;10678.369354419534;10818;14697.412103515953;14772.926135369255;14793.408263669548;14827.555173344817;14862.554123376316;7591.772246832604;7676.846463070819;7714.845703085907;7822.335101516321;7856.921430785734;7145.499815013003;7174.92825071753;7259.317740057633;7348.559086454829;7374.631268436557;6802.727890884309;6920.9653951729915;6921.8961715574305;6927.653617319113;6999.12510936133;2051.5281485258474;2063.546019875625;2074.346580827035;2103.1692481469736;2178.7712290209615;842.0611018714089;864.2783275964514;865.5801936061006;894.3650008493912;894.7360528644066;16336.101514416583;16432;16440.260188291555;16496.6700665986;17067;842.2882664148784;856.1652388920877;864.8875646165958;865.1348651348651;889.0220757167065;8862.911370886337;9049;9060.909390906007;9263.953680231556;9325.580348884316;391996;393993;397026;397640;399549;70294.89115326549;71545.64227178831;71711.2828871715;74111.62944185245;74341;1024.8770147582188;1045.9372437653612;1072.056590200634;1109.1681239070697;1112.5772206561455;16626.16869156513;17019.48941531756;17377.565560860574;17732.91133544324;17953.743237973216;38277.61722382852;39417.40873886837;40270.39594406028;40632.79683601563;40799.59200407958;48345.09929404247;48540.7572962147;48559;48591.757041214565;50537;7771.650275737492;7777.222277772177;8022.117567067501;8044.3564514839845;8337.499750014777;12405.193662411913;12630.179038362478;12690.619281421203;12923.676908077374;13221.405036773176;10962.890371096188;10972.286801357886;10998.725031874266;11341.546338146381;11463.337816016465;9950.35322704022;10089.09198172168;10102.79794404093;10184.236182286506;10505.422201778976;10195.286329956833;10683.94658026705;10835.891641083803;10961.232713709964;10970.506327215455;8189.836203275782;8320.292775114183;8329.791755206168;8424.83150337002;8555.230029297392;9643.421394716339;10204.38773673582;10216.233782466494;10256.43589602579;10369.118624916966 15:44:26 INFO - PID 3558 | |3;mootools.html;1210.667066556697;1248.0577164240997;1261;1262.9873701262984;1276.4128500889587;9767.120959113687;10172.694819155418;10188.796224075524;10353.534090965906;10596.31123976943;10427.68716938493;10629.096526795232;10635.893641063587;10642.201834862377;10646.62736804212;2216.1689366487567;2263.864168149908;2272.227442669492;2273.8067264282554;2274.3404412720292;2168.8698678079368;2208.315422219109;2225.020990764067;2231.542533780579;2245.921392751254;2215.3575463115676;2232.430730163806;2264.3320220534983;2267.965980510294;2271.318604418676;2121.8939053047284;2134.8505604607685;2184.923527676524;2187.0704950396016;2187.0814258011674;1877.7089551119461;1944.0862794486568;2115.259659119296;2120.4486833423266;2138.347803919804;10128.848067278997;10147.934466881019;10182.28723989321;10201.693949181536;10234.846477302846;5607.831765047055;5784.132380143013;5800.0429929062075;5804.912926306109;5820.097884827858;3269.304159776109;3309.8014119152926;3340.1816554943953;3450.896473105811;3452.7583069185166;1059.819830628795;1084.2406076535237;1086.0659832544006;1138.55027264231;1162.5698491558094;14978.775318370233;15047.398104075824;15186.544403667907;15201.543953681406;15220.923895380563;4543.728135932034;4643.396358473445;4910.337104490848;4940.357753492023;5014.197728363444;10658.73353166177;10690.679279621623;10702.143828493701;10713.732156696145;10742.73143171427;5623.10030395143;5624.91562626561;5625.803096891589;5637.943620563824;5642.746076426571;5025.170846810235;5114.795408183705;5119.129747942859;5187.170052791535;5252.238425428368;3756.8309426075893;3833.8274777635074;3874.024247633727;3915.9021024474046;3925.1364699766004;1082.6806092202662;1087.9401632910108;1088.7441451258949;1095.7041598768287;1099.6481126039591;655.2006552006544;680.5440354962187;687.6905392573362;702.6170736948376;710.4742490557054;5158.329417175818;5169.844904652867;5223.13818219997;5401.972990135024;5404.189371594213;546.4890327543759;547.0781732780199;556.476911703006;558.6703844731628;558.9301337332834;3324.16895776056;3606.621304762962;3620.7827530348263;3621.94567081494;3736.2527494500664;12781.872181278255;13569.728605427836;13585.932070339584;13600.93199533996;13624.455021799215;12009.219400738924;13373.46506139763;13443.663908402172;13443.663908402368;13481.59555213345;7220.530665506725;7472.589007604743;7509.586972716444;7516.849663006818;7579.431542634215;5611.466910643482;5652;5692.402297758841;5712.34308054579;5896.9115463268945;11655.766884662089;11781.234219775688;11821.468033938321;11866.228695134789;11960.282383057045;11750.353730544903;12222.816657750318;12237.143399961917;12403.75192496163;12416.379181040731;8100.311473524816;8258.710945116893;8264.628091736007;8359.456635318686;8386.11945745688;9555.18780903631;9595.28035397362;9613.134817866425;9741.269404794528;9753.658621948482;8062.637181326972;8063.233992770677;8065.153158918229;8112.188781122077;8332.250097491255;8123.75628731139;8163.428560000743;8240.793980150544;8273.296769774637;8294.958525207578;7163.641817909188;7283.7450689225625;7402.4448166386655;7436.0333156689285;7445.143808462096;4870.977094809988;4951.232558953368;5013.623978201723;5030.698158110525;5096.286519887145;5010.899782004412;5038;5101.719405432588;5125.769340379767;5187.144121219956 15:44:26 INFO - PID 3558 | |4;prototype.html;372.72604635592836;383.91553858151207;393.8188433320672;394.67439362525926;398.18968399307414;5499;5626.240457538226;5644.915326270104;5675.460831221033;5689.431056894308;5448.37343705473;5483.287172667558;5487.670739755617;5488.17677348398;5530.198121272413;4137.379393091031;4145.709800313979;4145.834166633339;4159.003678234434;4170.874873753793;4102.958970410303;4148.875533733993;4162.687798415116;4176.1230141670285;4187.916241675165;4072.328065869128;4075.6535694466006;4081.5918408159096;4097.405876147956;4101.425800387948;4094.365373367118;4100.261952848486;4123.36087906375;4125.731827431207;4132.669386449107;3536.975895539071;3593.4969104325414;3601.6398360164035;3610.765300255475;3611.8916432507067;5338.199270109515;5342.839714808562;5347.064263753828;5361.919571206435;5435.266239057716;4819.807207711688;4841.031793641286;4842.394700662418;4845.85462436124;4864.270359446076;5697.6011679182475;5856.385079566627;5867.882642347129;5886.882262354772;5897.675627840467;3999.240144372589;4021.155557332964;4029.959700402988;4038.7980600969836;4056.5132184137797;6064.4541991221;6152.200213972155;6207.534434917399;6227.688615569204;6269.404406581368;4108.876733697994;4130.141436353653;4131.834726610902;4143.08852052548;4148.502179738391;4188.005576013165;4189.539150693421;4194.832206711759;4197.958020419818;4219.1139860629;4750.358701575312;4837.830675926396;4869.829555965524;4879.39007624047;4891.633127515451;5886.175935369051;5892.823215303548;5898.217050392083;5909.2908850938165;5911.822645320647;1441.502681574855;1455.7670772676322;1456.3592019511593;1457.0893191755154;1458.9197594132424;937.9343445958717;962.8796400449944;963.2197919684937;970.3983530211315;970.4807927758616;4961.826336078292;4970.304157417964;4975.950240497621;4976.009596161564;4988.72562009093;6002.429769172009;6030.185924900083;6039.097684229454;6058.575899687068;6071.150038994544;4932.013597280558;4958.181899986534;4991.151504244287;5015.072211640785;5055.368078990126;3184.8726050958167;3222.6616205298574;3239.1902024493875;3241.6596257393107;3253.8698452062126;5485.424030476823;5569.498745112878;5613.129964855454;5631.521320687705;5646.378898321182;6192.938070619236;6224.688765561704;6245.937540624626;6248.843778905472;6252.874942501216;5617.606767526398;5621.747021384048;5626.071698169838;5648.74580643872;5665.66006039639;5823.049278491752;6074.848128796815;6087.665178415053;6148.9692551536955;6164.630122192682;5882.323532793784;6028.336882942785;6072.908906366496;6085.087236914498;6098.298695650057;5582.665040097607;5663.150527420919;5670;5695.117256825199;5713.657180569179;4099.159672267118;4144.088300573869;4151.626353628188;4156.542780294226;4169.91660166801;6046.1535385045245;6179.721912514037;6212.875742485216;6216.347283535164;6226.159468471698;5908.763649453974;5932.080527518242;5939.376365481735;5942.286925568959;5952.970235148797;5807.738651760596;5929.377415371324;5938.168656388023;5942.821715348547;5953.28560572734;5795.420457954171;5827.970860145672;5850.151727999331;5863.413658634103;5870.589058766016;5957.970210149095;5971.581989260884;5979.820605381846;5985.802839432044;6023.728932198149;5611.270534830446;5722.62802917809;5776.393478684678;5780.826575202751;5819.738111784895 15:44:26 INFO - PID 3558 | |5;yui.html;710.5949608723023;731.1664702239447;744.5049042386813;749.8875168724692;753.1038064703004;13314.667133321671;13950.651233719149;14029.859701402997;16108.59728506785;16362.263698133584;15118;15209.619759506018;15298.158601276953;15392.923035384807;16439.83560164398;871.5555066915871;913.5204017890594;918.8943271523793;920.8250432417852;923.2660035271941;910.9180173784358;913.3423934766957;913.5888850017485;914.7438717159206;917.1928702741578;960.3997501561524;964.161179773598;964.3972517176765;964.9710508684751;967.5791030901545;940.4592359393342;941.9952900235523;944.9055094490599;950.4772375193651;954.0030667952007;694.8992396102587;695.7530076822757;696.8014115976922;698.2040473859804;701.6596950479013;13534.323283835769;13714.588562343146;14994.850051499454;15113.697726045528;15128.924355378263;15823.841761582353;15852.682946341123;16341.836581634268;16356.591085222846;16509.422170223985;11745.765084698343;11789.528418863236;11806.409679516075;11855.881441185651;11961.282323060645;2944.7791415643696;2956.6895475975143;2959.8224106553675;2966.1842993176833;2972.539256415259;69984.6500767498;70283;70809;71642.2835771646;74195.25804741938;12472.376381181086;12559.623211303493;12779.105462617528;12790.488380464863;12821.871781282254;21804.672929906064;22606.704726101987;22638.773612263667;22856;22974.885125574267;6102.481289090389;6130.601510901777;6203.906941395882;6220.03589443637;6240.126382306481;2910.2869796899895;2975.1669532530927;2982.0904624089426;2987.3726517431146;2992.311768293305;3670.825335892542;3699.6300369962787;3713.6843368313994;3752.399616061417;3761.8307176177136;673.6564352180326;675.3044364304774;676.1075380497696;684.6576711644178;684.9657517124124;527.3645257464746;546.529984213576;552.1138572591013;552.5883217003358;553.1619596311591;8551.273141782895;8662.653493860302;8731.56342182901;8880.51157186361;8949.955250223707;545.8744488767605;547.2748608094291;558.2672816562902;561.5900392713261;576.4869266352949;4008.939865902014;4158.334666453353;4206.221848957892;4273.7008409411665;4357.082883531236;55893;56430.717846411324;57272.42727572754;59465;60127.69936150291;49420.75289623601;49672.50327496751;49854.50145498499;50069;51805.7409712949;46088.308675369895;47005;47563.578916845785;48864;49076.26385604219;9180.17378435944;9500.239980801658;9507.239420846177;9532.809343813224;9792.118709316195;24860.37849053788;24961.87519062393;25080.122195723063;25378.238652840446;26460.603090953267;40175.79912100421;43053.78473107614;43497.56502434935;43731.78134109309;43796.34305485357;13580.660483487993;13780.242086685328;13870.65323366924;14027.228502432465;14240.430382784572;15016.549503514912;15036.849631503545;15248.085114893142;15262.23688815577;15599;12373.690657733629;12520.248785072925;12613.621591352274;12693.42879570403;12883.677908052;13456;13569.118007329493;13580.117292375964;13712.451501939811;13994.230317332238;11971.940140299243;11991.76016479683;12084.335361555199;12109.757804843677;12274.202176858476;9400.012998635319;9426.95286523563;9733.270004749813;9735.1725103367;10067.194624429882;9625.56684949193;9742.853857192005;9856.21150307988;9870.605175792887;10109.64616238428 15:44:26 INFO - PID 3558 | __end_tp_report 15:44:26 INFO - PID 3558 | __start_cc_report 15:44:26 INFO - PID 3558 | _x_x_mozilla_cycle_collect,289 15:44:26 INFO - PID 3558 | __end_cc_report 15:44:26 INFO - PID 3558 | __startTimestamp1495233866967__endTimestamp 15:44:26 INFO - PID 3558 | 15:44:26 INFO - PID 3558 | ------- Summary: start ------- 15:44:26 INFO - PID 3558 | Number of tests: 6 15:44:26 INFO - PID 3558 | 15:44:26 INFO - PID 3558 | [#0] dojo.html Cycles:165 Average:5300.49 Median:5452.00 stddev:629.59 (11.5%) stddev-sans-first:597.90 15:44:26 INFO - PID 3558 | Values: 2712.6 2726.6 2763.6 2771.2 2794.1 5269.3 5330.6 5372.3 5393.8 5421.8 5329.9 5357.2 5365.1 5397.6 5426.7 4680.0 4704.3 4742.5 4757.8 4799.4 4749.5 4750.3 4844.6 4872.6 4919.9 4687.2 4790.7 4839.7 4855.6 4869.1 4748.8 4749.9 4800.0 4801.7 4816.9 4669.1 4755.2 4762.7 4782.2 4815.3 5329.9 5334.3 5359.3 5365.1 5373.1 5654.3 5724.1 5763.3 5826.0 5831.0 5877.8 5904.9 5909.0 5924.5 5949.9 5470.3 5478.8 5488.6 5494.1 5497.3 5860.0 5935.5 5954.9 5955.4 6048.1 5692.3 5698.3 5705.4 5705.8 5706.1 5771.5 5785.6 5794.5 5847.4 5860.8 5733.3 5785.9 5800.4 5800.8 5806.5 5771.8 5787.8 5806.2 5809.8 5820.2 4781.9 4841.7 4861.1 4897.0 4905.2 4205.2 4225.5 4264.9 4269.9 4276.4 4852.0 4861.0 4861.0 4876.3 4914.0 5765.3 5798.7 5814.7 5817.0 5820.7 4792.5 4839.1 4864.5 4882.8 4891.3 5177.6 5187.7 5192.3 5197.6 5222.8 5430.0 5430.7 5434.5 5438.0 5494.1 5680.7 5787.9 5793.0 5793.7 5869.8 5351.0 5374.8 5430.8 5435.2 5443.8 5767.1 5776.2 5776.3 5780.9 5823.2 5762.3 5862.0 5872.3 5877.2 5888.0 5447.5 5539.0 5648.7 5686.4 5687.0 5592.0 5592.2 5654.0 5672.7 5675.7 5466.9 5502.0 5530.8 5541.4 5543.0 5552.2 5669.1 5673.1 5675.9 5677.9 5387.9 5439.1 5452.0 5466.9 5479.8 15:44:26 INFO - PID 3558 | 15:44:26 INFO - PID 3558 | [#1] ext.html Cycles:180 Average:30640.84 Median:30247.62 stddev:41453.77 (137.0%) stddev-sans-first:41508.78 15:44:26 INFO - PID 3558 | Values: 623.0 668.2 691.3 1129.6 1174.0 32616.5 33992.3 34058.5 34084.5 34161.0 31709.8 31960.2 32017.5 32053.7 32108.5 6416.0 6505.0 6728.0 6918.0 6919.8 6715.7 6749.5 6772.7 6797.8 6808.0 6707.0 6853.7 6853.8 6876.8 6886.8 6781.2 6802.8 6809.5 6819.8 6846.6 6839.4 6868.7 6889.7 6895.3 6898.9 31260.2 31307.1 31590.5 31720.7 31739.5 3032.2 3042.1 3045.0 3068.2 3070.9 24445.5 24455.8 24486.9 24502.4 24511.3 2928.4 2985.6 3004.0 3009.8 3010.7 145069.3 145333.3 145946.0 152627.0 158172.0 38685.8 39103.0 39136.6 39153.0 39224.4 40096.4 40223.4 40227.8 42661.4 43748.3 12754.6 12874.2 12875.4 12901.2 12902.9 10138.2 10208.3 10262.6 10276.7 10302.1 12479.0 12562.6 12622.4 12680.6 12749.7 5224.3 5298.0 5343.9 5351.7 5426.3 855.5 885.2 889.0 903.4 914.7 20238.0 23940.0 25541.0 25880.7 25913.7 974.7 976.2 980.2 993.2 995.0 11127.0 11556.7 11621.2 11677.1 11781.1 164209.0 167376.0 168019.0 168292.0 180312.0 44190.6 44841.6 44842.6 44858.6 44880.0 1243.1 1254.5 1257.5 1267.1 1270.1 24539.1 24716.9 25782.9 25973.7 25984.6 29979.4 30203.8 30212.5 30234.7 30260.5 162229.2 162665.2 162710.2 162755.0 162835.0 28472.7 28684.4 28742.3 28929.0 28967.4 35314.6 35615.5 35690.8 35861.6 35928.5 25566.0 26994.3 27200.6 27273.5 27727.0 26346.0 27184.7 27671.2 27779.6 28332.3 30618.2 30618.5 30652.4 30705.1 30799.2 26111.6 26318.6 26416.6 26952.3 27663.1 20968.2 21681.2 21761.3 21965.1 22129.3 15:44:26 INFO - PID 3558 | 15:44:26 INFO - PID 3558 | [#2] jquery.html Cycles:180 Average:25448.75 Median:40451.60 stddev:65656.08 (162.3%) stddev-sans-first:65813.35 15:44:26 INFO - PID 3558 | Values: 410.4 415.3 424.3 429.0 437.7 14122.4 16954.7 17634.6 17643.7 17739.6 17810.1 18161.3 18173.0 18225.3 18277.6 5328.8 5356.8 5477.0 5551.0 5599.3 5425.1 5508.5 5518.7 5529.9 5542.3 5234.6 5410.9 5441.6 5471.6 5484.5 5458.0 5467.9 5468.3 5485.5 5491.3 4748.8 4878.4 4899.4 4902.3 4974.5 21144.5 21309.6 21439.4 21733.1 21806.9 1600.0 1648.7 1663.9 1673.2 1675.8 13845.3 14246.0 14618.4 14631.4 14674.3 2028.7 2055.2 2078.6 2085.7 2142.4 87934.0 90836.5 91166.1 91532.0 91831.5 10484.8 10510.5 10586.6 10678.4 10818.0 14697.4 14772.9 14793.4 14827.6 14862.6 7591.8 7676.8 7714.8 7822.3 7856.9 7145.5 7174.9 7259.3 7348.6 7374.6 6802.7 6921.0 6921.9 6927.7 6999.1 2051.5 2063.5 2074.3 2103.2 2178.8 842.1 864.3 865.6 894.4 894.7 16336.1 16432.0 16440.3 16496.7 17067.0 842.3 856.2 864.9 865.1 889.0 8862.9 9049.0 9060.9 9264.0 9325.6 391996.0 393993.0 397026.0 397640.0 399549.0 70294.9 71545.6 71711.3 74111.6 74341.0 1024.9 1045.9 1072.1 1109.2 1112.6 16626.2 17019.5 17377.6 17732.9 17953.7 38277.6 39417.4 40270.4 40632.8 40799.6 48345.1 48540.8 48559.0 48591.8 50537.0 7771.7 7777.2 8022.1 8044.4 8337.5 12405.2 12630.2 12690.6 12923.7 13221.4 10962.9 10972.3 10998.7 11341.5 11463.3 9950.4 10089.1 10102.8 10184.2 10505.4 10195.3 10683.9 10835.9 10961.2 10970.5 8189.8 8320.3 8329.8 8424.8 8555.2 9643.4 10204.4 10216.2 10256.4 10369.1 15:44:26 INFO - PID 3558 | 15:44:26 INFO - PID 3558 | [#3] mootools.html Cycles:180 Average:6259.56 Median:3613.70 stddev:4073.91 (112.7%) stddev-sans-first:4067.68 15:44:26 INFO - PID 3558 | Values: 1210.7 1248.1 1261.0 1263.0 1276.4 9767.1 10172.7 10188.8 10353.5 10596.3 10427.7 10629.1 10635.9 10642.2 10646.6 2216.2 2263.9 2272.2 2273.8 2274.3 2168.9 2208.3 2225.0 2231.5 2245.9 2215.4 2232.4 2264.3 2268.0 2271.3 2121.9 2134.9 2184.9 2187.1 2187.1 1877.7 1944.1 2115.3 2120.4 2138.3 10128.8 10147.9 10182.3 10201.7 10234.8 5607.8 5784.1 5800.0 5804.9 5820.1 3269.3 3309.8 3340.2 3450.9 3452.8 1059.8 1084.2 1086.1 1138.6 1162.6 14978.8 15047.4 15186.5 15201.5 15220.9 4543.7 4643.4 4910.3 4940.4 5014.2 10658.7 10690.7 10702.1 10713.7 10742.7 5623.1 5624.9 5625.8 5637.9 5642.7 5025.2 5114.8 5119.1 5187.2 5252.2 3756.8 3833.8 3874.0 3915.9 3925.1 1082.7 1087.9 1088.7 1095.7 1099.6 655.2 680.5 687.7 702.6 710.5 5158.3 5169.8 5223.1 5402.0 5404.2 546.5 547.1 556.5 558.7 558.9 3324.2 3606.6 3620.8 3621.9 3736.3 12781.9 13569.7 13585.9 13600.9 13624.5 12009.2 13373.5 13443.7 13443.7 13481.6 7220.5 7472.6 7509.6 7516.8 7579.4 5611.5 5652.0 5692.4 5712.3 5896.9 11655.8 11781.2 11821.5 11866.2 11960.3 11750.4 12222.8 12237.1 12403.8 12416.4 8100.3 8258.7 8264.6 8359.5 8386.1 9555.2 9595.3 9613.1 9741.3 9753.7 8062.6 8063.2 8065.2 8112.2 8332.3 8123.8 8163.4 8240.8 8273.3 8295.0 7163.6 7283.7 7402.4 7436.0 7445.1 4871.0 4951.2 5013.6 5030.7 5096.3 5010.9 5038.0 5101.7 5125.8 5187.1 15:44:26 INFO - PID 3558 | 15:44:26 INFO - PID 3558 | [#4] prototype.html Cycles:180 Average:4820.64 Median:5514.60 stddev:1450.77 (26.3%) stddev-sans-first:1415.91 15:44:26 INFO - PID 3558 | Values: 372.7 383.9 393.8 394.7 398.2 5499.0 5626.2 5644.9 5675.5 5689.4 5448.4 5483.3 5487.7 5488.2 5530.2 4137.4 4145.7 4145.8 4159.0 4170.9 4103.0 4148.9 4162.7 4176.1 4187.9 4072.3 4075.7 4081.6 4097.4 4101.4 4094.4 4100.3 4123.4 4125.7 4132.7 3537.0 3593.5 3601.6 3610.8 3611.9 5338.2 5342.8 5347.1 5361.9 5435.3 4819.8 4841.0 4842.4 4845.9 4864.3 5697.6 5856.4 5867.9 5886.9 5897.7 3999.2 4021.2 4030.0 4038.8 4056.5 6064.5 6152.2 6207.5 6227.7 6269.4 4108.9 4130.1 4131.8 4143.1 4148.5 4188.0 4189.5 4194.8 4198.0 4219.1 4750.4 4837.8 4869.8 4879.4 4891.6 5886.2 5892.8 5898.2 5909.3 5911.8 1441.5 1455.8 1456.4 1457.1 1458.9 937.9 962.9 963.2 970.4 970.5 4961.8 4970.3 4976.0 4976.0 4988.7 6002.4 6030.2 6039.1 6058.6 6071.2 4932.0 4958.2 4991.2 5015.1 5055.4 3184.9 3222.7 3239.2 3241.7 3253.9 5485.4 5569.5 5613.1 5631.5 5646.4 6192.9 6224.7 6245.9 6248.8 6252.9 5617.6 5621.7 5626.1 5648.7 5665.7 5823.0 6074.8 6087.7 6149.0 6164.6 5882.3 6028.3 6072.9 6085.1 6098.3 5582.7 5663.2 5670.0 5695.1 5713.7 4099.2 4144.1 4151.6 4156.5 4169.9 6046.2 6179.7 6212.9 6216.3 6226.2 5908.8 5932.1 5939.4 5942.3 5953.0 5807.7 5929.4 5938.2 5942.8 5953.3 5795.4 5828.0 5850.2 5863.4 5870.6 5958.0 5971.6 5979.8 5985.8 6023.7 5611.3 5722.6 5776.4 5780.8 5819.7 15:44:26 INFO - PID 3558 | 15:44:26 INFO - PID 3558 | [#5] yui.html Cycles:180 Average:14876.86 Median:43764.06 stddev:17421.12 (39.8%) stddev-sans-first:17437.50 15:44:26 INFO - PID 3558 | Values: 710.6 731.2 744.5 749.9 753.1 13314.7 13950.7 14029.9 16108.6 16362.3 15118.0 15209.6 15298.2 15392.9 16439.8 871.6 913.5 918.9 920.8 923.3 910.9 913.3 913.6 914.7 917.2 960.4 964.2 964.4 965.0 967.6 940.5 942.0 944.9 950.5 954.0 694.9 695.8 696.8 698.2 701.7 13534.3 13714.6 14994.9 15113.7 15128.9 15823.8 15852.7 16341.8 16356.6 16509.4 11745.8 11789.5 11806.4 11855.9 11961.3 2944.8 2956.7 2959.8 2966.2 2972.5 69984.7 70283.0 70809.0 71642.3 74195.3 12472.4 12559.6 12779.1 12790.5 12821.9 21804.7 22606.7 22638.8 22856.0 22974.9 6102.5 6130.6 6203.9 6220.0 6240.1 2910.3 2975.2 2982.1 2987.4 2992.3 3670.8 3699.6 3713.7 3752.4 3761.8 673.7 675.3 676.1 684.7 685.0 527.4 546.5 552.1 552.6 553.2 8551.3 8662.7 8731.6 8880.5 8950.0 545.9 547.3 558.3 561.6 576.5 4008.9 4158.3 4206.2 4273.7 4357.1 55893.0 56430.7 57272.4 59465.0 60127.7 49420.8 49672.5 49854.5 50069.0 51805.7 46088.3 47005.0 47563.6 48864.0 49076.3 9180.2 9500.2 9507.2 9532.8 9792.1 24860.4 24961.9 25080.1 25378.2 26460.6 40175.8 43053.8 43497.6 43731.8 43796.3 13580.7 13780.2 13870.7 14027.2 14240.4 15016.5 15036.8 15248.1 15262.2 15599.0 12373.7 12520.2 12613.6 12693.4 12883.7 13456.0 13569.1 13580.1 13712.5 13994.2 11971.9 11991.8 12084.3 12109.8 12274.2 9400.0 9427.0 9733.3 9735.2 10067.2 9625.6 9742.9 9856.2 9870.6 10109.6 15:44:26 INFO - PID 3558 | -------- Summary: end -------- 15:44:26 INFO - PID 3558 | 15:44:27 INFO - TEST-INFO | 3558: exit 0 15:44:27 INFO - TEST-OK | dromaeo_css | took 1121282ms 15:44:27 INFO - TEST-START | kraken 15:44:27 INFO - operating with platform_type : linux_ 15:44:27 INFO - Initialising browser for kraken test... 15:44:27 INFO - TEST-INFO | started process 3982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp41KcBF/profile http://localhost:43390/getInfo.html) 15:44:28 INFO - PID 3982 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2963: String.localeCompare is deprecated; use String.prototype.localeCompare instead 15:44:32 INFO - PID 3982 | __metrics Screen width/height:1600/1200 15:44:32 INFO - PID 3982 | colorDepth:24 15:44:32 INFO - PID 3982 | Browser inner width/height: 1024/695 15:44:32 INFO - PID 3982 | __metrics 15:44:34 INFO - TEST-INFO | 3982: exit 0 15:44:34 INFO - Browser initialized. 15:44:34 INFO - Running cycle 1/1 for kraken test... 15:44:34 INFO - TEST-INFO | started process 4159 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp41KcBF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:44:45 INFO - PID 4159 | RSS: Main: 170995712 15:44:45 INFO - PID 4159 | 15:44:48 INFO - PID 4159 | Cycle 1(1): loaded http://localhost:43390/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43390/tests/kraken/driver.html?testName=audio-beat-detection) 15:44:49 INFO - PID 4159 | RSS: Main: 174288896 15:44:49 INFO - PID 4159 | 15:44:52 INFO - PID 4159 | Cycle 1(1): loaded http://localhost:43390/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43390/tests/kraken/driver.html?testName=audio-dft) 15:44:52 INFO - PID 4159 | RSS: Main: 174342144 15:44:52 INFO - PID 4159 | 15:44:55 INFO - PID 4159 | Cycle 1(1): loaded http://localhost:43390/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43390/tests/kraken/driver.html?testName=audio-fft) 15:44:56 INFO - PID 4159 | RSS: Main: 170004480 15:44:56 INFO - PID 4159 | 15:44:58 INFO - PID 4159 | Cycle 1(1): loaded http://localhost:43390/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43390/tests/kraken/driver.html?testName=audio-oscillator) 15:44:59 INFO - PID 4159 | RSS: Main: 169938944 15:44:59 INFO - PID 4159 | 15:45:01 INFO - PID 4159 | Cycle 1(1): loaded http://localhost:43390/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43390/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:45:01 INFO - PID 4159 | RSS: Main: 170676224 15:45:01 INFO - PID 4159 | 15:45:05 INFO - PID 4159 | Cycle 1(1): loaded http://localhost:43390/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43390/tests/kraken/driver.html?testName=imaging-darkroom) 15:45:05 INFO - PID 4159 | RSS: Main: 174718976 15:45:05 INFO - PID 4159 | 15:45:09 INFO - PID 4159 | Cycle 1(1): loaded http://localhost:43390/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43390/tests/kraken/driver.html?testName=imaging-desaturate) 15:45:09 INFO - PID 4159 | RSS: Main: 172380160 15:45:09 INFO - PID 4159 | 15:45:12 INFO - PID 4159 | Cycle 1(1): loaded http://localhost:43390/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43390/tests/kraken/driver.html?testName=json-parse-financial) 15:45:13 INFO - PID 4159 | RSS: Main: 172793856 15:45:13 INFO - PID 4159 | 15:45:15 INFO - PID 4159 | Cycle 1(1): loaded http://localhost:43390/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43390/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:45:15 INFO - PID 4159 | RSS: Main: 173043712 15:45:15 INFO - PID 4159 | 15:45:17 INFO - PID 4159 | Cycle 1(1): loaded http://localhost:43390/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43390/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:45:18 INFO - PID 4159 | RSS: Main: 173473792 15:45:18 INFO - PID 4159 | 15:45:20 INFO - PID 4159 | Cycle 1(1): loaded http://localhost:43390/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43390/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:45:20 INFO - PID 4159 | RSS: Main: 173404160 15:45:20 INFO - PID 4159 | 15:45:23 INFO - PID 4159 | Cycle 1(1): loaded http://localhost:43390/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43390/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:45:24 INFO - PID 4159 | RSS: Main: 173510656 15:45:24 INFO - PID 4159 | 15:45:27 INFO - PID 4159 | Cycle 1(1): loaded http://localhost:43390/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43390/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:45:28 INFO - PID 4159 | RSS: Main: 173215744 15:45:28 INFO - PID 4159 | 15:45:30 INFO - PID 4159 | Cycle 1(1): loaded http://localhost:43390/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43390/tests/kraken/driver.html?testName=ai-astar) 15:45:30 INFO - PID 4159 | RSS: Main: 174616576 15:45:30 INFO - PID 4159 | 15:45:30 INFO - PID 4159 | __start_tp_report 15:45:30 INFO - PID 4159 | _x_x_mozilla_page_load 15:45:30 INFO - PID 4159 | _x_x_mozilla_page_load_details 15:45:30 INFO - PID 4159 | |i|pagename|runs| 15:45:30 INFO - PID 4159 | |0;ai-astar;104;113;111;111;111;111;111;111;111;115 15:45:30 INFO - PID 4159 | |1;audio-beat-detection;155;124;124;184;131;131;133;126;149;125 15:45:30 INFO - PID 4159 | |2;audio-dft;165;165;161;164;161;165;166;165;162;165 15:45:30 INFO - PID 4159 | |3;audio-fft;82;75;77;112;76;75;79;77;99;75 15:45:30 INFO - PID 4159 | |4;audio-oscillator;84;83;112;83;83;85;101;86;83;106 15:45:30 INFO - PID 4159 | |5;imaging-gaussian-blur;114;114;115;116;114;113;114;114;114;114 15:45:30 INFO - PID 4159 | |6;imaging-darkroom;153;154;152;152;150;151;151;150;150;150 15:45:30 INFO - PID 4159 | |7;imaging-desaturate;94;103;95;94;96;95;95;95;95;99 15:45:30 INFO - PID 4159 | |8;json-parse-financial;54;54;54;54;55;57;54;56;57;55 15:45:30 INFO - PID 4159 | |9;json-stringify-tinderbox;58;58;57;56;58;57;57;57;58;57 15:45:30 INFO - PID 4159 | |10;stanford-crypto-aes;84;91;93;82;81;82;81;83;83;81 15:45:30 INFO - PID 4159 | |11;stanford-crypto-ccm;140;134;141;132;139;132;136;136;240;135 15:45:30 INFO - PID 4159 | |12;stanford-crypto-pbkdf2;196;197;198;204;193;197;206;189;200;195 15:45:30 INFO - PID 4159 | |13;stanford-crypto-sha256-iterative;74;75;77;77;77;77;77;75;73;72 15:45:30 INFO - PID 4159 | __end_tp_report 15:45:30 INFO - PID 4159 | __start_cc_report 15:45:30 INFO - PID 4159 | _x_x_mozilla_cycle_collect,746 15:45:30 INFO - PID 4159 | __end_cc_report 15:45:30 INFO - PID 4159 | __startTimestamp1495233930465__endTimestamp 15:45:30 INFO - PID 4159 | 15:45:30 INFO - PID 4159 | ------- Summary: start ------- 15:45:30 INFO - PID 4159 | Number of tests: 14 15:45:30 INFO - PID 4159 | 15:45:30 INFO - PID 4159 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:2.77 (2.5%) stddev-sans-first:1.41 15:45:30 INFO - PID 4159 | Values: 104.0 113.0 111.0 111.0 111.0 111.0 111.0 111.0 111.0 115.0 15:45:30 INFO - PID 4159 | 15:45:30 INFO - PID 4159 | [#1] audio-beat-detection Cycles:10 Average:138.20 Median:132.00 stddev:19.30 (14.6%) stddev-sans-first:19.49 15:45:30 INFO - PID 4159 | Values: 155.0 124.0 124.0 184.0 131.0 131.0 133.0 126.0 149.0 125.0 15:45:30 INFO - PID 4159 | 15:45:30 INFO - PID 4159 | [#2] audio-dft Cycles:10 Average:163.90 Median:165.00 stddev:1.85 (1.1%) stddev-sans-first:1.92 15:45:30 INFO - PID 4159 | Values: 165.0 165.0 161.0 164.0 161.0 165.0 166.0 165.0 162.0 165.0 15:45:30 INFO - PID 4159 | 15:45:30 INFO - PID 4159 | [#3] audio-fft Cycles:10 Average:82.70 Median:77.00 stddev:12.59 (16.3%) stddev-sans-first:13.35 15:45:30 INFO - PID 4159 | Values: 82.0 75.0 77.0 112.0 76.0 75.0 79.0 77.0 99.0 75.0 15:45:30 INFO - PID 4159 | 15:45:30 INFO - PID 4159 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:83.00 stddev:11.21 (13.5%) stddev-sans-first:11.63 15:45:30 INFO - PID 4159 | Values: 84.0 83.0 112.0 83.0 83.0 85.0 101.0 86.0 83.0 106.0 15:45:30 INFO - PID 4159 | 15:45:30 INFO - PID 4159 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 15:45:30 INFO - PID 4159 | Values: 114.0 114.0 115.0 116.0 114.0 113.0 114.0 114.0 114.0 114.0 15:45:30 INFO - PID 4159 | 15:45:30 INFO - PID 4159 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:151.50 stddev:1.42 (0.9%) stddev-sans-first:1.36 15:45:30 INFO - PID 4159 | Values: 153.0 154.0 152.0 152.0 150.0 151.0 151.0 150.0 150.0 150.0 15:45:30 INFO - PID 4159 | 15:45:30 INFO - PID 4159 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:95.00 stddev:2.81 (3.0%) stddev-sans-first:2.87 15:45:30 INFO - PID 4159 | Values: 94.0 103.0 95.0 94.0 96.0 95.0 95.0 95.0 95.0 99.0 15:45:30 INFO - PID 4159 | 15:45:30 INFO - PID 4159 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:1.25 (2.3%) stddev-sans-first:1.27 15:45:30 INFO - PID 4159 | Values: 54.0 54.0 54.0 54.0 55.0 57.0 54.0 56.0 57.0 55.0 15:45:30 INFO - PID 4159 | 15:45:30 INFO - PID 4159 | [#9] json-stringify-tinderbox Cycles:10 Average:57.30 Median:57.50 stddev:0.67 (1.2%) stddev-sans-first:0.67 15:45:30 INFO - PID 4159 | Values: 58.0 58.0 57.0 56.0 58.0 57.0 57.0 57.0 58.0 57.0 15:45:30 INFO - PID 4159 | 15:45:30 INFO - PID 4159 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:83.00 stddev:4.31 (5.2%) stddev-sans-first:4.57 15:45:30 INFO - PID 4159 | Values: 84.0 91.0 93.0 82.0 81.0 82.0 81.0 83.0 83.0 81.0 15:45:30 INFO - PID 4159 | 15:45:30 INFO - PID 4159 | [#11] stanford-crypto-ccm Cycles:10 Average:146.50 Median:137.50 stddev:33.00 (24.0%) stddev-sans-first:34.92 15:45:30 INFO - PID 4159 | Values: 140.0 134.0 141.0 132.0 139.0 132.0 136.0 136.0 240.0 135.0 15:45:30 INFO - PID 4159 | 15:45:30 INFO - PID 4159 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.50 Median:197.50 stddev:4.97 (2.5%) stddev-sans-first:5.24 15:45:30 INFO - PID 4159 | Values: 196.0 197.0 198.0 204.0 193.0 197.0 206.0 189.0 200.0 195.0 15:45:30 INFO - PID 4159 | 15:45:30 INFO - PID 4159 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.40 Median:77.00 stddev:1.90 (2.5%) stddev-sans-first:1.94 15:45:30 INFO - PID 4159 | Values: 74.0 75.0 77.0 77.0 77.0 77.0 77.0 75.0 73.0 72.0 15:45:30 INFO - PID 4159 | -------- Summary: end -------- 15:45:30 INFO - PID 4159 | 15:45:31 INFO - TEST-INFO | 4159: exit 0 15:45:31 INFO - TEST-OK | kraken | took 63666ms 15:45:31 INFO - SUITE-END | took 1184s 15:45:31 INFO - Completed test suite (00:19:45) 15:45:31 INFO - javascript benchmark 15:45:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6708.899897241342, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2712.6066720325553, 2726.5501192303273, 2763.6269103670998, 2771.2240572639657, 2794.077954275089, 5269.314989051418, 5330.573554115671, 5372.328458942632, 5393.811216607414, 5421.756020979055, 5329.893402131955, 5357.249985002103, 5365.114756065244, 5397.649152805065, 5426.67439953603, 4679.953200468003, 4704.317873908281, 4742.478327383985, 4757.785899634508, 4799.400074990626, 4749.548792864673, 4750.287456881478, 4844.5882100021545, 4872.585830204437, 4919.877003074916, 4687.179743544866, 4790.688605240648, 4839.7338146401935, 4855.56299933006, 4869.147899117658, 4748.810047598092, 4749.905001899942, 4799.992001679651, 4801.73590452525, 4816.879578010543, 4669.112868554964, 4755.239161734141, 4762.714237145782, 4782.234842425195, 4815.253635686474, 5329.866753331159, 5334.306540149794, 5359.303290572239, 5365.114756065244, 5373.113436283009, 5654.264945557093, 5724.055530837407, 5763.279590051244, 5826.0, 5831.008728516163, 5877.794277200277, 5904.940950590482, 5908.97045514774, 5924.496417804492, 5949.9107513387335, 5470.343558772973, 5478.808241711521, 5488.615796894259, 5494.066008778517, 5497.312835895513, 5860.033094539439, 5935.52515798735, 5954.940450595525, 5955.404459554096, 6048.123022161762, 5692.260006199251, 5698.3162020556965, 5705.372409035002, 5705.800296989585, 5706.144078388275, 5771.480566749013, 5785.595008349375, 5794.478496935296, 5847.44449277318, 5860.794872179454, 5733.283339582552, 5785.8553536161935, 5800.39095894925, 5800.8259752207505, 5806.506446952057, 5771.769129234867, 5787.797427090031, 5806.187133801272, 5809.82570522885, 5820.185174075633, 4781.9043619128115, 4841.661083724176, 4861.052094841542, 4896.975515122402, 4905.190643543775, 4205.158968206371, 4225.471816022997, 4264.850730224427, 4269.893252668709, 4276.358546218092, 4851.975740121276, 4861.0, 4861.0277944411255, 4876.317315575822, 4914.0, 5765.308163020464, 5798.6810725410505, 5814.680192589448, 5816.970915145482, 5820.650760954356, 4792.496787837296, 4839.080574690797, 4864.464908860023, 4882.804687812519, 4891.33966914462, 5177.58579313654, 5187.662801917863, 5192.299039629677, 5197.558207552324, 5222.817201398009, 5429.972850135724, 5430.70131142791, 5434.456554344534, 5437.997271541481, 5494.066008778437, 5680.6591604503865, 5787.884242315215, 5793.044147715748, 5793.681347525927, 5869.8239052828485, 5350.9732451337495, 5374.785008599612, 5430.782768689366, 5435.211894275387, 5443.7822487100075, 5767.134929760569, 5776.249087618583, 5776.277965254343, 5780.901628690535, 5823.213866128019, 5762.30852297727, 5861.9706901465215, 5872.29532456108, 5877.206577112035, 5888.0, 5447.536959358499, 5539.0, 5648.745806438638, 5686.4029276926985, 5686.971565142313, 5592.0, 5592.245046918614, 5654.038813401649, 5672.744726487401, 5675.716214189357, 5466.863328416822, 5502.0371434997915, 5530.7511161997, 5541.3904470507405, 5542.972285138549, 5552.194931734956, 5669.064604340238, 5673.06394444912, 5675.858103547444, 5677.8864422710485, 5387.86530336729, 5439.102548079522, 5452.0, 5466.8906621866545, 5479.780808767764], "value": 5253.944076051484, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.9719662615182, 668.15144766147, 691.3017851969511, 1129.5989923577135, 1173.9823902641456, 32616.510752338705, 33992.32015359694, 34058.48912266315, 34084.48873266903, 34161.0, 31709.841450792715, 31960.200994975137, 32017.519737203904, 32053.67946320536, 32108.518372224436, 6416.005519144528, 6504.967475162617, 6728.0, 6918.0314755934205, 6919.757808476705, 6715.731370745164, 6749.527533072687, 6772.695228714695, 6797.830054248659, 6808.046873437723, 6707.02748101525, 6853.657317134148, 6853.828654283658, 6876.793696189123, 6886.793396198122, 6781.152355955505, 6802.795916122524, 6809.5233333666665, 6819.829504262409, 6846.554973926729, 6839.350261725128, 6868.7252509900045, 6889.655517224119, 6895.310468953115, 6898.862022759517, 31260.218494537592, 31307.06078817639, 31590.526142107658, 31720.682793172004, 31739.52390714141, 3032.2267821705545, 3042.087373787877, 3044.9695503045127, 3068.1562570293127, 3070.8925187618324, 24445.533268003976, 24455.755442445527, 24486.87756561206, 24502.387440313956, 24511.264662060166, 2928.3996780659913, 2985.596944412498, 3004.0, 3009.8043627164166, 3010.668826429113, 145069.2746536271, 145333.27333363265, 145946.0, 152627.0, 158172.0, 38685.80657096753, 39103.0, 39136.608633913296, 39153.0, 39224.411633824944, 40096.39855402171, 40223.396649050286, 40227.79886100551, 42661.36007959883, 43748.3437748434, 12754.553590624284, 12874.16317939331, 12875.356232188353, 12901.225926444444, 12902.935485322514, 10138.188944884392, 10208.285420020527, 10262.58949642006, 10276.691699249035, 10302.124319432782, 12479.0, 12562.623121306375, 12622.412405457042, 12680.619581412573, 12749.745005099847, 5224.320838291073, 5298.0, 5343.946560534423, 5351.705656188947, 5426.267453893753, 855.5422848775875, 885.1856292211181, 888.9644414223488, 903.4443817052465, 914.6981496106268, 20238.0, 23940.0, 25541.0, 25880.741192588208, 25913.740862591134, 974.6686126716809, 976.2434113562047, 980.1864452504404, 993.1955116355775, 995.0447570332417, 11127.0, 11556.711082222844, 11621.24461909973, 11677.124215683858, 11781.057515398748, 164209.0, 167376.0, 168019.0, 168292.0, 180312.0, 44190.558094419284, 44841.55158448439, 44842.551574483834, 44858.55141448609, 44880.0, 1243.0863315463127, 1254.4982007197011, 1257.4844313831468, 1267.0876968582606, 1270.12361470585, 24539.14113006036, 24716.876415617808, 25782.871085644452, 25973.740262597134, 25984.610230846174, 29979.400411991202, 30203.848980754956, 30212.546811798282, 30234.697653023188, 30260.54609180908, 162229.18885405498, 162665.18667406586, 162710.186449067, 162755.0, 162835.0, 28472.715272847006, 28684.42631147407, 28742.281442963256, 28929.0, 28967.420651586428, 35314.646853531136, 35615.46576801298, 35690.821545892104, 35861.64138358583, 35928.4610730834, 25566.0, 26994.32514187161, 27200.591991120546, 27273.454530908875, 27727.029553965513, 26346.0, 27184.72815271822, 27671.169864904085, 27779.583306250017, 28332.291692707848, 30618.234544136576, 30618.540721888745, 30652.386952261277, 30705.078847634606, 30799.2300192497, 26111.608325875506, 26318.60522092132, 26416.603750944134, 26952.32619184536, 27663.056725981092, 20968.161273549496, 21681.241156559445, 21761.34715958524, 21965.121395144015, 22129.33611991643], "value": 14588.322976072242, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.39876580809107, 415.2919272640149, 424.33803266903624, 428.9978550107249, 437.70892356582874, 14122.364493597786, 16954.745678814827, 17634.559136021606, 17643.73534396985, 17739.55651108723, 17810.109494525288, 18161.273549058056, 18173.0, 18225.270989160417, 18277.634447311048, 5328.8401347959625, 5356.758945847427, 5477.0, 5551.0, 5599.272094627693, 5425.13197888338, 5508.531774799147, 5518.696471694056, 5529.866377392625, 5542.279503664538, 5234.581233501311, 5410.8917821643545, 5441.619086663935, 5471.562275017989, 5484.506394424501, 5458.0, 5467.863303417406, 5468.26178465908, 5485.533729632966, 5491.313585801775, 4748.762561871893, 4878.438979517366, 4899.412070551521, 4902.338184345103, 4974.477679843637, 21144.471388215265, 21309.573808523743, 21439.35681929529, 21733.13067477299, 21806.89096554507, 1600.0, 1648.6949914265779, 1663.9084850333227, 1673.1968655045525, 1675.790526184227, 13845.30773461333, 14246.0, 14618.415263389452, 14631.41474341025, 14674.266286685623, 2028.655128628122, 2055.1882006607457, 2078.625847347477, 2085.728855248823, 2142.4001279641725, 87934.0, 90836.5458172705, 91166.08833911708, 91532.0, 91831.54084229536, 10484.842727358942, 10510.4774854036, 10586.57653693859, 10678.369354419534, 10818.0, 14697.412103515953, 14772.926135369255, 14793.408263669548, 14827.555173344817, 14862.554123376316, 7591.772246832604, 7676.846463070819, 7714.845703085907, 7822.335101516321, 7856.921430785734, 7145.499815013003, 7174.92825071753, 7259.317740057633, 7348.559086454829, 7374.631268436557, 6802.727890884309, 6920.9653951729915, 6921.8961715574305, 6927.653617319113, 6999.12510936133, 2051.5281485258474, 2063.546019875625, 2074.346580827035, 2103.1692481469736, 2178.7712290209615, 842.0611018714089, 864.2783275964514, 865.5801936061006, 894.3650008493912, 894.7360528644066, 16336.101514416583, 16432.0, 16440.260188291555, 16496.6700665986, 17067.0, 842.2882664148784, 856.1652388920877, 864.8875646165958, 865.1348651348651, 889.0220757167065, 8862.911370886337, 9049.0, 9060.909390906007, 9263.953680231556, 9325.580348884316, 391996.0, 393993.0, 397026.0, 397640.0, 399549.0, 70294.89115326549, 71545.64227178831, 71711.2828871715, 74111.62944185245, 74341.0, 1024.8770147582188, 1045.9372437653612, 1072.056590200634, 1109.1681239070697, 1112.5772206561455, 16626.16869156513, 17019.48941531756, 17377.565560860574, 17732.91133544324, 17953.743237973216, 38277.61722382852, 39417.40873886837, 40270.39594406028, 40632.79683601563, 40799.59200407958, 48345.09929404247, 48540.7572962147, 48559.0, 48591.757041214565, 50537.0, 7771.650275737492, 7777.222277772177, 8022.117567067501, 8044.3564514839845, 8337.499750014777, 12405.193662411913, 12630.179038362478, 12690.619281421203, 12923.676908077374, 13221.405036773176, 10962.890371096188, 10972.286801357886, 10998.725031874266, 11341.546338146381, 11463.337816016465, 9950.35322704022, 10089.09198172168, 10102.79794404093, 10184.236182286506, 10505.422201778976, 10195.286329956833, 10683.94658026705, 10835.891641083803, 10961.232713709964, 10970.506327215455, 8189.836203275782, 8320.292775114183, 8329.791755206168, 8424.83150337002, 8555.230029297392, 9643.421394716339, 10204.38773673582, 10216.233782466494, 10256.43589602579, 10369.118624916966], "value": 8763.411908395485, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1210.667066556697, 1248.0577164240997, 1261.0, 1262.9873701262984, 1276.4128500889587, 9767.120959113687, 10172.694819155418, 10188.796224075524, 10353.534090965906, 10596.31123976943, 10427.68716938493, 10629.096526795232, 10635.893641063587, 10642.201834862377, 10646.62736804212, 2216.1689366487567, 2263.864168149908, 2272.227442669492, 2273.8067264282554, 2274.3404412720292, 2168.8698678079368, 2208.315422219109, 2225.020990764067, 2231.542533780579, 2245.921392751254, 2215.3575463115676, 2232.430730163806, 2264.3320220534983, 2267.965980510294, 2271.318604418676, 2121.8939053047284, 2134.8505604607685, 2184.923527676524, 2187.0704950396016, 2187.0814258011674, 1877.7089551119461, 1944.0862794486568, 2115.259659119296, 2120.4486833423266, 2138.347803919804, 10128.848067278997, 10147.934466881019, 10182.28723989321, 10201.693949181536, 10234.846477302846, 5607.831765047055, 5784.132380143013, 5800.0429929062075, 5804.912926306109, 5820.097884827858, 3269.304159776109, 3309.8014119152926, 3340.1816554943953, 3450.896473105811, 3452.7583069185166, 1059.819830628795, 1084.2406076535237, 1086.0659832544006, 1138.55027264231, 1162.5698491558094, 14978.775318370233, 15047.398104075824, 15186.544403667907, 15201.543953681406, 15220.923895380563, 4543.728135932034, 4643.396358473445, 4910.337104490848, 4940.357753492023, 5014.197728363444, 10658.73353166177, 10690.679279621623, 10702.143828493701, 10713.732156696145, 10742.73143171427, 5623.10030395143, 5624.91562626561, 5625.803096891589, 5637.943620563824, 5642.746076426571, 5025.170846810235, 5114.795408183705, 5119.129747942859, 5187.170052791535, 5252.238425428368, 3756.8309426075893, 3833.8274777635074, 3874.024247633727, 3915.9021024474046, 3925.1364699766004, 1082.6806092202662, 1087.9401632910108, 1088.7441451258949, 1095.7041598768287, 1099.6481126039591, 655.2006552006544, 680.5440354962187, 687.6905392573362, 702.6170736948376, 710.4742490557054, 5158.329417175818, 5169.844904652867, 5223.13818219997, 5401.972990135024, 5404.189371594213, 546.4890327543759, 547.0781732780199, 556.476911703006, 558.6703844731628, 558.9301337332834, 3324.16895776056, 3606.621304762962, 3620.7827530348263, 3621.94567081494, 3736.2527494500664, 12781.872181278255, 13569.728605427836, 13585.932070339584, 13600.93199533996, 13624.455021799215, 12009.219400738924, 13373.46506139763, 13443.663908402172, 13443.663908402368, 13481.59555213345, 7220.530665506725, 7472.589007604743, 7509.586972716444, 7516.849663006818, 7579.431542634215, 5611.466910643482, 5652.0, 5692.402297758841, 5712.34308054579, 5896.9115463268945, 11655.766884662089, 11781.234219775688, 11821.468033938321, 11866.228695134789, 11960.282383057045, 11750.353730544903, 12222.816657750318, 12237.143399961917, 12403.75192496163, 12416.379181040731, 8100.311473524816, 8258.710945116893, 8264.628091736007, 8359.456635318686, 8386.11945745688, 9555.18780903631, 9595.28035397362, 9613.134817866425, 9741.269404794528, 9753.658621948482, 8062.637181326972, 8063.233992770677, 8065.153158918229, 8112.188781122077, 8332.250097491255, 8123.75628731139, 8163.428560000743, 8240.793980150544, 8273.296769774637, 8294.958525207578, 7163.641817909188, 7283.7450689225625, 7402.4448166386655, 7436.0333156689285, 7445.143808462096, 4870.977094809988, 4951.232558953368, 5013.623978201723, 5030.698158110525, 5096.286519887145, 5010.899782004412, 5038.0, 5101.719405432588, 5125.769340379767, 5187.144121219956], "value": 4652.708760590504, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.72604635592836, 383.91553858151207, 393.8188433320672, 394.67439362525926, 398.18968399307414, 5499.0, 5626.240457538226, 5644.915326270104, 5675.460831221033, 5689.431056894308, 5448.37343705473, 5483.287172667558, 5487.670739755617, 5488.17677348398, 5530.198121272413, 4137.379393091031, 4145.709800313979, 4145.834166633339, 4159.003678234434, 4170.874873753793, 4102.958970410303, 4148.875533733993, 4162.687798415116, 4176.1230141670285, 4187.916241675165, 4072.328065869128, 4075.6535694466006, 4081.5918408159096, 4097.405876147956, 4101.425800387948, 4094.365373367118, 4100.261952848486, 4123.36087906375, 4125.731827431207, 4132.669386449107, 3536.975895539071, 3593.4969104325414, 3601.6398360164035, 3610.765300255475, 3611.8916432507067, 5338.199270109515, 5342.839714808562, 5347.064263753828, 5361.919571206435, 5435.266239057716, 4819.807207711688, 4841.031793641286, 4842.394700662418, 4845.85462436124, 4864.270359446076, 5697.6011679182475, 5856.385079566627, 5867.882642347129, 5886.882262354772, 5897.675627840467, 3999.240144372589, 4021.155557332964, 4029.959700402988, 4038.7980600969836, 4056.5132184137797, 6064.4541991221, 6152.200213972155, 6207.534434917399, 6227.688615569204, 6269.404406581368, 4108.876733697994, 4130.141436353653, 4131.834726610902, 4143.08852052548, 4148.502179738391, 4188.005576013165, 4189.539150693421, 4194.832206711759, 4197.958020419818, 4219.1139860629, 4750.358701575312, 4837.830675926396, 4869.829555965524, 4879.39007624047, 4891.633127515451, 5886.175935369051, 5892.823215303548, 5898.217050392083, 5909.2908850938165, 5911.822645320647, 1441.502681574855, 1455.7670772676322, 1456.3592019511593, 1457.0893191755154, 1458.9197594132424, 937.9343445958717, 962.8796400449944, 963.2197919684937, 970.3983530211315, 970.4807927758616, 4961.826336078292, 4970.304157417964, 4975.950240497621, 4976.009596161564, 4988.72562009093, 6002.429769172009, 6030.185924900083, 6039.097684229454, 6058.575899687068, 6071.150038994544, 4932.013597280558, 4958.181899986534, 4991.151504244287, 5015.072211640785, 5055.368078990126, 3184.8726050958167, 3222.6616205298574, 3239.1902024493875, 3241.6596257393107, 3253.8698452062126, 5485.424030476823, 5569.498745112878, 5613.129964855454, 5631.521320687705, 5646.378898321182, 6192.938070619236, 6224.688765561704, 6245.937540624626, 6248.843778905472, 6252.874942501216, 5617.606767526398, 5621.747021384048, 5626.071698169838, 5648.74580643872, 5665.66006039639, 5823.049278491752, 6074.848128796815, 6087.665178415053, 6148.9692551536955, 6164.630122192682, 5882.323532793784, 6028.336882942785, 6072.908906366496, 6085.087236914498, 6098.298695650057, 5582.665040097607, 5663.150527420919, 5670.0, 5695.117256825199, 5713.657180569179, 4099.159672267118, 4144.088300573869, 4151.626353628188, 4156.542780294226, 4169.91660166801, 6046.1535385045245, 6179.721912514037, 6212.875742485216, 6216.347283535164, 6226.159468471698, 5908.763649453974, 5932.080527518242, 5939.376365481735, 5942.286925568959, 5952.970235148797, 5807.738651760596, 5929.377415371324, 5938.168656388023, 5942.821715348547, 5953.28560572734, 5795.420457954171, 5827.970860145672, 5850.151727999331, 5863.413658634103, 5870.589058766016, 5957.970210149095, 5971.581989260884, 5979.820605381846, 5985.802839432044, 6023.728932198149, 5611.270534830446, 5722.62802917809, 5776.393478684678, 5780.826575202751, 5819.738111784895], "value": 4372.63293157502, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.5949608723023, 731.1664702239447, 744.5049042386813, 749.8875168724692, 753.1038064703004, 13314.667133321671, 13950.651233719149, 14029.859701402997, 16108.59728506785, 16362.263698133584, 15118.0, 15209.619759506018, 15298.158601276953, 15392.923035384807, 16439.83560164398, 871.5555066915871, 913.5204017890594, 918.8943271523793, 920.8250432417852, 923.2660035271941, 910.9180173784358, 913.3423934766957, 913.5888850017485, 914.7438717159206, 917.1928702741578, 960.3997501561524, 964.161179773598, 964.3972517176765, 964.9710508684751, 967.5791030901545, 940.4592359393342, 941.9952900235523, 944.9055094490599, 950.4772375193651, 954.0030667952007, 694.8992396102587, 695.7530076822757, 696.8014115976922, 698.2040473859804, 701.6596950479013, 13534.323283835769, 13714.588562343146, 14994.850051499454, 15113.697726045528, 15128.924355378263, 15823.841761582353, 15852.682946341123, 16341.836581634268, 16356.591085222846, 16509.422170223985, 11745.765084698343, 11789.528418863236, 11806.409679516075, 11855.881441185651, 11961.282323060645, 2944.7791415643696, 2956.6895475975143, 2959.8224106553675, 2966.1842993176833, 2972.539256415259, 69984.6500767498, 70283.0, 70809.0, 71642.2835771646, 74195.25804741938, 12472.376381181086, 12559.623211303493, 12779.105462617528, 12790.488380464863, 12821.871781282254, 21804.672929906064, 22606.704726101987, 22638.773612263667, 22856.0, 22974.885125574267, 6102.481289090389, 6130.601510901777, 6203.906941395882, 6220.03589443637, 6240.126382306481, 2910.2869796899895, 2975.1669532530927, 2982.0904624089426, 2987.3726517431146, 2992.311768293305, 3670.825335892542, 3699.6300369962787, 3713.6843368313994, 3752.399616061417, 3761.8307176177136, 673.6564352180326, 675.3044364304774, 676.1075380497696, 684.6576711644178, 684.9657517124124, 527.3645257464746, 546.529984213576, 552.1138572591013, 552.5883217003358, 553.1619596311591, 8551.273141782895, 8662.653493860302, 8731.56342182901, 8880.51157186361, 8949.955250223707, 545.8744488767605, 547.2748608094291, 558.2672816562902, 561.5900392713261, 576.4869266352949, 4008.939865902014, 4158.334666453353, 4206.221848957892, 4273.7008409411665, 4357.082883531236, 55893.0, 56430.717846411324, 57272.42727572754, 59465.0, 60127.69936150291, 49420.75289623601, 49672.50327496751, 49854.50145498499, 50069.0, 51805.7409712949, 46088.308675369895, 47005.0, 47563.578916845785, 48864.0, 49076.26385604219, 9180.17378435944, 9500.239980801658, 9507.239420846177, 9532.809343813224, 9792.118709316195, 24860.37849053788, 24961.87519062393, 25080.122195723063, 25378.238652840446, 26460.603090953267, 40175.79912100421, 43053.78473107614, 43497.56502434935, 43731.78134109309, 43796.34305485357, 13580.660483487993, 13780.242086685328, 13870.65323366924, 14027.228502432465, 14240.430382784572, 15016.549503514912, 15036.849631503545, 15248.085114893142, 15262.23688815577, 15599.0, 12373.690657733629, 12520.248785072925, 12613.621591352274, 12693.42879570403, 12883.677908052, 13456.0, 13569.118007329493, 13580.117292375964, 13712.451501939811, 13994.230317332238, 11971.940140299243, 11991.76016479683, 12084.335361555199, 12109.757804843677, 12274.202176858476, 9400.012998635319, 9426.95286523563, 9733.270004749813, 9735.1725103367, 10067.194624429882, 9625.56684949193, 9742.853857192005, 9856.21150307988, 9870.605175792887, 10109.64616238428], "value": 6672.116356490073, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1563.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 111.0, 111.0, 111.0, 111.0, 111.0, 111.0, 111.0, 115.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 124.0, 184.0, 131.0, 131.0, 133.0, 126.0, 149.0, 125.0], "value": 138.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 161.0, 164.0, 161.0, 165.0, 166.0, 165.0, 162.0, 165.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 75.0, 77.0, 112.0, 76.0, 75.0, 79.0, 77.0, 99.0, 75.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 112.0, 83.0, 83.0, 85.0, 101.0, 86.0, 83.0, 106.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 116.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 154.0, 152.0, 152.0, 150.0, 151.0, 151.0, 150.0, 150.0, 150.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 103.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 99.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 55.0, 57.0, 54.0, 56.0, 57.0, 55.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 56.0, 58.0, 57.0, 57.0, 57.0, 58.0, 57.0], "value": 57.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 91.0, 93.0, 82.0, 81.0, 82.0, 81.0, 83.0, 83.0, 81.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 134.0, 141.0, 132.0, 139.0, 132.0, 136.0, 136.0, 240.0, 135.0], "value": 146.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 197.0, 198.0, 204.0, 193.0, 197.0, 206.0, 189.0, 200.0, 195.0], "value": 197.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 77.0, 77.0, 77.0, 77.0, 75.0, 73.0, 72.0], "value": 75.4, "unit": "score"}]}]} 15:45:31 INFO - Return code: 0 15:45:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:45:31 INFO - # TBPL SUCCESS # 15:45:31 INFO - Running post-action listener: _resource_record_post_action 15:45:31 INFO - [mozharness: 2017-05-19 22:45:31.777981Z] Finished run-tests step (success) 15:45:31 INFO - Running post-run listener: _resource_record_post_run 15:45:31 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 7958528; Write bytes: 430129152; Read time: 1884; Write time: 340404 15:45:31 INFO - TinderboxPrint: CPU usage
13.3% 15:45:31 INFO - TinderboxPrint: I/O read bytes / time
7,958,528 / 1,884 15:45:31 INFO - TinderboxPrint: I/O write bytes / time
430,129,152 / 340,404 15:45:31 INFO - TinderboxPrint: CPU idle
8,313.5 (86.7%) 15:45:31 INFO - TinderboxPrint: CPU user
1,218.6 (12.7%) 15:45:31 INFO - TinderboxPrint: Swap in / out
0 / 0 15:45:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 101490688; Read time: 0; Write time: 60556 15:45:31 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 5791744; Write bytes: 237527040; Read time: 1596; Write time: 199412 15:45:32 INFO - Running post-run listener: _upload_blobber_files 15:45:32 INFO - Blob upload gear active. 15:45:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:45:32 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:45:32 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:45:32 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:45:32 INFO - (blobuploader) - INFO - Open directory for files ... 15:45:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:45:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:45:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:35 INFO - (blobuploader) - INFO - Done attempting. 15:45:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:45:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:45:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:36 INFO - (blobuploader) - INFO - Done attempting. 15:45:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:45:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:45:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:37 INFO - (blobuploader) - INFO - Done attempting. 15:45:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:45:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:45:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:38 INFO - (blobuploader) - INFO - Done attempting. 15:45:38 INFO - (blobuploader) - INFO - Iteration through files over. 15:45:38 INFO - Return code: 0 15:45:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:45:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:45:38 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6fe6de41e6f6551345392d486983ffd7455367971f3944fb4ef12c3924d924f69e9f62bdfcd2d75efc34b0d19e176faf81f67600818ef2c907678a0dc6942f44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eff81b1edb8f1291de904b9960d6d1ca20d38dbf136396ac652ee1bae509adf6b787bea81b3c5600a4844067770614a99160bdb895ca7fa73809420205b61930", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b72252f90154f36c0573dcfe0414dfa1514183d4ed4101dc49176f0392a0894b93490f0eff0703f834491d7da36bcb2b848a004a75c65a8c6312c23d811aa68d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f36cd1c60a4a35708e763558bf4131b2d56e4aa40f291661b0cd074e90e0e8640b40aed65d3c73b437ce665be0ad46a4cf2ce5655172fc61b2dea8bc179ab07"} 15:45:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:45:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:45:38 INFO - Contents: 15:45:38 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6fe6de41e6f6551345392d486983ffd7455367971f3944fb4ef12c3924d924f69e9f62bdfcd2d75efc34b0d19e176faf81f67600818ef2c907678a0dc6942f44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eff81b1edb8f1291de904b9960d6d1ca20d38dbf136396ac652ee1bae509adf6b787bea81b3c5600a4844067770614a99160bdb895ca7fa73809420205b61930", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b72252f90154f36c0573dcfe0414dfa1514183d4ed4101dc49176f0392a0894b93490f0eff0703f834491d7da36bcb2b848a004a75c65a8c6312c23d811aa68d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f36cd1c60a4a35708e763558bf4131b2d56e4aa40f291661b0cd074e90e0e8640b40aed65d3c73b437ce665be0ad46a4cf2ce5655172fc61b2dea8bc179ab07"} 15:45:38 INFO - Running post-run listener: copy_logs_to_upload_dir 15:45:38 INFO - Copying logs to upload dir... 15:45:38 INFO - mkdir: /builds/slave/test/build/upload/logs 15:45:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.318845 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-05-19 15:45:37.969685) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-19 15:45:37.974415) ========= 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=232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070 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/6fe6de41e6f6551345392d486983ffd7455367971f3944fb4ef12c3924d924f69e9f62bdfcd2d75efc34b0d19e176faf81f67600818ef2c907678a0dc6942f44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eff81b1edb8f1291de904b9960d6d1ca20d38dbf136396ac652ee1bae509adf6b787bea81b3c5600a4844067770614a99160bdb895ca7fa73809420205b61930", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b72252f90154f36c0573dcfe0414dfa1514183d4ed4101dc49176f0392a0894b93490f0eff0703f834491d7da36bcb2b848a004a75c65a8c6312c23d811aa68d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f36cd1c60a4a35708e763558bf4131b2d56e4aa40f291661b0cd074e90e0e8640b40aed65d3c73b437ce665be0ad46a4cf2ce5655172fc61b2dea8bc179ab07"} build_url:https://queue.taskcluster.net/v1/task/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011270 build_url: 'https://queue.taskcluster.net/v1/task/aj4kEjOJSEW7bo4yDl4uBQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6fe6de41e6f6551345392d486983ffd7455367971f3944fb4ef12c3924d924f69e9f62bdfcd2d75efc34b0d19e176faf81f67600818ef2c907678a0dc6942f44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eff81b1edb8f1291de904b9960d6d1ca20d38dbf136396ac652ee1bae509adf6b787bea81b3c5600a4844067770614a99160bdb895ca7fa73809420205b61930", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b72252f90154f36c0573dcfe0414dfa1514183d4ed4101dc49176f0392a0894b93490f0eff0703f834491d7da36bcb2b848a004a75c65a8c6312c23d811aa68d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f36cd1c60a4a35708e763558bf4131b2d56e4aa40f291661b0cd074e90e0e8640b40aed65d3c73b437ce665be0ad46a4cf2ce5655172fc61b2dea8bc179ab07"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-19 15:45:37.998045) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 15:45:38.001350) ========= 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=232498196343f89f466a4a9a000001c8-1495218688.134933-1788042070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 15:45:38.079733) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-19 15:45:38.080039) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-19 15:45:38.083344) ========= ========= Total master_lag: 0.21 =========