builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-051 starttime: 1494605447.58 results: success (0) revision: 1ec1d88637208098802e57d13db9033902e5a229 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 09:10:47.582966) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 09:10:47.583492) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 09:10:47.583785) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 09:10:47.640842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:10:47.641406) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-12 09:10:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2017-05-12 09:10:47 (42.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.164980 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:10:47.854818) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:10:47.855183) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019177 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:10:47.908746) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-12 09:10:47.909178) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1ec1d88637208098802e57d13db9033902e5a229 --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 1ec1d88637208098802e57d13db9033902e5a229 --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=5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-12 09:10:48,017 truncating revision to first 12 chars 2017-05-12 09:10:48,017 Setting DEBUG logging. 2017-05-12 09:10:48,017 attempt 1/10 2017-05-12 09:10:48,017 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1ec1d8863720?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-12 09:10:49,118 unpacking tar archive at: mozilla-central-1ec1d8863720/testing/mozharness/ program finished with exit code 0 elapsedTime=1.419895 ========= master_lag: 0.37 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-12 09:10:49.695473) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 09:10:49.696057) ========= script_repo_revision: 1ec1d88637208098802e57d13db9033902e5a229 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 09:10:49.704476) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 09:10:49.705122) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 09:10:49.761644) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-05-12 09:10:49.762237) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:10:50 INFO - MultiFileLogger online at 20170512 09:10:50 in /builds/slave/test 09:10:50 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 09:10:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:10:50 INFO - {'append_to_log': False, 09:10:50 INFO - 'base_work_dir': '/builds/slave/test', 09:10:50 INFO - 'blob_upload_branch': 'Firefox', 09:10:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:10:50 INFO - 'branch': 'Firefox', 09:10:50 INFO - 'buildbot_json_path': 'buildprops.json', 09:10:50 INFO - 'config_files': ('talos/linux_config.py',), 09:10:50 INFO - 'default_actions': ('clobber', 09:10:50 INFO - 'read-buildbot-config', 09:10:50 INFO - 'download-and-extract', 09:10:50 INFO - 'populate-webroot', 09:10:50 INFO - 'create-virtualenv', 09:10:50 INFO - 'install', 09:10:50 INFO - 'run-tests'), 09:10:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:10:50 INFO - 'download_minidump_stackwalk': True, 09:10:50 INFO - 'download_symbols': 'ondemand', 09:10:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:10:50 INFO - 'tooltool.py': '/tools/tooltool.py', 09:10:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:10:50 INFO - '/tools/misc-python/virtualenv.py')}, 09:10:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:10:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:10:50 INFO - 'gecko_profile': False, 09:10:50 INFO - 'gecko_profile_interval': 0, 09:10:50 INFO - 'installer_path': 'installer.exe', 09:10:50 INFO - 'log_level': 'info', 09:10:50 INFO - 'log_name': 'talos', 09:10:50 INFO - 'log_to_console': True, 09:10:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:10:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:10:50 INFO - 'opt_config_files': (), 09:10:50 INFO - 'pip_index': False, 09:10:50 INFO - 'suite': 'dromaeojs-e10s', 09:10:50 INFO - 'system_bits': '32', 09:10:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:10:50 INFO - 'title': 'talos-linux64-ix-051', 09:10:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:10:50 INFO - 'use_talos_json': True, 09:10:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:10:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:10:50 INFO - 'work_dir': 'build'} 09:10:50 INFO - [mozharness: 2017-05-12 16:10:50.075401Z] Running clobber step. 09:10:50 INFO - Running pre-action listener: _resource_record_pre_action 09:10:50 INFO - Running main action method: clobber 09:10:50 INFO - rmtree: /builds/slave/test/build 09:10:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:10:50 INFO - Running post-action listener: _resource_record_post_action 09:10:50 INFO - [mozharness: 2017-05-12 16:10:50.977489Z] Finished clobber step (success) 09:10:50 INFO - [mozharness: 2017-05-12 16:10:50.977591Z] Running read-buildbot-config step. 09:10:50 INFO - Running pre-action listener: _resource_record_pre_action 09:10:50 INFO - Running main action method: read_buildbot_config 09:10:50 INFO - Using buildbot properties: 09:10:50 INFO - { 09:10:50 INFO - "project": "", 09:10:50 INFO - "product": "firefox", 09:10:50 INFO - "who": "cbook@mozilla.com", 09:10:50 INFO - "installer_path": "public/build/target.tar.bz2", 09:10:50 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 09:10:50 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:10:50 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 09:10:50 INFO - "stage_platform": "linux64-stylo", 09:10:50 INFO - "basedir": "/builds/slave/test", 09:10:50 INFO - "buildnumber": 85, 09:10:50 INFO - "platform": "ubuntu64_hw_stylo", 09:10:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:10:50 INFO - "slavebuilddir": "test", 09:10:50 INFO - "taskId": "DwHYmws0SlOqXyEvhqX6Cw", 09:10:50 INFO - "branch": "mozilla-central", 09:10:50 INFO - "script_repo_revision": "production", 09:10:50 INFO - "revision": "1ec1d88637208098802e57d13db9033902e5a229", 09:10:50 INFO - "slavename": "talos-linux64-ix-051", 09:10:50 INFO - "repo_path": "mozilla-central" 09:10:50 INFO - } 09:10:50 INFO - Finding installer, test and symbols from parent task. 09:10:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DwHYmws0SlOqXyEvhqX6Cw'}, attempt #1 09:10:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DwHYmws0SlOqXyEvhqX6Cw'}, attempt #1 09:10:51 INFO - Task dependencies: O3pIdWc-SU-4zAJfgrgW-g 09:10:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O3pIdWc-SU-4zAJfgrgW-g'}, attempt #1 09:10:52 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/target.tar.bz2 09:10:52 INFO - Set test_url: https://queue.taskcluster.net/v1/task/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/test_packages.json 09:10:52 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/target.crashreporter-symbols.zip 09:10:52 INFO - Running post-action listener: _resource_record_post_action 09:10:52 INFO - [mozharness: 2017-05-12 16:10:52.369280Z] Finished read-buildbot-config step (success) 09:10:52 INFO - [mozharness: 2017-05-12 16:10:52.369537Z] Running download-and-extract step. 09:10:52 INFO - Running pre-action listener: _resource_record_pre_action 09:10:52 INFO - Running main action method: download_and_extract 09:10:52 INFO - mkdir: /builds/slave/test/build/tests 09:10:52 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')]} 09:10:52 INFO - trying https://queue.taskcluster.net/v1/task/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/target.test_packages.json 09:10:52 INFO - Downloading https://queue.taskcluster.net/v1/task/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:10:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:10:52 INFO - Downloaded 986 bytes. 09:10:52 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:10:52 INFO - Using the following test package requirements: 09:10:52 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:10:52 INFO - u'common': [u'target.common.tests.zip'], 09:10:52 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:10:52 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:10:52 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:10:52 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:10:52 INFO - u'mozbase': [u'target.common.tests.zip'], 09:10:52 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:10:52 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:10:52 INFO - u'web-platform': [u'target.common.tests.zip', 09:10:52 INFO - u'target.web-platform.tests.zip'], 09:10:52 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:10:52 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:10:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/target.common.tests.zip 09:10:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:10:52 INFO - Fetch https://queue.taskcluster.net/v1/task/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/target.common.tests.zip into memory 09:10:54 INFO - Content-Length response header: 62452303 09:10:54 INFO - Bytes received: 62452303 09:11:05 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:11:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/target.common.tests.zip 09:11:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:11:05 INFO - Fetch https://queue.taskcluster.net/v1/task/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/target.common.tests.zip into memory 09:11:06 INFO - Content-Length response header: 62452303 09:11:06 INFO - Bytes received: 62452303 09:11:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/target.talos.tests.zip 09:11:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:11:19 INFO - Fetch https://queue.taskcluster.net/v1/task/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/target.talos.tests.zip into memory 09:11:19 INFO - Content-Length response header: 14409411 09:11:19 INFO - Bytes received: 14409411 09:11: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')]} 09:11:20 INFO - trying https://queue.taskcluster.net/v1/task/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/target.tar.bz2 09:11:20 INFO - Downloading https://queue.taskcluster.net/v1/task/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:11:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:11:21 INFO - Downloaded 65039256 bytes. 09:11:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/target.tar.bz2 09:11:21 INFO - mkdir: /builds/slave/test/properties 09:11:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:11:21 INFO - Writing to file /builds/slave/test/properties/build_url 09:11:21 INFO - Contents: 09:11:21 INFO - build_url:https://queue.taskcluster.net/v1/task/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/target.tar.bz2 09:11:21 INFO - Running post-action listener: _resource_record_post_action 09:11:21 INFO - Running post-action listener: set_extra_try_arguments 09:11:21 INFO - [mozharness: 2017-05-12 16:11:21.242298Z] Finished download-and-extract step (success) 09:11:21 INFO - [mozharness: 2017-05-12 16:11:21.242395Z] Running populate-webroot step. 09:11:21 INFO - Running pre-action listener: _resource_record_pre_action 09:11:21 INFO - Running main action method: populate_webroot 09:11:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:11:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:11:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:11:21 INFO - '--tppagecycles', 09:11:21 INFO - '7'], 09:11:21 INFO - 'tests': ['tsvgm']}}, 09:11:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:11:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:11:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:11:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:11:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:11:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:11:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:11:21 INFO - 'talos_options': ['--disable-e10s'], 09:11:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:11:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:11:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:11:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:11:21 INFO - 'talos_options': ['--disable-e10s'], 09:11:21 INFO - 'tests': ['damp', 'tps']}, 09:11:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:11:21 INFO - 'tests': ['damp', 'tps']}, 09:11:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:11:21 INFO - 'tests': ['dromaeo_dom']}, 09:11:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:11:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:11:21 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:11:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:11:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:11:21 INFO - 'tests': ['a11yr', 09:11:21 INFO - 'ts_paint', 09:11:21 INFO - 'tpaint', 09:11:21 INFO - 'sessionrestore', 09:11:21 INFO - 'sessionrestore_no_auto_restore', 09:11:21 INFO - 'tabpaint']}, 09:11:21 INFO - 'other-e10s': {'tests': ['a11yr', 09:11:21 INFO - 'ts_paint', 09:11:21 INFO - 'tpaint', 09:11:21 INFO - 'sessionrestore', 09:11:21 INFO - 'sessionrestore_no_auto_restore', 09:11:21 INFO - 'tabpaint']}, 09:11:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:11:21 INFO - 'ts_paint', 09:11:21 INFO - 'tpaint', 09:11:21 INFO - 'sessionrestore', 09:11:21 INFO - 'sessionrestore_no_auto_restore', 09:11:21 INFO - 'tabpaint']}, 09:11:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:11:21 INFO - 'ts_paint', 09:11:21 INFO - 'tpaint', 09:11:21 INFO - 'sessionrestore', 09:11:21 INFO - 'sessionrestore_no_auto_restore', 09:11:21 INFO - 'tabpaint']}, 09:11:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:11:21 INFO - 'tests': ['a11yr', 09:11:21 INFO - 'ts_paint', 09:11:21 INFO - 'tpaint', 09:11:21 INFO - 'sessionrestore', 09:11:21 INFO - 'sessionrestore_no_auto_restore', 09:11:21 INFO - 'tabpaint']}, 09:11:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:11:21 INFO - 'tests': ['a11yr', 09:11:21 INFO - 'ts_paint', 09:11:21 INFO - 'tpaint', 09:11:21 INFO - 'sessionrestore', 09:11:21 INFO - 'sessionrestore_no_auto_restore', 09:11:21 INFO - 'tabpaint']}, 09:11:21 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:11:21 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:11:21 INFO - 'bloom_basic_ref']}, 09:11:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:11:21 INFO - 'tests': ['tsvgx', 09:11:21 INFO - 'tsvgr_opacity', 09:11:21 INFO - 'tart', 09:11:21 INFO - 'tscrollx', 09:11:21 INFO - 'cart', 09:11:21 INFO - 'tsvg_static']}, 09:11:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:11:21 INFO - 'tsvgr_opacity', 09:11:21 INFO - 'tart', 09:11:21 INFO - 'tscrollx', 09:11:21 INFO - 'cart', 09:11:21 INFO - 'tsvg_static']}, 09:11:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:11:21 INFO - 'talos_options': ['--disable-e10s'], 09:11:21 INFO - 'tests': ['tp5o']}, 09:11:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:11:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:11:21 INFO - 'talos_options': ['--disable-e10s', 09:11:21 INFO - '--xperf_path', 09:11:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:11:21 INFO - 'tests': ['tp5n']}, 09:11:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:11:21 INFO - 'talos_options': ['--xperf_path', 09:11:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:11:21 INFO - 'tests': ['tp5n']}}, 09:11:21 INFO - 'talos.zip': {'path': '', 09:11:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:11:21 INFO - Running post-action listener: _resource_record_post_action 09:11:21 INFO - [mozharness: 2017-05-12 16:11:21.256161Z] Finished populate-webroot step (success) 09:11:21 INFO - [mozharness: 2017-05-12 16:11:21.256251Z] Running create-virtualenv step. 09:11:21 INFO - Running pre-action listener: _resource_record_pre_action 09:11:21 INFO - Running main action method: create_virtualenv 09:11:21 INFO - Creating virtualenv /builds/slave/test/build/venv 09:11:21 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 09:11:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:11:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:11:21 INFO - Using real prefix '/usr' 09:11:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:11:21 INFO - Installing distribute.............................................................................................................................................................................................done. 09:11:23 INFO - Installing pip.................done. 09:11:23 INFO - Return code: 0 09:11:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:11:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:11:24 INFO - Reading from file tmpfile_stdout 09:11:24 INFO - Output received: 09:11:24 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) 09:11:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:11:24 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')]} 09:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:24 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')]} 09:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:24 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 0x1b691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8a30>, '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 0x1ed97f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073', '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 09:11:24 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 09:11:24 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 09:11:24 INFO - Using env: {'DISPLAY': ':0', 09:11:24 INFO - 'HOME': '/home/cltbld', 09:11:24 INFO - 'LANG': 'en_US.UTF-8', 09:11:24 INFO - 'LANGUAGE': 'en_US:en', 09:11:24 INFO - 'LOGNAME': 'cltbld', 09:11:24 INFO - 'MAIL': '/var/mail/cltbld', 09:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:24 INFO - 'MOZ_NO_REMOTE': '1', 09:11:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:24 INFO - 'NO_EM_RESTART': '1', 09:11:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:24 INFO - 'PWD': '/builds/slave/test', 09:11:24 INFO - 'SHELL': '/bin/bash', 09:11:24 INFO - 'SHLVL': '1', 09:11:24 INFO - 'TERM': 'linux', 09:11:24 INFO - 'TMOUT': '86400', 09:11:24 INFO - 'USER': 'cltbld', 09:11:24 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073', 09:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:24 INFO - '_': '/tools/buildbot/bin/python'} 09:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:24 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 09:11:24 INFO - Cleaning up... 09:11:24 INFO - Return code: 0 09:11:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:11:24 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')]} 09:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:24 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')]} 09:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:24 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 0x1b691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8a30>, '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 0x1ed97f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073', '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 09:11:24 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 09:11:24 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 09:11:24 INFO - Using env: {'DISPLAY': ':0', 09:11:24 INFO - 'HOME': '/home/cltbld', 09:11:24 INFO - 'LANG': 'en_US.UTF-8', 09:11:24 INFO - 'LANGUAGE': 'en_US:en', 09:11:24 INFO - 'LOGNAME': 'cltbld', 09:11:24 INFO - 'MAIL': '/var/mail/cltbld', 09:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:24 INFO - 'MOZ_NO_REMOTE': '1', 09:11:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:24 INFO - 'NO_EM_RESTART': '1', 09:11:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:24 INFO - 'PWD': '/builds/slave/test', 09:11:24 INFO - 'SHELL': '/bin/bash', 09:11:24 INFO - 'SHLVL': '1', 09:11:24 INFO - 'TERM': 'linux', 09:11:24 INFO - 'TMOUT': '86400', 09:11:24 INFO - 'USER': 'cltbld', 09:11:24 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073', 09:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:24 INFO - '_': '/tools/buildbot/bin/python'} 09:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:24 INFO - Downloading/unpacking psutil>=3.1.1 09:11:24 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 09:11:24 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 09:11:24 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 09:11:24 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 09:11:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:11:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:11:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:11:25 INFO - Installing collected packages: psutil 09:11:25 INFO - Running setup.py install for psutil 09:11:25 INFO - building 'psutil._psutil_linux' extension 09:11:25 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 09:11:27 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 09:11:27 INFO - building 'psutil._psutil_posix' extension 09:11:27 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 09:11:27 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 09:11:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:11:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:11:27 INFO - Successfully installed psutil 09:11:27 INFO - Cleaning up... 09:11:27 INFO - Return code: 0 09:11:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:11:27 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')]} 09:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:27 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')]} 09:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:27 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 0x1b691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8a30>, '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 0x1ed97f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073', '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 09:11:27 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 09:11:27 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 09:11:27 INFO - Using env: {'DISPLAY': ':0', 09:11:27 INFO - 'HOME': '/home/cltbld', 09:11:27 INFO - 'LANG': 'en_US.UTF-8', 09:11:27 INFO - 'LANGUAGE': 'en_US:en', 09:11:27 INFO - 'LOGNAME': 'cltbld', 09:11:27 INFO - 'MAIL': '/var/mail/cltbld', 09:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:27 INFO - 'MOZ_NO_REMOTE': '1', 09:11:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:27 INFO - 'NO_EM_RESTART': '1', 09:11:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:27 INFO - 'PWD': '/builds/slave/test', 09:11:27 INFO - 'SHELL': '/bin/bash', 09:11:27 INFO - 'SHLVL': '1', 09:11:27 INFO - 'TERM': 'linux', 09:11:27 INFO - 'TMOUT': '86400', 09:11:27 INFO - 'USER': 'cltbld', 09:11:27 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073', 09:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:27 INFO - '_': '/tools/buildbot/bin/python'} 09:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:11: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 09:11: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 09:11: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 09:11: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 09:11:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:11:28 INFO - Installing collected packages: mozsystemmonitor 09:11:28 INFO - Running setup.py install for mozsystemmonitor 09:11:29 INFO - Successfully installed mozsystemmonitor 09:11:29 INFO - Cleaning up... 09:11:29 INFO - Return code: 0 09:11:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:11: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')]} 09:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11: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')]} 09:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8a30>, '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 0x1ed97f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073', '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 09:11: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==2.5.1'] in /builds/slave/test/build 09:11: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==2.5.1 09:11:29 INFO - Using env: {'DISPLAY': ':0', 09:11:29 INFO - 'HOME': '/home/cltbld', 09:11:29 INFO - 'LANG': 'en_US.UTF-8', 09:11:29 INFO - 'LANGUAGE': 'en_US:en', 09:11:29 INFO - 'LOGNAME': 'cltbld', 09:11:29 INFO - 'MAIL': '/var/mail/cltbld', 09:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:29 INFO - 'MOZ_NO_REMOTE': '1', 09:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:29 INFO - 'NO_EM_RESTART': '1', 09:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:29 INFO - 'PWD': '/builds/slave/test', 09:11:29 INFO - 'SHELL': '/bin/bash', 09:11:29 INFO - 'SHLVL': '1', 09:11:29 INFO - 'TERM': 'linux', 09:11:29 INFO - 'TMOUT': '86400', 09:11:29 INFO - 'USER': 'cltbld', 09:11:29 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073', 09:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:29 INFO - '_': '/tools/buildbot/bin/python'} 09:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:29 INFO - Downloading/unpacking jsonschema==2.5.1 09:11:29 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 09:11:29 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 09:11:29 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 09:11:29 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 09:11:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:11:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:11:30 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 09:11:30 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 09:11:30 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 09:11:30 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 09:11:30 INFO - Downloading functools32-3.2.3-2.tar.gz 09:11:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:11:30 INFO - warning: no files found matching '*.txt' 09:11:30 INFO - no previously-included directories found matching 'build' 09:11:30 INFO - no previously-included directories found matching 'dist' 09:11:30 INFO - no previously-included directories found matching '.git*' 09:11:30 INFO - Installing collected packages: jsonschema, functools32 09:11:30 INFO - Running setup.py install for functools32 09:11:30 INFO - warning: no files found matching '*.txt' 09:11:30 INFO - no previously-included directories found matching 'build' 09:11:30 INFO - no previously-included directories found matching 'dist' 09:11:30 INFO - no previously-included directories found matching '.git*' 09:11:30 INFO - Successfully installed jsonschema functools32 09:11:30 INFO - Cleaning up... 09:11:30 INFO - Return code: 0 09:11:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:11:30 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')]} 09:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:30 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')]} 09:11:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:30 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 0x1b691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8a30>, '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 0x1ed97f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073', '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 09:11:30 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 09:11:30 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 09:11:30 INFO - Using env: {'DISPLAY': ':0', 09:11:30 INFO - 'HOME': '/home/cltbld', 09:11:30 INFO - 'LANG': 'en_US.UTF-8', 09:11:30 INFO - 'LANGUAGE': 'en_US:en', 09:11:30 INFO - 'LOGNAME': 'cltbld', 09:11:30 INFO - 'MAIL': '/var/mail/cltbld', 09:11:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:30 INFO - 'MOZ_NO_REMOTE': '1', 09:11:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:30 INFO - 'NO_EM_RESTART': '1', 09:11:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:30 INFO - 'PWD': '/builds/slave/test', 09:11:30 INFO - 'SHELL': '/bin/bash', 09:11:30 INFO - 'SHLVL': '1', 09:11:30 INFO - 'TERM': 'linux', 09:11:30 INFO - 'TMOUT': '86400', 09:11:30 INFO - 'USER': 'cltbld', 09:11:30 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073', 09:11:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:30 INFO - '_': '/tools/buildbot/bin/python'} 09:11:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:11:30 INFO - Cleaning up... 09:11:30 INFO - Return code: 0 09:11:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:11:30 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')]} 09:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:30 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')]} 09:11:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:30 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 0x1b691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8a30>, '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 0x1ed97f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073', '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 09:11:30 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 09:11:30 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 09:11:30 INFO - Using env: {'DISPLAY': ':0', 09:11:30 INFO - 'HOME': '/home/cltbld', 09:11:30 INFO - 'LANG': 'en_US.UTF-8', 09:11:30 INFO - 'LANGUAGE': 'en_US:en', 09:11:30 INFO - 'LOGNAME': 'cltbld', 09:11:30 INFO - 'MAIL': '/var/mail/cltbld', 09:11:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:30 INFO - 'MOZ_NO_REMOTE': '1', 09:11:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:30 INFO - 'NO_EM_RESTART': '1', 09:11:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:30 INFO - 'PWD': '/builds/slave/test', 09:11:30 INFO - 'SHELL': '/bin/bash', 09:11:30 INFO - 'SHLVL': '1', 09:11:30 INFO - 'TERM': 'linux', 09:11:30 INFO - 'TMOUT': '86400', 09:11:30 INFO - 'USER': 'cltbld', 09:11:30 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073', 09:11:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:30 INFO - '_': '/tools/buildbot/bin/python'} 09:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:31 INFO - Downloading/unpacking blobuploader==1.2.4 09:11:31 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 09:11:31 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 09:11:31 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 09:11:31 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 09:11:32 INFO - Downloading blobuploader-1.2.4.tar.gz 09:11:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:11:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:11:32 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 09:11:32 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 09:11:32 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 09:11:32 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 09:11:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:11:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:11:32 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 09:11:32 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 09:11:32 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 09:11:32 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 09:11:32 INFO - Downloading docopt-0.6.1.tar.gz 09:11:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:11:32 INFO - Installing collected packages: blobuploader, requests, docopt 09:11:32 INFO - Running setup.py install for blobuploader 09:11:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:11:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:11:32 INFO - Running setup.py install for requests 09:11:33 INFO - Running setup.py install for docopt 09:11:33 INFO - Successfully installed blobuploader requests docopt 09:11:33 INFO - Cleaning up... 09:11:33 INFO - Return code: 0 09:11:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11:33 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')]} 09:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:33 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')]} 09:11:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:33 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 0x1b691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8a30>, '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 0x1ed97f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073', '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 09:11:33 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 09:11:33 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 09:11:33 INFO - Using env: {'DISPLAY': ':0', 09:11:33 INFO - 'HOME': '/home/cltbld', 09:11:33 INFO - 'LANG': 'en_US.UTF-8', 09:11:33 INFO - 'LANGUAGE': 'en_US:en', 09:11:33 INFO - 'LOGNAME': 'cltbld', 09:11:33 INFO - 'MAIL': '/var/mail/cltbld', 09:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:33 INFO - 'MOZ_NO_REMOTE': '1', 09:11:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:33 INFO - 'NO_EM_RESTART': '1', 09:11:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:33 INFO - 'PWD': '/builds/slave/test', 09:11:33 INFO - 'SHELL': '/bin/bash', 09:11:33 INFO - 'SHLVL': '1', 09:11:33 INFO - 'TERM': 'linux', 09:11:33 INFO - 'TMOUT': '86400', 09:11:33 INFO - 'USER': 'cltbld', 09:11:33 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073', 09:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:33 INFO - '_': '/tools/buildbot/bin/python'} 09:11:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:11:33 INFO - Running setup.py (path:/tmp/pip-5h8Fhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:11:33 INFO - Running setup.py (path:/tmp/pip-LkrfTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:11:33 INFO - Running setup.py (path:/tmp/pip-2kk4W2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:11:33 INFO - Running setup.py (path:/tmp/pip-WoT99q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:11:33 INFO - Running setup.py (path:/tmp/pip-JqHbRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:11:34 INFO - Running setup.py (path:/tmp/pip-j9cA8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:11:34 INFO - Running setup.py (path:/tmp/pip-IA4WGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:11:34 INFO - Running setup.py (path:/tmp/pip-dn1CM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:11:34 INFO - Running setup.py (path:/tmp/pip-AdvHeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:11:34 INFO - Running setup.py (path:/tmp/pip-3sTVXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:11:34 INFO - Running setup.py (path:/tmp/pip-WW1h9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:11:34 INFO - Running setup.py (path:/tmp/pip-X1dA3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:11:34 INFO - Running setup.py (path:/tmp/pip-Gdad6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:11:34 INFO - Running setup.py (path:/tmp/pip-3GxKpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:34 INFO - Running setup.py (path:/tmp/pip-tWuRpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:11:34 INFO - Running setup.py (path:/tmp/pip-NS32P_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:11:34 INFO - Running setup.py (path:/tmp/pip-hx41EL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:11:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:11:34 INFO - Running setup.py install for manifestparser 09:11:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:11:34 INFO - Running setup.py install for mozcrash 09:11:35 INFO - Running setup.py install for mozdebug 09:11:35 INFO - Running setup.py install for mozdevice 09:11:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:11:35 INFO - Running setup.py install for mozfile 09:11:35 INFO - Running setup.py install for mozhttpd 09:11:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:11:35 INFO - Running setup.py install for mozinfo 09:11:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:11:35 INFO - Running setup.py install for mozInstall 09:11:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:11:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:11:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:11:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:11:35 INFO - Running setup.py install for mozleak 09:11:35 INFO - Running setup.py install for mozlog 09:11:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:11:35 INFO - Running setup.py install for moznetwork 09:11:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:11:35 INFO - Running setup.py install for mozprocess 09:11:36 INFO - Running setup.py install for mozprofile 09:11:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:11:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:11:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:11:36 INFO - Running setup.py install for mozrunner 09:11:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:11:36 INFO - Running setup.py install for mozscreenshot 09:11:36 INFO - Running setup.py install for moztest 09:11:36 INFO - Running setup.py install for mozversion 09:11:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:11:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:11:36 INFO - Cleaning up... 09:11:36 INFO - Return code: 0 09:11:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:36 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 0x1b691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8a30>, '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 0x1ed97f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073', '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 09:11:36 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 09:11:36 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 09:11:36 INFO - Using env: {'DISPLAY': ':0', 09:11:36 INFO - 'HOME': '/home/cltbld', 09:11:36 INFO - 'LANG': 'en_US.UTF-8', 09:11:36 INFO - 'LANGUAGE': 'en_US:en', 09:11:36 INFO - 'LOGNAME': 'cltbld', 09:11:36 INFO - 'MAIL': '/var/mail/cltbld', 09:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:36 INFO - 'MOZ_NO_REMOTE': '1', 09:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:36 INFO - 'NO_EM_RESTART': '1', 09:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:36 INFO - 'PWD': '/builds/slave/test', 09:11:36 INFO - 'SHELL': '/bin/bash', 09:11:36 INFO - 'SHLVL': '1', 09:11:36 INFO - 'TERM': 'linux', 09:11:36 INFO - 'TMOUT': '86400', 09:11:36 INFO - 'USER': 'cltbld', 09:11:36 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073', 09:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:36 INFO - '_': '/tools/buildbot/bin/python'} 09:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:11:36 INFO - Running setup.py (path:/tmp/pip-qZxuFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:11:36 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)) 09:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:11:36 INFO - Running setup.py (path:/tmp/pip-IZ3VO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:11:37 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)) 09:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:11:37 INFO - Running setup.py (path:/tmp/pip-6H8FhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:11:37 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)) 09:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:11:37 INFO - Running setup.py (path:/tmp/pip-A8YO_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:11:37 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)) 09:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:11:37 INFO - Running setup.py (path:/tmp/pip-fmm8nR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:11:37 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)) 09:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:11:37 INFO - Running setup.py (path:/tmp/pip-cxRrQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:11:37 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)) 09:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:11:37 INFO - Running setup.py (path:/tmp/pip-0Pa7Ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:11:37 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)) 09:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:11:37 INFO - Running setup.py (path:/tmp/pip-UCh3nM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:11:37 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)) 09:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:11:37 INFO - Running setup.py (path:/tmp/pip-XXmDMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:11:37 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)) 09:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:11:37 INFO - Running setup.py (path:/tmp/pip-cK0DTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:11:37 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)) 09:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:11:37 INFO - Running setup.py (path:/tmp/pip-HBrylJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:11:37 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)) 09:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:11:37 INFO - Running setup.py (path:/tmp/pip-xXF8Pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:11:37 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)) 09:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:11:37 INFO - Running setup.py (path:/tmp/pip-96drML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:11:37 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)) 09:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:11:37 INFO - Running setup.py (path:/tmp/pip-TicTic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:11:37 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)) 09:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:37 INFO - Running setup.py (path:/tmp/pip-nfy4Um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:37 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)) 09:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:11:37 INFO - Running setup.py (path:/tmp/pip-jR1i1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:11:38 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)) 09:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:11:38 INFO - Running setup.py (path:/tmp/pip-W1XpYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:11:38 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)) 09:11:38 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)) 09:11:38 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)) 09:11:38 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)) 09:11:38 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)) 09:11:38 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)) 09:11:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:39 INFO - Downloading blessings-1.6.tar.gz 09:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:11:39 INFO - Installing collected packages: blessings 09:11:39 INFO - Running setup.py install for blessings 09:11:39 INFO - Successfully installed blessings 09:11:39 INFO - Cleaning up... 09:11:39 INFO - Return code: 0 09:11:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:11:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:11:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:11:39 INFO - Reading from file tmpfile_stdout 09:11:39 INFO - Current package versions: 09:11:39 INFO - argparse == 1.2.1 09:11:39 INFO - blessings == 1.6 09:11:39 INFO - blobuploader == 1.2.4 09:11:39 INFO - docopt == 0.6.1 09:11:39 INFO - functools32 == 3.2.3-2 09:11:39 INFO - jsonschema == 2.5.1 09:11:39 INFO - manifestparser == 1.1 09:11:39 INFO - mozInstall == 1.12 09:11:39 INFO - mozcrash == 1.0 09:11:39 INFO - mozdebug == 0.1 09:11:39 INFO - mozdevice == 0.50 09:11:39 INFO - mozfile == 1.2 09:11:39 INFO - mozhttpd == 0.7 09:11:39 INFO - mozinfo == 0.9 09:11:39 INFO - mozleak == 0.1 09:11:39 INFO - mozlog == 3.4 09:11:39 INFO - moznetwork == 0.27 09:11:39 INFO - mozprocess == 0.25 09:11:39 INFO - mozprofile == 0.28 09:11:39 INFO - mozrunner == 6.13 09:11:39 INFO - mozscreenshot == 0.1 09:11:39 INFO - mozsystemmonitor == 0.3 09:11:39 INFO - moztest == 0.8 09:11:39 INFO - mozversion == 1.4 09:11:39 INFO - psutil == 3.1.1 09:11:39 INFO - requests == 1.2.3 09:11:39 INFO - wsgiref == 0.1.2 09:11:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11:39 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')]} 09:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:39 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')]} 09:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:39 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 0x1b691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8a30>, '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 0x1ed97f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073', '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 09:11:39 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 09:11:39 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 09:11:39 INFO - Using env: {'DISPLAY': ':0', 09:11:39 INFO - 'HOME': '/home/cltbld', 09:11:39 INFO - 'LANG': 'en_US.UTF-8', 09:11:39 INFO - 'LANGUAGE': 'en_US:en', 09:11:39 INFO - 'LOGNAME': 'cltbld', 09:11:39 INFO - 'MAIL': '/var/mail/cltbld', 09:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:39 INFO - 'MOZ_NO_REMOTE': '1', 09:11:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:39 INFO - 'NO_EM_RESTART': '1', 09:11:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:39 INFO - 'PWD': '/builds/slave/test', 09:11:39 INFO - 'SHELL': '/bin/bash', 09:11:39 INFO - 'SHLVL': '1', 09:11:39 INFO - 'TERM': 'linux', 09:11:39 INFO - 'TMOUT': '86400', 09:11:39 INFO - 'USER': 'cltbld', 09:11:39 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073', 09:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:39 INFO - '_': '/tools/buildbot/bin/python'} 09:11:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:39 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)) 09:11:39 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)) 09:11:39 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)) 09:11:39 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)) 09:11:39 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)) 09:11:39 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)) 09:11:39 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)) 09:11:39 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)) 09:11:39 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)) 09:11:39 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)) 09:11:39 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)) 09:11:39 INFO - Cleaning up... 09:11:39 INFO - Return code: 0 09:11:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:11:39 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')]} 09:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:39 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')]} 09:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:39 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 0x1b691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1edb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8a30>, '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 0x1ed97f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073', '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 09:11:39 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 09:11:39 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 09:11:39 INFO - Using env: {'DISPLAY': ':0', 09:11:39 INFO - 'HOME': '/home/cltbld', 09:11:39 INFO - 'LANG': 'en_US.UTF-8', 09:11:39 INFO - 'LANGUAGE': 'en_US:en', 09:11:39 INFO - 'LOGNAME': 'cltbld', 09:11:39 INFO - 'MAIL': '/var/mail/cltbld', 09:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:39 INFO - 'MOZ_NO_REMOTE': '1', 09:11:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:39 INFO - 'NO_EM_RESTART': '1', 09:11:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:39 INFO - 'PWD': '/builds/slave/test', 09:11:39 INFO - 'SHELL': '/bin/bash', 09:11:39 INFO - 'SHLVL': '1', 09:11:39 INFO - 'TERM': 'linux', 09:11:39 INFO - 'TMOUT': '86400', 09:11:39 INFO - 'USER': 'cltbld', 09:11:39 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073', 09:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:39 INFO - '_': '/tools/buildbot/bin/python'} 09:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:11:40 INFO - Cleaning up... 09:11:40 INFO - Return code: 0 09:11:40 INFO - Running post-action listener: _resource_record_post_action 09:11:40 INFO - Running post-action listener: _start_resource_monitoring 09:11:40 INFO - Starting resource monitoring. 09:11:40 INFO - [mozharness: 2017-05-12 16:11:40.155417Z] Finished create-virtualenv step (success) 09:11:40 INFO - [mozharness: 2017-05-12 16:11:40.155877Z] Running install step. 09:11:40 INFO - Running pre-action listener: _resource_record_pre_action 09:11:40 INFO - Running main action method: install 09:11:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:11:40 INFO - Reading from file tmpfile_stdout 09:11:40 INFO - Detecting whether we're running mozinstall >=1.0... 09:11:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:11:40 INFO - Reading from file tmpfile_stdout 09:11:40 INFO - Output received: 09:11:40 INFO - Usage: mozinstall [options] installer 09:11:40 INFO - Options: 09:11:40 INFO - -h, --help show this help message and exit 09:11:40 INFO - -d DEST, --destination=DEST 09:11:40 INFO - Directory to install application into. [default: 09:11:40 INFO - "/builds/slave/test"] 09:11:40 INFO - --app=APP Application being installed. [default: firefox] 09:11:40 INFO - mkdir: /builds/slave/test/build/application 09:11:40 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'] 09:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:11:56 INFO - Reading from file tmpfile_stdout 09:11:56 INFO - Output received: 09:11:56 INFO - /builds/slave/test/build/application/firefox/firefox 09:11:56 INFO - Running post-action listener: _resource_record_post_action 09:11:56 INFO - [mozharness: 2017-05-12 16:11:56.787419Z] Finished install step (success) 09:11:56 INFO - [mozharness: 2017-05-12 16:11:56.787667Z] Running run-tests step. 09:11:56 INFO - Running pre-action listener: _resource_record_pre_action 09:11:56 INFO - Running main action method: run_tests 09:11:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:11:56 INFO - Python 2.7.3 09:11:56 INFO - Return code: 0 09:11:56 INFO - grabbing minidump binary from tooltool 09:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:56 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 0x1ed8a30>, '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 0x1ed97f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed9ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:11:56 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 09:11:56 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 09:11:56 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 09:11:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:11:56 INFO - Return code: 0 09:11:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:11:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:11:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:11:56 INFO - ENV: RUST_BACKTRACE is now 1 09:11:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:11:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:11:56 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/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 09:11:56 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/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 09:11:56 INFO - Using env: {'DISPLAY': ':0', 09:11:56 INFO - 'HOME': '/home/cltbld', 09:11:56 INFO - 'LANG': 'en_US.UTF-8', 09:11:56 INFO - 'LANGUAGE': 'en_US:en', 09:11:56 INFO - 'LOGNAME': 'cltbld', 09:11:56 INFO - 'MAIL': '/var/mail/cltbld', 09:11:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:11:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:56 INFO - 'MOZ_NO_REMOTE': '1', 09:11:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:56 INFO - 'NO_EM_RESTART': '1', 09:11:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:56 INFO - 'PWD': '/builds/slave/test', 09:11:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:11:56 INFO - 'RUST_BACKTRACE': '1', 09:11:56 INFO - 'SHELL': '/bin/bash', 09:11:56 INFO - 'SHLVL': '1', 09:11:56 INFO - 'TERM': 'linux', 09:11:56 INFO - 'TMOUT': '86400', 09:11:56 INFO - 'USER': 'cltbld', 09:11:56 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073', 09:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:56 INFO - '_': '/tools/buildbot/bin/python'} 09:11:56 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/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 09:11:57 INFO - mozversion application_buildid: 20170512140107 09:11:57 INFO - mozversion application_changeset: 1ec1d88637208098802e57d13db9033902e5a229 09:11:57 INFO - mozversion application_display_name: Nightly 09:11:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:11:57 INFO - mozversion application_name: Firefox 09:11:57 INFO - mozversion application_remotingname: firefox 09:11:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:11:57 INFO - mozversion application_vendor: Mozilla 09:11:57 INFO - mozversion application_version: 55.0a1 09:11:57 INFO - mozversion platform_buildid: 20170512140107 09:11:57 INFO - mozversion platform_changeset: 1ec1d88637208098802e57d13db9033902e5a229 09:11:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:11:57 INFO - mozversion platform_version: 55.0a1 09:11:57 INFO - using testdate: 1494605517 09:11:57 INFO - actual date: 1494605517 09:11:57 INFO - starting webserver on 'localhost:41146' 09:11:57 INFO - SUITE-START | Running 2 tests 09:11:57 INFO - TEST-START | dromaeo_css 09:11:57 INFO - operating with platform_type : linux_ 09:11:57 INFO - Initialising browser for dromaeo_css test... 09:11:57 INFO - TEST-INFO | started process 3322 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwoPOC2/profile http://localhost:41146/getInfo.html) 09:12:02 INFO - PID 3322 | __metrics Screen width/height:1600/1200 09:12:02 INFO - PID 3322 | colorDepth:24 09:12:02 INFO - PID 3322 | Browser inner width/height: 1024/695 09:12:02 INFO - PID 3322 | __metrics 09:12:04 INFO - TEST-INFO | 3322: exit 0 09:12:04 INFO - Browser initialized. 09:12:04 INFO - Running cycle 1/1 for dromaeo_css test... 09:12:04 INFO - TEST-INFO | started process 3518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwoPOC2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:12:16 INFO - PID 3518 | RSS: Main: 168034304 09:12:16 INFO - PID 3518 | 09:15:22 INFO - PID 3518 | Cycle 1(1): loaded http://localhost:41146/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41146/tests/dromaeo/cssquery-ext.html) 09:15:24 INFO - PID 3518 | RSS: Main: 184664064 09:15:24 INFO - PID 3518 | 09:18:25 INFO - PID 3518 | Cycle 1(1): loaded http://localhost:41146/tests/dromaeo/cssquery-ext.html (next: http://localhost:41146/tests/dromaeo/cssquery-jquery.html) 09:18:26 INFO - PID 3518 | RSS: Main: 180072448 09:18:26 INFO - PID 3518 | 09:21:28 INFO - PID 3518 | Cycle 1(1): loaded http://localhost:41146/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41146/tests/dromaeo/cssquery-mootools.html) 09:21:29 INFO - PID 3518 | RSS: Main: 191246336 09:21:29 INFO - PID 3518 | 09:24:30 INFO - PID 3518 | Cycle 1(1): loaded http://localhost:41146/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41146/tests/dromaeo/cssquery-prototype.html) 09:24:31 INFO - PID 3518 | RSS: Main: 182444032 09:24:31 INFO - PID 3518 | 09:27:34 INFO - PID 3518 | Cycle 1(1): loaded http://localhost:41146/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41146/tests/dromaeo/cssquery-yui.html) 09:27:35 INFO - PID 3518 | RSS: Main: 186269696 09:27:35 INFO - PID 3518 | 09:30:37 INFO - PID 3518 | Cycle 1(1): loaded http://localhost:41146/tests/dromaeo/cssquery-yui.html (next: http://localhost:41146/tests/dromaeo/cssquery-dojo.html) 09:30:37 INFO - PID 3518 | RSS: Main: 190996480 09:30:37 INFO - PID 3518 | 09:30:37 INFO - PID 3518 | __start_tp_report 09:30:37 INFO - PID 3518 | _x_x_mozilla_page_load 09:30:37 INFO - PID 3518 | _x_x_mozilla_page_load_details 09:30:37 INFO - PID 3518 | |i|pagename|runs| 09:30:37 INFO - PID 3518 | |0;dojo.html;2733.7402946720063;2747.917562473124;2762.848043357616;2788.302924268932;2794.88820447182;5138.383393992726;5303.204519322098;5310.468953104688;5332.093544097508;5349.5185433311;5216.26972223889;5242.161254199329;5255.237990491377;5320.042392369372;5361.0618141825125;4673.462551806551;4693.71837689738;4722.362481065046;4740.525947405249;4743.501932297111;4749.7387643679585;4793.9280910786365;4818.012307476959;4819.542143496362;4828.130936431441;4562.634989200856;4598.793054312564;4609.331646911212;4649.976750116261;4721.008588196483;4721.268203428474;4736.407949006374;4736.64475164364;4752.667313288071;4784.282357646346;4666.603338716213;4690.69510481821;4706.858794236178;4717.315989181549;4734.573888350065;5071.7210553419545;5139.794408223666;5143.897122057575;5272.710000949946;5279.41926388097;5583.106702927512;5593.133064375028;5597.104463285896;5598.972005139948;5599.188117722907;5609.3268807742925;5621.887562248732;5627.971860140714;5632.549396048306;5637.71811409432;5212.087884620177;5247.580193584504;5329.973350133225;5334.14653655421;5344.011357898801;5825.38833422493;5858.970705146447;5859.5019423349495;5881.264841894763;5943.494802941712;5441.646292990943;5475.06923822951;5510.972445137749;5519.144532597454;5619.662820230799;5701.9736447439855;5746.712664366765;5750.769969201185;5759.971200144057;5765.654060756284;5475;5533.7786488540005;5543.445655434424;5694.772209111672;5716.771329146787;5586.329640443173;5596.664200148004;5598.272224610856;5603.411641777636;5610.158476228598;4714.528547145258;4729.983053643483;4755.476897541268;4762.880927976759;4768.47546769855;4103.610157035137;4131.669466442678;4173.499180098408;4176.0395109125075;4176.83292668296;4897.95102048975;4914.631402644816;4926.852194434173;4932.728699921467;4934.703917764946;5745.425457454221;5798.391168927286;5809.7095145242565;5812.505936995402;5840.8539786504825;4857.319975203474;4869.513048695102;4880.219164933594;4886.731229782396;4930.975345123252;4940.6788558743565;5006;5014.548690617862;5018.3476148101245;5136.768845401966;5216.478352164753;5220.608454365938;5235.3717553893775;5236.162214045735;5238.97380513095;5603.747831347518;5606.299212598426;5611.943880561143;5628.634138780966;5740.253767010262;5356.1697936819855;5408.188771684278;5414.404415514369;5429.918551221655;5433.212184233185;5632.690202038927;5641.407652196624;5663.915041274467;5676.574256930664;5678.0915053591225;5530.972345138249;5753.597248192586;5768.798092066758;5781;5787.189793429007;5442.945570544244;5470.288862447856;5525.060739674184;5533.335999680065;5573.247611572386;5488.067028605067;5519.641223320471;5523.751431185526;5528.86177845541;5536.667799932017;5297.073012222769;5447.836564903059;5471.671699698031;5476.80831170923;5506.063969125178;5513.58648101386;5582.748776304995;5625.353084395347;5636.267285252891;5653.547716182778;5371.435999220182;5379.67721936685;5391.7034563099405;5417.458254174709;5419.485148910847 09:30:37 INFO - PID 3518 | |1;ext.html;622.7944778223186;643.5173619785161;670.9731610735571;1178.1340714574785;1191.31499387852;33641.32717345655;34525.82737086311;34579.13552161197;34628.48057279143;34708.30583388331;32123.83938080312;32547.51178732321;32608.67391326086;32658.346833063326;32678.67321326786;6401.327860574643;6420.101185833975;6963.2688567700425;6973.930260697404;6976.5465244758925;6923.723051077951;6988.056612357343;7000.964995175017;7004.194517630462;7016.122984626922;6981.057557229785;6982.7905162844945;7025.156981162268;7031.156261248631;7043.084399028145;6934.653267336613;6954.687039083254;6957.060796792444;6972.79081627552;7006.1592608887;6808.829779255509;6827.249002609709;6841.521093523455;6842.110525631686;6855.862882742317;31214.53178202329;31818;31841.84079079613;31866.840665796753;31910;2972.5689774982507;2981.344104297051;2992.7007299270117;2995.41589390069;3006.383691343269;24108;24200.757992420025;24249.878750606134;24265.87867060671;24290.149844755524;3066.080175947207;3100.534919762031;3101.4727496325677;3116.4234616595777;3137.670544592808;137609;137777;138034;151672.2416387922;154479.22760386238;38467.42298865519;38613.613863861;38686.613133868865;38733.612663873566;38912.80543597264;39877.60122398739;39984.400233996515;40021.59978400237;40189;40198.79900600478;12099.274043557414;12286.201396909173;12325.630231093082;12389.504419823106;12467.5012999479;9764.804703905882;9832.655857044969;9900.950495247478;9949.801003980025;9954;12576.81134782979;12701.809472857914;12776.361181940865;12849.871501285055;12859.292738899263;5331.253624492574;5440.537554307928;5451.591130665216;5457.372402173722;5474.507294343449;845.2012847858714;887.6981826179001;900.2123142250531;905.9682911098212;914.5564401265381;20275.695864562043;21225.575488490143;21263.68104478434;21274.680879786814;21421.78578214198;987.3236832769576;989.1987490133015;1008.9545970431349;1015.1777060580953;1015.2284263959444;10744.194185436123;11154.721131971766;11162.497687604076;11195.39759192585;11316.773664526663;175588;175709;176320;176960;176973;40498;40734.130257625475;40756;40859.79570102131;40873.795631021654;1210.3706072842074;1250.7060840702427;1253.642711827125;1256.5350820196404;1256.7486502699496;19533.51166220799;19706.113224904628;19998;20602.896985514977;20883.53815232919;29161;29240.415191696473;29379.559306610845;29406.852965735034;29465.558016630195;145622;146300;146422;146943;147082;28529.857350713115;28631.856840715664;28683.282917926383;29805.701942980293;29955.400891982474;35197.424334837335;35293.47059794054;35608.109797255274;35630;35677.64322356847;25851.22446326613;26890;27012.59481107824;27833;28150.2962425941;26677.466450671265;26842.731572684024;27363.58954615722;28618.57072143878;28669.28326791847;29400.55899161557;29606.407871842872;29896.402071958004;29926.401471970003;30546.389072218877;26922.32694182661;27373.589396158673;27562.5865612012;27661.446771064868;28405.289867753472;21101.472463188544;22758.317250482512;22758.886205568866;22781.658275126218;22816.65775013343 09:30:37 INFO - PID 3518 | |2;jquery.html;401.45602708330193;402.4446264155465;417.6429153074122;438.8003458426416;439.76252823475323;11654.883451165486;13613.931930340334;17313.82686173138;17780.64438711225;17944.91027544862;18257.36099236527;18350.1742421591;18662.160202790874;19414.126364313604;19728.112234949425;5417.539509141718;5500.762328476101;5589.8602534936745;5593.524550413199;5602.915956260659;5287.629865909388;5485.369182543998;5508.779648814043;5517.36550296717;5527.032769265383;5307.601929855257;5471.616986810925;5474.863128421782;5514.531264842493;5531.25328080708;5429.809956651498;5463.071277882769;5480.808171713991;5485.451454854522;5497.147942068986;4728.385309909724;4829.710217386968;4969.552740253358;4972.676776009548;4973.278874563168;22282.55434891293;22324.88837555818;22334.441638958993;22484.775152248432;22598.096076156933;1643.531593495848;1682.0664531185187;1690.112690837308;1702.174445393983;1707.5474999125242;14632;14957.775633365509;15221.467248646244;15348.386064557404;15500.922495387564;2056.434480517855;2101.2015434134933;2113.6618141097506;2117.523557199633;2125.543008253233;91863.54068229617;97322.51338743331;97843;98185.50907245418;98278;10926.617568385227;10985.539555040137;11136.665900023012;11356.716082098013;11616.186866919235;15753.842461575467;15930.283137258852;15959.68080638404;15966;15969.680606387807;7597.430192735567;7635.160132385433;7821.530708157528;7867.488613240121;7886.605669716491;7010.544314619636;7046.541974771623;7081.167532986847;7227.205007449176;7229.638518074075;6958.130233720785;7076.964615176994;7088.432925365958;7170.984046363898;7297.890531641923;2082.7917208279355;2107.3783233946024;2111.440468275908;2132.221739065261;2219.889005549748;855.4311382930282;892.9910700892908;894.3024440936081;907.832051070554;924.0297687428174;16947.576310592332;17397.867629049462;17670.469885903443;17924.372646957294;18163.36428225006;890.8708237305684;897.4121950122681;905.6558507767006;912.9497877616794;919.7884486567993;9378.90621093794;9605.231581473465;9833.557489912972;9948.408254679216;10023.899761002442;358701;358978;363699;364903;367288;73943.26056739471;75402.24597753953;75767;75829;76428.2357176421;1051.810674078658;1066.498745589587;1089.373610174153;1099.7580532282884;1100.2188446203124;14694.265286735834;14848.480303189337;15038.54884353471;15189.92405038012;15679.372825086868;38390.23219535538;38395.42406863955;39112.6088739109;39643.603563965145;40622.59377406188;51582.74208628933;51754.482455176476;51762;51838.740806295726;54706.45293547014;8003.6798528058225;8036.357091432555;8083.151269116658;8261.256486916207;8358.122397148212;13320.134191277535;13405.865941340851;13455.46178152902;13483.191008539126;13545.458181672622;10883.183761218099;10978.451077446256;11049.5027723751;11135.276207046516;11290.209685321948;10686.25196236256;10740.248182627141;10789.244752867224;10825;10928.180386470887;11332;11382.14633902444;11501.48243329069;11795;11842.82235766447;8132.26675193975;8201.876971845308;8348.958255208929;8394.244517993166;8431.578421079044;11015.173861960546;11070.667879963614;11365.261258018203;11414.828777568177;11555.653330400102 09:30:37 INFO - PID 3518 | |3;mootools.html;1230.206516796666;1302.3943866102265;1312.7702652035898;1313.8160657507947;1315.6908126590245;10144.391336519813;10513.73715657109;10601.469926503672;10636.042756151945;10669.573217071307;10563.683089507307;10722.748222873206;10727.892721072787;10732.946335268332;10749.731256718585;2277.0436416704983;2303.1593468384003;2305.262316058862;2306.884655767213;2316.3745788637057;2212.9557408851815;2287.7597852225526;2287.897044632987;2289.8740569268766;2293.7247530296386;2190.9890450547723;2195.4291884110166;2207.3598656389627;2223.9332820015425;2262.438917147171;2050.2106688924723;2125.532382875765;2138.893055347234;2148.6669566217183;2150.129197674936;2075.616011037948;2205.547862688145;2217.1242359268;2218.3566765637947;2222.6666000100113;10124.240681948882;10147.797044059078;10199.235057370654;10218.591256349737;10234.692959211236;5465.890682186334;5683.3464151622675;5686.601937864351;5693.800716974927;5703.08750599902;3243.221626809572;3439.5872495300473;3459.3427248822895;3484.581850177995;3510.6840384365273;1041.6146025970363;1079.7786453777035;1086.7989421956963;1146.3064845768274;1155.3125890095464;15039.323230454547;15112.622184445367;15271.694566108727;15319.310631021519;15366.385344586202;4726.1492931272705;4800.231962885991;5034.395872495251;5092.083424983464;5123.769430375642;11066.833997490045;11068.3912384818;11068.889311106946;11080.722981925517;11092.33445993243;5722.484976352148;5734.340550836624;5745.13822926556;5745.425457454221;5751.424857514216;4867.878303042452;5035.823746168867;5111.8722031948755;5114.974425127925;5180.9740951295;3823.7705737655274;3896.1818018215927;3904.3362628353248;3996.100877302642;4026.1947610478023;1065.5737704918095;1072.9302595331278;1081.0324759340347;1082.2532452607675;1082.832161015044;669.5112567825514;688.8725585766649;693.5769180799708;704.8132244954988;713.4292565947325;5185.948140518622;5229.50319719626;5259.8422047338645;5444.6188766785945;5488.835334939959;550.6365798572923;558.522463293886;561.1918836874887;562.4572287742349;568.5707290995272;3432.9656703433147;3601.1177261571083;3636.99982504808;3655.7989310588173;3768.679662228741;13066.738665226832;13445.596632101053;13684.86315136836;13693.931530342485;13753.312334383241;13053.412596433183;13244.072914896058;13446.865531344562;13462.932685336511;13550.119242249222;7358.080239970004;7446.292602202782;7628;7655.119661239029;7670.923290767021;5481.862953426037;5489.204065410573;5559.52744016747;5569.66582005081;5589.832305030855;11994.460249288977;12114.575989840314;12172.45223964906;12180.939095304468;12194.329311887932;11780.52877884875;12130.150889437655;12248.142630015813;12349;12360.567380141652;8473.449225800303;8500.404971651926;8673.392862499564;8674.349423793115;8698.91301086981;9738;9746.463944483121;9838.950805245928;9850.359726617748;9857.556409961713;8262.586870656563;8294.087650358335;8310.750677479686;8415.873761893454;8542.572871356531;8141.837163256583;8153.510789352657;8200.671973121009;8337.166283371615;8351.540665263468;7362.22696616869;7445.478816483011;7474.804031354957;7519.323260906544;7560.168381478143;5009.0733214354;5071;5131.8717032073;5148.948510514847;5184.118699820964;5193.636445448782;5287.920681189862;5297.973510132425;5324.733763311897;5328 09:30:37 INFO - PID 3518 | |4;prototype.html;379.4630597704249;381.5402440059727;385.0201237849672;388.99027524311896;390.1027636436197;5411.891762164754;5428.538574221191;5482.819964420632;5503.11950087986;5602.355729091156;5367.677939323643;5381.381141168767;5413.864653383657;5423.156126916848;5428.83713488595;4105.302098643223;4109.856155034575;4236.851710190144;4343.04453020335;4355.629771469429;4305.397244385788;4335.111302183061;4342.869713908572;4347.260965635849;4358.912821743564;4319.414885644907;4323.2218200723855;4328.523862375137;4331.5884990925815;4332.220200363933;4179.853705120307;4293.699441039129;4316.913661726763;4330.008196229738;4365.9126817463475;3935.5670876203594;3937.1928754605524;3938.3895496198134;3983.223271462066;3990.840366385341;5360.070374665117;5389.919151212695;5397.62216644835;5398.568114550826;5401.621886467949;4970.378702662168;5145.125328694131;5156.252343410222;5161.225816127573;5181.378234611833;5818.185454036438;5837;5843.883122337529;5860.384659610722;5870.913880932041;4447.288433850601;4449.154660614506;4456.064226512436;4457.108578284357;4465.82136714531;6102.115193296947;6128.877422451526;6152.477039451652;6182.165407669952;6197.96901015492;4545.704529205591;4592.288195329729;4592.839250626279;4596.172688916027;4610.700304480198;4654.418197725285;4666.929996050062;4668.883277918011;4672.486026537078;4682.367880336111;5064.164412871909;5118.488151184852;5145.665531740425;5156.458571849977;5163.948360516422;5787.594868359174;5809.838032393538;5817.476427121579;5828.504577110993;5828.59199856006;1582.786323846266;1599.5683862942833;1626.951191464258;1633.1344387474658;1633.575270429673;1109.8113320735495;1119.8544189255508;1141.594733869481;1144.1876267849752;1161.7676464707092;4989.525995030466;4990.251462280687;5021.271915572222;5041.69749815005;5075.593952483792;5935.6735379553675;5953.940460595425;5975.342712301644;5997.640141591519;6003.549733769984;4856.757162141878;4990.828989389554;5007.173816320339;5014.6991180529285;5035.866929940734;3171.5410910980745;3207.550942868;3208.1338038729414;3211.1169428407375;3213.6464988851208;5611.915821262684;5619.494245517923;5622.497988395125;5622.57830662702;5630.493255607015;5993.61041532299;5996.13056106862;6174.086033329592;6210.441060304594;6236.937630623635;5548.77804887808;5616.943830561642;5619.094729163192;5625.071863142617;5668.26312579362;5950.821475355746;5994.850128746816;6036.645708173904;6037.486813620892;6053.485453736305;5746.798862039808;5881.265026817014;5915.201447804491;5941.554383421174;5945.524358051432;5598.692071936082;5600.411956744646;5611.298587676541;5630.352509461464;5644.548436125018;4005.239004589119;4050.3519436889956;4062.8374865005067;4065.8170382332273;4070.61329173728;5995.310539288038;5995.970020149872;6006.3693312201585;6042.3655516170165;6050.2437195350585;5730.169125476866;5756.654600723802;5769.1634712967225;5772;5777.191193232867;5690.118031705092;5762.7694892203845;5764.538836893123;5769.624974376652;5800.419958004166;5690.715464226855;5700.971495142498;5710.543156547383;5718.3423906249645;5719.2279042328755;5651.943480565306;5827.358990510956;5836.270466191726;5844.327902291291;5851.122331650116;5657.603967722384;5694.231278777312;5709.942900570941;5721.313442386774;5722.713864306851 09:30:37 INFO - PID 3518 | |5;yui.html;739.5414842797467;752.1275320628072;758.2152472191283;776.4719990406521;778.6145857800387;12036.398180090993;12469.937650311736;12643.49426022959;12661.810072848903;13119.21284722915;15022.173780442072;15450.22748862558;15514.456994005212;15567.922160389211;15568.766468502954;889.8576227803553;904.8235594059161;906.3519583497798;908.0783005249676;908.3414524469773;920.0707285641516;928.1878356438117;930.4649826349876;932.2262522106636;934.4066517761237;969.903009699028;971.6987733802544;974.3325821812082;979.6424305128612;980.1325826643437;963.3449254506933;964.5322018820866;966.7099870038995;973.109604711688;974.0454354732367;713.2332742301994;713.864365770502;715.2168375628678;716.4232792602005;720.3660778514874;14508.927455362656;14527.70944581113;15244.390224391122;15302.158381289024;15353.616159595987;15631.140287284195;15938.362465501366;16189.595260118473;16190.75713864293;16249.756253656205;12500.562480313236;12560.246385216826;12592.118551701384;12699.301538415384;12821.935890320488;3029.772767042459;3034.180771191766;3055.740262077726;3056.587360706321;3059.7093276138953;70566;71062.2893771066;71559.64220178917;72527;73768;12509.249445033327;12590.622281331574;12688.302143382018;12701.428435720414;12784.424700888483;22633.981470833853;22862.42843928882;22958.885205573864;23045.193418230618;23099.3070207894;6045.576809623284;6173.56785025044;6178.443940045418;6193.380661933861;6200.81397558074;2875.4536638038708;2939.4415061138316;2943.249471384783;2946.764258859286;2950.9704902950693;3502.964970350315;3509.3332266869215;3511.894643160709;3559.43049112146;3571.607123216444;628.4752231886334;633.5470138850744;633.94294513494;634.7175506899478;641.8363317354139;585.6076428792634;607.7386723708847;611.458858909859;613.5919613457002;618.326024633152;9497.762555936019;9900;10002.599896004078;10064.899351006543;10628.36229826213;600.7566935391174;610.6854969690613;611.2176414189844;613.0405914743412;624.9718762655691;4301.268784306675;4349.521552629209;4374.846880359172;4402.3396490526675;4434.5343738907595;62003.689981550706;62036.68981655063;62564.68717656383;64003.35996640067;65168;54775.452245477834;55189.44810551924;55672.44327556754;56164.157537636966;56261.437385626436;48801.51198488041;49257.2611410822;49392.50607493879;50325.24512132248;50367;8169.468984515987;8428.915710842813;8534.359923005675;8645.135486451305;8683.609237584451;25940.740592593833;25959.091431799796;26432.339191520365;26786.866065670325;27498.45003099887;41723.37414938718;43266;43416.34875476807;43857.122857543305;44169.81622572907;13385.598432047054;13708.24604646754;13848.584542463743;14057.578272651837;14120.223387713364;14961.251937402869;15151;15459.304331305344;15681.843181568038;15835.287412066715;14549.781753273921;14659.193744344164;14678.559643210721;14728.55814325572;15104.244787760788;13653.385597647932;13754.243516606683;13841;13926.234057126956;15304.846951530788;13444.798328025283;13486.460541578226;14303;14319.284035798377;14550.781738273723;10006.44964526958;10126.59493620247;10299.227557933034;10415;10773.73065673333;10921.563137474412;11210.215284929976;11426.085913127095;11430.771384572428;11511.712207194887 09:30:37 INFO - PID 3518 | __end_tp_report 09:30:37 INFO - PID 3518 | __start_cc_report 09:30:37 INFO - PID 3518 | _x_x_mozilla_cycle_collect,345 09:30:37 INFO - PID 3518 | __end_cc_report 09:30:37 INFO - PID 3518 | __startTimestamp1494606637424__endTimestamp 09:30:37 INFO - PID 3518 | 09:30:37 INFO - PID 3518 | ------- Summary: start ------- 09:30:37 INFO - PID 3518 | Number of tests: 6 09:30:37 INFO - PID 3518 | 09:30:37 INFO - PID 3518 | [#0] dojo.html Cycles:165 Average:5199.99 Median:5371.44 stddev:598.34 (11.1%) stddev-sans-first:568.03 09:30:37 INFO - PID 3518 | Values: 2733.7 2747.9 2762.8 2788.3 2794.9 5138.4 5303.2 5310.5 5332.1 5349.5 5216.3 5242.2 5255.2 5320.0 5361.1 4673.5 4693.7 4722.4 4740.5 4743.5 4749.7 4793.9 4818.0 4819.5 4828.1 4562.6 4598.8 4609.3 4650.0 4721.0 4721.3 4736.4 4736.6 4752.7 4784.3 4666.6 4690.7 4706.9 4717.3 4734.6 5071.7 5139.8 5143.9 5272.7 5279.4 5583.1 5593.1 5597.1 5599.0 5599.2 5609.3 5621.9 5628.0 5632.5 5637.7 5212.1 5247.6 5330.0 5334.1 5344.0 5825.4 5859.0 5859.5 5881.3 5943.5 5441.6 5475.1 5511.0 5519.1 5619.7 5702.0 5746.7 5750.8 5760.0 5765.7 5475.0 5533.8 5543.4 5694.8 5716.8 5586.3 5596.7 5598.3 5603.4 5610.2 4714.5 4730.0 4755.5 4762.9 4768.5 4103.6 4131.7 4173.5 4176.0 4176.8 4898.0 4914.6 4926.9 4932.7 4934.7 5745.4 5798.4 5809.7 5812.5 5840.9 4857.3 4869.5 4880.2 4886.7 4931.0 4940.7 5006.0 5014.5 5018.3 5136.8 5216.5 5220.6 5235.4 5236.2 5239.0 5603.7 5606.3 5611.9 5628.6 5740.3 5356.2 5408.2 5414.4 5429.9 5433.2 5632.7 5641.4 5663.9 5676.6 5678.1 5531.0 5753.6 5768.8 5781.0 5787.2 5442.9 5470.3 5525.1 5533.3 5573.2 5488.1 5519.6 5523.8 5528.9 5536.7 5297.1 5447.8 5471.7 5476.8 5506.1 5513.6 5582.7 5625.4 5636.3 5653.5 5371.4 5379.7 5391.7 5417.5 5419.5 09:30:37 INFO - PID 3518 | 09:30:37 INFO - PID 3518 | [#1] ext.html Cycles:180 Average:29862.85 Median:16460.91 stddev:40287.53 (244.7%) stddev-sans-first:40340.71 09:30:37 INFO - PID 3518 | Values: 622.8 643.5 671.0 1178.1 1191.3 33641.3 34525.8 34579.1 34628.5 34708.3 32123.8 32547.5 32608.7 32658.3 32678.7 6401.3 6420.1 6963.3 6973.9 6976.5 6923.7 6988.1 7001.0 7004.2 7016.1 6981.1 6982.8 7025.2 7031.2 7043.1 6934.7 6954.7 6957.1 6972.8 7006.2 6808.8 6827.2 6841.5 6842.1 6855.9 31214.5 31818.0 31841.8 31866.8 31910.0 2972.6 2981.3 2992.7 2995.4 3006.4 24108.0 24200.8 24249.9 24265.9 24290.1 3066.1 3100.5 3101.5 3116.4 3137.7 137609.0 137777.0 138034.0 151672.2 154479.2 38467.4 38613.6 38686.6 38733.6 38912.8 39877.6 39984.4 40021.6 40189.0 40198.8 12099.3 12286.2 12325.6 12389.5 12467.5 9764.8 9832.7 9901.0 9949.8 9954.0 12576.8 12701.8 12776.4 12849.9 12859.3 5331.3 5440.5 5451.6 5457.4 5474.5 845.2 887.7 900.2 906.0 914.6 20275.7 21225.6 21263.7 21274.7 21421.8 987.3 989.2 1009.0 1015.2 1015.2 10744.2 11154.7 11162.5 11195.4 11316.8 175588.0 175709.0 176320.0 176960.0 176973.0 40498.0 40734.1 40756.0 40859.8 40873.8 1210.4 1250.7 1253.6 1256.5 1256.7 19533.5 19706.1 19998.0 20602.9 20883.5 29161.0 29240.4 29379.6 29406.9 29465.6 145622.0 146300.0 146422.0 146943.0 147082.0 28529.9 28631.9 28683.3 29805.7 29955.4 35197.4 35293.5 35608.1 35630.0 35677.6 25851.2 26890.0 27012.6 27833.0 28150.3 26677.5 26842.7 27363.6 28618.6 28669.3 29400.6 29606.4 29896.4 29926.4 30546.4 26922.3 27373.6 27562.6 27661.4 28405.3 21101.5 22758.3 22758.9 22781.7 22816.7 09:30:37 INFO - PID 3518 | 09:30:37 INFO - PID 3518 | [#2] jquery.html Cycles:180 Average:25021.62 Median:202839.12 stddev:60688.90 (29.9%) stddev-sans-first:60830.99 09:30:37 INFO - PID 3518 | Values: 401.5 402.4 417.6 438.8 439.8 11654.9 13613.9 17313.8 17780.6 17944.9 18257.4 18350.2 18662.2 19414.1 19728.1 5417.5 5500.8 5589.9 5593.5 5602.9 5287.6 5485.4 5508.8 5517.4 5527.0 5307.6 5471.6 5474.9 5514.5 5531.3 5429.8 5463.1 5480.8 5485.5 5497.1 4728.4 4829.7 4969.6 4972.7 4973.3 22282.6 22324.9 22334.4 22484.8 22598.1 1643.5 1682.1 1690.1 1702.2 1707.5 14632.0 14957.8 15221.5 15348.4 15500.9 2056.4 2101.2 2113.7 2117.5 2125.5 91863.5 97322.5 97843.0 98185.5 98278.0 10926.6 10985.5 11136.7 11356.7 11616.2 15753.8 15930.3 15959.7 15966.0 15969.7 7597.4 7635.2 7821.5 7867.5 7886.6 7010.5 7046.5 7081.2 7227.2 7229.6 6958.1 7077.0 7088.4 7171.0 7297.9 2082.8 2107.4 2111.4 2132.2 2219.9 855.4 893.0 894.3 907.8 924.0 16947.6 17397.9 17670.5 17924.4 18163.4 890.9 897.4 905.7 912.9 919.8 9378.9 9605.2 9833.6 9948.4 10023.9 358701.0 358978.0 363699.0 364903.0 367288.0 73943.3 75402.2 75767.0 75829.0 76428.2 1051.8 1066.5 1089.4 1099.8 1100.2 14694.3 14848.5 15038.5 15189.9 15679.4 38390.2 38395.4 39112.6 39643.6 40622.6 51582.7 51754.5 51762.0 51838.7 54706.5 8003.7 8036.4 8083.2 8261.3 8358.1 13320.1 13405.9 13455.5 13483.2 13545.5 10883.2 10978.5 11049.5 11135.3 11290.2 10686.3 10740.2 10789.2 10825.0 10928.2 11332.0 11382.1 11501.5 11795.0 11842.8 8132.3 8201.9 8349.0 8394.2 8431.6 11015.2 11070.7 11365.3 11414.8 11555.7 09:30:37 INFO - PID 3518 | 09:30:37 INFO - PID 3518 | [#3] mootools.html Cycles:180 Average:6343.96 Median:3555.90 stddev:4127.89 (116.1%) stddev-sans-first:4121.59 09:30:37 INFO - PID 3518 | Values: 1230.2 1302.4 1312.8 1313.8 1315.7 10144.4 10513.7 10601.5 10636.0 10669.6 10563.7 10722.7 10727.9 10732.9 10749.7 2277.0 2303.2 2305.3 2306.9 2316.4 2213.0 2287.8 2287.9 2289.9 2293.7 2191.0 2195.4 2207.4 2223.9 2262.4 2050.2 2125.5 2138.9 2148.7 2150.1 2075.6 2205.5 2217.1 2218.4 2222.7 10124.2 10147.8 10199.2 10218.6 10234.7 5465.9 5683.3 5686.6 5693.8 5703.1 3243.2 3439.6 3459.3 3484.6 3510.7 1041.6 1079.8 1086.8 1146.3 1155.3 15039.3 15112.6 15271.7 15319.3 15366.4 4726.1 4800.2 5034.4 5092.1 5123.8 11066.8 11068.4 11068.9 11080.7 11092.3 5722.5 5734.3 5745.1 5745.4 5751.4 4867.9 5035.8 5111.9 5115.0 5181.0 3823.8 3896.2 3904.3 3996.1 4026.2 1065.6 1072.9 1081.0 1082.3 1082.8 669.5 688.9 693.6 704.8 713.4 5185.9 5229.5 5259.8 5444.6 5488.8 550.6 558.5 561.2 562.5 568.6 3433.0 3601.1 3637.0 3655.8 3768.7 13066.7 13445.6 13684.9 13693.9 13753.3 13053.4 13244.1 13446.9 13462.9 13550.1 7358.1 7446.3 7628.0 7655.1 7670.9 5481.9 5489.2 5559.5 5569.7 5589.8 11994.5 12114.6 12172.5 12180.9 12194.3 11780.5 12130.2 12248.1 12349.0 12360.6 8473.4 8500.4 8673.4 8674.3 8698.9 9738.0 9746.5 9839.0 9850.4 9857.6 8262.6 8294.1 8310.8 8415.9 8542.6 8141.8 8153.5 8200.7 8337.2 8351.5 7362.2 7445.5 7474.8 7519.3 7560.2 5009.1 5071.0 5131.9 5148.9 5184.1 5193.6 5287.9 5298.0 5324.7 5328.0 09:30:37 INFO - PID 3518 | 09:30:37 INFO - PID 3518 | [#4] prototype.html Cycles:180 Average:4866.59 Median:5400.10 stddev:1369.81 (25.4%) stddev-sans-first:1331.60 09:30:37 INFO - PID 3518 | Values: 379.5 381.5 385.0 389.0 390.1 5411.9 5428.5 5482.8 5503.1 5602.4 5367.7 5381.4 5413.9 5423.2 5428.8 4105.3 4109.9 4236.9 4343.0 4355.6 4305.4 4335.1 4342.9 4347.3 4358.9 4319.4 4323.2 4328.5 4331.6 4332.2 4179.9 4293.7 4316.9 4330.0 4365.9 3935.6 3937.2 3938.4 3983.2 3990.8 5360.1 5389.9 5397.6 5398.6 5401.6 4970.4 5145.1 5156.3 5161.2 5181.4 5818.2 5837.0 5843.9 5860.4 5870.9 4447.3 4449.2 4456.1 4457.1 4465.8 6102.1 6128.9 6152.5 6182.2 6198.0 4545.7 4592.3 4592.8 4596.2 4610.7 4654.4 4666.9 4668.9 4672.5 4682.4 5064.2 5118.5 5145.7 5156.5 5163.9 5787.6 5809.8 5817.5 5828.5 5828.6 1582.8 1599.6 1627.0 1633.1 1633.6 1109.8 1119.9 1141.6 1144.2 1161.8 4989.5 4990.3 5021.3 5041.7 5075.6 5935.7 5953.9 5975.3 5997.6 6003.5 4856.8 4990.8 5007.2 5014.7 5035.9 3171.5 3207.6 3208.1 3211.1 3213.6 5611.9 5619.5 5622.5 5622.6 5630.5 5993.6 5996.1 6174.1 6210.4 6236.9 5548.8 5616.9 5619.1 5625.1 5668.3 5950.8 5994.9 6036.6 6037.5 6053.5 5746.8 5881.3 5915.2 5941.6 5945.5 5598.7 5600.4 5611.3 5630.4 5644.5 4005.2 4050.4 4062.8 4065.8 4070.6 5995.3 5996.0 6006.4 6042.4 6050.2 5730.2 5756.7 5769.2 5772.0 5777.2 5690.1 5762.8 5764.5 5769.6 5800.4 5690.7 5701.0 5710.5 5718.3 5719.2 5651.9 5827.4 5836.3 5844.3 5851.1 5657.6 5694.2 5709.9 5721.3 5722.7 09:30:37 INFO - PID 3518 | 09:30:37 INFO - PID 3518 | [#5] yui.html Cycles:180 Average:15464.89 Median:3535.66 stddev:18271.48 (516.8%) stddev-sans-first:18289.27 09:30:37 INFO - PID 3518 | Values: 739.5 752.1 758.2 776.5 778.6 12036.4 12469.9 12643.5 12661.8 13119.2 15022.2 15450.2 15514.5 15567.9 15568.8 889.9 904.8 906.4 908.1 908.3 920.1 928.2 930.5 932.2 934.4 969.9 971.7 974.3 979.6 980.1 963.3 964.5 966.7 973.1 974.0 713.2 713.9 715.2 716.4 720.4 14508.9 14527.7 15244.4 15302.2 15353.6 15631.1 15938.4 16189.6 16190.8 16249.8 12500.6 12560.2 12592.1 12699.3 12821.9 3029.8 3034.2 3055.7 3056.6 3059.7 70566.0 71062.3 71559.6 72527.0 73768.0 12509.2 12590.6 12688.3 12701.4 12784.4 22634.0 22862.4 22958.9 23045.2 23099.3 6045.6 6173.6 6178.4 6193.4 6200.8 2875.5 2939.4 2943.2 2946.8 2951.0 3503.0 3509.3 3511.9 3559.4 3571.6 628.5 633.5 633.9 634.7 641.8 585.6 607.7 611.5 613.6 618.3 9497.8 9900.0 10002.6 10064.9 10628.4 600.8 610.7 611.2 613.0 625.0 4301.3 4349.5 4374.8 4402.3 4434.5 62003.7 62036.7 62564.7 64003.4 65168.0 54775.5 55189.4 55672.4 56164.2 56261.4 48801.5 49257.3 49392.5 50325.2 50367.0 8169.5 8428.9 8534.4 8645.1 8683.6 25940.7 25959.1 26432.3 26786.9 27498.5 41723.4 43266.0 43416.3 43857.1 44169.8 13385.6 13708.2 13848.6 14057.6 14120.2 14961.3 15151.0 15459.3 15681.8 15835.3 14549.8 14659.2 14678.6 14728.6 15104.2 13653.4 13754.2 13841.0 13926.2 15304.8 13444.8 13486.5 14303.0 14319.3 14550.8 10006.4 10126.6 10299.2 10415.0 10773.7 10921.6 11210.2 11426.1 11430.8 11511.7 09:30:37 INFO - PID 3518 | -------- Summary: end -------- 09:30:37 INFO - PID 3518 | 09:30:38 INFO - TEST-INFO | 3518: exit 0 09:30:38 INFO - TEST-OK | dromaeo_css | took 1121130ms 09:30:38 INFO - TEST-START | kraken 09:30:38 INFO - operating with platform_type : linux_ 09:30:38 INFO - Initialising browser for kraken test... 09:30:38 INFO - TEST-INFO | started process 3953 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSP0Wsm/profile http://localhost:41146/getInfo.html) 09:30:42 INFO - PID 3953 | __metrics Screen width/height:1600/1200 09:30:42 INFO - PID 3953 | colorDepth:24 09:30:42 INFO - PID 3953 | Browser inner width/height: 1024/695 09:30:42 INFO - PID 3953 | __metrics 09:30:44 INFO - TEST-INFO | 3953: exit 0 09:30:44 INFO - Browser initialized. 09:30:44 INFO - Running cycle 1/1 for kraken test... 09:30:44 INFO - TEST-INFO | started process 4143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSP0Wsm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:30:56 INFO - PID 4143 | RSS: Main: 168120320 09:30:56 INFO - PID 4143 | 09:30:58 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:41146/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41146/tests/kraken/driver.html?testName=audio-beat-detection) 09:30:59 INFO - PID 4143 | RSS: Main: 178413568 09:30:59 INFO - PID 4143 | 09:31:02 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:41146/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41146/tests/kraken/driver.html?testName=audio-dft) 09:31:03 INFO - PID 4143 | RSS: Main: 177647616 09:31:03 INFO - PID 4143 | 09:31:06 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:41146/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41146/tests/kraken/driver.html?testName=audio-fft) 09:31:06 INFO - PID 4143 | RSS: Main: 176005120 09:31:06 INFO - PID 4143 | 09:31:08 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:41146/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41146/tests/kraken/driver.html?testName=audio-oscillator) 09:31:09 INFO - PID 4143 | RSS: Main: 176951296 09:31:09 INFO - PID 4143 | 09:31:11 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:41146/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41146/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:31:12 INFO - PID 4143 | RSS: Main: 176492544 09:31:12 INFO - PID 4143 | 09:31:15 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:41146/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41146/tests/kraken/driver.html?testName=imaging-darkroom) 09:31:16 INFO - PID 4143 | RSS: Main: 179093504 09:31:16 INFO - PID 4143 | 09:31:19 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:41146/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41146/tests/kraken/driver.html?testName=imaging-desaturate) 09:31:20 INFO - PID 4143 | RSS: Main: 179064832 09:31:20 INFO - PID 4143 | 09:31:23 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:41146/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41146/tests/kraken/driver.html?testName=json-parse-financial) 09:31:23 INFO - PID 4143 | RSS: Main: 181399552 09:31:23 INFO - PID 4143 | 09:31:25 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:41146/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41146/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:31:26 INFO - PID 4143 | RSS: Main: 182620160 09:31:26 INFO - PID 4143 | 09:31:27 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:41146/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41146/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:31:28 INFO - PID 4143 | RSS: Main: 182816768 09:31:28 INFO - PID 4143 | 09:31:30 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:41146/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41146/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:31:31 INFO - PID 4143 | RSS: Main: 182833152 09:31:31 INFO - PID 4143 | 09:31:34 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:41146/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41146/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:31:34 INFO - PID 4143 | RSS: Main: 182358016 09:31:34 INFO - PID 4143 | 09:31:38 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:41146/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41146/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:31:38 INFO - PID 4143 | RSS: Main: 182726656 09:31:38 INFO - PID 4143 | 09:31:40 INFO - PID 4143 | Cycle 1(1): loaded http://localhost:41146/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41146/tests/kraken/driver.html?testName=ai-astar) 09:31:40 INFO - PID 4143 | RSS: Main: 184627200 09:31:40 INFO - PID 4143 | 09:31:40 INFO - PID 4143 | __start_tp_report 09:31:40 INFO - PID 4143 | _x_x_mozilla_page_load 09:31:40 INFO - PID 4143 | _x_x_mozilla_page_load_details 09:31:40 INFO - PID 4143 | |i|pagename|runs| 09:31:40 INFO - PID 4143 | |0;ai-astar;103;112;113;112;112;112;112;112;111;112 09:31:40 INFO - PID 4143 | |1;audio-beat-detection;150;123;121;162;122;126;124;126;152;122 09:31:40 INFO - PID 4143 | |2;audio-dft;166;166;165;164;168;179;163;162;163;161 09:31:40 INFO - PID 4143 | |3;audio-fft;75;77;75;110;75;75;75;75;91;75 09:31:40 INFO - PID 4143 | |4;audio-oscillator;83;83;109;84;84;83;99;84;84;104 09:31:40 INFO - PID 4143 | |5;imaging-gaussian-blur;115;114;114;115;114;115;115;118;121;116 09:31:40 INFO - PID 4143 | |6;imaging-darkroom;152;154;152;149;150;151;150;150;150;150 09:31:40 INFO - PID 4143 | |7;imaging-desaturate;94;96;94;94;94;94;95;95;94;94 09:31:40 INFO - PID 4143 | |8;json-parse-financial;54;56;54;55;58;57;56;56;63;56 09:31:40 INFO - PID 4143 | |9;json-stringify-tinderbox;55;55;56;56;56;58;55;59;55;56 09:31:40 INFO - PID 4143 | |10;stanford-crypto-aes;84;82;82;83;84;82;81;82;85;83 09:31:40 INFO - PID 4143 | |11;stanford-crypto-ccm;141;144;139;133;130;142;136;130;174;137 09:31:40 INFO - PID 4143 | |12;stanford-crypto-pbkdf2;192;200;209;192;191;190;182;194;204;185 09:31:40 INFO - PID 4143 | |13;stanford-crypto-sha256-iterative;72;74;76;75;74;73;76;74;75;73 09:31:40 INFO - PID 4143 | __end_tp_report 09:31:40 INFO - PID 4143 | __start_cc_report 09:31:40 INFO - PID 4143 | _x_x_mozilla_cycle_collect,827 09:31:40 INFO - PID 4143 | __end_cc_report 09:31:40 INFO - PID 4143 | __startTimestamp1494606700751__endTimestamp 09:31:40 INFO - PID 4143 | 09:31:40 INFO - PID 4143 | ------- Summary: start ------- 09:31:40 INFO - PID 4143 | Number of tests: 14 09:31:40 INFO - PID 4143 | 09:31:40 INFO - PID 4143 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.88 (2.6%) stddev-sans-first:0.50 09:31:40 INFO - PID 4143 | Values: 103.0 112.0 113.0 112.0 112.0 112.0 112.0 112.0 111.0 112.0 09:31:40 INFO - PID 4143 | 09:31:40 INFO - PID 4143 | [#1] audio-beat-detection Cycles:10 Average:132.80 Median:126.00 stddev:15.48 (12.3%) stddev-sans-first:15.11 09:31:40 INFO - PID 4143 | Values: 150.0 123.0 121.0 162.0 122.0 126.0 124.0 126.0 152.0 122.0 09:31:40 INFO - PID 4143 | 09:31:40 INFO - PID 4143 | [#2] audio-dft Cycles:10 Average:165.70 Median:165.50 stddev:5.12 (3.1%) stddev-sans-first:5.43 09:31:40 INFO - PID 4143 | Values: 166.0 166.0 165.0 164.0 168.0 179.0 163.0 162.0 163.0 161.0 09:31:40 INFO - PID 4143 | 09:31:40 INFO - PID 4143 | [#3] audio-fft Cycles:10 Average:80.30 Median:75.00 stddev:11.57 (15.4%) stddev-sans-first:12.11 09:31:40 INFO - PID 4143 | Values: 75.0 77.0 75.0 110.0 75.0 75.0 75.0 75.0 91.0 75.0 09:31:40 INFO - PID 4143 | 09:31:40 INFO - PID 4143 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:84.00 stddev:10.15 (12.1%) stddev-sans-first:10.48 09:31:40 INFO - PID 4143 | Values: 83.0 83.0 109.0 84.0 84.0 83.0 99.0 84.0 84.0 104.0 09:31:40 INFO - PID 4143 | 09:31:40 INFO - PID 4143 | [#5] imaging-gaussian-blur Cycles:10 Average:115.70 Median:115.00 stddev:2.21 (1.9%) stddev-sans-first:2.33 09:31:40 INFO - PID 4143 | Values: 115.0 114.0 114.0 115.0 114.0 115.0 115.0 118.0 121.0 116.0 09:31:40 INFO - PID 4143 | 09:31:40 INFO - PID 4143 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:150.50 stddev:1.48 (1.0%) stddev-sans-first:1.50 09:31:40 INFO - PID 4143 | Values: 152.0 154.0 152.0 149.0 150.0 151.0 150.0 150.0 150.0 150.0 09:31:40 INFO - PID 4143 | 09:31:40 INFO - PID 4143 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 09:31:40 INFO - PID 4143 | Values: 94.0 96.0 94.0 94.0 94.0 94.0 95.0 95.0 94.0 94.0 09:31:40 INFO - PID 4143 | 09:31:40 INFO - PID 4143 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.00 stddev:2.59 (4.6%) stddev-sans-first:2.59 09:31:40 INFO - PID 4143 | Values: 54.0 56.0 54.0 55.0 58.0 57.0 56.0 56.0 63.0 56.0 09:31:40 INFO - PID 4143 | 09:31:40 INFO - PID 4143 | [#9] json-stringify-tinderbox Cycles:10 Average:56.10 Median:56.00 stddev:1.37 (2.4%) stddev-sans-first:1.39 09:31:40 INFO - PID 4143 | Values: 55.0 55.0 56.0 56.0 56.0 58.0 55.0 59.0 55.0 56.0 09:31:40 INFO - PID 4143 | 09:31:40 INFO - PID 4143 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:1.23 (1.5%) stddev-sans-first:1.22 09:31:40 INFO - PID 4143 | Values: 84.0 82.0 82.0 83.0 84.0 82.0 81.0 82.0 85.0 83.0 09:31:40 INFO - PID 4143 | 09:31:40 INFO - PID 4143 | [#11] stanford-crypto-ccm Cycles:10 Average:140.60 Median:140.00 stddev:12.69 (9.1%) stddev-sans-first:13.45 09:31:40 INFO - PID 4143 | Values: 141.0 144.0 139.0 133.0 130.0 142.0 136.0 130.0 174.0 137.0 09:31:40 INFO - PID 4143 | 09:31:40 INFO - PID 4143 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.90 Median:193.00 stddev:8.29 (4.3%) stddev-sans-first:8.77 09:31:40 INFO - PID 4143 | Values: 192.0 200.0 209.0 192.0 191.0 190.0 182.0 194.0 204.0 185.0 09:31:40 INFO - PID 4143 | 09:31:40 INFO - PID 4143 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.20 Median:74.50 stddev:1.32 (1.8%) stddev-sans-first:1.13 09:31:40 INFO - PID 4143 | Values: 72.0 74.0 76.0 75.0 74.0 73.0 76.0 74.0 75.0 73.0 09:31:40 INFO - PID 4143 | -------- Summary: end -------- 09:31:40 INFO - PID 4143 | 09:31:41 INFO - TEST-INFO | 4143: exit 0 09:31:41 INFO - TEST-OK | kraken | took 63636ms 09:31:41 INFO - SUITE-END | took 1184s 09:31:42 INFO - Completed test suite (00:19:45) 09:31:42 INFO - javascript benchmark 09:31:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6760.580717343231, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2733.7402946720063, 2747.917562473124, 2762.848043357616, 2788.302924268932, 2794.88820447182, 5138.383393992726, 5303.204519322098, 5310.468953104688, 5332.093544097508, 5349.5185433311, 5216.26972223889, 5242.161254199329, 5255.237990491377, 5320.042392369372, 5361.0618141825125, 4673.462551806551, 4693.71837689738, 4722.362481065046, 4740.525947405249, 4743.501932297111, 4749.7387643679585, 4793.9280910786365, 4818.012307476959, 4819.542143496362, 4828.130936431441, 4562.634989200856, 4598.793054312564, 4609.331646911212, 4649.976750116261, 4721.008588196483, 4721.268203428474, 4736.407949006374, 4736.64475164364, 4752.667313288071, 4784.282357646346, 4666.603338716213, 4690.69510481821, 4706.858794236178, 4717.315989181549, 4734.573888350065, 5071.7210553419545, 5139.794408223666, 5143.897122057575, 5272.710000949946, 5279.41926388097, 5583.106702927512, 5593.133064375028, 5597.104463285896, 5598.972005139948, 5599.188117722907, 5609.3268807742925, 5621.887562248732, 5627.971860140714, 5632.549396048306, 5637.71811409432, 5212.087884620177, 5247.580193584504, 5329.973350133225, 5334.14653655421, 5344.011357898801, 5825.38833422493, 5858.970705146447, 5859.5019423349495, 5881.264841894763, 5943.494802941712, 5441.646292990943, 5475.06923822951, 5510.972445137749, 5519.144532597454, 5619.662820230799, 5701.9736447439855, 5746.712664366765, 5750.769969201185, 5759.971200144057, 5765.654060756284, 5475.0, 5533.7786488540005, 5543.445655434424, 5694.772209111672, 5716.771329146787, 5586.329640443173, 5596.664200148004, 5598.272224610856, 5603.411641777636, 5610.158476228598, 4714.528547145258, 4729.983053643483, 4755.476897541268, 4762.880927976759, 4768.47546769855, 4103.610157035137, 4131.669466442678, 4173.499180098408, 4176.0395109125075, 4176.83292668296, 4897.95102048975, 4914.631402644816, 4926.852194434173, 4932.728699921467, 4934.703917764946, 5745.425457454221, 5798.391168927286, 5809.7095145242565, 5812.505936995402, 5840.8539786504825, 4857.319975203474, 4869.513048695102, 4880.219164933594, 4886.731229782396, 4930.975345123252, 4940.6788558743565, 5006.0, 5014.548690617862, 5018.3476148101245, 5136.768845401966, 5216.478352164753, 5220.608454365938, 5235.3717553893775, 5236.162214045735, 5238.97380513095, 5603.747831347518, 5606.299212598426, 5611.943880561143, 5628.634138780966, 5740.253767010262, 5356.1697936819855, 5408.188771684278, 5414.404415514369, 5429.918551221655, 5433.212184233185, 5632.690202038927, 5641.407652196624, 5663.915041274467, 5676.574256930664, 5678.0915053591225, 5530.972345138249, 5753.597248192586, 5768.798092066758, 5781.0, 5787.189793429007, 5442.945570544244, 5470.288862447856, 5525.060739674184, 5533.335999680065, 5573.247611572386, 5488.067028605067, 5519.641223320471, 5523.751431185526, 5528.86177845541, 5536.667799932017, 5297.073012222769, 5447.836564903059, 5471.671699698031, 5476.80831170923, 5506.063969125178, 5513.58648101386, 5582.748776304995, 5625.353084395347, 5636.267285252891, 5653.547716182778, 5371.435999220182, 5379.67721936685, 5391.7034563099405, 5417.458254174709, 5419.485148910847], "value": 5157.416889813887, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.7944778223186, 643.5173619785161, 670.9731610735571, 1178.1340714574785, 1191.31499387852, 33641.32717345655, 34525.82737086311, 34579.13552161197, 34628.48057279143, 34708.30583388331, 32123.83938080312, 32547.51178732321, 32608.67391326086, 32658.346833063326, 32678.67321326786, 6401.327860574643, 6420.101185833975, 6963.2688567700425, 6973.930260697404, 6976.5465244758925, 6923.723051077951, 6988.056612357343, 7000.964995175017, 7004.194517630462, 7016.122984626922, 6981.057557229785, 6982.7905162844945, 7025.156981162268, 7031.156261248631, 7043.084399028145, 6934.653267336613, 6954.687039083254, 6957.060796792444, 6972.79081627552, 7006.1592608887, 6808.829779255509, 6827.249002609709, 6841.521093523455, 6842.110525631686, 6855.862882742317, 31214.53178202329, 31818.0, 31841.84079079613, 31866.840665796753, 31910.0, 2972.5689774982507, 2981.344104297051, 2992.7007299270117, 2995.41589390069, 3006.383691343269, 24108.0, 24200.757992420025, 24249.878750606134, 24265.87867060671, 24290.149844755524, 3066.080175947207, 3100.534919762031, 3101.4727496325677, 3116.4234616595777, 3137.670544592808, 137609.0, 137777.0, 138034.0, 151672.2416387922, 154479.22760386238, 38467.42298865519, 38613.613863861, 38686.613133868865, 38733.612663873566, 38912.80543597264, 39877.60122398739, 39984.400233996515, 40021.59978400237, 40189.0, 40198.79900600478, 12099.274043557414, 12286.201396909173, 12325.630231093082, 12389.504419823106, 12467.5012999479, 9764.804703905882, 9832.655857044969, 9900.950495247478, 9949.801003980025, 9954.0, 12576.81134782979, 12701.809472857914, 12776.361181940865, 12849.871501285055, 12859.292738899263, 5331.253624492574, 5440.537554307928, 5451.591130665216, 5457.372402173722, 5474.507294343449, 845.2012847858714, 887.6981826179001, 900.2123142250531, 905.9682911098212, 914.5564401265381, 20275.695864562043, 21225.575488490143, 21263.68104478434, 21274.680879786814, 21421.78578214198, 987.3236832769576, 989.1987490133015, 1008.9545970431349, 1015.1777060580953, 1015.2284263959444, 10744.194185436123, 11154.721131971766, 11162.497687604076, 11195.39759192585, 11316.773664526663, 175588.0, 175709.0, 176320.0, 176960.0, 176973.0, 40498.0, 40734.130257625475, 40756.0, 40859.79570102131, 40873.795631021654, 1210.3706072842074, 1250.7060840702427, 1253.642711827125, 1256.5350820196404, 1256.7486502699496, 19533.51166220799, 19706.113224904628, 19998.0, 20602.896985514977, 20883.53815232919, 29161.0, 29240.415191696473, 29379.559306610845, 29406.852965735034, 29465.558016630195, 145622.0, 146300.0, 146422.0, 146943.0, 147082.0, 28529.857350713115, 28631.856840715664, 28683.282917926383, 29805.701942980293, 29955.400891982474, 35197.424334837335, 35293.47059794054, 35608.109797255274, 35630.0, 35677.64322356847, 25851.22446326613, 26890.0, 27012.59481107824, 27833.0, 28150.2962425941, 26677.466450671265, 26842.731572684024, 27363.58954615722, 28618.57072143878, 28669.28326791847, 29400.55899161557, 29606.407871842872, 29896.402071958004, 29926.401471970003, 30546.389072218877, 26922.32694182661, 27373.589396158673, 27562.5865612012, 27661.446771064868, 28405.289867753472, 21101.472463188544, 22758.317250482512, 22758.886205568866, 22781.658275126218, 22816.65775013343], "value": 14377.55477222669, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.45602708330193, 402.4446264155465, 417.6429153074122, 438.8003458426416, 439.76252823475323, 11654.883451165486, 13613.931930340334, 17313.82686173138, 17780.64438711225, 17944.91027544862, 18257.36099236527, 18350.1742421591, 18662.160202790874, 19414.126364313604, 19728.112234949425, 5417.539509141718, 5500.762328476101, 5589.8602534936745, 5593.524550413199, 5602.915956260659, 5287.629865909388, 5485.369182543998, 5508.779648814043, 5517.36550296717, 5527.032769265383, 5307.601929855257, 5471.616986810925, 5474.863128421782, 5514.531264842493, 5531.25328080708, 5429.809956651498, 5463.071277882769, 5480.808171713991, 5485.451454854522, 5497.147942068986, 4728.385309909724, 4829.710217386968, 4969.552740253358, 4972.676776009548, 4973.278874563168, 22282.55434891293, 22324.88837555818, 22334.441638958993, 22484.775152248432, 22598.096076156933, 1643.531593495848, 1682.0664531185187, 1690.112690837308, 1702.174445393983, 1707.5474999125242, 14632.0, 14957.775633365509, 15221.467248646244, 15348.386064557404, 15500.922495387564, 2056.434480517855, 2101.2015434134933, 2113.6618141097506, 2117.523557199633, 2125.543008253233, 91863.54068229617, 97322.51338743331, 97843.0, 98185.50907245418, 98278.0, 10926.617568385227, 10985.539555040137, 11136.665900023012, 11356.716082098013, 11616.186866919235, 15753.842461575467, 15930.283137258852, 15959.68080638404, 15966.0, 15969.680606387807, 7597.430192735567, 7635.160132385433, 7821.530708157528, 7867.488613240121, 7886.605669716491, 7010.544314619636, 7046.541974771623, 7081.167532986847, 7227.205007449176, 7229.638518074075, 6958.130233720785, 7076.964615176994, 7088.432925365958, 7170.984046363898, 7297.890531641923, 2082.7917208279355, 2107.3783233946024, 2111.440468275908, 2132.221739065261, 2219.889005549748, 855.4311382930282, 892.9910700892908, 894.3024440936081, 907.832051070554, 924.0297687428174, 16947.576310592332, 17397.867629049462, 17670.469885903443, 17924.372646957294, 18163.36428225006, 890.8708237305684, 897.4121950122681, 905.6558507767006, 912.9497877616794, 919.7884486567993, 9378.90621093794, 9605.231581473465, 9833.557489912972, 9948.408254679216, 10023.899761002442, 358701.0, 358978.0, 363699.0, 364903.0, 367288.0, 73943.26056739471, 75402.24597753953, 75767.0, 75829.0, 76428.2357176421, 1051.810674078658, 1066.498745589587, 1089.373610174153, 1099.7580532282884, 1100.2188446203124, 14694.265286735834, 14848.480303189337, 15038.54884353471, 15189.92405038012, 15679.372825086868, 38390.23219535538, 38395.42406863955, 39112.6088739109, 39643.603563965145, 40622.59377406188, 51582.74208628933, 51754.482455176476, 51762.0, 51838.740806295726, 54706.45293547014, 8003.6798528058225, 8036.357091432555, 8083.151269116658, 8261.256486916207, 8358.122397148212, 13320.134191277535, 13405.865941340851, 13455.46178152902, 13483.191008539126, 13545.458181672622, 10883.183761218099, 10978.451077446256, 11049.5027723751, 11135.276207046516, 11290.209685321948, 10686.25196236256, 10740.248182627141, 10789.244752867224, 10825.0, 10928.180386470887, 11332.0, 11382.14633902444, 11501.48243329069, 11795.0, 11842.82235766447, 8132.26675193975, 8201.876971845308, 8348.958255208929, 8394.244517993166, 8431.578421079044, 11015.173861960546, 11070.667879963614, 11365.261258018203, 11414.828777568177, 11555.653330400102], "value": 8935.732252891505, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1230.206516796666, 1302.3943866102265, 1312.7702652035898, 1313.8160657507947, 1315.6908126590245, 10144.391336519813, 10513.73715657109, 10601.469926503672, 10636.042756151945, 10669.573217071307, 10563.683089507307, 10722.748222873206, 10727.892721072787, 10732.946335268332, 10749.731256718585, 2277.0436416704983, 2303.1593468384003, 2305.262316058862, 2306.884655767213, 2316.3745788637057, 2212.9557408851815, 2287.7597852225526, 2287.897044632987, 2289.8740569268766, 2293.7247530296386, 2190.9890450547723, 2195.4291884110166, 2207.3598656389627, 2223.9332820015425, 2262.438917147171, 2050.2106688924723, 2125.532382875765, 2138.893055347234, 2148.6669566217183, 2150.129197674936, 2075.616011037948, 2205.547862688145, 2217.1242359268, 2218.3566765637947, 2222.6666000100113, 10124.240681948882, 10147.797044059078, 10199.235057370654, 10218.591256349737, 10234.692959211236, 5465.890682186334, 5683.3464151622675, 5686.601937864351, 5693.800716974927, 5703.08750599902, 3243.221626809572, 3439.5872495300473, 3459.3427248822895, 3484.581850177995, 3510.6840384365273, 1041.6146025970363, 1079.7786453777035, 1086.7989421956963, 1146.3064845768274, 1155.3125890095464, 15039.323230454547, 15112.622184445367, 15271.694566108727, 15319.310631021519, 15366.385344586202, 4726.1492931272705, 4800.231962885991, 5034.395872495251, 5092.083424983464, 5123.769430375642, 11066.833997490045, 11068.3912384818, 11068.889311106946, 11080.722981925517, 11092.33445993243, 5722.484976352148, 5734.340550836624, 5745.13822926556, 5745.425457454221, 5751.424857514216, 4867.878303042452, 5035.823746168867, 5111.8722031948755, 5114.974425127925, 5180.9740951295, 3823.7705737655274, 3896.1818018215927, 3904.3362628353248, 3996.100877302642, 4026.1947610478023, 1065.5737704918095, 1072.9302595331278, 1081.0324759340347, 1082.2532452607675, 1082.832161015044, 669.5112567825514, 688.8725585766649, 693.5769180799708, 704.8132244954988, 713.4292565947325, 5185.948140518622, 5229.50319719626, 5259.8422047338645, 5444.6188766785945, 5488.835334939959, 550.6365798572923, 558.522463293886, 561.1918836874887, 562.4572287742349, 568.5707290995272, 3432.9656703433147, 3601.1177261571083, 3636.99982504808, 3655.7989310588173, 3768.679662228741, 13066.738665226832, 13445.596632101053, 13684.86315136836, 13693.931530342485, 13753.312334383241, 13053.412596433183, 13244.072914896058, 13446.865531344562, 13462.932685336511, 13550.119242249222, 7358.080239970004, 7446.292602202782, 7628.0, 7655.119661239029, 7670.923290767021, 5481.862953426037, 5489.204065410573, 5559.52744016747, 5569.66582005081, 5589.832305030855, 11994.460249288977, 12114.575989840314, 12172.45223964906, 12180.939095304468, 12194.329311887932, 11780.52877884875, 12130.150889437655, 12248.142630015813, 12349.0, 12360.567380141652, 8473.449225800303, 8500.404971651926, 8673.392862499564, 8674.349423793115, 8698.91301086981, 9738.0, 9746.463944483121, 9838.950805245928, 9850.359726617748, 9857.556409961713, 8262.586870656563, 8294.087650358335, 8310.750677479686, 8415.873761893454, 8542.572871356531, 8141.837163256583, 8153.510789352657, 8200.671973121009, 8337.166283371615, 8351.540665263468, 7362.22696616869, 7445.478816483011, 7474.804031354957, 7519.323260906544, 7560.168381478143, 5009.0733214354, 5071.0, 5131.8717032073, 5148.948510514847, 5184.118699820964, 5193.636445448782, 5287.920681189862, 5297.973510132425, 5324.733763311897, 5328.0], "value": 4712.338221784049, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.4630597704249, 381.5402440059727, 385.0201237849672, 388.99027524311896, 390.1027636436197, 5411.891762164754, 5428.538574221191, 5482.819964420632, 5503.11950087986, 5602.355729091156, 5367.677939323643, 5381.381141168767, 5413.864653383657, 5423.156126916848, 5428.83713488595, 4105.302098643223, 4109.856155034575, 4236.851710190144, 4343.04453020335, 4355.629771469429, 4305.397244385788, 4335.111302183061, 4342.869713908572, 4347.260965635849, 4358.912821743564, 4319.414885644907, 4323.2218200723855, 4328.523862375137, 4331.5884990925815, 4332.220200363933, 4179.853705120307, 4293.699441039129, 4316.913661726763, 4330.008196229738, 4365.9126817463475, 3935.5670876203594, 3937.1928754605524, 3938.3895496198134, 3983.223271462066, 3990.840366385341, 5360.070374665117, 5389.919151212695, 5397.62216644835, 5398.568114550826, 5401.621886467949, 4970.378702662168, 5145.125328694131, 5156.252343410222, 5161.225816127573, 5181.378234611833, 5818.185454036438, 5837.0, 5843.883122337529, 5860.384659610722, 5870.913880932041, 4447.288433850601, 4449.154660614506, 4456.064226512436, 4457.108578284357, 4465.82136714531, 6102.115193296947, 6128.877422451526, 6152.477039451652, 6182.165407669952, 6197.96901015492, 4545.704529205591, 4592.288195329729, 4592.839250626279, 4596.172688916027, 4610.700304480198, 4654.418197725285, 4666.929996050062, 4668.883277918011, 4672.486026537078, 4682.367880336111, 5064.164412871909, 5118.488151184852, 5145.665531740425, 5156.458571849977, 5163.948360516422, 5787.594868359174, 5809.838032393538, 5817.476427121579, 5828.504577110993, 5828.59199856006, 1582.786323846266, 1599.5683862942833, 1626.951191464258, 1633.1344387474658, 1633.575270429673, 1109.8113320735495, 1119.8544189255508, 1141.594733869481, 1144.1876267849752, 1161.7676464707092, 4989.525995030466, 4990.251462280687, 5021.271915572222, 5041.69749815005, 5075.593952483792, 5935.6735379553675, 5953.940460595425, 5975.342712301644, 5997.640141591519, 6003.549733769984, 4856.757162141878, 4990.828989389554, 5007.173816320339, 5014.6991180529285, 5035.866929940734, 3171.5410910980745, 3207.550942868, 3208.1338038729414, 3211.1169428407375, 3213.6464988851208, 5611.915821262684, 5619.494245517923, 5622.497988395125, 5622.57830662702, 5630.493255607015, 5993.61041532299, 5996.13056106862, 6174.086033329592, 6210.441060304594, 6236.937630623635, 5548.77804887808, 5616.943830561642, 5619.094729163192, 5625.071863142617, 5668.26312579362, 5950.821475355746, 5994.850128746816, 6036.645708173904, 6037.486813620892, 6053.485453736305, 5746.798862039808, 5881.265026817014, 5915.201447804491, 5941.554383421174, 5945.524358051432, 5598.692071936082, 5600.411956744646, 5611.298587676541, 5630.352509461464, 5644.548436125018, 4005.239004589119, 4050.3519436889956, 4062.8374865005067, 4065.8170382332273, 4070.61329173728, 5995.310539288038, 5995.970020149872, 6006.3693312201585, 6042.3655516170165, 6050.2437195350585, 5730.169125476866, 5756.654600723802, 5769.1634712967225, 5772.0, 5777.191193232867, 5690.118031705092, 5762.7694892203845, 5764.538836893123, 5769.624974376652, 5800.419958004166, 5690.715464226855, 5700.971495142498, 5710.543156547383, 5718.3423906249645, 5719.2279042328755, 5651.943480565306, 5827.358990510956, 5836.270466191726, 5844.327902291291, 5851.122331650116, 5657.603967722384, 5694.231278777312, 5709.942900570941, 5721.313442386774, 5722.713864306851], "value": 4453.140634711964, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.5414842797467, 752.1275320628072, 758.2152472191283, 776.4719990406521, 778.6145857800387, 12036.398180090993, 12469.937650311736, 12643.49426022959, 12661.810072848903, 13119.21284722915, 15022.173780442072, 15450.22748862558, 15514.456994005212, 15567.922160389211, 15568.766468502954, 889.8576227803553, 904.8235594059161, 906.3519583497798, 908.0783005249676, 908.3414524469773, 920.0707285641516, 928.1878356438117, 930.4649826349876, 932.2262522106636, 934.4066517761237, 969.903009699028, 971.6987733802544, 974.3325821812082, 979.6424305128612, 980.1325826643437, 963.3449254506933, 964.5322018820866, 966.7099870038995, 973.109604711688, 974.0454354732367, 713.2332742301994, 713.864365770502, 715.2168375628678, 716.4232792602005, 720.3660778514874, 14508.927455362656, 14527.70944581113, 15244.390224391122, 15302.158381289024, 15353.616159595987, 15631.140287284195, 15938.362465501366, 16189.595260118473, 16190.75713864293, 16249.756253656205, 12500.562480313236, 12560.246385216826, 12592.118551701384, 12699.301538415384, 12821.935890320488, 3029.772767042459, 3034.180771191766, 3055.740262077726, 3056.587360706321, 3059.7093276138953, 70566.0, 71062.2893771066, 71559.64220178917, 72527.0, 73768.0, 12509.249445033327, 12590.622281331574, 12688.302143382018, 12701.428435720414, 12784.424700888483, 22633.981470833853, 22862.42843928882, 22958.885205573864, 23045.193418230618, 23099.3070207894, 6045.576809623284, 6173.56785025044, 6178.443940045418, 6193.380661933861, 6200.81397558074, 2875.4536638038708, 2939.4415061138316, 2943.249471384783, 2946.764258859286, 2950.9704902950693, 3502.964970350315, 3509.3332266869215, 3511.894643160709, 3559.43049112146, 3571.607123216444, 628.4752231886334, 633.5470138850744, 633.94294513494, 634.7175506899478, 641.8363317354139, 585.6076428792634, 607.7386723708847, 611.458858909859, 613.5919613457002, 618.326024633152, 9497.762555936019, 9900.0, 10002.599896004078, 10064.899351006543, 10628.36229826213, 600.7566935391174, 610.6854969690613, 611.2176414189844, 613.0405914743412, 624.9718762655691, 4301.268784306675, 4349.521552629209, 4374.846880359172, 4402.3396490526675, 4434.5343738907595, 62003.689981550706, 62036.68981655063, 62564.68717656383, 64003.35996640067, 65168.0, 54775.452245477834, 55189.44810551924, 55672.44327556754, 56164.157537636966, 56261.437385626436, 48801.51198488041, 49257.2611410822, 49392.50607493879, 50325.24512132248, 50367.0, 8169.468984515987, 8428.915710842813, 8534.359923005675, 8645.135486451305, 8683.609237584451, 25940.740592593833, 25959.091431799796, 26432.339191520365, 26786.866065670325, 27498.45003099887, 41723.37414938718, 43266.0, 43416.34875476807, 43857.122857543305, 44169.81622572907, 13385.598432047054, 13708.24604646754, 13848.584542463743, 14057.578272651837, 14120.223387713364, 14961.251937402869, 15151.0, 15459.304331305344, 15681.843181568038, 15835.287412066715, 14549.781753273921, 14659.193744344164, 14678.559643210721, 14728.55814325572, 15104.244787760788, 13653.385597647932, 13754.243516606683, 13841.0, 13926.234057126956, 15304.846951530788, 13444.798328025283, 13486.460541578226, 14303.0, 14319.284035798377, 14550.781738273723, 10006.44964526958, 10126.59493620247, 10299.227557933034, 10415.0, 10773.73065673333, 10921.563137474412, 11210.215284929976, 11426.085913127095, 11430.771384572428, 11511.712207194887], "value": 6866.30711788948, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 113.0, 112.0, 112.0, 112.0, 112.0, 112.0, 111.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 121.0, 162.0, 122.0, 126.0, 124.0, 126.0, 152.0, 122.0], "value": 132.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 165.0, 164.0, 168.0, 179.0, 163.0, 162.0, 163.0, 161.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 110.0, 75.0, 75.0, 75.0, 75.0, 91.0, 75.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 109.0, 84.0, 84.0, 83.0, 99.0, 84.0, 84.0, 104.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 115.0, 114.0, 115.0, 115.0, 118.0, 121.0, 116.0], "value": 115.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 154.0, 152.0, 149.0, 150.0, 151.0, 150.0, 150.0, 150.0, 150.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 54.0, 55.0, 58.0, 57.0, 56.0, 56.0, 63.0, 56.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 56.0, 56.0, 58.0, 55.0, 59.0, 55.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 82.0, 83.0, 84.0, 82.0, 81.0, 82.0, 85.0, 83.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 144.0, 139.0, 133.0, 130.0, 142.0, 136.0, 130.0, 174.0, 137.0], "value": 140.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 200.0, 209.0, 192.0, 191.0, 190.0, 182.0, 194.0, 204.0, 185.0], "value": 193.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 76.0, 75.0, 74.0, 73.0, 76.0, 74.0, 75.0, 73.0], "value": 74.2, "unit": "score"}]}]} 09:31:42 INFO - Return code: 0 09:31:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:31:42 INFO - # TBPL SUCCESS # 09:31:42 INFO - Running post-action listener: _resource_record_post_action 09:31:42 INFO - [mozharness: 2017-05-12 16:31:42.532792Z] Finished run-tests step (success) 09:31:42 INFO - Running post-run listener: _resource_record_post_run 09:31:42 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 7749632; Write bytes: 386285568; Read time: 1764; Write time: 259236 09:31:42 INFO - TinderboxPrint: CPU usage
13.3% 09:31:42 INFO - TinderboxPrint: I/O read bytes / time
7,749,632 / 1,764 09:31:42 INFO - TinderboxPrint: I/O write bytes / time
386,285,568 / 259,236 09:31:42 INFO - TinderboxPrint: CPU idle
8,315.4 (86.7%) 09:31:42 INFO - TinderboxPrint: CPU user
1,220.4 (12.7%) 09:31:42 INFO - TinderboxPrint: Swap in / out
0 / 0 09:31:42 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 121077760; Read time: 60; Write time: 102748 09:31:42 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 5615616; Write bytes: 265207808; Read time: 1584; Write time: 156488 09:31:43 INFO - Running post-run listener: _upload_blobber_files 09:31:43 INFO - Blob upload gear active. 09:31:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:31:43 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 09:31:43 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'] 09:31:43 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 09:31:43 INFO - (blobuploader) - INFO - Open directory for files ... 09:31:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:31:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:31:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:44 INFO - (blobuploader) - INFO - Done attempting. 09:31:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:31:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:31:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:45 INFO - (blobuploader) - INFO - Done attempting. 09:31:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:31:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:31:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:54 INFO - (blobuploader) - INFO - Done attempting. 09:31:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:31:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:31:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:56 INFO - (blobuploader) - INFO - Done attempting. 09:31:56 INFO - (blobuploader) - INFO - Iteration through files over. 09:31:57 INFO - Return code: 0 09:31:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:31:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:31:57 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8276dd801dcd3dd755eb9d96051128f4e1c088ac77822e23a660d054e6a26e6666b3d10636e39aef18c0c7fadc265b7cf84be60fc5e5ecf87ec978d72e2cb574", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae51fe2b8dbff31a0311085aa6c5d921281ca2ebdc51f02088cbd64f4e3e8f96fcccfcd80300993c1efea9face5bc65317e02e479b85484c5ec7a4d43d394316", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb73719da52fd40c3b462c33b3109a098d8930b356ce9bbd18e58e3ed59fc7864317b5400254fcb9ef80d535c998a6e339f0fe10fde4c4d0fcb6b210bf4f0246", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6148bbe3b6950babe01dc76fbdf836a7018368bccf108b6d9ab1181833b69d4278376090fb9c654ea21bf6a0fddf194c243c9c9e62dde0abbc336bb73ee91031"} 09:31:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:31:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:31:57 INFO - Contents: 09:31:57 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8276dd801dcd3dd755eb9d96051128f4e1c088ac77822e23a660d054e6a26e6666b3d10636e39aef18c0c7fadc265b7cf84be60fc5e5ecf87ec978d72e2cb574", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae51fe2b8dbff31a0311085aa6c5d921281ca2ebdc51f02088cbd64f4e3e8f96fcccfcd80300993c1efea9face5bc65317e02e479b85484c5ec7a4d43d394316", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb73719da52fd40c3b462c33b3109a098d8930b356ce9bbd18e58e3ed59fc7864317b5400254fcb9ef80d535c998a6e339f0fe10fde4c4d0fcb6b210bf4f0246", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6148bbe3b6950babe01dc76fbdf836a7018368bccf108b6d9ab1181833b69d4278376090fb9c654ea21bf6a0fddf194c243c9c9e62dde0abbc336bb73ee91031"} 09:31:57 INFO - Running post-run listener: copy_logs_to_upload_dir 09:31:57 INFO - Copying logs to upload dir... 09:31:57 INFO - mkdir: /builds/slave/test/build/upload/logs 09:31:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.212643 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-05-12 09:31:56.986652) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 09:31:56.989876) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073 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/8276dd801dcd3dd755eb9d96051128f4e1c088ac77822e23a660d054e6a26e6666b3d10636e39aef18c0c7fadc265b7cf84be60fc5e5ecf87ec978d72e2cb574", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae51fe2b8dbff31a0311085aa6c5d921281ca2ebdc51f02088cbd64f4e3e8f96fcccfcd80300993c1efea9face5bc65317e02e479b85484c5ec7a4d43d394316", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb73719da52fd40c3b462c33b3109a098d8930b356ce9bbd18e58e3ed59fc7864317b5400254fcb9ef80d535c998a6e339f0fe10fde4c4d0fcb6b210bf4f0246", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6148bbe3b6950babe01dc76fbdf836a7018368bccf108b6d9ab1181833b69d4278376090fb9c654ea21bf6a0fddf194c243c9c9e62dde0abbc336bb73ee91031"} build_url:https://queue.taskcluster.net/v1/task/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011293 build_url: 'https://queue.taskcluster.net/v1/task/O3pIdWc-SU-4zAJfgrgW-g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8276dd801dcd3dd755eb9d96051128f4e1c088ac77822e23a660d054e6a26e6666b3d10636e39aef18c0c7fadc265b7cf84be60fc5e5ecf87ec978d72e2cb574", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae51fe2b8dbff31a0311085aa6c5d921281ca2ebdc51f02088cbd64f4e3e8f96fcccfcd80300993c1efea9face5bc65317e02e479b85484c5ec7a4d43d394316", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb73719da52fd40c3b462c33b3109a098d8930b356ce9bbd18e58e3ed59fc7864317b5400254fcb9ef80d535c998a6e339f0fe10fde4c4d0fcb6b210bf4f0246", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6148bbe3b6950babe01dc76fbdf836a7018368bccf108b6d9ab1181833b69d4278376090fb9c654ea21bf6a0fddf194c243c9c9e62dde0abbc336bb73ee91031"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 09:31:57.015345) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:31:57.015685) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1494603242.465158-233179073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004390 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:31:57.099685) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 09:31:57.100031) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 09:31:57.100517) ========= ========= Total master_lag: 0.55 =========