builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1494607594.24 results: success (0) revision: 1e2fe13035e13b7b4001ade3b48f226957cef5fc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 09:46:34.243113) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 09:46:34.243588) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 09:46:34.243913) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 09:46:34.262092) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:46:34.262432) ========= 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=6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-12 09:46:34-- 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% 93.6M=0s 2017-05-12 09:46:34 (93.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115294 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:46:34.395199) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:46:34.395589) ========= 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=6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018110 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:46:34.445302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:46:34.448687) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1e2fe13035e13b7b4001ade3b48f226957cef5fc --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 1e2fe13035e13b7b4001ade3b48f226957cef5fc --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=6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-12 09:46:34,582 truncating revision to first 12 chars 2017-05-12 09:46:34,582 Setting DEBUG logging. 2017-05-12 09:46:34,582 attempt 1/10 2017-05-12 09:46:34,582 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1e2fe13035e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-12 09:46:35,063 unpacking tar archive at: mozilla-central-1e2fe13035e1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.842620 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:46:35.307871) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 09:46:35.308239) ========= script_repo_revision: 1e2fe13035e13b7b4001ade3b48f226957cef5fc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 09:46:35.308644) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 09:46:35.308955) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 09:46:35.319728) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-05-12 09:46:35.320086) ========= /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=6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:46:35 INFO - MultiFileLogger online at 20170512 09:46:35 in /builds/slave/test 09:46:35 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:46:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:46:35 INFO - {'append_to_log': False, 09:46:35 INFO - 'base_work_dir': '/builds/slave/test', 09:46:35 INFO - 'blob_upload_branch': 'Firefox', 09:46:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:46:35 INFO - 'branch': 'Firefox', 09:46:35 INFO - 'buildbot_json_path': 'buildprops.json', 09:46:35 INFO - 'config_files': ('talos/linux_config.py',), 09:46:35 INFO - 'default_actions': ('clobber', 09:46:35 INFO - 'read-buildbot-config', 09:46:35 INFO - 'download-and-extract', 09:46:35 INFO - 'populate-webroot', 09:46:35 INFO - 'create-virtualenv', 09:46:35 INFO - 'install', 09:46:35 INFO - 'run-tests'), 09:46:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:46:35 INFO - 'download_minidump_stackwalk': True, 09:46:35 INFO - 'download_symbols': 'ondemand', 09:46:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:46:35 INFO - 'tooltool.py': '/tools/tooltool.py', 09:46:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:46:35 INFO - '/tools/misc-python/virtualenv.py')}, 09:46:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:46:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:46:35 INFO - 'gecko_profile': False, 09:46:35 INFO - 'gecko_profile_interval': 0, 09:46:35 INFO - 'installer_path': 'installer.exe', 09:46:35 INFO - 'log_level': 'info', 09:46:35 INFO - 'log_name': 'talos', 09:46:35 INFO - 'log_to_console': True, 09:46:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:46:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:46:35 INFO - 'opt_config_files': (), 09:46:35 INFO - 'pip_index': False, 09:46:35 INFO - 'suite': 'dromaeojs-e10s', 09:46:35 INFO - 'system_bits': '32', 09:46:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:46:35 INFO - 'title': 'talos-linux64-ix-050', 09:46:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:46:35 INFO - 'use_talos_json': True, 09:46:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:46:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:46:35 INFO - 'work_dir': 'build'} 09:46:35 INFO - [mozharness: 2017-05-12 16:46:35.548870Z] Running clobber step. 09:46:35 INFO - Running pre-action listener: _resource_record_pre_action 09:46:35 INFO - Running main action method: clobber 09:46:35 INFO - rmtree: /builds/slave/test/build 09:46:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:46:36 INFO - Running post-action listener: _resource_record_post_action 09:46:36 INFO - [mozharness: 2017-05-12 16:46:36.560103Z] Finished clobber step (success) 09:46:36 INFO - [mozharness: 2017-05-12 16:46:36.560205Z] Running read-buildbot-config step. 09:46:36 INFO - Running pre-action listener: _resource_record_pre_action 09:46:36 INFO - Running main action method: read_buildbot_config 09:46:36 INFO - Using buildbot properties: 09:46:36 INFO - { 09:46:36 INFO - "project": "", 09:46:36 INFO - "product": "firefox", 09:46:36 INFO - "who": "ryanvm@gmail.com", 09:46:36 INFO - "installer_path": "public/build/target.tar.bz2", 09:46:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:46:36 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:46:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 09:46:36 INFO - "stage_platform": "linux64-pgo", 09:46:36 INFO - "basedir": "/builds/slave/test", 09:46:36 INFO - "buildnumber": 208, 09:46:36 INFO - "platform": "ubuntu64_hw", 09:46:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:46:36 INFO - "slavebuilddir": "test", 09:46:36 INFO - "taskId": "U4lC-UNmS_KzFN-d3XNWFA", 09:46:36 INFO - "branch": "mozilla-central", 09:46:36 INFO - "script_repo_revision": "production", 09:46:36 INFO - "revision": "1e2fe13035e13b7b4001ade3b48f226957cef5fc", 09:46:36 INFO - "slavename": "talos-linux64-ix-050", 09:46:36 INFO - "repo_path": "mozilla-central" 09:46:36 INFO - } 09:46:36 INFO - Finding installer, test and symbols from parent task. 09:46:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U4lC-UNmS_KzFN-d3XNWFA'}, attempt #1 09:46:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U4lC-UNmS_KzFN-d3XNWFA'}, attempt #1 09:46:37 INFO - Task dependencies: LSGaJGHfTrmZDJ2dFRsIjA 09:46:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LSGaJGHfTrmZDJ2dFRsIjA'}, attempt #1 09:46:37 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/target.tar.bz2 09:46:37 INFO - Set test_url: https://queue.taskcluster.net/v1/task/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/test_packages.json 09:46:37 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/target.crashreporter-symbols.zip 09:46:37 INFO - Running post-action listener: _resource_record_post_action 09:46:37 INFO - [mozharness: 2017-05-12 16:46:37.940011Z] Finished read-buildbot-config step (success) 09:46:37 INFO - [mozharness: 2017-05-12 16:46:37.940227Z] Running download-and-extract step. 09:46:37 INFO - Running pre-action listener: _resource_record_pre_action 09:46:37 INFO - Running main action method: download_and_extract 09:46:37 INFO - mkdir: /builds/slave/test/build/tests 09:46:37 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:46:37 INFO - trying https://queue.taskcluster.net/v1/task/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/target.test_packages.json 09:46:37 INFO - Downloading https://queue.taskcluster.net/v1/task/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:46:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:46:38 INFO - Downloaded 986 bytes. 09:46:38 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:46:38 INFO - Using the following test package requirements: 09:46:38 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:46:38 INFO - u'common': [u'target.common.tests.zip'], 09:46:38 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:46:38 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:46:38 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:46:38 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:46:38 INFO - u'mozbase': [u'target.common.tests.zip'], 09:46:38 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:46:38 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:46:38 INFO - u'web-platform': [u'target.common.tests.zip', 09:46:38 INFO - u'target.web-platform.tests.zip'], 09:46:38 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:46:38 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:46:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/target.common.tests.zip 09:46:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:46:38 INFO - Fetch https://queue.taskcluster.net/v1/task/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/target.common.tests.zip into memory 09:46:39 INFO - Content-Length response header: 64595571 09:46:39 INFO - Bytes received: 64595571 09:46:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:46:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/target.common.tests.zip 09:46:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:46:50 INFO - Fetch https://queue.taskcluster.net/v1/task/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/target.common.tests.zip into memory 09:46:51 INFO - Content-Length response header: 64595571 09:46:51 INFO - Bytes received: 64595571 09:47:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/target.talos.tests.zip 09:47:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:47:03 INFO - Fetch https://queue.taskcluster.net/v1/task/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/target.talos.tests.zip into memory 09:47:04 INFO - Content-Length response header: 14409411 09:47:04 INFO - Bytes received: 14409411 09:47:04 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:47:04 INFO - trying https://queue.taskcluster.net/v1/task/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/target.tar.bz2 09:47:04 INFO - Downloading https://queue.taskcluster.net/v1/task/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:47:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:47:05 INFO - Downloaded 68686715 bytes. 09:47:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/target.tar.bz2 09:47:05 INFO - mkdir: /builds/slave/test/properties 09:47:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:47:05 INFO - Writing to file /builds/slave/test/properties/build_url 09:47:05 INFO - Contents: 09:47:05 INFO - build_url:https://queue.taskcluster.net/v1/task/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/target.tar.bz2 09:47:05 INFO - Running post-action listener: _resource_record_post_action 09:47:05 INFO - Running post-action listener: set_extra_try_arguments 09:47:05 INFO - [mozharness: 2017-05-12 16:47:05.497323Z] Finished download-and-extract step (success) 09:47:05 INFO - [mozharness: 2017-05-12 16:47:05.497420Z] Running populate-webroot step. 09:47:05 INFO - Running pre-action listener: _resource_record_pre_action 09:47:05 INFO - Running main action method: populate_webroot 09:47:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:47:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:47:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:47:05 INFO - '--tppagecycles', 09:47:05 INFO - '7'], 09:47:05 INFO - 'tests': ['tsvgm']}}, 09:47:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:47:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:47:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:47:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:47:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:47:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:47:05 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:47:05 INFO - 'talos_options': ['--disable-e10s'], 09:47:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:47:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:47:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:47:05 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:47:05 INFO - 'talos_options': ['--disable-e10s'], 09:47:05 INFO - 'tests': ['damp', 'tps']}, 09:47:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:47:05 INFO - 'tests': ['damp', 'tps']}, 09:47:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:47:05 INFO - 'tests': ['dromaeo_dom']}, 09:47:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:47:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:47:05 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:47:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:47:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:47:05 INFO - 'tests': ['a11yr', 09:47:05 INFO - 'ts_paint', 09:47:05 INFO - 'tpaint', 09:47:05 INFO - 'sessionrestore', 09:47:05 INFO - 'sessionrestore_no_auto_restore', 09:47:05 INFO - 'tabpaint']}, 09:47:05 INFO - 'other-e10s': {'tests': ['a11yr', 09:47:05 INFO - 'ts_paint', 09:47:05 INFO - 'tpaint', 09:47:05 INFO - 'sessionrestore', 09:47:05 INFO - 'sessionrestore_no_auto_restore', 09:47:05 INFO - 'tabpaint']}, 09:47:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:47:05 INFO - 'ts_paint', 09:47:05 INFO - 'tpaint', 09:47:05 INFO - 'sessionrestore', 09:47:05 INFO - 'sessionrestore_no_auto_restore', 09:47:05 INFO - 'tabpaint']}, 09:47:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:47:05 INFO - 'ts_paint', 09:47:05 INFO - 'tpaint', 09:47:05 INFO - 'sessionrestore', 09:47:05 INFO - 'sessionrestore_no_auto_restore', 09:47:05 INFO - 'tabpaint']}, 09:47:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:47:05 INFO - 'tests': ['a11yr', 09:47:05 INFO - 'ts_paint', 09:47:05 INFO - 'tpaint', 09:47:05 INFO - 'sessionrestore', 09:47:05 INFO - 'sessionrestore_no_auto_restore', 09:47:05 INFO - 'tabpaint']}, 09:47:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:47:05 INFO - 'tests': ['a11yr', 09:47:05 INFO - 'ts_paint', 09:47:05 INFO - 'tpaint', 09:47:05 INFO - 'sessionrestore', 09:47:05 INFO - 'sessionrestore_no_auto_restore', 09:47:05 INFO - 'tabpaint']}, 09:47:05 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:47:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:47:05 INFO - 'bloom_basic_ref']}, 09:47:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:47:05 INFO - 'tests': ['tsvgx', 09:47:05 INFO - 'tsvgr_opacity', 09:47:05 INFO - 'tart', 09:47:05 INFO - 'tscrollx', 09:47:05 INFO - 'cart', 09:47:05 INFO - 'tsvg_static']}, 09:47:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:47:05 INFO - 'tsvgr_opacity', 09:47:05 INFO - 'tart', 09:47:05 INFO - 'tscrollx', 09:47:05 INFO - 'cart', 09:47:05 INFO - 'tsvg_static']}, 09:47:05 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:47:05 INFO - 'talos_options': ['--disable-e10s'], 09:47:05 INFO - 'tests': ['tp5o']}, 09:47:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:47:05 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:47:05 INFO - 'talos_options': ['--disable-e10s', 09:47:05 INFO - '--xperf_path', 09:47:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:47:05 INFO - 'tests': ['tp5n']}, 09:47:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:47:05 INFO - 'talos_options': ['--xperf_path', 09:47:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:47:05 INFO - 'tests': ['tp5n']}}, 09:47:05 INFO - 'talos.zip': {'path': '', 09:47:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:47:05 INFO - Running post-action listener: _resource_record_post_action 09:47:05 INFO - [mozharness: 2017-05-12 16:47:05.511011Z] Finished populate-webroot step (success) 09:47:05 INFO - [mozharness: 2017-05-12 16:47:05.511099Z] Running create-virtualenv step. 09:47:05 INFO - Running pre-action listener: _resource_record_pre_action 09:47:05 INFO - Running main action method: create_virtualenv 09:47:05 INFO - Creating virtualenv /builds/slave/test/build/venv 09:47:05 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:47:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:47:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:47:05 INFO - Using real prefix '/usr' 09:47:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:47:06 INFO - Installing distribute.............................................................................................................................................................................................done. 09:47:08 INFO - Installing pip.................done. 09:47:08 INFO - Return code: 0 09:47:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:47:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:47:08 INFO - Reading from file tmpfile_stdout 09:47:08 INFO - Output received: 09:47:08 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:47:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:08 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 0x1f591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2125a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c8a30>, '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 0x22c97f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c9ca0>, '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': '6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653', '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:47:08 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:47:08 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:47:08 INFO - Using env: {'DISPLAY': ':0', 09:47:08 INFO - 'HOME': '/home/cltbld', 09:47:08 INFO - 'LANG': 'en_US.UTF-8', 09:47:08 INFO - 'LANGUAGE': 'en_US:en', 09:47:08 INFO - 'LOGNAME': 'cltbld', 09:47:08 INFO - 'MAIL': '/var/mail/cltbld', 09:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:08 INFO - 'MOZ_NO_REMOTE': '1', 09:47:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:08 INFO - 'NO_EM_RESTART': '1', 09:47:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:08 INFO - 'PWD': '/builds/slave/test', 09:47:08 INFO - 'SHELL': '/bin/bash', 09:47:08 INFO - 'SHLVL': '1', 09:47:08 INFO - 'TERM': 'linux', 09:47:08 INFO - 'TMOUT': '86400', 09:47:08 INFO - 'USER': 'cltbld', 09:47:08 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653', 09:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:08 INFO - '_': '/tools/buildbot/bin/python'} 09:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:08 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:47:08 INFO - Cleaning up... 09:47:08 INFO - Return code: 0 09:47:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:08 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 0x1f591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2125a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c8a30>, '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 0x22c97f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c9ca0>, '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': '6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653', '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:47:08 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:47:08 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:47:08 INFO - Using env: {'DISPLAY': ':0', 09:47:08 INFO - 'HOME': '/home/cltbld', 09:47:08 INFO - 'LANG': 'en_US.UTF-8', 09:47:08 INFO - 'LANGUAGE': 'en_US:en', 09:47:08 INFO - 'LOGNAME': 'cltbld', 09:47:08 INFO - 'MAIL': '/var/mail/cltbld', 09:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:08 INFO - 'MOZ_NO_REMOTE': '1', 09:47:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:08 INFO - 'NO_EM_RESTART': '1', 09:47:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:08 INFO - 'PWD': '/builds/slave/test', 09:47:08 INFO - 'SHELL': '/bin/bash', 09:47:08 INFO - 'SHLVL': '1', 09:47:08 INFO - 'TERM': 'linux', 09:47:08 INFO - 'TMOUT': '86400', 09:47:08 INFO - 'USER': 'cltbld', 09:47:08 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653', 09:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:08 INFO - '_': '/tools/buildbot/bin/python'} 09:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:08 INFO - Downloading/unpacking psutil>=3.1.1 09:47:08 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:47:08 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:47:08 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:47:08 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:47:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:47:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:47:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:47:09 INFO - Installing collected packages: psutil 09:47:09 INFO - Running setup.py install for psutil 09:47:10 INFO - building 'psutil._psutil_linux' extension 09:47:10 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:47:10 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:47:10 INFO - building 'psutil._psutil_posix' extension 09:47:10 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:47:10 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:47:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:47:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:47:10 INFO - Successfully installed psutil 09:47:10 INFO - Cleaning up... 09:47:10 INFO - Return code: 0 09:47:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:47:10 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:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:10 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:47:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:10 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 0x1f591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2125a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c8a30>, '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 0x22c97f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c9ca0>, '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': '6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653', '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:47:10 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:47:10 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:47:10 INFO - Using env: {'DISPLAY': ':0', 09:47:10 INFO - 'HOME': '/home/cltbld', 09:47:10 INFO - 'LANG': 'en_US.UTF-8', 09:47:10 INFO - 'LANGUAGE': 'en_US:en', 09:47:10 INFO - 'LOGNAME': 'cltbld', 09:47:10 INFO - 'MAIL': '/var/mail/cltbld', 09:47:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:10 INFO - 'MOZ_NO_REMOTE': '1', 09:47:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:10 INFO - 'NO_EM_RESTART': '1', 09:47:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:10 INFO - 'PWD': '/builds/slave/test', 09:47:10 INFO - 'SHELL': '/bin/bash', 09:47:10 INFO - 'SHLVL': '1', 09:47:10 INFO - 'TERM': 'linux', 09:47:10 INFO - 'TMOUT': '86400', 09:47:10 INFO - 'USER': 'cltbld', 09:47:10 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653', 09:47:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:10 INFO - '_': '/tools/buildbot/bin/python'} 09:47:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:47:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:47:11 INFO - Installing collected packages: mozsystemmonitor 09:47:11 INFO - Running setup.py install for mozsystemmonitor 09:47:11 INFO - Successfully installed mozsystemmonitor 09:47:11 INFO - Cleaning up... 09:47:11 INFO - Return code: 0 09:47:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:47:11 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:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:11 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:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:11 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 0x1f591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2125a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c8a30>, '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 0x22c97f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c9ca0>, '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': '6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653', '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:47:11 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:47:11 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:47:11 INFO - Using env: {'DISPLAY': ':0', 09:47:11 INFO - 'HOME': '/home/cltbld', 09:47:11 INFO - 'LANG': 'en_US.UTF-8', 09:47:11 INFO - 'LANGUAGE': 'en_US:en', 09:47:11 INFO - 'LOGNAME': 'cltbld', 09:47:11 INFO - 'MAIL': '/var/mail/cltbld', 09:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:11 INFO - 'MOZ_NO_REMOTE': '1', 09:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:11 INFO - 'NO_EM_RESTART': '1', 09:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:11 INFO - 'PWD': '/builds/slave/test', 09:47:11 INFO - 'SHELL': '/bin/bash', 09:47:11 INFO - 'SHLVL': '1', 09:47:11 INFO - 'TERM': 'linux', 09:47:11 INFO - 'TMOUT': '86400', 09:47:11 INFO - 'USER': 'cltbld', 09:47:11 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653', 09:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:11 INFO - '_': '/tools/buildbot/bin/python'} 09:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:12 INFO - Downloading/unpacking jsonschema==2.5.1 09:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:47:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:13 INFO - Downloading functools32-3.2.3-2.tar.gz 09:47:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:47:13 INFO - warning: no files found matching '*.txt' 09:47:13 INFO - no previously-included directories found matching 'build' 09:47:13 INFO - no previously-included directories found matching 'dist' 09:47:13 INFO - no previously-included directories found matching '.git*' 09:47:13 INFO - Installing collected packages: jsonschema, functools32 09:47:13 INFO - Running setup.py install for functools32 09:47:13 INFO - warning: no files found matching '*.txt' 09:47:13 INFO - no previously-included directories found matching 'build' 09:47:13 INFO - no previously-included directories found matching 'dist' 09:47:13 INFO - no previously-included directories found matching '.git*' 09:47:13 INFO - Successfully installed jsonschema functools32 09:47:13 INFO - Cleaning up... 09:47:13 INFO - Return code: 0 09:47:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2125a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c8a30>, '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 0x22c97f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c9ca0>, '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': '6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653', '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:47:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:47:13 INFO - Using env: {'DISPLAY': ':0', 09:47:13 INFO - 'HOME': '/home/cltbld', 09:47:13 INFO - 'LANG': 'en_US.UTF-8', 09:47:13 INFO - 'LANGUAGE': 'en_US:en', 09:47:13 INFO - 'LOGNAME': 'cltbld', 09:47:13 INFO - 'MAIL': '/var/mail/cltbld', 09:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:13 INFO - 'MOZ_NO_REMOTE': '1', 09:47:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:13 INFO - 'NO_EM_RESTART': '1', 09:47:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:13 INFO - 'PWD': '/builds/slave/test', 09:47:13 INFO - 'SHELL': '/bin/bash', 09:47:13 INFO - 'SHLVL': '1', 09:47:13 INFO - 'TERM': 'linux', 09:47:13 INFO - 'TMOUT': '86400', 09:47:13 INFO - 'USER': 'cltbld', 09:47:13 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653', 09:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:13 INFO - '_': '/tools/buildbot/bin/python'} 09:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:47:13 INFO - Cleaning up... 09:47:13 INFO - Return code: 0 09:47:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2125a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c8a30>, '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 0x22c97f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c9ca0>, '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': '6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653', '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:47:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:47:13 INFO - Using env: {'DISPLAY': ':0', 09:47:13 INFO - 'HOME': '/home/cltbld', 09:47:13 INFO - 'LANG': 'en_US.UTF-8', 09:47:13 INFO - 'LANGUAGE': 'en_US:en', 09:47:13 INFO - 'LOGNAME': 'cltbld', 09:47:13 INFO - 'MAIL': '/var/mail/cltbld', 09:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:13 INFO - 'MOZ_NO_REMOTE': '1', 09:47:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:13 INFO - 'NO_EM_RESTART': '1', 09:47:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:13 INFO - 'PWD': '/builds/slave/test', 09:47:13 INFO - 'SHELL': '/bin/bash', 09:47:13 INFO - 'SHLVL': '1', 09:47:13 INFO - 'TERM': 'linux', 09:47:13 INFO - 'TMOUT': '86400', 09:47:13 INFO - 'USER': 'cltbld', 09:47:13 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653', 09:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:13 INFO - '_': '/tools/buildbot/bin/python'} 09:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:14 INFO - Downloading/unpacking blobuploader==1.2.4 09:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:15 INFO - Downloading blobuploader-1.2.4.tar.gz 09:47:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:47:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:47:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:15 INFO - Downloading docopt-0.6.1.tar.gz 09:47:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:47:15 INFO - Installing collected packages: blobuploader, requests, docopt 09:47:15 INFO - Running setup.py install for blobuploader 09:47:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:47:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:47:15 INFO - Running setup.py install for requests 09:47:16 INFO - Running setup.py install for docopt 09:47:16 INFO - Successfully installed blobuploader requests docopt 09:47:16 INFO - Cleaning up... 09:47:16 INFO - Return code: 0 09:47:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:47:16 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:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:16 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:47:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1f591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2125a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c8a30>, '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 0x22c97f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c9ca0>, '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': '6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653', '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:47:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:47:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:47:16 INFO - Using env: {'DISPLAY': ':0', 09:47:16 INFO - 'HOME': '/home/cltbld', 09:47:16 INFO - 'LANG': 'en_US.UTF-8', 09:47:16 INFO - 'LANGUAGE': 'en_US:en', 09:47:16 INFO - 'LOGNAME': 'cltbld', 09:47:16 INFO - 'MAIL': '/var/mail/cltbld', 09:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:16 INFO - 'MOZ_NO_REMOTE': '1', 09:47:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:16 INFO - 'NO_EM_RESTART': '1', 09:47:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:16 INFO - 'PWD': '/builds/slave/test', 09:47:16 INFO - 'SHELL': '/bin/bash', 09:47:16 INFO - 'SHLVL': '1', 09:47:16 INFO - 'TERM': 'linux', 09:47:16 INFO - 'TMOUT': '86400', 09:47:16 INFO - 'USER': 'cltbld', 09:47:16 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653', 09:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:16 INFO - '_': '/tools/buildbot/bin/python'} 09:47:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:47:16 INFO - Running setup.py (path:/tmp/pip-jHEuC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:47:16 INFO - Running setup.py (path:/tmp/pip-dSiGVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:47:16 INFO - Running setup.py (path:/tmp/pip-gynkTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:47:16 INFO - Running setup.py (path:/tmp/pip-bmIkkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:47:16 INFO - Running setup.py (path:/tmp/pip-GQ7tfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:47:16 INFO - Running setup.py (path:/tmp/pip-QdW9d6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:47:16 INFO - Running setup.py (path:/tmp/pip-kXHCES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:47:17 INFO - Running setup.py (path:/tmp/pip-4Zs021-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:47:17 INFO - Running setup.py (path:/tmp/pip-buZ2j3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:47:17 INFO - Running setup.py (path:/tmp/pip-40_SJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:47:17 INFO - Running setup.py (path:/tmp/pip-YGqpP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:47:17 INFO - Running setup.py (path:/tmp/pip-dl22cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:47:17 INFO - Running setup.py (path:/tmp/pip-XSTmFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:47:17 INFO - Running setup.py (path:/tmp/pip-XcNMrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:47:17 INFO - Running setup.py (path:/tmp/pip-gc2iOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:47:17 INFO - Running setup.py (path:/tmp/pip-8jts3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:47:17 INFO - Running setup.py (path:/tmp/pip-W6vecL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:47:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:47:17 INFO - Running setup.py install for manifestparser 09:47:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:47:17 INFO - Running setup.py install for mozcrash 09:47:17 INFO - Running setup.py install for mozdebug 09:47:18 INFO - Running setup.py install for mozdevice 09:47:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:47:18 INFO - Running setup.py install for mozfile 09:47:18 INFO - Running setup.py install for mozhttpd 09:47:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:47:18 INFO - Running setup.py install for mozinfo 09:47:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:47:18 INFO - Running setup.py install for mozInstall 09:47:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:47:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:47:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:47:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:47:18 INFO - Running setup.py install for mozleak 09:47:18 INFO - Running setup.py install for mozlog 09:47:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:47:18 INFO - Running setup.py install for moznetwork 09:47:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:47:18 INFO - Running setup.py install for mozprocess 09:47:18 INFO - Running setup.py install for mozprofile 09:47:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:47:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:47:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:47:19 INFO - Running setup.py install for mozrunner 09:47:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:47:19 INFO - Running setup.py install for mozscreenshot 09:47:19 INFO - Running setup.py install for moztest 09:47:19 INFO - Running setup.py install for mozversion 09:47:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:47:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:47:19 INFO - Cleaning up... 09:47:19 INFO - Return code: 0 09:47:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:47:19 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:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:19 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:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1f591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2125a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c8a30>, '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 0x22c97f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c9ca0>, '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': '6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653', '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:47:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:47:19 INFO - Using env: {'DISPLAY': ':0', 09:47:19 INFO - 'HOME': '/home/cltbld', 09:47:19 INFO - 'LANG': 'en_US.UTF-8', 09:47:19 INFO - 'LANGUAGE': 'en_US:en', 09:47:19 INFO - 'LOGNAME': 'cltbld', 09:47:19 INFO - 'MAIL': '/var/mail/cltbld', 09:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:19 INFO - 'MOZ_NO_REMOTE': '1', 09:47:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:19 INFO - 'NO_EM_RESTART': '1', 09:47:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:19 INFO - 'PWD': '/builds/slave/test', 09:47:19 INFO - 'SHELL': '/bin/bash', 09:47:19 INFO - 'SHLVL': '1', 09:47:19 INFO - 'TERM': 'linux', 09:47:19 INFO - 'TMOUT': '86400', 09:47:19 INFO - 'USER': 'cltbld', 09:47:19 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653', 09:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:19 INFO - '_': '/tools/buildbot/bin/python'} 09:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:47:19 INFO - Running setup.py (path:/tmp/pip-diiEBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:47:19 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:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:47:19 INFO - Running setup.py (path:/tmp/pip-_5bxyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:47:19 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:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:47:19 INFO - Running setup.py (path:/tmp/pip-ntYwaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:47:20 INFO - Running setup.py (path:/tmp/pip-uUGgPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:47:20 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:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:47:20 INFO - Running setup.py (path:/tmp/pip-azmF8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:47:20 INFO - Running setup.py (path:/tmp/pip-QzE_fP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:47:20 INFO - Running setup.py (path:/tmp/pip-iG5pYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:47:20 INFO - Running setup.py (path:/tmp/pip-7mz951-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:47:20 INFO - Running setup.py (path:/tmp/pip-VEUjz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:47:20 INFO - Running setup.py (path:/tmp/pip-cwsWoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:47:20 INFO - Running setup.py (path:/tmp/pip-wbHFKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:47:20 INFO - Running setup.py (path:/tmp/pip-Amzwxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:47:20 INFO - Running setup.py (path:/tmp/pip-otLEqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:47:20 INFO - Running setup.py (path:/tmp/pip-tvdA7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:47:20 INFO - Running setup.py (path:/tmp/pip-d3UPb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:47:20 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:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:47:20 INFO - Running setup.py (path:/tmp/pip-8Upf60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:47:20 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:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:47:20 INFO - Running setup.py (path:/tmp/pip-bRpx5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:47:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:22 INFO - Downloading blessings-1.6.tar.gz 09:47:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:47:22 INFO - Installing collected packages: blessings 09:47:22 INFO - Running setup.py install for blessings 09:47:22 INFO - Successfully installed blessings 09:47:22 INFO - Cleaning up... 09:47:22 INFO - Return code: 0 09:47:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:47:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:47:22 INFO - Reading from file tmpfile_stdout 09:47:22 INFO - Current package versions: 09:47:22 INFO - argparse == 1.2.1 09:47:22 INFO - blessings == 1.6 09:47:22 INFO - blobuploader == 1.2.4 09:47:22 INFO - docopt == 0.6.1 09:47:22 INFO - functools32 == 3.2.3-2 09:47:22 INFO - jsonschema == 2.5.1 09:47:22 INFO - manifestparser == 1.1 09:47:22 INFO - mozInstall == 1.12 09:47:22 INFO - mozcrash == 1.0 09:47:22 INFO - mozdebug == 0.1 09:47:22 INFO - mozdevice == 0.50 09:47:22 INFO - mozfile == 1.2 09:47:22 INFO - mozhttpd == 0.7 09:47:22 INFO - mozinfo == 0.9 09:47:22 INFO - mozleak == 0.1 09:47:22 INFO - mozlog == 3.4 09:47:22 INFO - moznetwork == 0.27 09:47:22 INFO - mozprocess == 0.25 09:47:22 INFO - mozprofile == 0.28 09:47:22 INFO - mozrunner == 6.13 09:47:22 INFO - mozscreenshot == 0.1 09:47:22 INFO - mozsystemmonitor == 0.3 09:47:22 INFO - moztest == 0.8 09:47:22 INFO - mozversion == 1.4 09:47:22 INFO - psutil == 3.1.1 09:47:22 INFO - requests == 1.2.3 09:47:22 INFO - wsgiref == 0.1.2 09:47:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:22 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 0x1f591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2125a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c8a30>, '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 0x22c97f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c9ca0>, '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': '6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653', '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:47:22 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:47:22 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:47:22 INFO - Using env: {'DISPLAY': ':0', 09:47:22 INFO - 'HOME': '/home/cltbld', 09:47:22 INFO - 'LANG': 'en_US.UTF-8', 09:47:22 INFO - 'LANGUAGE': 'en_US:en', 09:47:22 INFO - 'LOGNAME': 'cltbld', 09:47:22 INFO - 'MAIL': '/var/mail/cltbld', 09:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:22 INFO - 'MOZ_NO_REMOTE': '1', 09:47:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:22 INFO - 'NO_EM_RESTART': '1', 09:47:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:22 INFO - 'PWD': '/builds/slave/test', 09:47:22 INFO - 'SHELL': '/bin/bash', 09:47:22 INFO - 'SHLVL': '1', 09:47:22 INFO - 'TERM': 'linux', 09:47:22 INFO - 'TMOUT': '86400', 09:47:22 INFO - 'USER': 'cltbld', 09:47:22 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653', 09:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:22 INFO - '_': '/tools/buildbot/bin/python'} 09:47:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 INFO - Cleaning up... 09:47:22 INFO - Return code: 0 09:47:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:22 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 0x1f591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2125a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c8a30>, '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 0x22c97f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c9ca0>, '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': '6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653', '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:47:22 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:47:22 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:47:22 INFO - Using env: {'DISPLAY': ':0', 09:47:22 INFO - 'HOME': '/home/cltbld', 09:47:22 INFO - 'LANG': 'en_US.UTF-8', 09:47:22 INFO - 'LANGUAGE': 'en_US:en', 09:47:22 INFO - 'LOGNAME': 'cltbld', 09:47:22 INFO - 'MAIL': '/var/mail/cltbld', 09:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:22 INFO - 'MOZ_NO_REMOTE': '1', 09:47:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:22 INFO - 'NO_EM_RESTART': '1', 09:47:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:22 INFO - 'PWD': '/builds/slave/test', 09:47:22 INFO - 'SHELL': '/bin/bash', 09:47:22 INFO - 'SHLVL': '1', 09:47:22 INFO - 'TERM': 'linux', 09:47:22 INFO - 'TMOUT': '86400', 09:47:22 INFO - 'USER': 'cltbld', 09:47:22 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653', 09:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:22 INFO - '_': '/tools/buildbot/bin/python'} 09:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:47:23 INFO - Cleaning up... 09:47:23 INFO - Return code: 0 09:47:23 INFO - Running post-action listener: _resource_record_post_action 09:47:23 INFO - Running post-action listener: _start_resource_monitoring 09:47:23 INFO - Starting resource monitoring. 09:47:23 INFO - [mozharness: 2017-05-12 16:47:23.115207Z] Finished create-virtualenv step (success) 09:47:23 INFO - [mozharness: 2017-05-12 16:47:23.115673Z] Running install step. 09:47:23 INFO - Running pre-action listener: _resource_record_pre_action 09:47:23 INFO - Running main action method: install 09:47:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:47:23 INFO - Reading from file tmpfile_stdout 09:47:23 INFO - Detecting whether we're running mozinstall >=1.0... 09:47:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:47:23 INFO - Reading from file tmpfile_stdout 09:47:23 INFO - Output received: 09:47:23 INFO - Usage: mozinstall [options] installer 09:47:23 INFO - Options: 09:47:23 INFO - -h, --help show this help message and exit 09:47:23 INFO - -d DEST, --destination=DEST 09:47:23 INFO - Directory to install application into. [default: 09:47:23 INFO - "/builds/slave/test"] 09:47:23 INFO - --app=APP Application being installed. [default: firefox] 09:47:23 INFO - mkdir: /builds/slave/test/build/application 09:47:23 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:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:47:40 INFO - Reading from file tmpfile_stdout 09:47:40 INFO - Output received: 09:47:40 INFO - /builds/slave/test/build/application/firefox/firefox 09:47:40 INFO - Running post-action listener: _resource_record_post_action 09:47:40 INFO - [mozharness: 2017-05-12 16:47:40.508076Z] Finished install step (success) 09:47:40 INFO - [mozharness: 2017-05-12 16:47:40.508308Z] Running run-tests step. 09:47:40 INFO - Running pre-action listener: _resource_record_pre_action 09:47:40 INFO - Running main action method: run_tests 09:47:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:47:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:47:40 INFO - Python 2.7.3 09:47:40 INFO - Return code: 0 09:47:40 INFO - grabbing minidump binary from tooltool 09:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:40 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c8a30>, '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 0x22c97f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c9ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:47:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:47:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:47:40 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:47:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:47:40 INFO - Return code: 0 09:47:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:47:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:47:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:47:40 INFO - ENV: RUST_BACKTRACE is now 1 09:47:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:47:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:47:40 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/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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:47:40 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/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-050 --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:47:40 INFO - Using env: {'DISPLAY': ':0', 09:47:40 INFO - 'HOME': '/home/cltbld', 09:47:40 INFO - 'LANG': 'en_US.UTF-8', 09:47:40 INFO - 'LANGUAGE': 'en_US:en', 09:47:40 INFO - 'LOGNAME': 'cltbld', 09:47:40 INFO - 'MAIL': '/var/mail/cltbld', 09:47:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:47:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:47:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:40 INFO - 'MOZ_NO_REMOTE': '1', 09:47:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:47:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:40 INFO - 'NO_EM_RESTART': '1', 09:47:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:40 INFO - 'PWD': '/builds/slave/test', 09:47:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:47:40 INFO - 'RUST_BACKTRACE': '1', 09:47:40 INFO - 'SHELL': '/bin/bash', 09:47:40 INFO - 'SHLVL': '1', 09:47:40 INFO - 'TERM': 'linux', 09:47:40 INFO - 'TMOUT': '86400', 09:47:40 INFO - 'USER': 'cltbld', 09:47:40 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653', 09:47:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:40 INFO - '_': '/tools/buildbot/bin/python'} 09:47:40 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/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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:47:40 INFO - mozversion application_buildid: 20170512154902 09:47:40 INFO - mozversion application_changeset: 1e2fe13035e13b7b4001ade3b48f226957cef5fc 09:47:40 INFO - mozversion application_display_name: Nightly 09:47:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:47:40 INFO - mozversion application_name: Firefox 09:47:40 INFO - mozversion application_remotingname: firefox 09:47:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:47:40 INFO - mozversion application_vendor: Mozilla 09:47:40 INFO - mozversion application_version: 55.0a1 09:47:40 INFO - mozversion platform_buildid: 20170512154902 09:47:40 INFO - mozversion platform_changeset: 1e2fe13035e13b7b4001ade3b48f226957cef5fc 09:47:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:47:40 INFO - mozversion platform_version: 55.0a1 09:47:40 INFO - using testdate: 1494607660 09:47:40 INFO - actual date: 1494607660 09:47:40 INFO - starting webserver on 'localhost:33623' 09:47:40 INFO - SUITE-START | Running 2 tests 09:47:40 INFO - TEST-START | dromaeo_css 09:47:40 INFO - operating with platform_type : linux_ 09:47:40 INFO - Initialising browser for dromaeo_css test... 09:47:40 INFO - TEST-INFO | started process 13478 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzh9hAM/profile http://localhost:33623/getInfo.html) 09:47:44 INFO - PID 13478 | __metrics Screen width/height:1600/1200 09:47:44 INFO - PID 13478 | colorDepth:24 09:47:44 INFO - PID 13478 | Browser inner width/height: 1024/695 09:47:44 INFO - PID 13478 | __metrics 09:47:46 INFO - TEST-INFO | 13478: exit 0 09:47:46 INFO - Browser initialized. 09:47:46 INFO - Running cycle 1/1 for dromaeo_css test... 09:47:46 INFO - TEST-INFO | started process 13655 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzh9hAM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:47:58 INFO - PID 13655 | RSS: Main: 154951680 09:47:58 INFO - PID 13655 | 09:51:00 INFO - PID 13655 | Cycle 1(1): loaded http://localhost:33623/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33623/tests/dromaeo/cssquery-ext.html) 09:51:01 INFO - PID 13655 | RSS: Main: 164478976 09:51:01 INFO - PID 13655 | 09:54:03 INFO - PID 13655 | Cycle 1(1): loaded http://localhost:33623/tests/dromaeo/cssquery-ext.html (next: http://localhost:33623/tests/dromaeo/cssquery-jquery.html) 09:54:03 INFO - PID 13655 | RSS: Main: 159162368 09:54:03 INFO - PID 13655 | 09:57:05 INFO - PID 13655 | Cycle 1(1): loaded http://localhost:33623/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33623/tests/dromaeo/cssquery-mootools.html) 09:57:06 INFO - PID 13655 | RSS: Main: 166862848 09:57:06 INFO - PID 13655 | 10:00:07 INFO - PID 13655 | Cycle 1(1): loaded http://localhost:33623/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33623/tests/dromaeo/cssquery-prototype.html) 10:00:08 INFO - PID 13655 | RSS: Main: 159227904 10:00:08 INFO - PID 13655 | 10:03:11 INFO - PID 13655 | Cycle 1(1): loaded http://localhost:33623/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33623/tests/dromaeo/cssquery-yui.html) 10:03:11 INFO - PID 13655 | RSS: Main: 164601856 10:03:11 INFO - PID 13655 | 10:06:13 INFO - PID 13655 | Cycle 1(1): loaded http://localhost:33623/tests/dromaeo/cssquery-yui.html (next: http://localhost:33623/tests/dromaeo/cssquery-dojo.html) 10:06:13 INFO - PID 13655 | RSS: Main: 166305792 10:06:13 INFO - PID 13655 | 10:06:13 INFO - PID 13655 | __start_tp_report 10:06:13 INFO - PID 13655 | _x_x_mozilla_page_load 10:06:13 INFO - PID 13655 | _x_x_mozilla_page_load_details 10:06:13 INFO - PID 13655 | |i|pagename|runs| 10:06:13 INFO - PID 13655 | |0;dojo.html;3408.710259627932;3418;3447.8793242236497;3451.8101504417255;3458.6541345865417;5954.106883967407;6054.061620448826;6064.5148388128955;6080.63516189029;6097.817065488031;5933.821985340436;6021.337652858182;6068.271807383109;6109.860177052738;6135.539834512407;5052.247884874238;5249.1338929076655;5359.490848369399;5382.5963052771;5402.729863506828;5431.103867861798;5498.725063746797;5501.724913754317;5518.475744804237;5527.060399732035;5257.658252213594;5322.494363035506;5409.729513524348;5442.673439593617;5452.073147564884;5397.082495975694;5440.156775699773;5444.210589464545;5474.671519708831;5497;5380.300560927094;5394.109971854639;5433.239346491494;5433.972830135864;5484.177373393983;5921.674307913063;5979.192808970777;5991.460768530809;6020.217371741689;6084.60450070744;6454.354564543555;6565.868682626321;6566.901496477509;6574.243961944342;6600.570962887397;6637.103990961206;6651.733930642768;6664.666766661648;6685.264620891698;6687.331266873322;6017.849553761191;6130.417610327012;6151.938480615181;6160.199174107337;6189.907151392733;6567.802965911031;6655.966720166368;6683.532152749261;6764.627945463047;6787.355201255873;6243.188385509946;6288.9056664150075;6326.2724786649205;6490.837729056811;6515.511336649675;6388.680565971683;6492.09110724499;6501.837454063591;6504.739810407626;6509.218893732687;6424.486041116699;6465.418112369909;6477.319881412383;6479.5788273762055;6480.287168411471;6397.136386587844;6481.449076828428;6489.740410383626;6582.473402127818;6589.53873228879;4923.48303428142;4934.827281045146;4937.407511098691;4938.259261110862;4973.930604919888;4358.302671572596;4369.148016136823;4370.606645401929;4398.3842262083335;4410.514843367227;6073.878522429527;6096.950036952726;6106.36966090081;6139.723712432951;6211.068339748984;6504.707288172043;6557.082008518812;6594.604323740591;6616.933830661728;6633.933660663428;6124.908126378108;6135.9079613805825;6145.231846019247;6165.784197553064;6197.504199664016;5442.619016668795;5551.694656793915;5582.665040097607;5584.5811564132855;5594.748236329375;6589.275179730322;6696.06255124283;6731.124953755981;6748.966255168692;6780.288069752803;6638.236602790741;6649.102371180023;6655.401013908771;6656.068150458843;6661.16735408074;6775.5199332577495;6856.588604683735;6872.244053154249;6925.480588955747;6931.89602155958;6246.312905580292;6293.244810622755;6335.429811317003;6357.110004599267;6361.745530178741;6574.737010519717;6596.043573681885;6611.371919667624;6619.0733297339375;6626.56927299724;6191.442770150708;6248.718807653576;6254.906176407267;6349.619022858643;6389.329120442287;6403.327650596807;6429.77834211517;6434.774782882577;6435.742570297136;6477.255115661759;6180.845478862884;6189.35011823752;6301.684915754102;6386.457151142205;6447.097406363207;6422.165118534561;6489.8702025960165;6504.60972341661;6515.478761699147;6517.087607734826;6230.314665386894;6270.372962703693;6291.591046581958;6301.6219026858535;6309 10:06:13 INFO - PID 13655 | |1;ext.html;751.3988808952836;805.4965646470955;829.3655353654456;1060.8992145746151;1081.0810810810813;36594;37395.813020934926;37653.81173094137;37696.62303376972;37731;38886.22227555447;39071.21857562847;39117.21765564687;39148.80425597875;39213.80393098038;7069.4697897657625;7095.538789978661;7159.4988350815465;7241.275872412769;7263.854722905538;7300.269973002711;7311.195768465464;7331.926680733178;7370.115586129672;7397;7345.045144131255;7377.963110184468;7433.108027036763;7445.8883116753295;7450.552966822008;7361.668724907392;7397.667104980262;7399.556026638392;7407.296306850894;7432.033835601392;7293.380062694678;7327.560346379234;7342.082239720035;7359;7385.593792341419;36618.267634647425;36700.81649591735;36787;36866.815665921764;36905.630943690485;3501.562304711911;3519.4896739972814;3556.751027428081;3563.6614521620404;3568.8750893718857;29381.26546836325;29530.55704164439;29580.260493487618;29625;29664.25839354012;3725.2735716535285;3734.477173195755;3735.533058367704;3745.925081498382;3752.0057184846037;192559;193505;198016;204021;204173;46417.07165856664;46580.53419465762;46776.7661161692;46809;46939.061218776114;48528.27207591889;48714.512854871704;55084.97032663242;55781.72109139428;55991.72004139953;15573.196824571685;15844.92077539628;15961.36154553828;15961.600959976093;15975.760363594556;12607.432665530074;12642.304673242876;12644.873551264554;12664.683382915317;12691.619251422471;15151.166685832164;15159.166245856362;15184;15353.309101090477;15431.459898903484;5972.462478376967;6044.15381846533;6104.481119104837;6216.378362163748;6311.431971122529;1084.143526613966;1118.7370967822555;1131.2816361610437;1132.9433528323716;1135.4663308245113;26333;26767.732322676526;26997.460050798873;27141.592876106875;27169.320766980985;1207.0946789907568;1214.1925619463134;1214.2046959241534;1214.7631211913592;1230.2802860326808;13456.932715336361;13996.930015350063;14300.713985720227;14338.928305358406;14385.208813515357;236544;237499;239502;239725;241031;52633.210501842506;52730.73634631802;52784.73607632014;52872;52881.73559132257;1500.6998600279987;1528.9923550382177;1551.8836087293498;1555.8677512411346;1577.597712583284;24623;25665.486690266465;25883.094091707455;26135;26243.868780655976;38538.614613853504;38708.6129138705;38730.80634596809;38858.22283554257;38861;187002;187074;187875;188069;188435;35775.64224357827;36013.09967250735;36075.458868116475;36199.45700814542;36557.63442365542;44010;44011.77994110009;44059.33910991273;44089.338659920766;44162.779186103864;30725.23186920345;31914.840425797724;32239;32242.677573223966;33460.83269583636;32036.839815801704;32121.357572847945;32154.83922580372;32531.34937301288;33548.49677254892;37601.4359784598;37975.62024379721;37994.240115198096;38162.09189540456;38219.42670859884;30714.539281910344;31570.842145789124;32248.677513224568;32511.34977300488;33268.334633307684;25870.611940820527;26806.195814125607;26870.59694104629;26896.193114206606;27327.726722732517 10:06:13 INFO - PID 13655 | |2;jquery.html;448.15299084729844;454.69535411274444;456.5685427271228;475.65277347536295;478.6434106590588;19906.40280791577;19996.603464466254;21019.894900525494;21073;21229.469263268427;21459.785402145975;22398.88800555995;22399.55200895981;22428.775712242874;22500;4506.526814684444;5462.317210348697;5610.607257491977;5666.490015898568;5680.659160450366;5658.43415658435;5731.799387021455;5751.7986870459545;5775.682337471459;5781.4507621775865;5518.19986102015;5557.3886872444;5666;5697.77208911643;5726.055200891848;5609.439056094398;5617.466340697627;5636.605437619389;5647.152927060933;5653.095504719246;5058.46886076964;5090.261912022736;5133.974330128362;5144.279800827887;5171.37943446785;24715.62926556103;24814.627780583305;24957.5008499829;25040.499190016097;25207.84901887264;2105.8525903186783;2158.3093410108772;2170.121100954116;2183.1376606240447;2193.7038499802643;16672.83327166725;16943.745843812354;17077.231524581424;17161.313547458085;17320.13399330041;2201.3836125884777;2235.865848049122;2261.231181398316;2266.580682573729;2282.5549017941507;98206;100031;113840;115167;117019.99999999914;12502.437390317458;12637;12643.902243950291;12886.935565322301;13079.346032698328;17893.19480623375;18043;18051.458456246335;18077;18107.18517666708;8836.160564746338;8941.418807777603;9005.14451127142;9051.954740226256;9083.048009396973;8002.159773223728;8052.758417247492;8111.513309201467;8299.419040667217;8365.1216622255;7781.105172905075;8036.919630803734;8178.304844088319;8192.5494097824;8259.719743439777;2338.468911942978;2350.095213342841;2386.2006227913844;2392.653065305521;2457.69278840145;1031.6131450705984;1061.2040969273046;1071.59815069349;1072.8658917635296;1077.1060020183386;23338.299851004496;24806;25030.37424064413;25133;25186.11848585291;1067.5089458849016;1093.6554985179803;1094.2067001423904;1100.4057808783327;1123.5898896902572;10982.231243813016;11423.086153107732;11450.427478626201;11526.250793698382;11582.305061696325;516730;530009;531552;534984;536363;96199.51900240454;96262;96742;97638;97945.51027244961;1220.231254309797;1252.5303011370736;1283.6277479530831;1289.0976316578433;1289.9871001289866;17460.476185714448;17532.649347013245;17956.91021544884;18022.369217077863;18138.455846324632;44600.33099503575;45722.31416528688;46088.53911460842;46437.80544305084;46459.303110452696;58197.418025820894;58696.706516467144;58702.706486467294;59036.70481647564;59574;8835.558222089;8977.114805890837;9158.221551167959;9168.482841511503;9258.398204116711;13534.323283835573;13801.171929684251;13853.653658658613;13956.2324072177;14051.437942482595;11396.487158078073;11701;12011.399430028638;12172.39138043112;12379.69050773738;11279.605213817476;11310.886891131313;11654.76690466169;11744.94127529357;11895.762084758084;11156.832647510131;11267.098632109575;11403.828942566033;11660.416979151178;12421.689457763629;9003.459792412476;9283.350165488351;9522.714318570454;9545.713628591153;9938.354006989523;12324;12369.876301237233;12486.375681216085;12549.755090232497;12579.622611321674 10:06:13 INFO - PID 13655 | |3;mootools.html;1351.4796803230756;1431.7279716853798;1437.4609521429463;1438.3599298312256;1439.805626240458;11421.942890285547;11699.298042117469;11827.29036257824;11992.700182495442;12264.693382665439;11887.108466864976;12011.219270747395;12020.879791202085;12077;12115.697107572292;2389.199618127929;2438.3050830513307;2440.6583078369044;2442;2447.645091461737;2294.724633044037;2357.26924653358;2366.1363602285214;2380.4881950380664;2387.450886296153;2333.9416514587188;2335.3344296875393;2380.452495925938;2383.07060246504;2387.3554140382084;2253.876036817974;2333.5916214662366;2334.0080465801966;2335;2338.1115176232925;1940.3305859478457;2023.2817349840889;2266.9206577769864;2317.5712493188644;2323.5701395241936;11454.770904581861;11513.769724605461;11522.481488333045;11627.767444651145;11639.418029098511;6505.577137486096;6717.899231511531;6751.864962700768;6759.628220447873;6767.796966090976;3844.884653460401;4036.4348991141264;4096.996235922188;4111.5477297497555;4233.407322974786;1381.5924302330736;1393;1409.478492957602;1460.978085328721;1462.9414823407158;17546.473605791845;17715.645687086315;17744.11279436023;17784.199711013036;17832;5099.821506247264;5131.974340128276;5426.430224826337;5426.864328391822;5493.862653433616;12527.56153534622;12602.684932876751;12615.747685046432;12618.936905315415;12681.175723577939;6510.44661203803;6515.283318834924;6523.315051919575;6580.670966451754;6587.868242635121;5904.261967254093;6061.242344706911;6104.053871649901;6171.84570385735;6175.2898416681755;4176.206520761046;4226.387173859773;4282.550332215135;4325.4593175853015;4344.608985191285;1201.897838683704;1238.120934136755;1240.962771116868;1242.0932719115096;1251.7121062155754;811.9350451963828;826.2109685250572;831.6548632317641;847.4068152293419;863.6933888469629;5938.138969849348;5943.910841337383;5944.108383742473;6030.6080104793045;6136.7852125175405;635.4598591197445;636.5162476517879;642.7204166187723;648.8183308673579;655.1155939481662;3463.79217246966;4103.035786590149;4141.730787498803;4368.934465983013;4563.178627847019;15679.608009799618;15697;15860.04839709621;15893.761593576106;16122.677546449006;15614.843851561565;15635.765463518057;15707.528774136794;15817;15824.129672867872;8926.241269492166;9365;9440.244780417688;9453.90546094544;9497.90502094984;6693.799186024427;6732.562383445061;6742.089817874524;6764.594124352555;6849.726010959505;13478.46086156582;13701.794473083111;13888.375023123781;13970.720585588435;13974.790378144133;13777.793333099811;13970.602939705948;14104.365303561159;14197.148171109766;14462;9300.279448302086;9465.858012129962;9570.90429095728;9588.712338629852;9609.759756005877;10191.592336306465;10525.89474105249;10549.367037977747;10563.524641391003;10611.522481488197;9130.315226358183;9157.221636160735;9241.86137207929;9419;9472.100150485692;8731.825363492822;8889.422187557788;8896.199342059246;8896.955515222642;9112.908870911471;7374.668139933823;7615.809604759926;7645.770626881203;7647.273509016857;7655.349295309961;5621.9156712650165;5710.571707122065;5822.359540450631;5829.970850145722;5935.525157987437;5786.594938354275;5871.236739223874;5874.94125058744;5903.704814759159;5916.467517923407 10:06:13 INFO - PID 13655 | |4;prototype.html;413.5037954454655;418.8513077857361;434.1079082485492;437.4903237728046;442.7122370459201;5926.792562260322;6048.425399587043;6077.817665470032;6173.413525715061;6203.286622038461;5896.793612223573;5978.671173085479;6034.24571928509;6040.593668666541;6047.455728984391;4771.5467030632035;4853.640980525459;4859.927101093486;4864.367632207825;4882.609391248691;4481.686281960264;4624.260118381059;4630.652701047418;4636.837710680127;4868.148074087038;4577.519360467153;4590.081983603292;4594.104149690812;4594.770261486929;4602.861914142581;4571.862844114682;4600.6319494440695;4611.19304121779;4626.097910907374;4631.8147274109;4003.4795476588147;4283.421738065353;4388.605025547684;4428.822847086113;4431.756253406062;6016.308124565688;6024.975754121766;6030.155778191057;6031.642880351929;6036;5528.585356098309;5774.797882074107;5778.959787238296;5795;5810.273715785527;6484.935150648527;6493.577917435352;6500.4799616030605;6508.219013718337;6513.641749703765;4930;4959.454460009396;4972.204447288453;4975.676581022258;4991.925121123186;6694.062831203635;6778.8305292367595;6809.080774095483;6809.761658341984;6836.555623884432;5085.669431487016;5088.898222035613;5108.770105345268;5122.282880396748;5134.5635620972635;5039.874003149951;5162.406323272797;5180.352455943007;5203.7918483261;5222.190560463135;5717.399673034354;5736.368999410061;5755;5763.164341170507;5774.456521739094;6318.399752023551;6447.3552644735155;6533.346665333429;6542.313057128933;6575.914974029327;1780.6527727093091;1809.348634491582;1813.1478205243513;1814.1654838774311;1817.6273863857878;1247.5259401427581;1304.589054447846;1308.9934550327187;1312.4094157628915;1322.7751282281843;6183.81448556544;6192.628442293387;6197.318294987548;6216.191895053705;6240.875182496416;6440.452561532228;6666.933330666729;6689.4982876284475;6694.230163531159;6707.798766037026;6138.877222455526;6188.659623720649;6195.411435913581;6216.285127210338;6225.719842607094;3530.770499917497;3537.628549002318;3549.846299952526;3550.928981420409;3554.4940816724147;6742.42689371409;6896.241413444517;6900.3444672756;6901.792946211622;6991.720331186797;6815.250322464525;6861.656917154222;6885.621290829053;6899.93100069003;6905.409187222716;6860.211075726255;6898.689558969859;6973.198082220508;6977.965110174417;7023.613701246481;6672.733090676513;6706.899396509154;6712.83217919556;6734.56225345351;6746.325367463214;6516.902246466401;6537.182852143482;6606.273309935807;6610.9669451652435;6639.502037347122;6891;6929.896051559332;6956.40870526011;7004.579725216503;7021.824454388681;5063.113955057924;5121.462246464068;5178.456262092577;5179.145441002343;5182.689038657692;6523.967380163259;6711.966440167768;6722.361375669304;6736.562123461959;6756.905359338621;6461.19235095613;6479.8056058318325;6486.772962946275;6502.154719886385;6504.479641628753;6398.968005160131;6418.106658535837;6458.483321334188;6493.155889734304;6512.381323774234;6479.930811416064;6480.740770369321;6492.318306577741;6518.608883467007;6523.18460192476;6320.652364120017;6483.222013358427;6534.542582019213;6535;6544.443722283469;6349.174607301022;6360.173177487082;6372.96813515948;6374.139491168633;6375.6174629522375 10:06:13 INFO - PID 13655 | |5;yui.html;840.1010918317403;866.3675516872682;871.0636066228806;875.5840975536621;894.65555761032;15230.162341071236;15586.688266234683;15608.297626606816;16393.590160246;17496.387626433076;16423.58941026475;16547.172641367913;16631.501054968372;16754.916225418885;17254.482365529053;962.1388856973005;971.3831716859775;983.6557204978272;984.4733067808723;989.2481713897417;972.1396564040804;1002.1682003936716;1007.9294449388545;1009.0817356205854;1014.3457469931926;1058.3226734889638;1064.7178497698117;1066.9626563070294;1073.5544748929185;1075.811732946735;1038.444432228754;1043.8695163104612;1045.6862941117633;1046.1473898772551;1047.7433028907928;765.9119201291867;772.3820943245381;775.1628241499168;775.8836174573803;778.2723153851167;14263.500777472842;14264.286785660675;14285.500007499792;15432;15865.841341586553;17844.28622855084;17929.820701793076;17932.641347173114;18237.17932693032;18414.907925460288;13654.590362289147;13942.302884855819;13989.930050349683;14023.579292621238;14098.577042688736;3452.87914922979;3460.1349662584353;3463.6363181866045;3481.5125882376487;3482.9129271768156;92588.53705731496;93133;94670.526647367;95601;95613;13599.796003059962;13619.863801362058;13699.726005480034;13719.314034298246;13733;23802.166924157573;24087.879560602083;24259;24325.39186520351;25099.372515687253;8491.95754021226;8700.825983480296;8720.084391138966;8720.563971801384;8727.607257673293;4196.979015104966;4256.4679415073115;4284.785760712014;4365.607095361433;4366.847160349373;4377.4965878923695;4438.933415998763;4447.043885564619;4458.264386376277;4483.3947417098925;903.5211337990876;921.3688623292932;933.8645896344992;937.4234845569925;942.5569982108398;665.3679004945321;681.402196402993;687.5221720903924;695.5861262548775;704.5807744392079;10559.683209503728;11788.115891308185;12002.939985300018;12226;12376.133670642968;666.6000399760202;673.7069374821968;676.6887231873393;684.7637565040053;687.7764726463919;5197.610179236497;5202.583793296527;5279.1289437243195;5432.375276843135;5516.7517461714315;71341.64329178321;71579.56840863258;71868;75639.62180189064;79422;67582;70648.64675676692;70657.2934270661;71251.44982602017;71699;65456.67271663611;69185.30814691789;72952.63523682454;73287;74617.6269118651;11781.823272651089;12890.162139460905;12929.870701292866;13028.348582571023;13051.934740326238;32534.34931301408;34066.489002665476;34954.47568286427;35387.82306088453;36909.26181476409;59136;62698.37301626925;63159.36840631535;64027.35972640214;64315.356846432805;16555.427234412713;16761.91619041897;17049.147542623068;17663.38178163758;17969.640607188045;16715;17034;17274.654506910043;17320.566985825455;17436.128193590015;17434.9128254363;17652.73520897213;17688.469345919642;17897.46307610774;18135.36526221576;16375.344986200418;16407.343706251617;16460.588485287484;16533.256003479633;16672.416465423652;15725.764113538535;16248.593785155466;16316.918415407847;16546.66906661884;17003.574910627332;11878.524859005543;11893.46479408446;12322.753544928872;12459.439325230205;12524.311162886128;14291.64270893236;15098.849011509745;15195.696086077995;15288.235588220767;15356 10:06:13 INFO - PID 13655 | __end_tp_report 10:06:13 INFO - PID 13655 | __start_cc_report 10:06:13 INFO - PID 13655 | _x_x_mozilla_cycle_collect,333 10:06:13 INFO - PID 13655 | __end_cc_report 10:06:13 INFO - PID 13655 | __startTimestamp1494608773631__endTimestamp 10:06:13 INFO - PID 13655 | 10:06:13 INFO - PID 13655 | ------- Summary: start ------- 10:06:13 INFO - PID 13655 | Number of tests: 6 10:06:13 INFO - PID 13655 | 10:06:13 INFO - PID 13655 | [#0] dojo.html Cycles:165 Average:6034.26 Median:6254.91 stddev:733.93 (11.7%) stddev-sans-first:706.69 10:06:13 INFO - PID 13655 | Values: 3408.7 3418.0 3447.9 3451.8 3458.7 5954.1 6054.1 6064.5 6080.6 6097.8 5933.8 6021.3 6068.3 6109.9 6135.5 5052.2 5249.1 5359.5 5382.6 5402.7 5431.1 5498.7 5501.7 5518.5 5527.1 5257.7 5322.5 5409.7 5442.7 5452.1 5397.1 5440.2 5444.2 5474.7 5497.0 5380.3 5394.1 5433.2 5434.0 5484.2 5921.7 5979.2 5991.5 6020.2 6084.6 6454.4 6565.9 6566.9 6574.2 6600.6 6637.1 6651.7 6664.7 6685.3 6687.3 6017.8 6130.4 6151.9 6160.2 6189.9 6567.8 6656.0 6683.5 6764.6 6787.4 6243.2 6288.9 6326.3 6490.8 6515.5 6388.7 6492.1 6501.8 6504.7 6509.2 6424.5 6465.4 6477.3 6479.6 6480.3 6397.1 6481.4 6489.7 6582.5 6589.5 4923.5 4934.8 4937.4 4938.3 4973.9 4358.3 4369.1 4370.6 4398.4 4410.5 6073.9 6097.0 6106.4 6139.7 6211.1 6504.7 6557.1 6594.6 6616.9 6633.9 6124.9 6135.9 6145.2 6165.8 6197.5 5442.6 5551.7 5582.7 5584.6 5594.7 6589.3 6696.1 6731.1 6749.0 6780.3 6638.2 6649.1 6655.4 6656.1 6661.2 6775.5 6856.6 6872.2 6925.5 6931.9 6246.3 6293.2 6335.4 6357.1 6361.7 6574.7 6596.0 6611.4 6619.1 6626.6 6191.4 6248.7 6254.9 6349.6 6389.3 6403.3 6429.8 6434.8 6435.7 6477.3 6180.8 6189.4 6301.7 6386.5 6447.1 6422.2 6489.9 6504.6 6515.5 6517.1 6230.3 6270.4 6291.6 6301.6 6309.0 10:06:13 INFO - PID 13655 | 10:06:13 INFO - PID 13655 | [#1] ext.html Cycles:180 Average:37938.62 Median:3566.27 stddev:54257.31 (1521.4%) stddev-sans-first:54337.67 10:06:13 INFO - PID 13655 | Values: 751.4 805.5 829.4 1060.9 1081.1 36594.0 37395.8 37653.8 37696.6 37731.0 38886.2 39071.2 39117.2 39148.8 39213.8 7069.5 7095.5 7159.5 7241.3 7263.9 7300.3 7311.2 7331.9 7370.1 7397.0 7345.0 7378.0 7433.1 7445.9 7450.6 7361.7 7397.7 7399.6 7407.3 7432.0 7293.4 7327.6 7342.1 7359.0 7385.6 36618.3 36700.8 36787.0 36866.8 36905.6 3501.6 3519.5 3556.8 3563.7 3568.9 29381.3 29530.6 29580.3 29625.0 29664.3 3725.3 3734.5 3735.5 3745.9 3752.0 192559.0 193505.0 198016.0 204021.0 204173.0 46417.1 46580.5 46776.8 46809.0 46939.1 48528.3 48714.5 55085.0 55781.7 55991.7 15573.2 15844.9 15961.4 15961.6 15975.8 12607.4 12642.3 12644.9 12664.7 12691.6 15151.2 15159.2 15184.0 15353.3 15431.5 5972.5 6044.2 6104.5 6216.4 6311.4 1084.1 1118.7 1131.3 1132.9 1135.5 26333.0 26767.7 26997.5 27141.6 27169.3 1207.1 1214.2 1214.2 1214.8 1230.3 13456.9 13996.9 14300.7 14338.9 14385.2 236544.0 237499.0 239502.0 239725.0 241031.0 52633.2 52730.7 52784.7 52872.0 52881.7 1500.7 1529.0 1551.9 1555.9 1577.6 24623.0 25665.5 25883.1 26135.0 26243.9 38538.6 38708.6 38730.8 38858.2 38861.0 187002.0 187074.0 187875.0 188069.0 188435.0 35775.6 36013.1 36075.5 36199.5 36557.6 44010.0 44011.8 44059.3 44089.3 44162.8 30725.2 31914.8 32239.0 32242.7 33460.8 32036.8 32121.4 32154.8 32531.3 33548.5 37601.4 37975.6 37994.2 38162.1 38219.4 30714.5 31570.8 32248.7 32511.3 33268.3 25870.6 26806.2 26870.6 26896.2 27327.7 10:06:13 INFO - PID 13655 | 10:06:13 INFO - PID 13655 | [#2] jquery.html Cycles:180 Average:32038.06 Median:2344.28 stddev:87723.40 (3742.0%) stddev-sans-first:87937.42 10:06:13 INFO - PID 13655 | Values: 448.2 454.7 456.6 475.7 478.6 19906.4 19996.6 21019.9 21073.0 21229.5 21459.8 22398.9 22399.6 22428.8 22500.0 4506.5 5462.3 5610.6 5666.5 5680.7 5658.4 5731.8 5751.8 5775.7 5781.5 5518.2 5557.4 5666.0 5697.8 5726.1 5609.4 5617.5 5636.6 5647.2 5653.1 5058.5 5090.3 5134.0 5144.3 5171.4 24715.6 24814.6 24957.5 25040.5 25207.8 2105.9 2158.3 2170.1 2183.1 2193.7 16672.8 16943.7 17077.2 17161.3 17320.1 2201.4 2235.9 2261.2 2266.6 2282.6 98206.0 100031.0 113840.0 115167.0 117020.0 12502.4 12637.0 12643.9 12886.9 13079.3 17893.2 18043.0 18051.5 18077.0 18107.2 8836.2 8941.4 9005.1 9052.0 9083.0 8002.2 8052.8 8111.5 8299.4 8365.1 7781.1 8036.9 8178.3 8192.5 8259.7 2338.5 2350.1 2386.2 2392.7 2457.7 1031.6 1061.2 1071.6 1072.9 1077.1 23338.3 24806.0 25030.4 25133.0 25186.1 1067.5 1093.7 1094.2 1100.4 1123.6 10982.2 11423.1 11450.4 11526.3 11582.3 516730.0 530009.0 531552.0 534984.0 536363.0 96199.5 96262.0 96742.0 97638.0 97945.5 1220.2 1252.5 1283.6 1289.1 1290.0 17460.5 17532.6 17956.9 18022.4 18138.5 44600.3 45722.3 46088.5 46437.8 46459.3 58197.4 58696.7 58702.7 59036.7 59574.0 8835.6 8977.1 9158.2 9168.5 9258.4 13534.3 13801.2 13853.7 13956.2 14051.4 11396.5 11701.0 12011.4 12172.4 12379.7 11279.6 11310.9 11654.8 11744.9 11895.8 11156.8 11267.1 11403.8 11660.4 12421.7 9003.5 9283.4 9522.7 9545.7 9938.4 12324.0 12369.9 12486.4 12549.8 12579.6 10:06:13 INFO - PID 13655 | 10:06:13 INFO - PID 13655 | [#3] mootools.html Cycles:180 Average:7195.93 Median:3654.34 stddev:4769.53 (130.5%) stddev-sans-first:4762.69 10:06:13 INFO - PID 13655 | Values: 1351.5 1431.7 1437.5 1438.4 1439.8 11421.9 11699.3 11827.3 11992.7 12264.7 11887.1 12011.2 12020.9 12077.0 12115.7 2389.2 2438.3 2440.7 2442.0 2447.6 2294.7 2357.3 2366.1 2380.5 2387.5 2333.9 2335.3 2380.5 2383.1 2387.4 2253.9 2333.6 2334.0 2335.0 2338.1 1940.3 2023.3 2266.9 2317.6 2323.6 11454.8 11513.8 11522.5 11627.8 11639.4 6505.6 6717.9 6751.9 6759.6 6767.8 3844.9 4036.4 4097.0 4111.5 4233.4 1381.6 1393.0 1409.5 1461.0 1462.9 17546.5 17715.6 17744.1 17784.2 17832.0 5099.8 5132.0 5426.4 5426.9 5493.9 12527.6 12602.7 12615.7 12618.9 12681.2 6510.4 6515.3 6523.3 6580.7 6587.9 5904.3 6061.2 6104.1 6171.8 6175.3 4176.2 4226.4 4282.6 4325.5 4344.6 1201.9 1238.1 1241.0 1242.1 1251.7 811.9 826.2 831.7 847.4 863.7 5938.1 5943.9 5944.1 6030.6 6136.8 635.5 636.5 642.7 648.8 655.1 3463.8 4103.0 4141.7 4368.9 4563.2 15679.6 15697.0 15860.0 15893.8 16122.7 15614.8 15635.8 15707.5 15817.0 15824.1 8926.2 9365.0 9440.2 9453.9 9497.9 6693.8 6732.6 6742.1 6764.6 6849.7 13478.5 13701.8 13888.4 13970.7 13974.8 13777.8 13970.6 14104.4 14197.1 14462.0 9300.3 9465.9 9570.9 9588.7 9609.8 10191.6 10525.9 10549.4 10563.5 10611.5 9130.3 9157.2 9241.9 9419.0 9472.1 8731.8 8889.4 8896.2 8897.0 9112.9 7374.7 7615.8 7645.8 7647.3 7655.3 5621.9 5710.6 5822.4 5830.0 5935.5 5786.6 5871.2 5874.9 5903.7 5916.5 10:06:13 INFO - PID 13655 | 10:06:13 INFO - PID 13655 | [#4] prototype.html Cycles:180 Average:5522.73 Median:6186.24 stddev:1580.25 (25.5%) stddev-sans-first:1537.44 10:06:13 INFO - PID 13655 | Values: 413.5 418.9 434.1 437.5 442.7 5926.8 6048.4 6077.8 6173.4 6203.3 5896.8 5978.7 6034.2 6040.6 6047.5 4771.5 4853.6 4859.9 4864.4 4882.6 4481.7 4624.3 4630.7 4636.8 4868.1 4577.5 4590.1 4594.1 4594.8 4602.9 4571.9 4600.6 4611.2 4626.1 4631.8 4003.5 4283.4 4388.6 4428.8 4431.8 6016.3 6025.0 6030.2 6031.6 6036.0 5528.6 5774.8 5779.0 5795.0 5810.3 6484.9 6493.6 6500.5 6508.2 6513.6 4930.0 4959.5 4972.2 4975.7 4991.9 6694.1 6778.8 6809.1 6809.8 6836.6 5085.7 5088.9 5108.8 5122.3 5134.6 5039.9 5162.4 5180.4 5203.8 5222.2 5717.4 5736.4 5755.0 5763.2 5774.5 6318.4 6447.4 6533.3 6542.3 6575.9 1780.7 1809.3 1813.1 1814.2 1817.6 1247.5 1304.6 1309.0 1312.4 1322.8 6183.8 6192.6 6197.3 6216.2 6240.9 6440.5 6666.9 6689.5 6694.2 6707.8 6138.9 6188.7 6195.4 6216.3 6225.7 3530.8 3537.6 3549.8 3550.9 3554.5 6742.4 6896.2 6900.3 6901.8 6991.7 6815.3 6861.7 6885.6 6899.9 6905.4 6860.2 6898.7 6973.2 6978.0 7023.6 6672.7 6706.9 6712.8 6734.6 6746.3 6516.9 6537.2 6606.3 6611.0 6639.5 6891.0 6929.9 6956.4 7004.6 7021.8 5063.1 5121.5 5178.5 5179.1 5182.7 6524.0 6712.0 6722.4 6736.6 6756.9 6461.2 6479.8 6486.8 6502.2 6504.5 6399.0 6418.1 6458.5 6493.2 6512.4 6479.9 6480.7 6492.3 6518.6 6523.2 6320.7 6483.2 6534.5 6535.0 6544.4 6349.2 6360.2 6373.0 6374.1 6375.6 10:06:13 INFO - PID 13655 | 10:06:13 INFO - PID 13655 | [#5] yui.html Cycles:180 Average:19327.78 Median:24173.44 stddev:23892.24 (98.8%) stddev-sans-first:23918.93 10:06:13 INFO - PID 13655 | Values: 840.1 866.4 871.1 875.6 894.7 15230.2 15586.7 15608.3 16393.6 17496.4 16423.6 16547.2 16631.5 16754.9 17254.5 962.1 971.4 983.7 984.5 989.2 972.1 1002.2 1007.9 1009.1 1014.3 1058.3 1064.7 1067.0 1073.6 1075.8 1038.4 1043.9 1045.7 1046.1 1047.7 765.9 772.4 775.2 775.9 778.3 14263.5 14264.3 14285.5 15432.0 15865.8 17844.3 17929.8 17932.6 18237.2 18414.9 13654.6 13942.3 13989.9 14023.6 14098.6 3452.9 3460.1 3463.6 3481.5 3482.9 92588.5 93133.0 94670.5 95601.0 95613.0 13599.8 13619.9 13699.7 13719.3 13733.0 23802.2 24087.9 24259.0 24325.4 25099.4 8492.0 8700.8 8720.1 8720.6 8727.6 4197.0 4256.5 4284.8 4365.6 4366.8 4377.5 4438.9 4447.0 4458.3 4483.4 903.5 921.4 933.9 937.4 942.6 665.4 681.4 687.5 695.6 704.6 10559.7 11788.1 12002.9 12226.0 12376.1 666.6 673.7 676.7 684.8 687.8 5197.6 5202.6 5279.1 5432.4 5516.8 71341.6 71579.6 71868.0 75639.6 79422.0 67582.0 70648.6 70657.3 71251.4 71699.0 65456.7 69185.3 72952.6 73287.0 74617.6 11781.8 12890.2 12929.9 13028.3 13051.9 32534.3 34066.5 34954.5 35387.8 36909.3 59136.0 62698.4 63159.4 64027.4 64315.4 16555.4 16761.9 17049.1 17663.4 17969.6 16715.0 17034.0 17274.7 17320.6 17436.1 17434.9 17652.7 17688.5 17897.5 18135.4 16375.3 16407.3 16460.6 16533.3 16672.4 15725.8 16248.6 16316.9 16546.7 17003.6 11878.5 11893.5 12322.8 12459.4 12524.3 14291.6 15098.8 15195.7 15288.2 15356.0 10:06:13 INFO - PID 13655 | -------- Summary: end -------- 10:06:13 INFO - PID 13655 | 10:06:14 INFO - TEST-INFO | 13655: exit 0 10:06:14 INFO - TEST-OK | dromaeo_css | took 1113659ms 10:06:14 INFO - TEST-START | kraken 10:06:14 INFO - operating with platform_type : linux_ 10:06:14 INFO - Initialising browser for kraken test... 10:06:14 INFO - TEST-INFO | started process 14077 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_Zv1wg/profile http://localhost:33623/getInfo.html) 10:06:18 INFO - PID 14077 | __metrics Screen width/height:1600/1200 10:06:18 INFO - PID 14077 | colorDepth:24 10:06:18 INFO - PID 14077 | Browser inner width/height: 1024/695 10:06:18 INFO - PID 14077 | __metrics 10:06:19 INFO - TEST-INFO | 14077: exit 0 10:06:19 INFO - Browser initialized. 10:06:19 INFO - Running cycle 1/1 for kraken test... 10:06:19 INFO - TEST-INFO | started process 14255 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_Zv1wg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:06:31 INFO - PID 14255 | RSS: Main: 154030080 10:06:31 INFO - PID 14255 | 10:06:34 INFO - PID 14255 | Cycle 1(1): loaded http://localhost:33623/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33623/tests/kraken/driver.html?testName=audio-beat-detection) 10:06:34 INFO - PID 14255 | RSS: Main: 160272384 10:06:34 INFO - PID 14255 | 10:06:37 INFO - PID 14255 | Cycle 1(1): loaded http://localhost:33623/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33623/tests/kraken/driver.html?testName=audio-dft) 10:06:38 INFO - PID 14255 | RSS: Main: 158961664 10:06:38 INFO - PID 14255 | 10:06:40 INFO - PID 14255 | Cycle 1(1): loaded http://localhost:33623/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33623/tests/kraken/driver.html?testName=audio-fft) 10:06:41 INFO - PID 14255 | RSS: Main: 154857472 10:06:41 INFO - PID 14255 | 10:06:43 INFO - PID 14255 | Cycle 1(1): loaded http://localhost:33623/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33623/tests/kraken/driver.html?testName=audio-oscillator) 10:06:44 INFO - PID 14255 | RSS: Main: 156008448 10:06:44 INFO - PID 14255 | 10:06:46 INFO - PID 14255 | Cycle 1(1): loaded http://localhost:33623/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33623/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:06:46 INFO - PID 14255 | RSS: Main: 156155904 10:06:46 INFO - PID 14255 | 10:06:49 INFO - PID 14255 | Cycle 1(1): loaded http://localhost:33623/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33623/tests/kraken/driver.html?testName=imaging-darkroom) 10:06:50 INFO - PID 14255 | RSS: Main: 161214464 10:06:50 INFO - PID 14255 | 10:06:53 INFO - PID 14255 | Cycle 1(1): loaded http://localhost:33623/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33623/tests/kraken/driver.html?testName=imaging-desaturate) 10:06:54 INFO - PID 14255 | RSS: Main: 159834112 10:06:54 INFO - PID 14255 | 10:06:57 INFO - PID 14255 | Cycle 1(1): loaded http://localhost:33623/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33623/tests/kraken/driver.html?testName=json-parse-financial) 10:06:58 INFO - PID 14255 | RSS: Main: 160108544 10:06:58 INFO - PID 14255 | 10:06:59 INFO - PID 14255 | Cycle 1(1): loaded http://localhost:33623/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33623/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:07:00 INFO - PID 14255 | RSS: Main: 160301056 10:07:00 INFO - PID 14255 | 10:07:01 INFO - PID 14255 | Cycle 1(1): loaded http://localhost:33623/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33623/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:07:02 INFO - PID 14255 | RSS: Main: 160079872 10:07:02 INFO - PID 14255 | 10:07:04 INFO - PID 14255 | Cycle 1(1): loaded http://localhost:33623/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33623/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:07:05 INFO - PID 14255 | RSS: Main: 161075200 10:07:05 INFO - PID 14255 | 10:07:07 INFO - PID 14255 | Cycle 1(1): loaded http://localhost:33623/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33623/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:07:08 INFO - PID 14255 | RSS: Main: 160616448 10:07:08 INFO - PID 14255 | 10:07:11 INFO - PID 14255 | Cycle 1(1): loaded http://localhost:33623/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33623/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:07:12 INFO - PID 14255 | RSS: Main: 161284096 10:07:12 INFO - PID 14255 | 10:07:13 INFO - PID 14255 | Cycle 1(1): loaded http://localhost:33623/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33623/tests/kraken/driver.html?testName=ai-astar) 10:07:13 INFO - PID 14255 | RSS: Main: 162914304 10:07:13 INFO - PID 14255 | 10:07:13 INFO - PID 14255 | __start_tp_report 10:07:13 INFO - PID 14255 | _x_x_mozilla_page_load 10:07:13 INFO - PID 14255 | _x_x_mozilla_page_load_details 10:07:13 INFO - PID 14255 | |i|pagename|runs| 10:07:13 INFO - PID 14255 | |0;ai-astar;103;111;110;111;110;110;111;110;110;112 10:07:13 INFO - PID 14255 | |1;audio-beat-detection;148;121;120;172;120;118;117;117;143;125 10:07:13 INFO - PID 14255 | |2;audio-dft;162;164;164;160;161;161;163;169;173;164 10:07:13 INFO - PID 14255 | |3;audio-fft;74;76;75;94;74;74;74;75;104;74 10:07:13 INFO - PID 14255 | |4;audio-oscillator;83;83;112;82;83;82;96;82;83;106 10:07:13 INFO - PID 14255 | |5;imaging-gaussian-blur;114;115;114;114;114;113;114;114;113;114 10:07:13 INFO - PID 14255 | |6;imaging-darkroom;149;149;148;147;149;149;149;148;149;148 10:07:13 INFO - PID 14255 | |7;imaging-desaturate;95;96;94;95;95;96;94;94;95;95 10:07:13 INFO - PID 14255 | |8;json-parse-financial;48;48;48;48;48;48;51;49;48;46 10:07:13 INFO - PID 14255 | |9;json-stringify-tinderbox;54;56;53;55;53;55;54;54;55;54 10:07:13 INFO - PID 14255 | |10;stanford-crypto-aes;87;83;80;81;79;80;79;79;79;82 10:07:13 INFO - PID 14255 | |11;stanford-crypto-ccm;132;127;130;125;132;131;129;127;210;125 10:07:13 INFO - PID 14255 | |12;stanford-crypto-pbkdf2;176;188;180;174;182;186;191;189;183;186 10:07:13 INFO - PID 14255 | |13;stanford-crypto-sha256-iterative;70;70;71;70;69;68;66;70;67;67 10:07:13 INFO - PID 14255 | __end_tp_report 10:07:13 INFO - PID 14255 | __start_cc_report 10:07:13 INFO - PID 14255 | _x_x_mozilla_cycle_collect,770 10:07:13 INFO - PID 14255 | __end_cc_report 10:07:13 INFO - PID 14255 | __startTimestamp1494608833959__endTimestamp 10:07:13 INFO - PID 14255 | 10:07:13 INFO - PID 14255 | ------- Summary: start ------- 10:07:13 INFO - PID 14255 | Number of tests: 14 10:07:13 INFO - PID 14255 | 10:07:13 INFO - PID 14255 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.50 stddev:2.49 (2.2%) stddev-sans-first:0.73 10:07:13 INFO - PID 14255 | Values: 103.0 111.0 110.0 111.0 110.0 110.0 111.0 110.0 110.0 112.0 10:07:13 INFO - PID 14255 | 10:07:13 INFO - PID 14255 | [#1] audio-beat-detection Cycles:10 Average:130.10 Median:123.00 stddev:18.39 (15.0%) stddev-sans-first:18.33 10:07:13 INFO - PID 14255 | Values: 148.0 121.0 120.0 172.0 120.0 118.0 117.0 117.0 143.0 125.0 10:07:13 INFO - PID 14255 | 10:07:13 INFO - PID 14255 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:4.01 (2.4%) stddev-sans-first:4.18 10:07:13 INFO - PID 14255 | Values: 162.0 164.0 164.0 160.0 161.0 161.0 163.0 169.0 173.0 164.0 10:07:13 INFO - PID 14255 | 10:07:13 INFO - PID 14255 | [#3] audio-fft Cycles:10 Average:79.40 Median:74.50 stddev:10.62 (14.3%) stddev-sans-first:11.08 10:07:13 INFO - PID 14255 | Values: 74.0 76.0 75.0 94.0 74.0 74.0 74.0 75.0 104.0 74.0 10:07:13 INFO - PID 14255 | 10:07:13 INFO - PID 14255 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:83.00 stddev:11.34 (13.7%) stddev-sans-first:11.81 10:07:13 INFO - PID 14255 | Values: 83.0 83.0 112.0 82.0 83.0 82.0 96.0 82.0 83.0 106.0 10:07:13 INFO - PID 14255 | 10:07:13 INFO - PID 14255 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 10:07:13 INFO - PID 14255 | Values: 114.0 115.0 114.0 114.0 114.0 113.0 114.0 114.0 113.0 114.0 10:07:13 INFO - PID 14255 | 10:07:13 INFO - PID 14255 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 10:07:13 INFO - PID 14255 | Values: 149.0 149.0 148.0 147.0 149.0 149.0 149.0 148.0 149.0 148.0 10:07:13 INFO - PID 14255 | 10:07:13 INFO - PID 14255 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 10:07:13 INFO - PID 14255 | Values: 95.0 96.0 94.0 95.0 95.0 96.0 94.0 94.0 95.0 95.0 10:07:13 INFO - PID 14255 | 10:07:13 INFO - PID 14255 | [#8] json-parse-financial Cycles:10 Average:48.20 Median:48.00 stddev:1.23 (2.6%) stddev-sans-first:1.30 10:07:13 INFO - PID 14255 | Values: 48.0 48.0 48.0 48.0 48.0 48.0 51.0 49.0 48.0 46.0 10:07:13 INFO - PID 14255 | 10:07:13 INFO - PID 14255 | [#9] json-stringify-tinderbox Cycles:10 Average:54.30 Median:54.50 stddev:0.95 (1.7%) stddev-sans-first:1.00 10:07:13 INFO - PID 14255 | Values: 54.0 56.0 53.0 55.0 53.0 55.0 54.0 54.0 55.0 54.0 10:07:13 INFO - PID 14255 | 10:07:13 INFO - PID 14255 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.50 stddev:2.56 (3.2%) stddev-sans-first:1.48 10:07:13 INFO - PID 14255 | Values: 87.0 83.0 80.0 81.0 79.0 80.0 79.0 79.0 79.0 82.0 10:07:13 INFO - PID 14255 | 10:07:13 INFO - PID 14255 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:130.50 stddev:25.85 (19.8%) stddev-sans-first:27.36 10:07:13 INFO - PID 14255 | Values: 132.0 127.0 130.0 125.0 132.0 131.0 129.0 127.0 210.0 125.0 10:07:13 INFO - PID 14255 | 10:07:13 INFO - PID 14255 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.50 Median:186.00 stddev:5.58 (3.0%) stddev-sans-first:5.22 10:07:13 INFO - PID 14255 | Values: 176.0 188.0 180.0 174.0 182.0 186.0 191.0 189.0 183.0 186.0 10:07:13 INFO - PID 14255 | 10:07:13 INFO - PID 14255 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:70.00 stddev:1.69 (2.4%) stddev-sans-first:1.73 10:07:13 INFO - PID 14255 | Values: 70.0 70.0 71.0 70.0 69.0 68.0 66.0 70.0 67.0 67.0 10:07:13 INFO - PID 14255 | -------- Summary: end -------- 10:07:13 INFO - PID 14255 | 10:07:15 INFO - TEST-INFO | 14255: exit 0 10:07:15 INFO - TEST-OK | kraken | took 60621ms 10:07:15 INFO - SUITE-END | took 1174s 10:07:15 INFO - Completed test suite (00:19:34) 10:07:15 INFO - javascript benchmark 10:07:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7845.462368573048, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3408.710259627932, 3418.0, 3447.8793242236497, 3451.8101504417255, 3458.6541345865417, 5954.106883967407, 6054.061620448826, 6064.5148388128955, 6080.63516189029, 6097.817065488031, 5933.821985340436, 6021.337652858182, 6068.271807383109, 6109.860177052738, 6135.539834512407, 5052.247884874238, 5249.1338929076655, 5359.490848369399, 5382.5963052771, 5402.729863506828, 5431.103867861798, 5498.725063746797, 5501.724913754317, 5518.475744804237, 5527.060399732035, 5257.658252213594, 5322.494363035506, 5409.729513524348, 5442.673439593617, 5452.073147564884, 5397.082495975694, 5440.156775699773, 5444.210589464545, 5474.671519708831, 5497.0, 5380.300560927094, 5394.109971854639, 5433.239346491494, 5433.972830135864, 5484.177373393983, 5921.674307913063, 5979.192808970777, 5991.460768530809, 6020.217371741689, 6084.60450070744, 6454.354564543555, 6565.868682626321, 6566.901496477509, 6574.243961944342, 6600.570962887397, 6637.103990961206, 6651.733930642768, 6664.666766661648, 6685.264620891698, 6687.331266873322, 6017.849553761191, 6130.417610327012, 6151.938480615181, 6160.199174107337, 6189.907151392733, 6567.802965911031, 6655.966720166368, 6683.532152749261, 6764.627945463047, 6787.355201255873, 6243.188385509946, 6288.9056664150075, 6326.2724786649205, 6490.837729056811, 6515.511336649675, 6388.680565971683, 6492.09110724499, 6501.837454063591, 6504.739810407626, 6509.218893732687, 6424.486041116699, 6465.418112369909, 6477.319881412383, 6479.5788273762055, 6480.287168411471, 6397.136386587844, 6481.449076828428, 6489.740410383626, 6582.473402127818, 6589.53873228879, 4923.48303428142, 4934.827281045146, 4937.407511098691, 4938.259261110862, 4973.930604919888, 4358.302671572596, 4369.148016136823, 4370.606645401929, 4398.3842262083335, 4410.514843367227, 6073.878522429527, 6096.950036952726, 6106.36966090081, 6139.723712432951, 6211.068339748984, 6504.707288172043, 6557.082008518812, 6594.604323740591, 6616.933830661728, 6633.933660663428, 6124.908126378108, 6135.9079613805825, 6145.231846019247, 6165.784197553064, 6197.504199664016, 5442.619016668795, 5551.694656793915, 5582.665040097607, 5584.5811564132855, 5594.748236329375, 6589.275179730322, 6696.06255124283, 6731.124953755981, 6748.966255168692, 6780.288069752803, 6638.236602790741, 6649.102371180023, 6655.401013908771, 6656.068150458843, 6661.16735408074, 6775.5199332577495, 6856.588604683735, 6872.244053154249, 6925.480588955747, 6931.89602155958, 6246.312905580292, 6293.244810622755, 6335.429811317003, 6357.110004599267, 6361.745530178741, 6574.737010519717, 6596.043573681885, 6611.371919667624, 6619.0733297339375, 6626.56927299724, 6191.442770150708, 6248.718807653576, 6254.906176407267, 6349.619022858643, 6389.329120442287, 6403.327650596807, 6429.77834211517, 6434.774782882577, 6435.742570297136, 6477.255115661759, 6180.845478862884, 6189.35011823752, 6301.684915754102, 6386.457151142205, 6447.097406363207, 6422.165118534561, 6489.8702025960165, 6504.60972341661, 6515.478761699147, 6517.087607734826, 6230.314665386894, 6270.372962703693, 6291.591046581958, 6301.6219026858535, 6309.0], "value": 5981.404893250909, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.3988808952836, 805.4965646470955, 829.3655353654456, 1060.8992145746151, 1081.0810810810813, 36594.0, 37395.813020934926, 37653.81173094137, 37696.62303376972, 37731.0, 38886.22227555447, 39071.21857562847, 39117.21765564687, 39148.80425597875, 39213.80393098038, 7069.4697897657625, 7095.538789978661, 7159.4988350815465, 7241.275872412769, 7263.854722905538, 7300.269973002711, 7311.195768465464, 7331.926680733178, 7370.115586129672, 7397.0, 7345.045144131255, 7377.963110184468, 7433.108027036763, 7445.8883116753295, 7450.552966822008, 7361.668724907392, 7397.667104980262, 7399.556026638392, 7407.296306850894, 7432.033835601392, 7293.380062694678, 7327.560346379234, 7342.082239720035, 7359.0, 7385.593792341419, 36618.267634647425, 36700.81649591735, 36787.0, 36866.815665921764, 36905.630943690485, 3501.562304711911, 3519.4896739972814, 3556.751027428081, 3563.6614521620404, 3568.8750893718857, 29381.26546836325, 29530.55704164439, 29580.260493487618, 29625.0, 29664.25839354012, 3725.2735716535285, 3734.477173195755, 3735.533058367704, 3745.925081498382, 3752.0057184846037, 192559.0, 193505.0, 198016.0, 204021.0, 204173.0, 46417.07165856664, 46580.53419465762, 46776.7661161692, 46809.0, 46939.061218776114, 48528.27207591889, 48714.512854871704, 55084.97032663242, 55781.72109139428, 55991.72004139953, 15573.196824571685, 15844.92077539628, 15961.36154553828, 15961.600959976093, 15975.760363594556, 12607.432665530074, 12642.304673242876, 12644.873551264554, 12664.683382915317, 12691.619251422471, 15151.166685832164, 15159.166245856362, 15184.0, 15353.309101090477, 15431.459898903484, 5972.462478376967, 6044.15381846533, 6104.481119104837, 6216.378362163748, 6311.431971122529, 1084.143526613966, 1118.7370967822555, 1131.2816361610437, 1132.9433528323716, 1135.4663308245113, 26333.0, 26767.732322676526, 26997.460050798873, 27141.592876106875, 27169.320766980985, 1207.0946789907568, 1214.1925619463134, 1214.2046959241534, 1214.7631211913592, 1230.2802860326808, 13456.932715336361, 13996.930015350063, 14300.713985720227, 14338.928305358406, 14385.208813515357, 236544.0, 237499.0, 239502.0, 239725.0, 241031.0, 52633.210501842506, 52730.73634631802, 52784.73607632014, 52872.0, 52881.73559132257, 1500.6998600279987, 1528.9923550382177, 1551.8836087293498, 1555.8677512411346, 1577.597712583284, 24623.0, 25665.486690266465, 25883.094091707455, 26135.0, 26243.868780655976, 38538.614613853504, 38708.6129138705, 38730.80634596809, 38858.22283554257, 38861.0, 187002.0, 187074.0, 187875.0, 188069.0, 188435.0, 35775.64224357827, 36013.09967250735, 36075.458868116475, 36199.45700814542, 36557.63442365542, 44010.0, 44011.77994110009, 44059.33910991273, 44089.338659920766, 44162.779186103864, 30725.23186920345, 31914.840425797724, 32239.0, 32242.677573223966, 33460.83269583636, 32036.839815801704, 32121.357572847945, 32154.83922580372, 32531.34937301288, 33548.49677254892, 37601.4359784598, 37975.62024379721, 37994.240115198096, 38162.09189540456, 38219.42670859884, 30714.539281910344, 31570.842145789124, 32248.677513224568, 32511.34977300488, 33268.334633307684, 25870.611940820527, 26806.195814125607, 26870.59694104629, 26896.193114206606, 27327.726722732517], "value": 17309.028107792175, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [448.15299084729844, 454.69535411274444, 456.5685427271228, 475.65277347536295, 478.6434106590588, 19906.40280791577, 19996.603464466254, 21019.894900525494, 21073.0, 21229.469263268427, 21459.785402145975, 22398.88800555995, 22399.55200895981, 22428.775712242874, 22500.0, 4506.526814684444, 5462.317210348697, 5610.607257491977, 5666.490015898568, 5680.659160450366, 5658.43415658435, 5731.799387021455, 5751.7986870459545, 5775.682337471459, 5781.4507621775865, 5518.19986102015, 5557.3886872444, 5666.0, 5697.77208911643, 5726.055200891848, 5609.439056094398, 5617.466340697627, 5636.605437619389, 5647.152927060933, 5653.095504719246, 5058.46886076964, 5090.261912022736, 5133.974330128362, 5144.279800827887, 5171.37943446785, 24715.62926556103, 24814.627780583305, 24957.5008499829, 25040.499190016097, 25207.84901887264, 2105.8525903186783, 2158.3093410108772, 2170.121100954116, 2183.1376606240447, 2193.7038499802643, 16672.83327166725, 16943.745843812354, 17077.231524581424, 17161.313547458085, 17320.13399330041, 2201.3836125884777, 2235.865848049122, 2261.231181398316, 2266.580682573729, 2282.5549017941507, 98206.0, 100031.0, 113840.0, 115167.0, 117019.99999999914, 12502.437390317458, 12637.0, 12643.902243950291, 12886.935565322301, 13079.346032698328, 17893.19480623375, 18043.0, 18051.458456246335, 18077.0, 18107.18517666708, 8836.160564746338, 8941.418807777603, 9005.14451127142, 9051.954740226256, 9083.048009396973, 8002.159773223728, 8052.758417247492, 8111.513309201467, 8299.419040667217, 8365.1216622255, 7781.105172905075, 8036.919630803734, 8178.304844088319, 8192.5494097824, 8259.719743439777, 2338.468911942978, 2350.095213342841, 2386.2006227913844, 2392.653065305521, 2457.69278840145, 1031.6131450705984, 1061.2040969273046, 1071.59815069349, 1072.8658917635296, 1077.1060020183386, 23338.299851004496, 24806.0, 25030.37424064413, 25133.0, 25186.11848585291, 1067.5089458849016, 1093.6554985179803, 1094.2067001423904, 1100.4057808783327, 1123.5898896902572, 10982.231243813016, 11423.086153107732, 11450.427478626201, 11526.250793698382, 11582.305061696325, 516730.0, 530009.0, 531552.0, 534984.0, 536363.0, 96199.51900240454, 96262.0, 96742.0, 97638.0, 97945.51027244961, 1220.231254309797, 1252.5303011370736, 1283.6277479530831, 1289.0976316578433, 1289.9871001289866, 17460.476185714448, 17532.649347013245, 17956.91021544884, 18022.369217077863, 18138.455846324632, 44600.33099503575, 45722.31416528688, 46088.53911460842, 46437.80544305084, 46459.303110452696, 58197.418025820894, 58696.706516467144, 58702.706486467294, 59036.70481647564, 59574.0, 8835.558222089, 8977.114805890837, 9158.221551167959, 9168.482841511503, 9258.398204116711, 13534.323283835573, 13801.171929684251, 13853.653658658613, 13956.2324072177, 14051.437942482595, 11396.487158078073, 11701.0, 12011.399430028638, 12172.39138043112, 12379.69050773738, 11279.605213817476, 11310.886891131313, 11654.76690466169, 11744.94127529357, 11895.762084758084, 11156.832647510131, 11267.098632109575, 11403.828942566033, 11660.416979151178, 12421.689457763629, 9003.459792412476, 9283.350165488351, 9522.714318570454, 9545.713628591153, 9938.354006989523, 12324.0, 12369.876301237233, 12486.375681216085, 12549.755090232497, 12579.622611321674], "value": 10181.295436272025, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.4796803230756, 1431.7279716853798, 1437.4609521429463, 1438.3599298312256, 1439.805626240458, 11421.942890285547, 11699.298042117469, 11827.29036257824, 11992.700182495442, 12264.693382665439, 11887.108466864976, 12011.219270747395, 12020.879791202085, 12077.0, 12115.697107572292, 2389.199618127929, 2438.3050830513307, 2440.6583078369044, 2442.0, 2447.645091461737, 2294.724633044037, 2357.26924653358, 2366.1363602285214, 2380.4881950380664, 2387.450886296153, 2333.9416514587188, 2335.3344296875393, 2380.452495925938, 2383.07060246504, 2387.3554140382084, 2253.876036817974, 2333.5916214662366, 2334.0080465801966, 2335.0, 2338.1115176232925, 1940.3305859478457, 2023.2817349840889, 2266.9206577769864, 2317.5712493188644, 2323.5701395241936, 11454.770904581861, 11513.769724605461, 11522.481488333045, 11627.767444651145, 11639.418029098511, 6505.577137486096, 6717.899231511531, 6751.864962700768, 6759.628220447873, 6767.796966090976, 3844.884653460401, 4036.4348991141264, 4096.996235922188, 4111.5477297497555, 4233.407322974786, 1381.5924302330736, 1393.0, 1409.478492957602, 1460.978085328721, 1462.9414823407158, 17546.473605791845, 17715.645687086315, 17744.11279436023, 17784.199711013036, 17832.0, 5099.821506247264, 5131.974340128276, 5426.430224826337, 5426.864328391822, 5493.862653433616, 12527.56153534622, 12602.684932876751, 12615.747685046432, 12618.936905315415, 12681.175723577939, 6510.44661203803, 6515.283318834924, 6523.315051919575, 6580.670966451754, 6587.868242635121, 5904.261967254093, 6061.242344706911, 6104.053871649901, 6171.84570385735, 6175.2898416681755, 4176.206520761046, 4226.387173859773, 4282.550332215135, 4325.4593175853015, 4344.608985191285, 1201.897838683704, 1238.120934136755, 1240.962771116868, 1242.0932719115096, 1251.7121062155754, 811.9350451963828, 826.2109685250572, 831.6548632317641, 847.4068152293419, 863.6933888469629, 5938.138969849348, 5943.910841337383, 5944.108383742473, 6030.6080104793045, 6136.7852125175405, 635.4598591197445, 636.5162476517879, 642.7204166187723, 648.8183308673579, 655.1155939481662, 3463.79217246966, 4103.035786590149, 4141.730787498803, 4368.934465983013, 4563.178627847019, 15679.608009799618, 15697.0, 15860.04839709621, 15893.761593576106, 16122.677546449006, 15614.843851561565, 15635.765463518057, 15707.528774136794, 15817.0, 15824.129672867872, 8926.241269492166, 9365.0, 9440.244780417688, 9453.90546094544, 9497.90502094984, 6693.799186024427, 6732.562383445061, 6742.089817874524, 6764.594124352555, 6849.726010959505, 13478.46086156582, 13701.794473083111, 13888.375023123781, 13970.720585588435, 13974.790378144133, 13777.793333099811, 13970.602939705948, 14104.365303561159, 14197.148171109766, 14462.0, 9300.279448302086, 9465.858012129962, 9570.90429095728, 9588.712338629852, 9609.759756005877, 10191.592336306465, 10525.89474105249, 10549.367037977747, 10563.524641391003, 10611.522481488197, 9130.315226358183, 9157.221636160735, 9241.86137207929, 9419.0, 9472.100150485692, 8731.825363492822, 8889.422187557788, 8896.199342059246, 8896.955515222642, 9112.908870911471, 7374.668139933823, 7615.809604759926, 7645.770626881203, 7647.273509016857, 7655.349295309961, 5621.9156712650165, 5710.571707122065, 5822.359540450631, 5829.970850145722, 5935.525157987437, 5786.594938354275, 5871.236739223874, 5874.94125058744, 5903.704814759159, 5916.467517923407], "value": 5318.00304063986, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.5037954454655, 418.8513077857361, 434.1079082485492, 437.4903237728046, 442.7122370459201, 5926.792562260322, 6048.425399587043, 6077.817665470032, 6173.413525715061, 6203.286622038461, 5896.793612223573, 5978.671173085479, 6034.24571928509, 6040.593668666541, 6047.455728984391, 4771.5467030632035, 4853.640980525459, 4859.927101093486, 4864.367632207825, 4882.609391248691, 4481.686281960264, 4624.260118381059, 4630.652701047418, 4636.837710680127, 4868.148074087038, 4577.519360467153, 4590.081983603292, 4594.104149690812, 4594.770261486929, 4602.861914142581, 4571.862844114682, 4600.6319494440695, 4611.19304121779, 4626.097910907374, 4631.8147274109, 4003.4795476588147, 4283.421738065353, 4388.605025547684, 4428.822847086113, 4431.756253406062, 6016.308124565688, 6024.975754121766, 6030.155778191057, 6031.642880351929, 6036.0, 5528.585356098309, 5774.797882074107, 5778.959787238296, 5795.0, 5810.273715785527, 6484.935150648527, 6493.577917435352, 6500.4799616030605, 6508.219013718337, 6513.641749703765, 4930.0, 4959.454460009396, 4972.204447288453, 4975.676581022258, 4991.925121123186, 6694.062831203635, 6778.8305292367595, 6809.080774095483, 6809.761658341984, 6836.555623884432, 5085.669431487016, 5088.898222035613, 5108.770105345268, 5122.282880396748, 5134.5635620972635, 5039.874003149951, 5162.406323272797, 5180.352455943007, 5203.7918483261, 5222.190560463135, 5717.399673034354, 5736.368999410061, 5755.0, 5763.164341170507, 5774.456521739094, 6318.399752023551, 6447.3552644735155, 6533.346665333429, 6542.313057128933, 6575.914974029327, 1780.6527727093091, 1809.348634491582, 1813.1478205243513, 1814.1654838774311, 1817.6273863857878, 1247.5259401427581, 1304.589054447846, 1308.9934550327187, 1312.4094157628915, 1322.7751282281843, 6183.81448556544, 6192.628442293387, 6197.318294987548, 6216.191895053705, 6240.875182496416, 6440.452561532228, 6666.933330666729, 6689.4982876284475, 6694.230163531159, 6707.798766037026, 6138.877222455526, 6188.659623720649, 6195.411435913581, 6216.285127210338, 6225.719842607094, 3530.770499917497, 3537.628549002318, 3549.846299952526, 3550.928981420409, 3554.4940816724147, 6742.42689371409, 6896.241413444517, 6900.3444672756, 6901.792946211622, 6991.720331186797, 6815.250322464525, 6861.656917154222, 6885.621290829053, 6899.93100069003, 6905.409187222716, 6860.211075726255, 6898.689558969859, 6973.198082220508, 6977.965110174417, 7023.613701246481, 6672.733090676513, 6706.899396509154, 6712.83217919556, 6734.56225345351, 6746.325367463214, 6516.902246466401, 6537.182852143482, 6606.273309935807, 6610.9669451652435, 6639.502037347122, 6891.0, 6929.896051559332, 6956.40870526011, 7004.579725216503, 7021.824454388681, 5063.113955057924, 5121.462246464068, 5178.456262092577, 5179.145441002343, 5182.689038657692, 6523.967380163259, 6711.966440167768, 6722.361375669304, 6736.562123461959, 6756.905359338621, 6461.19235095613, 6479.8056058318325, 6486.772962946275, 6502.154719886385, 6504.479641628753, 6398.968005160131, 6418.106658535837, 6458.483321334188, 6493.155889734304, 6512.381323774234, 6479.930811416064, 6480.740770369321, 6492.318306577741, 6518.608883467007, 6523.18460192476, 6320.652364120017, 6483.222013358427, 6534.542582019213, 6535.0, 6544.443722283469, 6349.174607301022, 6360.173177487082, 6372.96813515948, 6374.139491168633, 6375.6174629522375], "value": 5044.0470313685955, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [840.1010918317403, 866.3675516872682, 871.0636066228806, 875.5840975536621, 894.65555761032, 15230.162341071236, 15586.688266234683, 15608.297626606816, 16393.590160246, 17496.387626433076, 16423.58941026475, 16547.172641367913, 16631.501054968372, 16754.916225418885, 17254.482365529053, 962.1388856973005, 971.3831716859775, 983.6557204978272, 984.4733067808723, 989.2481713897417, 972.1396564040804, 1002.1682003936716, 1007.9294449388545, 1009.0817356205854, 1014.3457469931926, 1058.3226734889638, 1064.7178497698117, 1066.9626563070294, 1073.5544748929185, 1075.811732946735, 1038.444432228754, 1043.8695163104612, 1045.6862941117633, 1046.1473898772551, 1047.7433028907928, 765.9119201291867, 772.3820943245381, 775.1628241499168, 775.8836174573803, 778.2723153851167, 14263.500777472842, 14264.286785660675, 14285.500007499792, 15432.0, 15865.841341586553, 17844.28622855084, 17929.820701793076, 17932.641347173114, 18237.17932693032, 18414.907925460288, 13654.590362289147, 13942.302884855819, 13989.930050349683, 14023.579292621238, 14098.577042688736, 3452.87914922979, 3460.1349662584353, 3463.6363181866045, 3481.5125882376487, 3482.9129271768156, 92588.53705731496, 93133.0, 94670.526647367, 95601.0, 95613.0, 13599.796003059962, 13619.863801362058, 13699.726005480034, 13719.314034298246, 13733.0, 23802.166924157573, 24087.879560602083, 24259.0, 24325.39186520351, 25099.372515687253, 8491.95754021226, 8700.825983480296, 8720.084391138966, 8720.563971801384, 8727.607257673293, 4196.979015104966, 4256.4679415073115, 4284.785760712014, 4365.607095361433, 4366.847160349373, 4377.4965878923695, 4438.933415998763, 4447.043885564619, 4458.264386376277, 4483.3947417098925, 903.5211337990876, 921.3688623292932, 933.8645896344992, 937.4234845569925, 942.5569982108398, 665.3679004945321, 681.402196402993, 687.5221720903924, 695.5861262548775, 704.5807744392079, 10559.683209503728, 11788.115891308185, 12002.939985300018, 12226.0, 12376.133670642968, 666.6000399760202, 673.7069374821968, 676.6887231873393, 684.7637565040053, 687.7764726463919, 5197.610179236497, 5202.583793296527, 5279.1289437243195, 5432.375276843135, 5516.7517461714315, 71341.64329178321, 71579.56840863258, 71868.0, 75639.62180189064, 79422.0, 67582.0, 70648.64675676692, 70657.2934270661, 71251.44982602017, 71699.0, 65456.67271663611, 69185.30814691789, 72952.63523682454, 73287.0, 74617.6269118651, 11781.823272651089, 12890.162139460905, 12929.870701292866, 13028.348582571023, 13051.934740326238, 32534.34931301408, 34066.489002665476, 34954.47568286427, 35387.82306088453, 36909.26181476409, 59136.0, 62698.37301626925, 63159.36840631535, 64027.35972640214, 64315.356846432805, 16555.427234412713, 16761.91619041897, 17049.147542623068, 17663.38178163758, 17969.640607188045, 16715.0, 17034.0, 17274.654506910043, 17320.566985825455, 17436.128193590015, 17434.9128254363, 17652.73520897213, 17688.469345919642, 17897.46307610774, 18135.36526221576, 16375.344986200418, 16407.343706251617, 16460.588485287484, 16533.256003479633, 16672.416465423652, 15725.764113538535, 16248.593785155466, 16316.918415407847, 16546.66906661884, 17003.574910627332, 11878.524859005543, 11893.46479408446, 12322.753544928872, 12459.439325230205, 12524.311162886128, 14291.64270893236, 15098.849011509745, 15195.696086077995, 15288.235588220767, 15356.0], "value": 8246.620123851133, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1502.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 110.0, 111.0, 110.0, 110.0, 111.0, 110.0, 110.0, 112.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 121.0, 120.0, 172.0, 120.0, 118.0, 117.0, 117.0, 143.0, 125.0], "value": 130.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 164.0, 160.0, 161.0, 161.0, 163.0, 169.0, 173.0, 164.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 94.0, 74.0, 74.0, 74.0, 75.0, 104.0, 74.0], "value": 79.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 112.0, 82.0, 83.0, 82.0, 96.0, 82.0, 83.0, 106.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 113.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 147.0, 149.0, 149.0, 149.0, 148.0, 149.0, 148.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 95.0, 95.0, 96.0, 94.0, 94.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 48.0, 48.0, 48.0, 48.0, 48.0, 51.0, 49.0, 48.0, 46.0], "value": 48.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 53.0, 55.0, 53.0, 55.0, 54.0, 54.0, 55.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 80.0, 81.0, 79.0, 80.0, 79.0, 79.0, 79.0, 82.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 127.0, 130.0, 125.0, 132.0, 131.0, 129.0, 127.0, 210.0, 125.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 188.0, 180.0, 174.0, 182.0, 186.0, 191.0, 189.0, 183.0, 186.0], "value": 183.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 71.0, 70.0, 69.0, 68.0, 66.0, 70.0, 67.0, 67.0], "value": 68.8, "unit": "score"}]}]} 10:07:15 INFO - Return code: 0 10:07:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:07:15 INFO - # TBPL SUCCESS # 10:07:15 INFO - Running post-action listener: _resource_record_post_action 10:07:15 INFO - [mozharness: 2017-05-12 17:07:15.261130Z] Finished run-tests step (success) 10:07:15 INFO - Running post-run listener: _resource_record_post_run 10:07:15 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 379162624; Read time: 0; Write time: 265576 10:07:15 INFO - TinderboxPrint: CPU usage
13.3% 10:07:15 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:07:15 INFO - TinderboxPrint: I/O write bytes / time
379,162,624 / 265,576 10:07:15 INFO - TinderboxPrint: CPU idle
8,251.9 (86.7%) 10:07:15 INFO - TinderboxPrint: CPU user
1,206.1 (12.7%) 10:07:15 INFO - TinderboxPrint: Swap in / out
0 / 0 10:07:15 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 112087040; Read time: 0; Write time: 93684 10:07:15 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 267075584; Read time: 0; Write time: 171892 10:07:15 INFO - Running post-run listener: _upload_blobber_files 10:07:15 INFO - Blob upload gear active. 10:07:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:07:15 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 10:07:15 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'] 10:07:15 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 10:07:16 INFO - (blobuploader) - INFO - Open directory for files ... 10:07:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:07:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:07:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:07:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:07:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:07:17 INFO - (blobuploader) - INFO - Done attempting. 10:07:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:07:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:07:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:07:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:07:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:07:18 INFO - (blobuploader) - INFO - Done attempting. 10:07:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:07:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:07:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:07:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:07:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:07:21 INFO - (blobuploader) - INFO - Done attempting. 10:07:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:07:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:07:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:07:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:07:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:07:22 INFO - (blobuploader) - INFO - Done attempting. 10:07:22 INFO - (blobuploader) - INFO - Iteration through files over. 10:07:22 INFO - Return code: 0 10:07:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:07:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:07:22 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e33f60420474abe948e861ad0139743abdd64fabcfc0b65f3baa98de427ed81bde657cc056111665b5e05f6e19c9bbc2655e8a8519ffcf1389685de16235c1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e090f2639693fa68545952ebbb270040fe6bb3c135a6689de02542ee93101a1e1e167e49ed4a67e577d79e3a02a6dec42306cca8beb71ee2a48c2e7f90e137ec", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f308e7661d9c8ee3d40d04fec2ba8a017cc57a5423ae0902731b994f27b8f207efbb0a9361553bde7ec53bd657192b20d9c409da497bb360a4de58bda559722d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/062d99db7c06dac57412433c52fb359aa0fdeaf6a71e2dc841177bb9554e0f2763b1372113acc5b20465a66200d413163ce19d347e701a2f1c604d6155819763"} 10:07:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:07:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:07:22 INFO - Contents: 10:07:22 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e33f60420474abe948e861ad0139743abdd64fabcfc0b65f3baa98de427ed81bde657cc056111665b5e05f6e19c9bbc2655e8a8519ffcf1389685de16235c1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e090f2639693fa68545952ebbb270040fe6bb3c135a6689de02542ee93101a1e1e167e49ed4a67e577d79e3a02a6dec42306cca8beb71ee2a48c2e7f90e137ec", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f308e7661d9c8ee3d40d04fec2ba8a017cc57a5423ae0902731b994f27b8f207efbb0a9361553bde7ec53bd657192b20d9c409da497bb360a4de58bda559722d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/062d99db7c06dac57412433c52fb359aa0fdeaf6a71e2dc841177bb9554e0f2763b1372113acc5b20465a66200d413163ce19d347e701a2f1c604d6155819763"} 10:07:22 INFO - Running post-run listener: copy_logs_to_upload_dir 10:07:22 INFO - Copying logs to upload dir... 10:07:22 INFO - mkdir: /builds/slave/test/build/upload/logs 10:07:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.088051 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-05-12 10:07:22.427062) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 10:07:22.432137) ========= 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=6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653 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/3e33f60420474abe948e861ad0139743abdd64fabcfc0b65f3baa98de427ed81bde657cc056111665b5e05f6e19c9bbc2655e8a8519ffcf1389685de16235c1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e090f2639693fa68545952ebbb270040fe6bb3c135a6689de02542ee93101a1e1e167e49ed4a67e577d79e3a02a6dec42306cca8beb71ee2a48c2e7f90e137ec", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f308e7661d9c8ee3d40d04fec2ba8a017cc57a5423ae0902731b994f27b8f207efbb0a9361553bde7ec53bd657192b20d9c409da497bb360a4de58bda559722d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/062d99db7c06dac57412433c52fb359aa0fdeaf6a71e2dc841177bb9554e0f2763b1372113acc5b20465a66200d413163ce19d347e701a2f1c604d6155819763"} build_url:https://queue.taskcluster.net/v1/task/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011068 build_url: 'https://queue.taskcluster.net/v1/task/LSGaJGHfTrmZDJ2dFRsIjA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e33f60420474abe948e861ad0139743abdd64fabcfc0b65f3baa98de427ed81bde657cc056111665b5e05f6e19c9bbc2655e8a8519ffcf1389685de16235c1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e090f2639693fa68545952ebbb270040fe6bb3c135a6689de02542ee93101a1e1e167e49ed4a67e577d79e3a02a6dec42306cca8beb71ee2a48c2e7f90e137ec", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f308e7661d9c8ee3d40d04fec2ba8a017cc57a5423ae0902731b994f27b8f207efbb0a9361553bde7ec53bd657192b20d9c409da497bb360a4de58bda559722d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/062d99db7c06dac57412433c52fb359aa0fdeaf6a71e2dc841177bb9554e0f2763b1372113acc5b20465a66200d413163ce19d347e701a2f1c604d6155819763"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 10:07:22.461528) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 10:07:22.461928) ========= 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=6dbc10da6d83fee962c624be000001a8-1494607452.192677-959458653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 10:07:22.544447) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 10:07:22.547834) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 10:07:22.548193) ========= ========= Total master_lag: 0.18 =========