builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-072 starttime: 1495234035.25 results: success (0) revision: 8d60d0f825110cfb646ac31dc16dc011708bcf34 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-19 15:47:15.255180) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-19 15:47:15.255666) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-19 15:47:15.255998) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-19 15:47:15.330734) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 15:47:15.331122) ========= 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=199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-19 15:47:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2017-05-19 15:47:15 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083560 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 15:47:15.449448) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 15:47:15.449786) ========= 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=199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019439 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 15:47:15.503338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 15:47:15.503710) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8d60d0f825110cfb646ac31dc16dc011708bcf34 --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 8d60d0f825110cfb646ac31dc16dc011708bcf34 --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=199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-19 15:47:15,880 truncating revision to first 12 chars 2017-05-19 15:47:15,880 Setting DEBUG logging. 2017-05-19 15:47:15,880 attempt 1/10 2017-05-19 15:47:15,880 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8d60d0f82511?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-19 15:47:16,209 unpacking tar archive at: mozilla-central-8d60d0f82511/testing/mozharness/ program finished with exit code 0 elapsedTime=0.601237 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 15:47:16.121412) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-19 15:47:16.121800) ========= script_repo_revision: 8d60d0f825110cfb646ac31dc16dc011708bcf34 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-19 15:47:16.122261) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-19 15:47:16.122612) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-19 15:47:16.131369) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-05-19 15:47:16.131674) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:47:16 INFO - MultiFileLogger online at 20170519 15:47:16 in /builds/slave/test 15:47:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:47:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:47:16 INFO - {'append_to_log': False, 15:47:16 INFO - 'base_work_dir': '/builds/slave/test', 15:47:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:47:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:47:16 INFO - 'branch': 'Firefox-Non-PGO', 15:47:16 INFO - 'buildbot_json_path': 'buildprops.json', 15:47:16 INFO - 'config_files': ('talos/linux_config.py',), 15:47:16 INFO - 'default_actions': ('clobber', 15:47:16 INFO - 'read-buildbot-config', 15:47:16 INFO - 'download-and-extract', 15:47:16 INFO - 'populate-webroot', 15:47:16 INFO - 'create-virtualenv', 15:47:16 INFO - 'install', 15:47:16 INFO - 'run-tests'), 15:47:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:47:16 INFO - 'download_minidump_stackwalk': True, 15:47:16 INFO - 'download_symbols': 'ondemand', 15:47:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:47:16 INFO - 'tooltool.py': '/tools/tooltool.py', 15:47:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:47:16 INFO - '/tools/misc-python/virtualenv.py')}, 15:47:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:47:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:47:16 INFO - 'gecko_profile': False, 15:47:16 INFO - 'gecko_profile_interval': 0, 15:47:16 INFO - 'installer_path': 'installer.exe', 15:47:16 INFO - 'log_level': 'info', 15:47:16 INFO - 'log_name': 'talos', 15:47:16 INFO - 'log_to_console': True, 15:47:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:47:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:47:16 INFO - 'opt_config_files': (), 15:47:16 INFO - 'pip_index': False, 15:47:16 INFO - 'suite': 'dromaeojs-e10s', 15:47:16 INFO - 'system_bits': '32', 15:47:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:47:16 INFO - 'title': 'talos-linux64-ix-072', 15:47:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:47:16 INFO - 'use_talos_json': True, 15:47:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:47:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:47:16 INFO - 'work_dir': 'build'} 15:47:16 INFO - [mozharness: 2017-05-19 22:47:16.605439Z] Running clobber step. 15:47:16 INFO - Running pre-action listener: _resource_record_pre_action 15:47:16 INFO - Running main action method: clobber 15:47:16 INFO - rmtree: /builds/slave/test/build 15:47:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:47:17 INFO - Running post-action listener: _resource_record_post_action 15:47:17 INFO - [mozharness: 2017-05-19 22:47:17.633741Z] Finished clobber step (success) 15:47:17 INFO - [mozharness: 2017-05-19 22:47:17.633843Z] Running read-buildbot-config step. 15:47:17 INFO - Running pre-action listener: _resource_record_pre_action 15:47:17 INFO - Running main action method: read_buildbot_config 15:47:17 INFO - Using buildbot properties: 15:47:17 INFO - { 15:47:17 INFO - "project": "", 15:47:17 INFO - "product": "firefox", 15:47:17 INFO - "who": "kwierso@gmail.com", 15:47:17 INFO - "installer_path": "public/build/target.tar.bz2", 15:47:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:47:17 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 15:47:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:47:17 INFO - "stage_platform": "linux64", 15:47:17 INFO - "basedir": "/builds/slave/test", 15:47:17 INFO - "buildnumber": 887, 15:47:17 INFO - "platform": "ubuntu64_hw", 15:47:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:47:17 INFO - "slavebuilddir": "test", 15:47:17 INFO - "taskId": "Dawvn6EdQLKg9MCIL8LPxA", 15:47:17 INFO - "branch": "mozilla-central", 15:47:17 INFO - "script_repo_revision": "production", 15:47:17 INFO - "revision": "8d60d0f825110cfb646ac31dc16dc011708bcf34", 15:47:17 INFO - "slavename": "talos-linux64-ix-072", 15:47:17 INFO - "repo_path": "mozilla-central" 15:47:17 INFO - } 15:47:17 INFO - Finding installer, test and symbols from parent task. 15:47:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dawvn6EdQLKg9MCIL8LPxA'}, attempt #1 15:47:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dawvn6EdQLKg9MCIL8LPxA'}, attempt #1 15:47:18 INFO - Task dependencies: bFUxTHNvTiKLiEgp_rTjEg 15:47:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg'}, attempt #1 15:47:19 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/target.tar.bz2 15:47:19 INFO - Set test_url: https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/test_packages.json 15:47:19 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/target.crashreporter-symbols.zip 15:47:19 INFO - Running post-action listener: _resource_record_post_action 15:47:19 INFO - [mozharness: 2017-05-19 22:47:19.010528Z] Finished read-buildbot-config step (success) 15:47:19 INFO - [mozharness: 2017-05-19 22:47:19.010749Z] Running download-and-extract step. 15:47:19 INFO - Running pre-action listener: _resource_record_pre_action 15:47:19 INFO - Running main action method: download_and_extract 15:47:19 INFO - mkdir: /builds/slave/test/build/tests 15: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')]} 15:47:19 INFO - trying https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/target.test_packages.json 15:47:19 INFO - Downloading https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:47:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:47:19 INFO - Downloaded 986 bytes. 15:47:19 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:47:19 INFO - Using the following test package requirements: 15:47:19 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:47:19 INFO - u'common': [u'target.common.tests.zip'], 15:47:19 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:47:19 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:47:19 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:47:19 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:47:19 INFO - u'mozbase': [u'target.common.tests.zip'], 15:47:19 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:47:19 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:47:19 INFO - u'web-platform': [u'target.common.tests.zip', 15:47:19 INFO - u'target.web-platform.tests.zip'], 15:47:19 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:47:19 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:47:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/target.common.tests.zip 15:47:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:47:19 INFO - Fetch https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/target.common.tests.zip into memory 15:47:22 INFO - Content-Length response header: 63520763 15:47:22 INFO - Bytes received: 63520763 15:47:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:47:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/target.common.tests.zip 15:47:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:47:33 INFO - Fetch https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/target.common.tests.zip into memory 15:47:34 INFO - Content-Length response header: 63520763 15:47:34 INFO - Bytes received: 63520763 15:47:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/target.talos.tests.zip 15:47:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:47:46 INFO - Fetch https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/target.talos.tests.zip into memory 15:47:47 INFO - Content-Length response header: 14410000 15:47:47 INFO - Bytes received: 14410000 15:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:47 INFO - trying https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/target.tar.bz2 15:47:47 INFO - Downloading https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:47:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:47:49 INFO - Downloaded 54801655 bytes. 15:47:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/target.tar.bz2 15:47:49 INFO - mkdir: /builds/slave/test/properties 15:47:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:47:49 INFO - Writing to file /builds/slave/test/properties/build_url 15:47:49 INFO - Contents: 15:47:49 INFO - build_url:https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/target.tar.bz2 15:47:49 INFO - Running post-action listener: _resource_record_post_action 15:47:49 INFO - Running post-action listener: set_extra_try_arguments 15:47:49 INFO - [mozharness: 2017-05-19 22:47:49.610624Z] Finished download-and-extract step (success) 15:47:49 INFO - [mozharness: 2017-05-19 22:47:49.610742Z] Running populate-webroot step. 15:47:49 INFO - Running pre-action listener: _resource_record_pre_action 15:47:49 INFO - Running main action method: populate_webroot 15:47:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:47:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:47:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:47:49 INFO - '--tppagecycles', 15:47:49 INFO - '7'], 15:47:49 INFO - 'tests': ['tsvgm']}}, 15:47:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:47:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:47:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:47:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:47:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:47:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:47:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:47:49 INFO - 'talos_options': ['--disable-e10s'], 15:47:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:47:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:47:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:47:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:47:49 INFO - 'talos_options': ['--disable-e10s'], 15:47:49 INFO - 'tests': ['damp', 'tps']}, 15:47:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:47:49 INFO - 'tests': ['damp', 'tps']}, 15:47:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:47:49 INFO - 'tests': ['dromaeo_dom']}, 15:47:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:47:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:47:49 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 15:47:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:47:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:47:49 INFO - 'tests': ['ts_paint', 'tp5o']}, 15:47:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:47:49 INFO - 'tests': ['a11yr', 15:47:49 INFO - 'ts_paint', 15:47:49 INFO - 'tpaint', 15:47:49 INFO - 'sessionrestore', 15:47:49 INFO - 'sessionrestore_no_auto_restore', 15:47:49 INFO - 'tabpaint']}, 15:47:49 INFO - 'other-e10s': {'tests': ['a11yr', 15:47:49 INFO - 'ts_paint', 15:47:49 INFO - 'tpaint', 15:47:49 INFO - 'sessionrestore', 15:47:49 INFO - 'sessionrestore_no_auto_restore', 15:47:49 INFO - 'tabpaint']}, 15:47:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:47:49 INFO - 'ts_paint', 15:47:49 INFO - 'tpaint', 15:47:49 INFO - 'sessionrestore', 15:47:49 INFO - 'sessionrestore_no_auto_restore', 15:47:49 INFO - 'tabpaint']}, 15:47:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:47:49 INFO - 'ts_paint', 15:47:49 INFO - 'tpaint', 15:47:49 INFO - 'sessionrestore', 15:47:49 INFO - 'sessionrestore_no_auto_restore', 15:47:49 INFO - 'tabpaint']}, 15:47:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:47:49 INFO - 'tests': ['a11yr', 15:47:49 INFO - 'ts_paint', 15:47:49 INFO - 'tpaint', 15:47:49 INFO - 'sessionrestore', 15:47:49 INFO - 'sessionrestore_no_auto_restore', 15:47:49 INFO - 'tabpaint']}, 15:47:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:47:49 INFO - 'tests': ['a11yr', 15:47:49 INFO - 'ts_paint', 15:47:49 INFO - 'tpaint', 15:47:49 INFO - 'sessionrestore', 15:47:49 INFO - 'sessionrestore_no_auto_restore', 15:47:49 INFO - 'tabpaint']}, 15:47:49 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 15:47:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 15:47:49 INFO - 'bloom_basic_ref']}, 15:47:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:47:49 INFO - 'tests': ['tsvgx', 15:47:49 INFO - 'tsvgr_opacity', 15:47:49 INFO - 'tart', 15:47:49 INFO - 'tscrollx', 15:47:49 INFO - 'cart', 15:47:49 INFO - 'tsvg_static']}, 15:47:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:47:49 INFO - 'tsvgr_opacity', 15:47:49 INFO - 'tart', 15:47:49 INFO - 'tscrollx', 15:47:49 INFO - 'cart', 15:47:49 INFO - 'tsvg_static']}, 15:47:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:47:49 INFO - 'talos_options': ['--disable-e10s'], 15:47:49 INFO - 'tests': ['tp5o']}, 15:47:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:47:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:47:49 INFO - 'talos_options': ['--disable-e10s', 15:47:49 INFO - '--xperf_path', 15:47:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:47:49 INFO - 'tests': ['tp5n']}, 15:47:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:47:49 INFO - 'talos_options': ['--xperf_path', 15:47:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:47:49 INFO - 'tests': ['tp5n']}}, 15:47:49 INFO - 'talos.zip': {'path': '', 15:47:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:47:49 INFO - Running post-action listener: _resource_record_post_action 15:47:49 INFO - [mozharness: 2017-05-19 22:47:49.628537Z] Finished populate-webroot step (success) 15:47:49 INFO - [mozharness: 2017-05-19 22:47:49.628645Z] Running create-virtualenv step. 15:47:49 INFO - Running pre-action listener: _resource_record_pre_action 15:47:49 INFO - Running main action method: create_virtualenv 15:47:49 INFO - Creating virtualenv /builds/slave/test/build/venv 15:47:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:47:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:47:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:47:49 INFO - Using real prefix '/usr' 15:47:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:47:50 INFO - Installing distribute.............................................................................................................................................................................................done. 15:47:52 INFO - Installing pip.................done. 15:47:52 INFO - Return code: 0 15:47:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:47:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:47:52 INFO - Reading from file tmpfile_stdout 15:47:52 INFO - Output received: 15:47:52 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:47:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:52 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 0x22bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26325c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f7a0>, '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 0x26306a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2630b30>, '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': '199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:47:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:47:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:47:52 INFO - Using env: {'DISPLAY': ':0', 15:47:52 INFO - 'HOME': '/home/cltbld', 15:47:52 INFO - 'LANG': 'en_US.UTF-8', 15:47:52 INFO - 'LANGUAGE': 'en_US:en', 15:47:52 INFO - 'LOGNAME': 'cltbld', 15:47:52 INFO - 'MAIL': '/var/mail/cltbld', 15:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:52 INFO - 'MOZ_NO_REMOTE': '1', 15:47:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:52 INFO - 'NO_EM_RESTART': '1', 15:47:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:52 INFO - 'PWD': '/builds/slave/test', 15:47:52 INFO - 'SHELL': '/bin/bash', 15:47:52 INFO - 'SHLVL': '1', 15:47:52 INFO - 'TERM': 'linux', 15:47:52 INFO - 'TMOUT': '86400', 15:47:52 INFO - 'USER': 'cltbld', 15:47:52 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511', 15:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:52 INFO - '_': '/tools/buildbot/bin/python'} 15:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:47:52 INFO - Cleaning up... 15:47:52 INFO - Return code: 0 15:47:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:52 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 0x22bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26325c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f7a0>, '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 0x26306a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2630b30>, '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': '199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:47:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:47:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:47:52 INFO - Using env: {'DISPLAY': ':0', 15:47:52 INFO - 'HOME': '/home/cltbld', 15:47:52 INFO - 'LANG': 'en_US.UTF-8', 15:47:52 INFO - 'LANGUAGE': 'en_US:en', 15:47:52 INFO - 'LOGNAME': 'cltbld', 15:47:52 INFO - 'MAIL': '/var/mail/cltbld', 15:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:52 INFO - 'MOZ_NO_REMOTE': '1', 15:47:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:52 INFO - 'NO_EM_RESTART': '1', 15:47:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:52 INFO - 'PWD': '/builds/slave/test', 15:47:52 INFO - 'SHELL': '/bin/bash', 15:47:52 INFO - 'SHLVL': '1', 15:47:52 INFO - 'TERM': 'linux', 15:47:52 INFO - 'TMOUT': '86400', 15:47:52 INFO - 'USER': 'cltbld', 15:47:52 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511', 15:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:52 INFO - '_': '/tools/buildbot/bin/python'} 15:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:52 INFO - Downloading/unpacking psutil>=3.1.1 15:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:47:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:54 INFO - Installing collected packages: psutil 15:47:54 INFO - Running setup.py install for psutil 15:47:54 INFO - building 'psutil._psutil_linux' extension 15:47:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:47:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:47:54 INFO - building 'psutil._psutil_posix' extension 15:47:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:47:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:47:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:54 INFO - Successfully installed psutil 15:47:54 INFO - Cleaning up... 15:47:54 INFO - Return code: 0 15:47:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:54 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 0x22bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26325c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f7a0>, '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 0x26306a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2630b30>, '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': '199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:47:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:47:54 INFO - Using env: {'DISPLAY': ':0', 15:47:54 INFO - 'HOME': '/home/cltbld', 15:47:54 INFO - 'LANG': 'en_US.UTF-8', 15:47:54 INFO - 'LANGUAGE': 'en_US:en', 15:47:54 INFO - 'LOGNAME': 'cltbld', 15:47:54 INFO - 'MAIL': '/var/mail/cltbld', 15:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:54 INFO - 'MOZ_NO_REMOTE': '1', 15:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:54 INFO - 'NO_EM_RESTART': '1', 15:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:54 INFO - 'PWD': '/builds/slave/test', 15:47:54 INFO - 'SHELL': '/bin/bash', 15:47:54 INFO - 'SHLVL': '1', 15:47:54 INFO - 'TERM': 'linux', 15:47:54 INFO - 'TMOUT': '86400', 15:47:54 INFO - 'USER': 'cltbld', 15:47:54 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511', 15:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:54 INFO - '_': '/tools/buildbot/bin/python'} 15:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:47:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:47:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:47:55 INFO - Installing collected packages: mozsystemmonitor 15:47:55 INFO - Running setup.py install for mozsystemmonitor 15:47:56 INFO - Successfully installed mozsystemmonitor 15:47:56 INFO - Cleaning up... 15:47:56 INFO - Return code: 0 15:47:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:56 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 0x22bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26325c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f7a0>, '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 0x26306a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2630b30>, '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': '199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:47:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:47:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:47:56 INFO - Using env: {'DISPLAY': ':0', 15:47:56 INFO - 'HOME': '/home/cltbld', 15:47:56 INFO - 'LANG': 'en_US.UTF-8', 15:47:56 INFO - 'LANGUAGE': 'en_US:en', 15:47:56 INFO - 'LOGNAME': 'cltbld', 15:47:56 INFO - 'MAIL': '/var/mail/cltbld', 15:47:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:56 INFO - 'MOZ_NO_REMOTE': '1', 15:47:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:56 INFO - 'NO_EM_RESTART': '1', 15:47:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:56 INFO - 'PWD': '/builds/slave/test', 15:47:56 INFO - 'SHELL': '/bin/bash', 15:47:56 INFO - 'SHLVL': '1', 15:47:56 INFO - 'TERM': 'linux', 15:47:56 INFO - 'TMOUT': '86400', 15:47:56 INFO - 'USER': 'cltbld', 15:47:56 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511', 15:47:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:56 INFO - '_': '/tools/buildbot/bin/python'} 15:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:56 INFO - Downloading/unpacking jsonschema==2.5.1 15:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:47:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:57 INFO - Downloading functools32-3.2.3-2.tar.gz 15:47:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:47:57 INFO - warning: no files found matching '*.txt' 15:47:57 INFO - no previously-included directories found matching 'build' 15:47:57 INFO - no previously-included directories found matching 'dist' 15:47:57 INFO - no previously-included directories found matching '.git*' 15:47:57 INFO - Installing collected packages: jsonschema, functools32 15:47:57 INFO - Running setup.py install for functools32 15:47:57 INFO - warning: no files found matching '*.txt' 15:47:57 INFO - no previously-included directories found matching 'build' 15:47:57 INFO - no previously-included directories found matching 'dist' 15:47:57 INFO - no previously-included directories found matching '.git*' 15:47:57 INFO - Successfully installed jsonschema functools32 15:47:57 INFO - Cleaning up... 15:47:57 INFO - Return code: 0 15:47:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:57 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 0x22bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26325c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f7a0>, '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 0x26306a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2630b30>, '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': '199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:47:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:47:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:47:57 INFO - Using env: {'DISPLAY': ':0', 15:47:57 INFO - 'HOME': '/home/cltbld', 15:47:57 INFO - 'LANG': 'en_US.UTF-8', 15:47:57 INFO - 'LANGUAGE': 'en_US:en', 15:47:57 INFO - 'LOGNAME': 'cltbld', 15:47:57 INFO - 'MAIL': '/var/mail/cltbld', 15:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:57 INFO - 'MOZ_NO_REMOTE': '1', 15:47:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:57 INFO - 'NO_EM_RESTART': '1', 15:47:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:57 INFO - 'PWD': '/builds/slave/test', 15:47:57 INFO - 'SHELL': '/bin/bash', 15:47:57 INFO - 'SHLVL': '1', 15:47:57 INFO - 'TERM': 'linux', 15:47:57 INFO - 'TMOUT': '86400', 15:47:57 INFO - 'USER': 'cltbld', 15:47:57 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511', 15:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:57 INFO - '_': '/tools/buildbot/bin/python'} 15:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:47:57 INFO - Cleaning up... 15:47:57 INFO - Return code: 0 15:47:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:57 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 0x22bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26325c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f7a0>, '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 0x26306a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2630b30>, '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': '199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:47:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:47:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:47:57 INFO - Using env: {'DISPLAY': ':0', 15:47:57 INFO - 'HOME': '/home/cltbld', 15:47:57 INFO - 'LANG': 'en_US.UTF-8', 15:47:57 INFO - 'LANGUAGE': 'en_US:en', 15:47:57 INFO - 'LOGNAME': 'cltbld', 15:47:57 INFO - 'MAIL': '/var/mail/cltbld', 15:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:57 INFO - 'MOZ_NO_REMOTE': '1', 15:47:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:57 INFO - 'NO_EM_RESTART': '1', 15:47:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:57 INFO - 'PWD': '/builds/slave/test', 15:47:57 INFO - 'SHELL': '/bin/bash', 15:47:57 INFO - 'SHLVL': '1', 15:47:57 INFO - 'TERM': 'linux', 15:47:57 INFO - 'TMOUT': '86400', 15:47:57 INFO - 'USER': 'cltbld', 15:47:57 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511', 15:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:57 INFO - '_': '/tools/buildbot/bin/python'} 15:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:58 INFO - Downloading/unpacking blobuploader==1.2.4 15:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:59 INFO - Downloading blobuploader-1.2.4.tar.gz 15:47:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:47:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:47:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:59 INFO - Downloading docopt-0.6.1.tar.gz 15:47:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:47:59 INFO - Installing collected packages: blobuploader, requests, docopt 15:47:59 INFO - Running setup.py install for blobuploader 15:47:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:47:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:47:59 INFO - Running setup.py install for requests 15:48:00 INFO - Running setup.py install for docopt 15:48:00 INFO - Successfully installed blobuploader requests docopt 15:48:00 INFO - Cleaning up... 15:48:00 INFO - Return code: 0 15:48:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:00 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 0x22bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26325c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f7a0>, '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 0x26306a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2630b30>, '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': '199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:48:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:48:00 INFO - Using env: {'DISPLAY': ':0', 15:48:00 INFO - 'HOME': '/home/cltbld', 15:48:00 INFO - 'LANG': 'en_US.UTF-8', 15:48:00 INFO - 'LANGUAGE': 'en_US:en', 15:48:00 INFO - 'LOGNAME': 'cltbld', 15:48:00 INFO - 'MAIL': '/var/mail/cltbld', 15:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:00 INFO - 'MOZ_NO_REMOTE': '1', 15:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:00 INFO - 'NO_EM_RESTART': '1', 15:48:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:00 INFO - 'PWD': '/builds/slave/test', 15:48:00 INFO - 'SHELL': '/bin/bash', 15:48:00 INFO - 'SHLVL': '1', 15:48:00 INFO - 'TERM': 'linux', 15:48:00 INFO - 'TMOUT': '86400', 15:48:00 INFO - 'USER': 'cltbld', 15:48:00 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511', 15:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:00 INFO - '_': '/tools/buildbot/bin/python'} 15:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:48:00 INFO - Running setup.py (path:/tmp/pip-yp2Yhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:48:00 INFO - Running setup.py (path:/tmp/pip-iWRHX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:48:00 INFO - Running setup.py (path:/tmp/pip-875HmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:48:00 INFO - Running setup.py (path:/tmp/pip-TTLsO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:48:00 INFO - Running setup.py (path:/tmp/pip-g8OJHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:00 INFO - Running setup.py (path:/tmp/pip-_hq0dS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:01 INFO - Running setup.py (path:/tmp/pip-F4SOsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:01 INFO - Running setup.py (path:/tmp/pip-GvKMpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:01 INFO - Running setup.py (path:/tmp/pip-339E4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:01 INFO - Running setup.py (path:/tmp/pip-TqEZOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:01 INFO - Running setup.py (path:/tmp/pip-CkjUtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:01 INFO - Running setup.py (path:/tmp/pip-X5mG9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:01 INFO - Running setup.py (path:/tmp/pip-7d1NIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:01 INFO - Running setup.py (path:/tmp/pip-p2MuXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:01 INFO - Running setup.py (path:/tmp/pip-n1zvdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:01 INFO - Running setup.py (path:/tmp/pip-b5CLNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:01 INFO - Running setup.py (path:/tmp/pip-7dfRwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:48:01 INFO - Running setup.py install for manifestparser 15:48:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:48:01 INFO - Running setup.py install for mozcrash 15:48:02 INFO - Running setup.py install for mozdebug 15:48:02 INFO - Running setup.py install for mozdevice 15:48:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:48:02 INFO - Running setup.py install for mozfile 15:48:02 INFO - Running setup.py install for mozhttpd 15:48:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:48:02 INFO - Running setup.py install for mozinfo 15:48:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:48:02 INFO - Running setup.py install for mozInstall 15:48:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:48:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:48:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:48:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:48:02 INFO - Running setup.py install for mozleak 15:48:02 INFO - Running setup.py install for mozlog 15:48:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:48:02 INFO - Running setup.py install for moznetwork 15:48:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:48:02 INFO - Running setup.py install for mozprocess 15:48:03 INFO - Running setup.py install for mozprofile 15:48:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:48:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:48:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:48:03 INFO - Running setup.py install for mozrunner 15:48:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:48:03 INFO - Running setup.py install for mozscreenshot 15:48:03 INFO - Running setup.py install for moztest 15:48:03 INFO - Running setup.py install for mozversion 15:48:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:48:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:48:03 INFO - Cleaning up... 15:48:03 INFO - Return code: 0 15:48:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:03 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 0x22bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26325c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f7a0>, '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 0x26306a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2630b30>, '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': '199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:48:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:48:03 INFO - Using env: {'DISPLAY': ':0', 15:48:03 INFO - 'HOME': '/home/cltbld', 15:48:03 INFO - 'LANG': 'en_US.UTF-8', 15:48:03 INFO - 'LANGUAGE': 'en_US:en', 15:48:03 INFO - 'LOGNAME': 'cltbld', 15:48:03 INFO - 'MAIL': '/var/mail/cltbld', 15:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:03 INFO - 'MOZ_NO_REMOTE': '1', 15:48:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:03 INFO - 'NO_EM_RESTART': '1', 15:48:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:03 INFO - 'PWD': '/builds/slave/test', 15:48:03 INFO - 'SHELL': '/bin/bash', 15:48:03 INFO - 'SHLVL': '1', 15:48:03 INFO - 'TERM': 'linux', 15:48:03 INFO - 'TMOUT': '86400', 15:48:03 INFO - 'USER': 'cltbld', 15:48:03 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511', 15:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:03 INFO - '_': '/tools/buildbot/bin/python'} 15:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:48:03 INFO - Running setup.py (path:/tmp/pip-cG4uwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:48:03 INFO - Running setup.py (path:/tmp/pip-HWiAGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:48:04 INFO - Running setup.py (path:/tmp/pip-cBfh1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:48:04 INFO - Running setup.py (path:/tmp/pip-9m5lb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:48:04 INFO - Running setup.py (path:/tmp/pip-AgfU5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:04 INFO - Running setup.py (path:/tmp/pip-LI9gqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:04 INFO - Running setup.py (path:/tmp/pip-bYuPjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:04 INFO - Running setup.py (path:/tmp/pip-qQCcTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:04 INFO - Running setup.py (path:/tmp/pip-AYKIS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:04 INFO - Running setup.py (path:/tmp/pip-MY46uv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:04 INFO - Running setup.py (path:/tmp/pip-KODSF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:04 INFO - Running setup.py (path:/tmp/pip-GkHKoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:04 INFO - Running setup.py (path:/tmp/pip-GvZDAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:04 INFO - Running setup.py (path:/tmp/pip-wRwjcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:04 INFO - Running setup.py (path:/tmp/pip-OhUqeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:04 INFO - Running setup.py (path:/tmp/pip-Ndrc5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:05 INFO - Running setup.py (path:/tmp/pip-9_YP3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:48:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:06 INFO - Downloading blessings-1.6.tar.gz 15:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:48:06 INFO - Installing collected packages: blessings 15:48:06 INFO - Running setup.py install for blessings 15:48:06 INFO - Successfully installed blessings 15:48:06 INFO - Cleaning up... 15:48:06 INFO - Return code: 0 15:48:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:48:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:06 INFO - Reading from file tmpfile_stdout 15:48:06 INFO - Current package versions: 15:48:06 INFO - argparse == 1.2.1 15:48:06 INFO - blessings == 1.6 15:48:06 INFO - blobuploader == 1.2.4 15:48:06 INFO - docopt == 0.6.1 15:48:06 INFO - functools32 == 3.2.3-2 15:48:06 INFO - jsonschema == 2.5.1 15:48:06 INFO - manifestparser == 1.1 15:48:06 INFO - mozInstall == 1.12 15:48:06 INFO - mozcrash == 1.0 15:48:06 INFO - mozdebug == 0.1 15:48:06 INFO - mozdevice == 0.50 15:48:06 INFO - mozfile == 1.2 15:48:06 INFO - mozhttpd == 0.7 15:48:06 INFO - mozinfo == 0.9 15:48:06 INFO - mozleak == 0.1 15:48:06 INFO - mozlog == 3.4 15:48:06 INFO - moznetwork == 0.27 15:48:06 INFO - mozprocess == 0.25 15:48:06 INFO - mozprofile == 0.28 15:48:06 INFO - mozrunner == 6.13 15:48:06 INFO - mozscreenshot == 0.1 15:48:06 INFO - mozsystemmonitor == 0.3 15:48:06 INFO - moztest == 0.8 15:48:06 INFO - mozversion == 1.4 15:48:06 INFO - psutil == 3.1.1 15:48:06 INFO - requests == 1.2.3 15:48:06 INFO - wsgiref == 0.1.2 15:48:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:06 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 0x22bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26325c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f7a0>, '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 0x26306a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2630b30>, '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': '199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:48:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:48:06 INFO - Using env: {'DISPLAY': ':0', 15:48:06 INFO - 'HOME': '/home/cltbld', 15:48:06 INFO - 'LANG': 'en_US.UTF-8', 15:48:06 INFO - 'LANGUAGE': 'en_US:en', 15:48:06 INFO - 'LOGNAME': 'cltbld', 15:48:06 INFO - 'MAIL': '/var/mail/cltbld', 15:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:06 INFO - 'MOZ_NO_REMOTE': '1', 15:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:06 INFO - 'NO_EM_RESTART': '1', 15:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:06 INFO - 'PWD': '/builds/slave/test', 15:48:06 INFO - 'SHELL': '/bin/bash', 15:48:06 INFO - 'SHLVL': '1', 15:48:06 INFO - 'TERM': 'linux', 15:48:06 INFO - 'TMOUT': '86400', 15:48:06 INFO - 'USER': 'cltbld', 15:48:06 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511', 15:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:06 INFO - '_': '/tools/buildbot/bin/python'} 15:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:48:06 INFO - Cleaning up... 15:48:06 INFO - Return code: 0 15:48:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:06 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 0x22bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26325c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262f7a0>, '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 0x26306a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2630b30>, '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': '199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:48:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:48:06 INFO - Using env: {'DISPLAY': ':0', 15:48:06 INFO - 'HOME': '/home/cltbld', 15:48:06 INFO - 'LANG': 'en_US.UTF-8', 15:48:06 INFO - 'LANGUAGE': 'en_US:en', 15:48:06 INFO - 'LOGNAME': 'cltbld', 15:48:06 INFO - 'MAIL': '/var/mail/cltbld', 15:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:06 INFO - 'MOZ_NO_REMOTE': '1', 15:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:06 INFO - 'NO_EM_RESTART': '1', 15:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:06 INFO - 'PWD': '/builds/slave/test', 15:48:06 INFO - 'SHELL': '/bin/bash', 15:48:06 INFO - 'SHLVL': '1', 15:48:06 INFO - 'TERM': 'linux', 15:48:06 INFO - 'TMOUT': '86400', 15:48:06 INFO - 'USER': 'cltbld', 15:48:06 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511', 15:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:06 INFO - '_': '/tools/buildbot/bin/python'} 15:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:48:07 INFO - Cleaning up... 15:48:07 INFO - Return code: 0 15:48:07 INFO - Running post-action listener: _resource_record_post_action 15:48:07 INFO - Running post-action listener: _start_resource_monitoring 15:48:07 INFO - Starting resource monitoring. 15:48:07 INFO - [mozharness: 2017-05-19 22:48:07.106930Z] Finished create-virtualenv step (success) 15:48:07 INFO - [mozharness: 2017-05-19 22:48:07.107389Z] Running install step. 15:48:07 INFO - Running pre-action listener: _resource_record_pre_action 15:48:07 INFO - Running main action method: install 15:48:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:07 INFO - Reading from file tmpfile_stdout 15:48:07 INFO - Detecting whether we're running mozinstall >=1.0... 15:48:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:48:07 INFO - Reading from file tmpfile_stdout 15:48:07 INFO - Output received: 15:48:07 INFO - Usage: mozinstall [options] installer 15:48:07 INFO - Options: 15:48:07 INFO - -h, --help show this help message and exit 15:48:07 INFO - -d DEST, --destination=DEST 15:48:07 INFO - Directory to install application into. [default: 15:48:07 INFO - "/builds/slave/test"] 15:48:07 INFO - --app=APP Application being installed. [default: firefox] 15:48:07 INFO - mkdir: /builds/slave/test/build/application 15:48:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:48:23 INFO - Reading from file tmpfile_stdout 15:48:23 INFO - Output received: 15:48:23 INFO - /builds/slave/test/build/application/firefox/firefox 15:48:23 INFO - Running post-action listener: _resource_record_post_action 15:48:23 INFO - [mozharness: 2017-05-19 22:48:23.089754Z] Finished install step (success) 15:48:23 INFO - [mozharness: 2017-05-19 22:48:23.090031Z] Running run-tests step. 15:48:23 INFO - Running pre-action listener: _resource_record_pre_action 15:48:23 INFO - Running main action method: run_tests 15:48:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:48:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:48:23 INFO - Python 2.7.3 15:48:23 INFO - Return code: 0 15:48:23 INFO - grabbing minidump binary from tooltool 15:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:23 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 0x262f7a0>, '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 0x26306a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2630b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:48:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:48:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:48:23 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:48:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:48:23 INFO - Return code: 0 15:48:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:48:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:48:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:48:23 INFO - ENV: RUST_BACKTRACE is now 1 15:48:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:48:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:48:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:48:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-072 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:48:23 INFO - Using env: {'DISPLAY': ':0', 15:48:23 INFO - 'HOME': '/home/cltbld', 15:48:23 INFO - 'LANG': 'en_US.UTF-8', 15:48:23 INFO - 'LANGUAGE': 'en_US:en', 15:48:23 INFO - 'LOGNAME': 'cltbld', 15:48:23 INFO - 'MAIL': '/var/mail/cltbld', 15:48:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:48:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:23 INFO - 'MOZ_NO_REMOTE': '1', 15:48:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:48:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:23 INFO - 'NO_EM_RESTART': '1', 15:48:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:23 INFO - 'PWD': '/builds/slave/test', 15:48:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:48:23 INFO - 'RUST_BACKTRACE': '1', 15:48:23 INFO - 'SHELL': '/bin/bash', 15:48:23 INFO - 'SHLVL': '1', 15:48:23 INFO - 'TERM': 'linux', 15:48:23 INFO - 'TMOUT': '86400', 15:48:23 INFO - 'USER': 'cltbld', 15:48:23 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511', 15:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:23 INFO - '_': '/tools/buildbot/bin/python'} 15:48:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:48:23 INFO - mozversion application_buildid: 20170519221428 15:48:23 INFO - mozversion application_changeset: 8d60d0f825110cfb646ac31dc16dc011708bcf34 15:48:23 INFO - mozversion application_display_name: Nightly 15:48:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:48:23 INFO - mozversion application_name: Firefox 15:48:23 INFO - mozversion application_remotingname: firefox 15:48:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:48:23 INFO - mozversion application_vendor: Mozilla 15:48:23 INFO - mozversion application_version: 55.0a1 15:48:23 INFO - mozversion platform_buildid: 20170519221428 15:48:23 INFO - mozversion platform_changeset: 8d60d0f825110cfb646ac31dc16dc011708bcf34 15:48:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:48:23 INFO - mozversion platform_version: 55.0a1 15:48:23 INFO - using testdate: 1495234103 15:48:23 INFO - actual date: 1495234103 15:48:23 INFO - starting webserver on 'localhost:58123' 15:48:23 INFO - SUITE-START | Running 2 tests 15:48:23 INFO - TEST-START | dromaeo_css 15:48:23 INFO - operating with platform_type : linux_ 15:48:23 INFO - Initialising browser for dromaeo_css test... 15:48:23 INFO - TEST-INFO | started process 560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2iltvP/profile http://localhost:58123/getInfo.html) 15:48:23 INFO - PID 560 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2963: String.localeCompare is deprecated; use String.prototype.localeCompare instead 15:48:27 INFO - PID 560 | __metrics Screen width/height:1600/1200 15:48:27 INFO - PID 560 | colorDepth:24 15:48:27 INFO - PID 560 | Browser inner width/height: 1024/695 15:48:27 INFO - PID 560 | __metrics 15:48:29 INFO - TEST-INFO | 560: exit 0 15:48:29 INFO - Browser initialized. 15:48:29 INFO - Running cycle 1/1 for dromaeo_css test... 15:48:29 INFO - TEST-INFO | started process 720 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2iltvP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:48:41 INFO - PID 720 | RSS: Main: 165785600 15:48:41 INFO - PID 720 | 15:51:46 INFO - PID 720 | Cycle 1(1): loaded http://localhost:58123/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58123/tests/dromaeo/cssquery-ext.html) 15:51:47 INFO - PID 720 | RSS: Main: 170143744 15:51:47 INFO - PID 720 | 15:54:49 INFO - PID 720 | Cycle 1(1): loaded http://localhost:58123/tests/dromaeo/cssquery-ext.html (next: http://localhost:58123/tests/dromaeo/cssquery-jquery.html) 15:54:50 INFO - PID 720 | RSS: Main: 169074688 15:54:50 INFO - PID 720 | 15:57:52 INFO - PID 720 | Cycle 1(1): loaded http://localhost:58123/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58123/tests/dromaeo/cssquery-mootools.html) 15:57:52 INFO - PID 720 | RSS: Main: 171085824 15:57:52 INFO - PID 720 | 16:00:54 INFO - PID 720 | Cycle 1(1): loaded http://localhost:58123/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58123/tests/dromaeo/cssquery-prototype.html) 16:00:55 INFO - PID 720 | RSS: Main: 168632320 16:00:55 INFO - PID 720 | 16:03:58 INFO - PID 720 | Cycle 1(1): loaded http://localhost:58123/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58123/tests/dromaeo/cssquery-yui.html) 16:03:58 INFO - PID 720 | RSS: Main: 169046016 16:03:58 INFO - PID 720 | 16:07:00 INFO - PID 720 | Cycle 1(1): loaded http://localhost:58123/tests/dromaeo/cssquery-yui.html (next: http://localhost:58123/tests/dromaeo/cssquery-dojo.html) 16:07:00 INFO - PID 720 | RSS: Main: 175607808 16:07:00 INFO - PID 720 | 16:07:00 INFO - PID 720 | __start_tp_report 16:07:00 INFO - PID 720 | _x_x_mozilla_page_load 16:07:00 INFO - PID 720 | _x_x_mozilla_page_load_details 16:07:00 INFO - PID 720 | |i|pagename|runs| 16:07:00 INFO - PID 720 | |0;dojo.html;2684.758371746543;2700.257429206969;2713.1860441867448;2736.7263273672634;2739.041335532563;5194.065068287707;5257.447967963366;5288;5298.576113910883;5342.439043900393;5218.973905130469;5243.134882744353;5263.210518422238;5275.973620131904;5301.045811753893;4562.589366956973;4637.304404339351;4639.443266807988;4700.224462963607;4715.740634265114;4647.930281045787;4654.8370807021765;4749.7387643679585;4756.28655701644;4785.71285722856;4573.748443835588;4673.345731597579;4697;4733.313669517918;4754.286856971447;4631.953680463186;4634.513376095495;4651.88370290742;4667.299905014241;4676.415448068991;4545.340925565807;4577.084583083363;4589.403377560896;4619.792109355087;4645.651576131803;5188.688678679291;5212.087884620214;5227.2159176123505;5243.10867152585;5259.0796610593;5589.217509548666;5597.048501754712;5648.406917273668;5659.8585035374035;5666.490015898547;5712.200291959129;5725.2843394575675;5732.254806875079;5746.425357464262;5775.393583673737;5325.520703136736;5329.520343169133;5331.840044798662;5333.2266821310695;5338.546223571001;5718.599698021182;5809.68046757424;5843.328017277982;5905.645661260338;5918.408159184133;5601.271834661549;5610.803621873215;5613.550915926716;5617.719114044281;5661.2923384576925;5595.524380427628;5631.493165615114;5676.8864622707315;5701.458361455655;5705.914411283834;5568.081266591048;5701.657900525982;5716.114002329646;5716.399778023248;5723.54211663066;5550.47270509301;5604.467575580395;5619.297587801525;5652.547796176296;5668.801591944262;4676.859694209179;4717.528247175255;4720.834770783006;4721.929171062437;4762.142814293391;4032.6572241359813;4035.2131334389514;4037.4953130858644;4066.1867626474823;4066.3087275163293;4624.28323609841;4686.015936653341;4689.343491911135;4724.338592597039;4789.760511974388;5696.088625819849;5704.543636509153;5734.770609175586;5752.626079304831;5757.107648314518;4716.103940251342;4716.3632909557455;4724.905501889943;4739.3601863748645;4754.286856971482;4935.259711043373;5009.874753131201;5021.372328458942;5024.874378140503;5028.472010438852;5262.105442074933;5337.9466205339;5346.518813306821;5347.705876176848;5350.7324633767375;5637.408072152365;5662.603617746883;5683.403242659461;5706.201131841629;5746.655200687972;5272.130098533699;5276.894462110813;5277.050130976461;5294;5328.920066198933;5420.349558052902;5518.2826232589505;5589.524890384363;5626.803061892814;5658.915116273177;5672.12082127271;5723.170140329546;5723.828285151452;5742.885142297047;5780.4970707615485;5427.5657947363325;5492.505674489315;5504.587155963239;5522.834314970557;5523.116301391758;5464.23500709893;5490.203920431435;5537.141743029837;5589.133684278943;5590.664560126405;5353.759080841293;5388.811391601275;5417.8103766367985;5437.211604317273;5492.395836458067;5539.169124631177;5597.188407680945;5600.691961942132;5610.691411972218;5638.887222255614;5407.2970513834525;5429.294191755047;5437.537809286255;5438.2386465894015;5441.401445841034 16:07:00 INFO - PID 720 | |1;ext.html;673.2190658835749;707.1584814071255;726.1866709285599;1160.5705888821133;1209.8729633388489;34899.4765078524;35908.82045589775;35973.46039809405;36062;36073.27853442933;34078.48882266762;34304;34392;34396.656033439656;34492;6619.7352105915825;6869.278725733801;7048.506604537684;7055.435565154801;7062.046623705811;7043.823904402405;7064.540804847668;7093.14882214135;7102.431805455577;7106.5025448218385;7047.295270472938;7057.223705392403;7079.61062141582;7091.751788687397;7102.502824802266;7019;7043.330883566053;7061;7085.326893945067;7086.539374940612;6951.131108611424;7024;7031.437485001187;7039.260877607829;7050.400715939151;31605.367892642247;31663.366732665447;31761.682383176336;31905;31914;3034.317278612317;3042.9695703042908;3065.2796592800673;3065.57082008519;3075.123589776903;24265.272041838598;24284;24318.27045188647;24471.755282447302;24531.386715332083;2885.870135843892;2910.0833237530323;2915.1546051644996;3019.909402717922;3101.8138911665374;135630;136039;136434.31782841022;151284;153305.2334738319;39356.21287574233;39373.803130984736;39552.80223598864;39645;39673.603263966994;40980;40982;41104;41146.794266028475;41237.587624123975;12299.631011069681;12471.501139954482;12476.625701228977;12493.25040497573;12536.122471426912;9476;9476.431414115175;9509.762255943657;9523.19052880513;9575.425474471554;12891.290978996058;12974.286414247119;13072;13085.542006029744;13235.338233088307;5321.547668448148;5373.140297552372;5409.2967914171695;5419.593530485229;5608.009156749376;839.842193352985;887.4453466583385;898.1198425543005;902.566767951387;936.9109934556207;20783.896080519502;21294;21514.247001354877;21772.673409898864;21773.129074837147;951.695457453622;974.1232890398556;979.4515071559949;990.3612170150357;993.3046867192994;10593.093243216295;14252.216128113054;14991.550253492413;15072.698546029018;15243.618909527351;173538;173865;174092;174210;174764;46135;46606.533934660896;46823;46836.765816171384;46879;1214.0773012510556;1247.5695884919508;1249.1380947146622;1253.1040306181123;1270.6696258972734;24046;24887.87556062208;25416;25445.35088024968;25830.608796504264;31045.534316985715;31141.532877007317;31186.532202017443;31262.436878156455;31289;158969;159955;159972;160101.19949400643;160217.1989140047;28362.716372836832;29188.708112918597;30356.69643303627;30363.544546832258;30755.077347679606;36020;36414.27171456503;37204.813975929945;37275;37811.43282850814;27563;27929.301767455978;28569.714302856704;28799.136025919255;29609;26644.600330994665;27478.862605686845;27546;27947.720522795324;28959.13122606325;30301.545476818308;30847.2288192797;31373.52939705952;31513.21216969594;31732.682673172974;26286.86856565705;26954.73045269522;27698;28652;28691.995780147594;21105.26131585387;23011.88494057519;23172.536549269258;23203.785602332006;23219.88390058039 16:07:00 INFO - PID 720 | |2;jquery.html;416.5334824996005;417.9979100104499;418.5709647611199;432.8679752675434;437.4531835205992;15219.543413697578;17343.39298124566;18103.456896293115;18152.455426337216;18260;18414.26342946284;18574.442766716988;19049.809501904976;19678.409647710556;19844.40466785995;5483.616146869721;5536.889262214743;5614.719264036782;5630.605857589971;5646.632968857031;5448.8365349039395;5607.299087614048;5618.073017952033;5620.634658747168;5631.915521267164;5463.781448742066;5495.752691128889;5555.055640541118;5582.665040097587;5590.91613625796;5403.567714582824;5540.63985840921;5554.666719996793;5565.888682226353;5573.164025396182;4946.208606622923;4993.550580447741;4996.800127994876;4996.950030499721;5015.699058056528;22141.335759927228;22325.99533021018;22388.664170037464;22417.215397461172;22510.66234006491;1627.5768300242023;1669.3406104588619;1673.5899704572337;1674.3470046681805;1680.9663806723797;14144.646383840383;14211.431542738279;14657.706845863024;15152.393904243818;15324.233788310652;2090.6236877362066;2121.4060063182333;2139.3047259640525;2144.6461333879893;2168.251953076186;87150;87901.12098878993;88377;89331;91433.54283228608;11029.573493831344;11071.612493562687;11195.257161995363;11399.259048161843;11575.363355015555;15066.54800355991;15529.534113976599;15569.532914012598;15577.454789082327;15726.21368931549;6988.860222795617;7071.398931090915;7239.131304243525;7255.492115551966;7263.92736072643;6068.848278792977;6229.408206220402;6267.1539342189135;6418.293987661354;6420.293767685551;6934.687939042755;7091.539049961736;7128.465365097535;7166.390856777128;7190.316919892602;2016.7781544030145;2057.249104077001;2059.9279025234346;2083.4062292246635;2140.668196429556;781.261707686231;818.6316157729045;831.1978940322497;832.4630613254417;841.6675413211747;16925.576860578338;16966.23651935666;17406.47780566585;17677.850939689135;17700.91149544244;828.9212524810133;835.415209353455;837.5895811052662;841.8610929196736;843.6838531890271;8947.821043579092;8957.14907083826;9165.954170229106;9519.095685909828;9723.65967191145;349971;353158;355280;358974;359544;78489;79727;82472.58763706143;82526.58736706398;83890;1049.3494033699003;1060.2790102730064;1094.600470828142;1104.0505165557613;1108.3682301088302;17719.557011074827;18010.99589393857;18594.721079184095;18612.720809187602;18850;37890.8105459471;38343.42484862785;38694.80652596719;39521.80239098786;40935.38596921108;48842;48946.26580601223;51123.74438127786;51218.23172652488;51556;8416.705415310435;8456.365772567206;8538.231559159705;8538.786530336543;8675.175858293453;12996.935015324863;13356.797888190109;13420.194788312732;13666.46508164195;13735.519256826363;10663.573457061631;10753.354798712102;10792.568297268335;10839.241253112521;11255.887441125484;10002.349847259904;10511.579536818748;10656.360618362924;10680.62617808373;10980.505877235384;10919.126469882549;11282;11384;11486.425678715863;11674.533018679158;8467.95766021166;8485.787855303666;8523.445976011539;8615.138486151334;8701.738947831574;10736.946315268373;11359.148063895076;11544.422778861192;11582.94208528952;11655 16:07:00 INFO - PID 720 | |3;mootools.html;1225.822255772913;1293.2563775828894;1296.7795474769289;1297.597744699144;1305.9347032648366;10000.699979000632;10357.119644830198;10438.164946804256;10459.267851250415;10751.193660475457;10489.1084257838;10606.469676516163;10672.519736611852;10697.090747286471;10703.892961070387;2198.967015494765;2219.889005549724;2226.3988723044768;2231.5871563760675;2234.0505285253785;2084.81236688698;2145.0561752828785;2148.291063948893;2151.0427859602482;2156.4824442133854;2179.5967745967046;2203.801657850793;2236.8769717665523;2249.1902914950606;2251.2908433843368;2146.8067873891346;2160.287105255262;2170.218721260345;2176.6517357222847;2182.519845633958;2092.7488701355783;2118.6758276077453;2170.3597438755446;2185.2351676913113;2222.7888350606827;10007.849882251772;10094.444805535693;10129.544170512345;10141.985801419873;10198.643047493377;5426.864328391783;5581.162825576155;5626.971865140689;5630.634008789416;5651.40660230674;3050.6796786337336;3307.4873394623874;3355.832208389571;3376.2909788944353;3397.2356219850585;970.6699722094522;975.9804803903953;1000.854876042977;1021.9591216351337;1025.4565080507343;14973.326200321011;15021.549353519413;15145.242737863064;15179.544613661497;15190.316435760416;4444.444444444444;4450.755208463501;4714.528547145258;4750.904981900343;4762.499937506512;10701.411422371844;10834;10836.512356943957;10847.294925829796;10851.67444976652;5450.291462109901;5454.481824226692;5476.452354764571;5496.230527726121;5500.202470641814;4945.455999840086;5051.2423136529815;5094.949050509522;5137.357830271216;5186.196139598368;3671.30245253401;3782.4893639358884;3822.866199682998;3866.4586957825927;3930.587288334741;1084.6203828660064;1099.70308016835;1106.5407855739777;1113.0983903038564;1126.8140756775203;709.8864181730899;718.1059580821806;727.7707522130512;733.4242619543633;743.0785825576246;5404.108322126884;5408.432114627907;5481.588880833874;5554.638948468337;5597.244372009808;483.94676585576264;500.2721040885503;502.7838029647287;506.2153661824231;511.562613965062;3757.1170774867883;3832.597577254404;3852.9422058669143;3857.4599556062176;3947.50656167979;12523.874761252271;12873.098883078095;13179;13283.933580332037;13331.46688130858;12822.102452828212;12976.545820896223;13143.277119758313;13229.933850330879;13241.867581324255;7414.777556673308;7583.2416758324825;7642.465027448136;7703.075630924325;7707.22927707236;6175.228096487939;6304.968475157595;6316.968415157895;6365.1088847562305;6393.424591786761;11469.655910322703;11489.482973266391;11588.362640054878;11692.35692036912;11696.590619328283;11643.767124657628;11715.941420292844;11747.647570572897;11842.46708898119;11934;8330.416870819226;8497.022842373206;8498.235158835734;8500.659973600987;8511.616977235915;9150.450972941644;9152.725418237464;9240.075992400707;9323.160915517636;9338.206252468617;8140.87788683182;8152.184781521801;8239;8386.538740369338;8575.61409736551;8075.636596353295;8102.7569172924905;8208.712695055645;8233.46482478637;8330.958345208235;7432.405407567489;7511.624418779148;7518.962405187939;7573.886391704239;7581.355584775356;5069.138246498031;5076.822311219237;5142.76857541419;5177.197534382177;5190.377154741455;5436.700981446058;5448.237246785374;5456.44913980047;5542.556595472433;5610.691411972381 16:07:00 INFO - PID 720 | |4;prototype.html;375.1577708045438;377.1043771043771;379.96580307772314;381.66794888447055;390.20787800764447;5522.475364840344;5550.944490555094;5571.693556854377;5575.442455754423;5703.77184912603;5394.271773310602;5472.72636368182;5476.890462190754;5495.313085864267;5526.917096243549;4000.8599699010542;4130.979345103277;4147.523034850986;4159.500859896802;4175.367430335612;4167.395727619509;4169;4173.415721798935;4178.415021896937;4188.790560471964;4147.294959856817;4149.958500415002;4154.43915071466;4154.91690166198;4159.334506478964;4077.143799802045;4124.566920473337;4155.854545090938;4157.251694694954;4160.729552579088;3561.857525698969;3566.1262990567216;3592.8742494012845;3601.1537288737127;3610.3501369753435;5437.537809286216;5458.918116228259;5462.754176062087;5467.234587157801;5479.315085614298;4760.1907675694865;4825.420949486049;4851.466338702739;4870.050340183666;4899.485554016848;5809.448102430262;5810.360860305363;5817;5817.272840894888;5846.239988801429;4011.1777085697363;4017.9397309040096;4028.5568587455355;4029.073313137965;4039.697022723278;5980.491658209057;6170.444659980579;6203.348648391944;6243.375662433766;6293.811185664437;4090.8568200112854;4115.36211887158;4117.75293482386;4133.937990930139;4142.668586513072;4194.664426845845;4195.58044195578;4195.888089656243;4201.138766552849;4206.432131662247;4741.905161896742;4806.855794326176;4880.780364883589;4881.29221262922;4885.2427873679635;5845.503132233723;5890.49930755882;5893.055291753711;5896.852578685567;5898.557608179318;1413.8374086979923;1417.9574612761633;1424.408870318806;1429.0711037825497;1435.5406269993503;929.6513807322254;937.9073379512928;938.784079661668;956.1538038835541;956.4834989105944;4954.8761280968265;4962.255661650781;4962.503749625009;4968.776405061781;4980.929100243465;6046.518602942308;6080.118382834465;6099.542534309944;6100.54245931548;6109.297430795426;4735.455422626442;4949.158643030693;4974.1543937530705;4992.725400102957;5006;3207.342494788563;3224.9032529024166;3237.838108094633;3238.805671659708;3240.902772916816;5488.368837583649;5652.463016013472;5669.149627555899;5700.144978253295;5703.572232082611;6082.908756368658;6276.46650034743;6288.5598008139905;6297.937020629826;6309.526785491106;5641.266635337544;5657.9434205658235;5668.348139963874;5671.51792097668;5709.22925405065;6121.204243448323;6153.584675524565;6154.169187159676;6158.846028849314;6179;5909.970450147722;5965.403459654;6013.488853447506;6038.818835434944;6043.214382130295;5646.407127251744;5671.404502527175;5673.177389278614;5686.658800471985;5697.914531281951;4094.2016306821074;4107.404426358221;4125.360569111793;4129.463169787909;4439.4006809080365;6068.908966365596;6139.969300153471;6154.1999540059505;6163.506919446523;6197.783077592263;5956.302453800646;5959.73181206838;5968.253968253968;5971.940280597139;6003.489703375088;5705.486506214461;5898.262717160355;5950.7917222896995;5954.702264886825;5985.371535988658;5882.49998750111;5890.941090589211;5891.705414729332;5897.292324921037;5927.607012352008;5727.513161381329;5970.5522085844605;6004.309504406874;6027.336992930686;6030.487408570145;5773.220615216892;5777;5786.768529258951;5793.275840519935;5798.449147330997 16:07:00 INFO - PID 720 | |5;yui.html;679.2697849811454;703.3388614702179;742.7734540965005;743.9628018599069;766.9271419215172;10846.349219046862;11393.316401015945;13127.94976401888;14051.929740351297;14135.363908624111;14411.63970900728;14584.343704533296;15118.773218401706;15141.924290378533;15162.317695703692;878.200837238115;896.3367108339814;906.1074841281365;906.7869050773063;907.1699395053552;902.4269588811119;904.0868722590199;907.3285768531273;912.6303846942;912.8265629530368;947.9857802132974;950.8383574792267;951.7525443384735;952.4999375327939;952.5284983932963;943.3915124744535;943.47165587271;943.5235206220883;943.6838659049226;948.5541795356206;696.7805141380449;698.5319835710086;698.7309885694044;701.9262977387403;703.1878180701298;14304.213268270241;14314.212718300489;14510.056846304957;14545.854541454555;14619.78070328946;15459.304331305118;15495.147766872817;15753.92123039389;15832.208389580475;15942.840571594368;11154.219204655677;11166.609168679139;11213.271137376045;11308.773824523545;11351.772964540663;2489.352768280242;2502.774750272484;2525.0783464035494;2525.4949010198034;2529.8868497861067;65352.3464765351;65917.3408265916;66265.66867165682;66902.66548667225;67792;10909.618163364403;11029.83455248172;11077.667669969915;11162.107031437465;11173.888261117447;17334.653306934044;17358.479245622653;17701.38045168439;17777.555561110818;17939.282428702965;5587.636803607753;6254.280757712831;6433;6436.710348034349;6461.450776683941;2685.073649590888;2733.275681944286;2751.793615478847;2753.8072334936764;2756.4073724149403;3127.4214270360058;3181.2683082890603;3189;3211.566438530768;3214.630317513469;725.9274072592804;729.5695539631643;734.5005396330547;736.8820988641792;737.1706829816457;546.0853071105961;570.5378643298941;573.7647564498619;574.8534123798405;578.719321129252;8631.395802293904;8955.373123881265;9095.863562046574;9180.357374983822;9741.464219467856;564.8503146666137;568.6247076929207;584.5002522842993;588.094334724528;597.9760809567568;4161.271777438997;4232.619064284229;4257.489101307863;4273.636740876998;4314;60206.69896650489;60436.697816510634;61883.381166188665;63199.05201421982;63528;53415;54256.72871635616;54621;54773.726131369884;55766.72116639472;49337.50662493329;49869;50669;50805.491945080816;51049.489505105215;8401.075881653136;8583.828323433621;8596.78508037304;8697.95651021741;8884.822303553763;26666.466670666865;26671.466570668865;26744;26917.730822691523;27751.861240693666;31872.203194920312;31917.36165276635;32179;32315.676843231267;32923.34153316968;10378;10492.580296788043;10536.52585633633;10636.255462117577;10763.085137763377;14223.715525689222;14578.416863325348;14787;15281.083135011935;15434.691306174038;11890;12420.130590858915;12650.936745316214;12714.87285127137;13059.281739504038;12362.196457230251;12362.258264504158;13022.348882556023;13597.79603305971;13743.244121573409;12456.626301210978;12631.494740210655;12767.233965962072;12951.093423460645;12962.35188240603;8541.316694664287;8684;8704.347173962105;8968.327375446737;9105.726828195166;9326.440413575207;9635.56639951218;9641.42151470914;9754.80490390174;9988.800223995335 16:07:00 INFO - PID 720 | __end_tp_report 16:07:00 INFO - PID 720 | __start_cc_report 16:07:00 INFO - PID 720 | _x_x_mozilla_cycle_collect,265 16:07:00 INFO - PID 720 | __end_cc_report 16:07:00 INFO - PID 720 | __startTimestamp1495235220923__endTimestamp 16:07:00 INFO - PID 720 | 16:07:00 INFO - PID 720 | ------- Summary: start ------- 16:07:00 INFO - PID 720 | Number of tests: 6 16:07:00 INFO - PID 720 | 16:07:00 INFO - PID 720 | [#0] dojo.html Cycles:165 Average:5179.26 Median:5346.52 stddev:626.35 (11.7%) stddev-sans-first:596.92 16:07:00 INFO - PID 720 | Values: 2684.8 2700.3 2713.2 2736.7 2739.0 5194.1 5257.4 5288.0 5298.6 5342.4 5219.0 5243.1 5263.2 5276.0 5301.0 4562.6 4637.3 4639.4 4700.2 4715.7 4647.9 4654.8 4749.7 4756.3 4785.7 4573.7 4673.3 4697.0 4733.3 4754.3 4632.0 4634.5 4651.9 4667.3 4676.4 4545.3 4577.1 4589.4 4619.8 4645.7 5188.7 5212.1 5227.2 5243.1 5259.1 5589.2 5597.0 5648.4 5659.9 5666.5 5712.2 5725.3 5732.3 5746.4 5775.4 5325.5 5329.5 5331.8 5333.2 5338.5 5718.6 5809.7 5843.3 5905.6 5918.4 5601.3 5610.8 5613.6 5617.7 5661.3 5595.5 5631.5 5676.9 5701.5 5705.9 5568.1 5701.7 5716.1 5716.4 5723.5 5550.5 5604.5 5619.3 5652.5 5668.8 4676.9 4717.5 4720.8 4721.9 4762.1 4032.7 4035.2 4037.5 4066.2 4066.3 4624.3 4686.0 4689.3 4724.3 4789.8 5696.1 5704.5 5734.8 5752.6 5757.1 4716.1 4716.4 4724.9 4739.4 4754.3 4935.3 5009.9 5021.4 5024.9 5028.5 5262.1 5337.9 5346.5 5347.7 5350.7 5637.4 5662.6 5683.4 5706.2 5746.7 5272.1 5276.9 5277.1 5294.0 5328.9 5420.3 5518.3 5589.5 5626.8 5658.9 5672.1 5723.2 5723.8 5742.9 5780.5 5427.6 5492.5 5504.6 5522.8 5523.1 5464.2 5490.2 5537.1 5589.1 5590.7 5353.8 5388.8 5417.8 5437.2 5492.4 5539.2 5597.2 5600.7 5610.7 5638.9 5407.3 5429.3 5437.5 5438.2 5441.4 16:07:00 INFO - PID 720 | 16:07:00 INFO - PID 720 | [#1] ext.html Cycles:180 Average:30886.99 Median:31164.03 stddev:41093.41 (131.9%) stddev-sans-first:41146.06 16:07:00 INFO - PID 720 | Values: 673.2 707.2 726.2 1160.6 1209.9 34899.5 35908.8 35973.5 36062.0 36073.3 34078.5 34304.0 34392.0 34396.7 34492.0 6619.7 6869.3 7048.5 7055.4 7062.0 7043.8 7064.5 7093.1 7102.4 7106.5 7047.3 7057.2 7079.6 7091.8 7102.5 7019.0 7043.3 7061.0 7085.3 7086.5 6951.1 7024.0 7031.4 7039.3 7050.4 31605.4 31663.4 31761.7 31905.0 31914.0 3034.3 3043.0 3065.3 3065.6 3075.1 24265.3 24284.0 24318.3 24471.8 24531.4 2885.9 2910.1 2915.2 3019.9 3101.8 135630.0 136039.0 136434.3 151284.0 153305.2 39356.2 39373.8 39552.8 39645.0 39673.6 40980.0 40982.0 41104.0 41146.8 41237.6 12299.6 12471.5 12476.6 12493.3 12536.1 9476.0 9476.4 9509.8 9523.2 9575.4 12891.3 12974.3 13072.0 13085.5 13235.3 5321.5 5373.1 5409.3 5419.6 5608.0 839.8 887.4 898.1 902.6 936.9 20783.9 21294.0 21514.2 21772.7 21773.1 951.7 974.1 979.5 990.4 993.3 10593.1 14252.2 14991.6 15072.7 15243.6 173538.0 173865.0 174092.0 174210.0 174764.0 46135.0 46606.5 46823.0 46836.8 46879.0 1214.1 1247.6 1249.1 1253.1 1270.7 24046.0 24887.9 25416.0 25445.4 25830.6 31045.5 31141.5 31186.5 31262.4 31289.0 158969.0 159955.0 159972.0 160101.2 160217.2 28362.7 29188.7 30356.7 30363.5 30755.1 36020.0 36414.3 37204.8 37275.0 37811.4 27563.0 27929.3 28569.7 28799.1 29609.0 26644.6 27478.9 27546.0 27947.7 28959.1 30301.5 30847.2 31373.5 31513.2 31732.7 26286.9 26954.7 27698.0 28652.0 28692.0 21105.3 23011.9 23172.5 23203.8 23219.9 16:07:00 INFO - PID 720 | 16:07:00 INFO - PID 720 | [#2] jquery.html Cycles:180 Average:24772.87 Median:38117.12 stddev:59421.21 (155.9%) stddev-sans-first:59559.76 16:07:00 INFO - PID 720 | Values: 416.5 418.0 418.6 432.9 437.5 15219.5 17343.4 18103.5 18152.5 18260.0 18414.3 18574.4 19049.8 19678.4 19844.4 5483.6 5536.9 5614.7 5630.6 5646.6 5448.8 5607.3 5618.1 5620.6 5631.9 5463.8 5495.8 5555.1 5582.7 5590.9 5403.6 5540.6 5554.7 5565.9 5573.2 4946.2 4993.6 4996.8 4997.0 5015.7 22141.3 22326.0 22388.7 22417.2 22510.7 1627.6 1669.3 1673.6 1674.3 1681.0 14144.6 14211.4 14657.7 15152.4 15324.2 2090.6 2121.4 2139.3 2144.6 2168.3 87150.0 87901.1 88377.0 89331.0 91433.5 11029.6 11071.6 11195.3 11399.3 11575.4 15066.5 15529.5 15569.5 15577.5 15726.2 6988.9 7071.4 7239.1 7255.5 7263.9 6068.8 6229.4 6267.2 6418.3 6420.3 6934.7 7091.5 7128.5 7166.4 7190.3 2016.8 2057.2 2059.9 2083.4 2140.7 781.3 818.6 831.2 832.5 841.7 16925.6 16966.2 17406.5 17677.9 17700.9 828.9 835.4 837.6 841.9 843.7 8947.8 8957.1 9166.0 9519.1 9723.7 349971.0 353158.0 355280.0 358974.0 359544.0 78489.0 79727.0 82472.6 82526.6 83890.0 1049.3 1060.3 1094.6 1104.1 1108.4 17719.6 18011.0 18594.7 18612.7 18850.0 37890.8 38343.4 38694.8 39521.8 40935.4 48842.0 48946.3 51123.7 51218.2 51556.0 8416.7 8456.4 8538.2 8538.8 8675.2 12996.9 13356.8 13420.2 13666.5 13735.5 10663.6 10753.4 10792.6 10839.2 11255.9 10002.3 10511.6 10656.4 10680.6 10980.5 10919.1 11282.0 11384.0 11486.4 11674.5 8468.0 8485.8 8523.4 8615.1 8701.7 10736.9 11359.1 11544.4 11582.9 11655.0 16:07:00 INFO - PID 720 | 16:07:00 INFO - PID 720 | [#3] mootools.html Cycles:180 Average:6265.73 Median:3802.68 stddev:4028.18 (105.9%) stddev-sans-first:4021.68 16:07:00 INFO - PID 720 | Values: 1225.8 1293.3 1296.8 1297.6 1305.9 10000.7 10357.1 10438.2 10459.3 10751.2 10489.1 10606.5 10672.5 10697.1 10703.9 2199.0 2219.9 2226.4 2231.6 2234.1 2084.8 2145.1 2148.3 2151.0 2156.5 2179.6 2203.8 2236.9 2249.2 2251.3 2146.8 2160.3 2170.2 2176.7 2182.5 2092.7 2118.7 2170.4 2185.2 2222.8 10007.8 10094.4 10129.5 10142.0 10198.6 5426.9 5581.2 5627.0 5630.6 5651.4 3050.7 3307.5 3355.8 3376.3 3397.2 970.7 976.0 1000.9 1022.0 1025.5 14973.3 15021.5 15145.2 15179.5 15190.3 4444.4 4450.8 4714.5 4750.9 4762.5 10701.4 10834.0 10836.5 10847.3 10851.7 5450.3 5454.5 5476.5 5496.2 5500.2 4945.5 5051.2 5094.9 5137.4 5186.2 3671.3 3782.5 3822.9 3866.5 3930.6 1084.6 1099.7 1106.5 1113.1 1126.8 709.9 718.1 727.8 733.4 743.1 5404.1 5408.4 5481.6 5554.6 5597.2 483.9 500.3 502.8 506.2 511.6 3757.1 3832.6 3852.9 3857.5 3947.5 12523.9 12873.1 13179.0 13283.9 13331.5 12822.1 12976.5 13143.3 13229.9 13241.9 7414.8 7583.2 7642.5 7703.1 7707.2 6175.2 6305.0 6317.0 6365.1 6393.4 11469.7 11489.5 11588.4 11692.4 11696.6 11643.8 11715.9 11747.6 11842.5 11934.0 8330.4 8497.0 8498.2 8500.7 8511.6 9150.5 9152.7 9240.1 9323.2 9338.2 8140.9 8152.2 8239.0 8386.5 8575.6 8075.6 8102.8 8208.7 8233.5 8331.0 7432.4 7511.6 7519.0 7573.9 7581.4 5069.1 5076.8 5142.8 5177.2 5190.4 5436.7 5448.2 5456.4 5542.6 5610.7 16:07:00 INFO - PID 720 | 16:07:00 INFO - PID 720 | [#4] prototype.html Cycles:180 Average:4827.23 Median:5524.70 stddev:1458.40 (26.4%) stddev-sans-first:1423.69 16:07:00 INFO - PID 720 | Values: 375.2 377.1 380.0 381.7 390.2 5522.5 5550.9 5571.7 5575.4 5703.8 5394.3 5472.7 5476.9 5495.3 5526.9 4000.9 4131.0 4147.5 4159.5 4175.4 4167.4 4169.0 4173.4 4178.4 4188.8 4147.3 4150.0 4154.4 4154.9 4159.3 4077.1 4124.6 4155.9 4157.3 4160.7 3561.9 3566.1 3592.9 3601.2 3610.4 5437.5 5458.9 5462.8 5467.2 5479.3 4760.2 4825.4 4851.5 4870.1 4899.5 5809.4 5810.4 5817.0 5817.3 5846.2 4011.2 4017.9 4028.6 4029.1 4039.7 5980.5 6170.4 6203.3 6243.4 6293.8 4090.9 4115.4 4117.8 4133.9 4142.7 4194.7 4195.6 4195.9 4201.1 4206.4 4741.9 4806.9 4880.8 4881.3 4885.2 5845.5 5890.5 5893.1 5896.9 5898.6 1413.8 1418.0 1424.4 1429.1 1435.5 929.7 937.9 938.8 956.2 956.5 4954.9 4962.3 4962.5 4968.8 4980.9 6046.5 6080.1 6099.5 6100.5 6109.3 4735.5 4949.2 4974.2 4992.7 5006.0 3207.3 3224.9 3237.8 3238.8 3240.9 5488.4 5652.5 5669.1 5700.1 5703.6 6082.9 6276.5 6288.6 6297.9 6309.5 5641.3 5657.9 5668.3 5671.5 5709.2 6121.2 6153.6 6154.2 6158.8 6179.0 5910.0 5965.4 6013.5 6038.8 6043.2 5646.4 5671.4 5673.2 5686.7 5697.9 4094.2 4107.4 4125.4 4129.5 4439.4 6068.9 6140.0 6154.2 6163.5 6197.8 5956.3 5959.7 5968.3 5971.9 6003.5 5705.5 5898.3 5950.8 5954.7 5985.4 5882.5 5890.9 5891.7 5897.3 5927.6 5727.5 5970.6 6004.3 6027.3 6030.5 5773.2 5777.0 5786.8 5793.3 5798.4 16:07:00 INFO - PID 720 | 16:07:00 INFO - PID 720 | [#5] yui.html Cycles:180 Average:14332.71 Median:49603.25 stddev:17341.00 (35.0%) stddev-sans-first:17359.34 16:07:00 INFO - PID 720 | Values: 679.3 703.3 742.8 744.0 766.9 10846.3 11393.3 13127.9 14051.9 14135.4 14411.6 14584.3 15118.8 15141.9 15162.3 878.2 896.3 906.1 906.8 907.2 902.4 904.1 907.3 912.6 912.8 948.0 950.8 951.8 952.5 952.5 943.4 943.5 943.5 943.7 948.6 696.8 698.5 698.7 701.9 703.2 14304.2 14314.2 14510.1 14545.9 14619.8 15459.3 15495.1 15753.9 15832.2 15942.8 11154.2 11166.6 11213.3 11308.8 11351.8 2489.4 2502.8 2525.1 2525.5 2529.9 65352.3 65917.3 66265.7 66902.7 67792.0 10909.6 11029.8 11077.7 11162.1 11173.9 17334.7 17358.5 17701.4 17777.6 17939.3 5587.6 6254.3 6433.0 6436.7 6461.5 2685.1 2733.3 2751.8 2753.8 2756.4 3127.4 3181.3 3189.0 3211.6 3214.6 725.9 729.6 734.5 736.9 737.2 546.1 570.5 573.8 574.9 578.7 8631.4 8955.4 9095.9 9180.4 9741.5 564.9 568.6 584.5 588.1 598.0 4161.3 4232.6 4257.5 4273.6 4314.0 60206.7 60436.7 61883.4 63199.1 63528.0 53415.0 54256.7 54621.0 54773.7 55766.7 49337.5 49869.0 50669.0 50805.5 51049.5 8401.1 8583.8 8596.8 8698.0 8884.8 26666.5 26671.5 26744.0 26917.7 27751.9 31872.2 31917.4 32179.0 32315.7 32923.3 10378.0 10492.6 10536.5 10636.3 10763.1 14223.7 14578.4 14787.0 15281.1 15434.7 11890.0 12420.1 12650.9 12714.9 13059.3 12362.2 12362.3 13022.3 13597.8 13743.2 12456.6 12631.5 12767.2 12951.1 12962.4 8541.3 8684.0 8704.3 8968.3 9105.7 9326.4 9635.6 9641.4 9754.8 9988.8 16:07:00 INFO - PID 720 | -------- Summary: end -------- 16:07:00 INFO - PID 720 | 16:07:01 INFO - TEST-INFO | 720: exit 0 16:07:01 INFO - TEST-OK | dromaeo_css | took 1118390ms 16:07:01 INFO - TEST-START | kraken 16:07:01 INFO - operating with platform_type : linux_ 16:07:01 INFO - Initialising browser for kraken test... 16:07:01 INFO - TEST-INFO | started process 1143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp0wmlo/profile http://localhost:58123/getInfo.html) 16:07:02 INFO - PID 1143 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2963: String.localeCompare is deprecated; use String.prototype.localeCompare instead 16:07:05 INFO - PID 1143 | __metrics Screen width/height:1600/1200 16:07:05 INFO - PID 1143 | colorDepth:24 16:07:05 INFO - PID 1143 | Browser inner width/height: 1024/695 16:07:05 INFO - PID 1143 | __metrics 16:07:08 INFO - TEST-INFO | 1143: exit 0 16:07:08 INFO - Browser initialized. 16:07:08 INFO - Running cycle 1/1 for kraken test... 16:07:08 INFO - TEST-INFO | started process 1374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp0wmlo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:07:19 INFO - PID 1374 | RSS: Main: 166903808 16:07:19 INFO - PID 1374 | 16:07:22 INFO - PID 1374 | Cycle 1(1): loaded http://localhost:58123/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58123/tests/kraken/driver.html?testName=audio-beat-detection) 16:07:23 INFO - PID 1374 | RSS: Main: 170196992 16:07:23 INFO - PID 1374 | 16:07:26 INFO - PID 1374 | Cycle 1(1): loaded http://localhost:58123/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58123/tests/kraken/driver.html?testName=audio-dft) 16:07:26 INFO - PID 1374 | RSS: Main: 169771008 16:07:26 INFO - PID 1374 | 16:07:29 INFO - PID 1374 | Cycle 1(1): loaded http://localhost:58123/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58123/tests/kraken/driver.html?testName=audio-fft) 16:07:30 INFO - PID 1374 | RSS: Main: 164724736 16:07:30 INFO - PID 1374 | 16:07:32 INFO - PID 1374 | Cycle 1(1): loaded http://localhost:58123/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58123/tests/kraken/driver.html?testName=audio-oscillator) 16:07:33 INFO - PID 1374 | RSS: Main: 165687296 16:07:33 INFO - PID 1374 | 16:07:35 INFO - PID 1374 | Cycle 1(1): loaded http://localhost:58123/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58123/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:07:35 INFO - PID 1374 | RSS: Main: 165949440 16:07:35 INFO - PID 1374 | 16:07:38 INFO - PID 1374 | Cycle 1(1): loaded http://localhost:58123/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58123/tests/kraken/driver.html?testName=imaging-darkroom) 16:07:39 INFO - PID 1374 | RSS: Main: 170672128 16:07:39 INFO - PID 1374 | 16:07:43 INFO - PID 1374 | Cycle 1(1): loaded http://localhost:58123/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58123/tests/kraken/driver.html?testName=imaging-desaturate) 16:07:43 INFO - PID 1374 | RSS: Main: 168271872 16:07:43 INFO - PID 1374 | 16:07:46 INFO - PID 1374 | Cycle 1(1): loaded http://localhost:58123/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58123/tests/kraken/driver.html?testName=json-parse-financial) 16:07:47 INFO - PID 1374 | RSS: Main: 169078784 16:07:47 INFO - PID 1374 | 16:07:48 INFO - PID 1374 | Cycle 1(1): loaded http://localhost:58123/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58123/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:07:49 INFO - PID 1374 | RSS: Main: 169394176 16:07:49 INFO - PID 1374 | 16:07:51 INFO - PID 1374 | Cycle 1(1): loaded http://localhost:58123/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58123/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:07:51 INFO - PID 1374 | RSS: Main: 169181184 16:07:51 INFO - PID 1374 | 16:07:53 INFO - PID 1374 | Cycle 1(1): loaded http://localhost:58123/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58123/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:07:54 INFO - PID 1374 | RSS: Main: 168714240 16:07:54 INFO - PID 1374 | 16:07:57 INFO - PID 1374 | Cycle 1(1): loaded http://localhost:58123/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58123/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:07:58 INFO - PID 1374 | RSS: Main: 169107456 16:07:58 INFO - PID 1374 | 16:08:01 INFO - PID 1374 | Cycle 1(1): loaded http://localhost:58123/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58123/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:08:01 INFO - PID 1374 | RSS: Main: 169259008 16:08:01 INFO - PID 1374 | 16:08:03 INFO - PID 1374 | Cycle 1(1): loaded http://localhost:58123/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58123/tests/kraken/driver.html?testName=ai-astar) 16:08:03 INFO - PID 1374 | RSS: Main: 170762240 16:08:03 INFO - PID 1374 | 16:08:03 INFO - PID 1374 | __start_tp_report 16:08:03 INFO - PID 1374 | _x_x_mozilla_page_load 16:08:04 INFO - PID 1374 | _x_x_mozilla_page_load_details 16:08:04 INFO - PID 1374 | |i|pagename|runs| 16:08:04 INFO - PID 1374 | |0;ai-astar;104;118;111;111;114;112;112;111;116;113 16:08:04 INFO - PID 1374 | |1;audio-beat-detection;152;126;126;171;130;126;126;127;147;126 16:08:04 INFO - PID 1374 | |2;audio-dft;163;164;163;163;162;165;168;178;163;163 16:08:04 INFO - PID 1374 | |3;audio-fft;75;76;76;105;77;76;75;75;96;76 16:08:04 INFO - PID 1374 | |4;audio-oscillator;84;83;100;82;83;82;111;84;83;109 16:08:04 INFO - PID 1374 | |5;imaging-gaussian-blur;116;115;115;115;115;115;114;114;114;119 16:08:04 INFO - PID 1374 | |6;imaging-darkroom;151;151;151;152;151;150;150;150;151;152 16:08:04 INFO - PID 1374 | |7;imaging-desaturate;94;95;94;95;97;94;94;94;98;95 16:08:04 INFO - PID 1374 | |8;json-parse-financial;57;55;55;56;58;57;57;58;56;59 16:08:04 INFO - PID 1374 | |9;json-stringify-tinderbox;61;59;60;61;61;60;61;61;59;60 16:08:04 INFO - PID 1374 | |10;stanford-crypto-aes;83;82;82;85;83;82;81;84;82;82 16:08:04 INFO - PID 1374 | |11;stanford-crypto-ccm;139;142;132;131;144;133;141;133;191;138 16:08:04 INFO - PID 1374 | |12;stanford-crypto-pbkdf2;192;201;187;187;188;201;196;206;198;192 16:08:04 INFO - PID 1374 | |13;stanford-crypto-sha256-iterative;78;77;74;78;77;73;74;77;73;73 16:08:04 INFO - PID 1374 | __end_tp_report 16:08:04 INFO - PID 1374 | __start_cc_report 16:08:04 INFO - PID 1374 | _x_x_mozilla_cycle_collect,795 16:08:04 INFO - PID 1374 | __end_cc_report 16:08:04 INFO - PID 1374 | __startTimestamp1495235283996__endTimestamp 16:08:04 INFO - PID 1374 | 16:08:04 INFO - PID 1374 | ------- Summary: start ------- 16:08:04 INFO - PID 1374 | Number of tests: 14 16:08:04 INFO - PID 1374 | 16:08:04 INFO - PID 1374 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.50 stddev:3.71 (3.3%) stddev-sans-first:2.47 16:08:04 INFO - PID 1374 | Values: 104.0 118.0 111.0 111.0 114.0 112.0 112.0 111.0 116.0 113.0 16:08:04 INFO - PID 1374 | 16:08:04 INFO - PID 1374 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:128.50 stddev:15.70 (12.2%) stddev-sans-first:15.50 16:08:04 INFO - PID 1374 | Values: 152.0 126.0 126.0 171.0 130.0 126.0 126.0 127.0 147.0 126.0 16:08:04 INFO - PID 1374 | 16:08:04 INFO - PID 1374 | [#2] audio-dft Cycles:10 Average:165.20 Median:163.50 stddev:4.80 (2.9%) stddev-sans-first:5.03 16:08:04 INFO - PID 1374 | Values: 163.0 164.0 163.0 163.0 162.0 165.0 168.0 178.0 163.0 163.0 16:08:04 INFO - PID 1374 | 16:08:04 INFO - PID 1374 | [#3] audio-fft Cycles:10 Average:80.70 Median:76.00 stddev:10.67 (14.0%) stddev-sans-first:11.11 16:08:04 INFO - PID 1374 | Values: 75.0 76.0 76.0 105.0 77.0 76.0 75.0 75.0 96.0 76.0 16:08:04 INFO - PID 1374 | 16:08:04 INFO - PID 1374 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:83.00 stddev:11.78 (14.2%) stddev-sans-first:12.29 16:08:04 INFO - PID 1374 | Values: 84.0 83.0 100.0 82.0 83.0 82.0 111.0 84.0 83.0 109.0 16:08:04 INFO - PID 1374 | 16:08:04 INFO - PID 1374 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.00 stddev:1.48 (1.3%) stddev-sans-first:1.54 16:08:04 INFO - PID 1374 | Values: 116.0 115.0 115.0 115.0 115.0 115.0 114.0 114.0 114.0 119.0 16:08:04 INFO - PID 1374 | 16:08:04 INFO - PID 1374 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 16:08:04 INFO - PID 1374 | Values: 151.0 151.0 151.0 152.0 151.0 150.0 150.0 150.0 151.0 152.0 16:08:04 INFO - PID 1374 | 16:08:04 INFO - PID 1374 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:1.41 (1.5%) stddev-sans-first:1.45 16:08:04 INFO - PID 1374 | Values: 94.0 95.0 94.0 95.0 97.0 94.0 94.0 94.0 98.0 95.0 16:08:04 INFO - PID 1374 | 16:08:04 INFO - PID 1374 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.00 stddev:1.32 (2.3%) stddev-sans-first:1.39 16:08:04 INFO - PID 1374 | Values: 57.0 55.0 55.0 56.0 58.0 57.0 57.0 58.0 56.0 59.0 16:08:04 INFO - PID 1374 | 16:08:04 INFO - PID 1374 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 16:08:04 INFO - PID 1374 | Values: 61.0 59.0 60.0 61.0 61.0 60.0 61.0 61.0 59.0 60.0 16:08:04 INFO - PID 1374 | 16:08:04 INFO - PID 1374 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.50 stddev:1.17 (1.4%) stddev-sans-first:1.24 16:08:04 INFO - PID 1374 | Values: 83.0 82.0 82.0 85.0 83.0 82.0 81.0 84.0 82.0 82.0 16:08:04 INFO - PID 1374 | 16:08:04 INFO - PID 1374 | [#11] stanford-crypto-ccm Cycles:10 Average:142.40 Median:140.00 stddev:17.68 (12.6%) stddev-sans-first:18.71 16:08:04 INFO - PID 1374 | Values: 139.0 142.0 132.0 131.0 144.0 133.0 141.0 133.0 191.0 138.0 16:08:04 INFO - PID 1374 | 16:08:04 INFO - PID 1374 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.80 Median:197.00 stddev:6.65 (3.4%) stddev-sans-first:6.97 16:08:04 INFO - PID 1374 | Values: 192.0 201.0 187.0 187.0 188.0 201.0 196.0 206.0 198.0 192.0 16:08:04 INFO - PID 1374 | 16:08:04 INFO - PID 1374 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.40 Median:77.00 stddev:2.17 (2.8%) stddev-sans-first:2.09 16:08:04 INFO - PID 1374 | Values: 78.0 77.0 74.0 78.0 77.0 73.0 74.0 77.0 73.0 73.0 16:08:04 INFO - PID 1374 | -------- Summary: end -------- 16:08:04 INFO - PID 1374 | 16:08:05 INFO - TEST-INFO | 1374: exit 0 16:08:05 INFO - TEST-OK | kraken | took 63309ms 16:08:05 INFO - SUITE-END | took 1181s 16:08:05 INFO - Completed test suite (00:19:41) 16:08:05 INFO - javascript benchmark 16:08:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6673.168915250393, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2684.758371746543, 2700.257429206969, 2713.1860441867448, 2736.7263273672634, 2739.041335532563, 5194.065068287707, 5257.447967963366, 5288.0, 5298.576113910883, 5342.439043900393, 5218.973905130469, 5243.134882744353, 5263.210518422238, 5275.973620131904, 5301.045811753893, 4562.589366956973, 4637.304404339351, 4639.443266807988, 4700.224462963607, 4715.740634265114, 4647.930281045787, 4654.8370807021765, 4749.7387643679585, 4756.28655701644, 4785.71285722856, 4573.748443835588, 4673.345731597579, 4697.0, 4733.313669517918, 4754.286856971447, 4631.953680463186, 4634.513376095495, 4651.88370290742, 4667.299905014241, 4676.415448068991, 4545.340925565807, 4577.084583083363, 4589.403377560896, 4619.792109355087, 4645.651576131803, 5188.688678679291, 5212.087884620214, 5227.2159176123505, 5243.10867152585, 5259.0796610593, 5589.217509548666, 5597.048501754712, 5648.406917273668, 5659.8585035374035, 5666.490015898547, 5712.200291959129, 5725.2843394575675, 5732.254806875079, 5746.425357464262, 5775.393583673737, 5325.520703136736, 5329.520343169133, 5331.840044798662, 5333.2266821310695, 5338.546223571001, 5718.599698021182, 5809.68046757424, 5843.328017277982, 5905.645661260338, 5918.408159184133, 5601.271834661549, 5610.803621873215, 5613.550915926716, 5617.719114044281, 5661.2923384576925, 5595.524380427628, 5631.493165615114, 5676.8864622707315, 5701.458361455655, 5705.914411283834, 5568.081266591048, 5701.657900525982, 5716.114002329646, 5716.399778023248, 5723.54211663066, 5550.47270509301, 5604.467575580395, 5619.297587801525, 5652.547796176296, 5668.801591944262, 4676.859694209179, 4717.528247175255, 4720.834770783006, 4721.929171062437, 4762.142814293391, 4032.6572241359813, 4035.2131334389514, 4037.4953130858644, 4066.1867626474823, 4066.3087275163293, 4624.28323609841, 4686.015936653341, 4689.343491911135, 4724.338592597039, 4789.760511974388, 5696.088625819849, 5704.543636509153, 5734.770609175586, 5752.626079304831, 5757.107648314518, 4716.103940251342, 4716.3632909557455, 4724.905501889943, 4739.3601863748645, 4754.286856971482, 4935.259711043373, 5009.874753131201, 5021.372328458942, 5024.874378140503, 5028.472010438852, 5262.105442074933, 5337.9466205339, 5346.518813306821, 5347.705876176848, 5350.7324633767375, 5637.408072152365, 5662.603617746883, 5683.403242659461, 5706.201131841629, 5746.655200687972, 5272.130098533699, 5276.894462110813, 5277.050130976461, 5294.0, 5328.920066198933, 5420.349558052902, 5518.2826232589505, 5589.524890384363, 5626.803061892814, 5658.915116273177, 5672.12082127271, 5723.170140329546, 5723.828285151452, 5742.885142297047, 5780.4970707615485, 5427.5657947363325, 5492.505674489315, 5504.587155963239, 5522.834314970557, 5523.116301391758, 5464.23500709893, 5490.203920431435, 5537.141743029837, 5589.133684278943, 5590.664560126405, 5353.759080841293, 5388.811391601275, 5417.8103766367985, 5437.211604317273, 5492.395836458067, 5539.169124631177, 5597.188407680945, 5600.691961942132, 5610.691411972218, 5638.887222255614, 5407.2970513834525, 5429.294191755047, 5437.537809286255, 5438.2386465894015, 5441.401445841034], "value": 5132.591185674888, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.2190658835749, 707.1584814071255, 726.1866709285599, 1160.5705888821133, 1209.8729633388489, 34899.4765078524, 35908.82045589775, 35973.46039809405, 36062.0, 36073.27853442933, 34078.48882266762, 34304.0, 34392.0, 34396.656033439656, 34492.0, 6619.7352105915825, 6869.278725733801, 7048.506604537684, 7055.435565154801, 7062.046623705811, 7043.823904402405, 7064.540804847668, 7093.14882214135, 7102.431805455577, 7106.5025448218385, 7047.295270472938, 7057.223705392403, 7079.61062141582, 7091.751788687397, 7102.502824802266, 7019.0, 7043.330883566053, 7061.0, 7085.326893945067, 7086.539374940612, 6951.131108611424, 7024.0, 7031.437485001187, 7039.260877607829, 7050.400715939151, 31605.367892642247, 31663.366732665447, 31761.682383176336, 31905.0, 31914.0, 3034.317278612317, 3042.9695703042908, 3065.2796592800673, 3065.57082008519, 3075.123589776903, 24265.272041838598, 24284.0, 24318.27045188647, 24471.755282447302, 24531.386715332083, 2885.870135843892, 2910.0833237530323, 2915.1546051644996, 3019.909402717922, 3101.8138911665374, 135630.0, 136039.0, 136434.31782841022, 151284.0, 153305.2334738319, 39356.21287574233, 39373.803130984736, 39552.80223598864, 39645.0, 39673.603263966994, 40980.0, 40982.0, 41104.0, 41146.794266028475, 41237.587624123975, 12299.631011069681, 12471.501139954482, 12476.625701228977, 12493.25040497573, 12536.122471426912, 9476.0, 9476.431414115175, 9509.762255943657, 9523.19052880513, 9575.425474471554, 12891.290978996058, 12974.286414247119, 13072.0, 13085.542006029744, 13235.338233088307, 5321.547668448148, 5373.140297552372, 5409.2967914171695, 5419.593530485229, 5608.009156749376, 839.842193352985, 887.4453466583385, 898.1198425543005, 902.566767951387, 936.9109934556207, 20783.896080519502, 21294.0, 21514.247001354877, 21772.673409898864, 21773.129074837147, 951.695457453622, 974.1232890398556, 979.4515071559949, 990.3612170150357, 993.3046867192994, 10593.093243216295, 14252.216128113054, 14991.550253492413, 15072.698546029018, 15243.618909527351, 173538.0, 173865.0, 174092.0, 174210.0, 174764.0, 46135.0, 46606.533934660896, 46823.0, 46836.765816171384, 46879.0, 1214.0773012510556, 1247.5695884919508, 1249.1380947146622, 1253.1040306181123, 1270.6696258972734, 24046.0, 24887.87556062208, 25416.0, 25445.35088024968, 25830.608796504264, 31045.534316985715, 31141.532877007317, 31186.532202017443, 31262.436878156455, 31289.0, 158969.0, 159955.0, 159972.0, 160101.19949400643, 160217.1989140047, 28362.716372836832, 29188.708112918597, 30356.69643303627, 30363.544546832258, 30755.077347679606, 36020.0, 36414.27171456503, 37204.813975929945, 37275.0, 37811.43282850814, 27563.0, 27929.301767455978, 28569.714302856704, 28799.136025919255, 29609.0, 26644.600330994665, 27478.862605686845, 27546.0, 27947.720522795324, 28959.13122606325, 30301.545476818308, 30847.2288192797, 31373.52939705952, 31513.21216969594, 31732.682673172974, 26286.86856565705, 26954.73045269522, 27698.0, 28652.0, 28691.995780147594, 21105.26131585387, 23011.88494057519, 23172.536549269258, 23203.785602332006, 23219.88390058039], "value": 14836.166640076912, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.5334824996005, 417.9979100104499, 418.5709647611199, 432.8679752675434, 437.4531835205992, 15219.543413697578, 17343.39298124566, 18103.456896293115, 18152.455426337216, 18260.0, 18414.26342946284, 18574.442766716988, 19049.809501904976, 19678.409647710556, 19844.40466785995, 5483.616146869721, 5536.889262214743, 5614.719264036782, 5630.605857589971, 5646.632968857031, 5448.8365349039395, 5607.299087614048, 5618.073017952033, 5620.634658747168, 5631.915521267164, 5463.781448742066, 5495.752691128889, 5555.055640541118, 5582.665040097587, 5590.91613625796, 5403.567714582824, 5540.63985840921, 5554.666719996793, 5565.888682226353, 5573.164025396182, 4946.208606622923, 4993.550580447741, 4996.800127994876, 4996.950030499721, 5015.699058056528, 22141.335759927228, 22325.99533021018, 22388.664170037464, 22417.215397461172, 22510.66234006491, 1627.5768300242023, 1669.3406104588619, 1673.5899704572337, 1674.3470046681805, 1680.9663806723797, 14144.646383840383, 14211.431542738279, 14657.706845863024, 15152.393904243818, 15324.233788310652, 2090.6236877362066, 2121.4060063182333, 2139.3047259640525, 2144.6461333879893, 2168.251953076186, 87150.0, 87901.12098878993, 88377.0, 89331.0, 91433.54283228608, 11029.573493831344, 11071.612493562687, 11195.257161995363, 11399.259048161843, 11575.363355015555, 15066.54800355991, 15529.534113976599, 15569.532914012598, 15577.454789082327, 15726.21368931549, 6988.860222795617, 7071.398931090915, 7239.131304243525, 7255.492115551966, 7263.92736072643, 6068.848278792977, 6229.408206220402, 6267.1539342189135, 6418.293987661354, 6420.293767685551, 6934.687939042755, 7091.539049961736, 7128.465365097535, 7166.390856777128, 7190.316919892602, 2016.7781544030145, 2057.249104077001, 2059.9279025234346, 2083.4062292246635, 2140.668196429556, 781.261707686231, 818.6316157729045, 831.1978940322497, 832.4630613254417, 841.6675413211747, 16925.576860578338, 16966.23651935666, 17406.47780566585, 17677.850939689135, 17700.91149544244, 828.9212524810133, 835.415209353455, 837.5895811052662, 841.8610929196736, 843.6838531890271, 8947.821043579092, 8957.14907083826, 9165.954170229106, 9519.095685909828, 9723.65967191145, 349971.0, 353158.0, 355280.0, 358974.0, 359544.0, 78489.0, 79727.0, 82472.58763706143, 82526.58736706398, 83890.0, 1049.3494033699003, 1060.2790102730064, 1094.600470828142, 1104.0505165557613, 1108.3682301088302, 17719.557011074827, 18010.99589393857, 18594.721079184095, 18612.720809187602, 18850.0, 37890.8105459471, 38343.42484862785, 38694.80652596719, 39521.80239098786, 40935.38596921108, 48842.0, 48946.26580601223, 51123.74438127786, 51218.23172652488, 51556.0, 8416.705415310435, 8456.365772567206, 8538.231559159705, 8538.786530336543, 8675.175858293453, 12996.935015324863, 13356.797888190109, 13420.194788312732, 13666.46508164195, 13735.519256826363, 10663.573457061631, 10753.354798712102, 10792.568297268335, 10839.241253112521, 11255.887441125484, 10002.349847259904, 10511.579536818748, 10656.360618362924, 10680.62617808373, 10980.505877235384, 10919.126469882549, 11282.0, 11384.0, 11486.425678715863, 11674.533018679158, 8467.95766021166, 8485.787855303666, 8523.445976011539, 8615.138486151334, 8701.738947831574, 10736.946315268373, 11359.148063895076, 11544.422778861192, 11582.94208528952, 11655.0], "value": 8894.09435262737, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1225.822255772913, 1293.2563775828894, 1296.7795474769289, 1297.597744699144, 1305.9347032648366, 10000.699979000632, 10357.119644830198, 10438.164946804256, 10459.267851250415, 10751.193660475457, 10489.1084257838, 10606.469676516163, 10672.519736611852, 10697.090747286471, 10703.892961070387, 2198.967015494765, 2219.889005549724, 2226.3988723044768, 2231.5871563760675, 2234.0505285253785, 2084.81236688698, 2145.0561752828785, 2148.291063948893, 2151.0427859602482, 2156.4824442133854, 2179.5967745967046, 2203.801657850793, 2236.8769717665523, 2249.1902914950606, 2251.2908433843368, 2146.8067873891346, 2160.287105255262, 2170.218721260345, 2176.6517357222847, 2182.519845633958, 2092.7488701355783, 2118.6758276077453, 2170.3597438755446, 2185.2351676913113, 2222.7888350606827, 10007.849882251772, 10094.444805535693, 10129.544170512345, 10141.985801419873, 10198.643047493377, 5426.864328391783, 5581.162825576155, 5626.971865140689, 5630.634008789416, 5651.40660230674, 3050.6796786337336, 3307.4873394623874, 3355.832208389571, 3376.2909788944353, 3397.2356219850585, 970.6699722094522, 975.9804803903953, 1000.854876042977, 1021.9591216351337, 1025.4565080507343, 14973.326200321011, 15021.549353519413, 15145.242737863064, 15179.544613661497, 15190.316435760416, 4444.444444444444, 4450.755208463501, 4714.528547145258, 4750.904981900343, 4762.499937506512, 10701.411422371844, 10834.0, 10836.512356943957, 10847.294925829796, 10851.67444976652, 5450.291462109901, 5454.481824226692, 5476.452354764571, 5496.230527726121, 5500.202470641814, 4945.455999840086, 5051.2423136529815, 5094.949050509522, 5137.357830271216, 5186.196139598368, 3671.30245253401, 3782.4893639358884, 3822.866199682998, 3866.4586957825927, 3930.587288334741, 1084.6203828660064, 1099.70308016835, 1106.5407855739777, 1113.0983903038564, 1126.8140756775203, 709.8864181730899, 718.1059580821806, 727.7707522130512, 733.4242619543633, 743.0785825576246, 5404.108322126884, 5408.432114627907, 5481.588880833874, 5554.638948468337, 5597.244372009808, 483.94676585576264, 500.2721040885503, 502.7838029647287, 506.2153661824231, 511.562613965062, 3757.1170774867883, 3832.597577254404, 3852.9422058669143, 3857.4599556062176, 3947.50656167979, 12523.874761252271, 12873.098883078095, 13179.0, 13283.933580332037, 13331.46688130858, 12822.102452828212, 12976.545820896223, 13143.277119758313, 13229.933850330879, 13241.867581324255, 7414.777556673308, 7583.2416758324825, 7642.465027448136, 7703.075630924325, 7707.22927707236, 6175.228096487939, 6304.968475157595, 6316.968415157895, 6365.1088847562305, 6393.424591786761, 11469.655910322703, 11489.482973266391, 11588.362640054878, 11692.35692036912, 11696.590619328283, 11643.767124657628, 11715.941420292844, 11747.647570572897, 11842.46708898119, 11934.0, 8330.416870819226, 8497.022842373206, 8498.235158835734, 8500.659973600987, 8511.616977235915, 9150.450972941644, 9152.725418237464, 9240.075992400707, 9323.160915517636, 9338.206252468617, 8140.87788683182, 8152.184781521801, 8239.0, 8386.538740369338, 8575.61409736551, 8075.636596353295, 8102.7569172924905, 8208.712695055645, 8233.46482478637, 8330.958345208235, 7432.405407567489, 7511.624418779148, 7518.962405187939, 7573.886391704239, 7581.355584775356, 5069.138246498031, 5076.822311219237, 5142.76857541419, 5177.197534382177, 5190.377154741455, 5436.700981446058, 5448.237246785374, 5456.44913980047, 5542.556595472433, 5610.691411972381], "value": 4657.220138909082, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.1577708045438, 377.1043771043771, 379.96580307772314, 381.66794888447055, 390.20787800764447, 5522.475364840344, 5550.944490555094, 5571.693556854377, 5575.442455754423, 5703.77184912603, 5394.271773310602, 5472.72636368182, 5476.890462190754, 5495.313085864267, 5526.917096243549, 4000.8599699010542, 4130.979345103277, 4147.523034850986, 4159.500859896802, 4175.367430335612, 4167.395727619509, 4169.0, 4173.415721798935, 4178.415021896937, 4188.790560471964, 4147.294959856817, 4149.958500415002, 4154.43915071466, 4154.91690166198, 4159.334506478964, 4077.143799802045, 4124.566920473337, 4155.854545090938, 4157.251694694954, 4160.729552579088, 3561.857525698969, 3566.1262990567216, 3592.8742494012845, 3601.1537288737127, 3610.3501369753435, 5437.537809286216, 5458.918116228259, 5462.754176062087, 5467.234587157801, 5479.315085614298, 4760.1907675694865, 4825.420949486049, 4851.466338702739, 4870.050340183666, 4899.485554016848, 5809.448102430262, 5810.360860305363, 5817.0, 5817.272840894888, 5846.239988801429, 4011.1777085697363, 4017.9397309040096, 4028.5568587455355, 4029.073313137965, 4039.697022723278, 5980.491658209057, 6170.444659980579, 6203.348648391944, 6243.375662433766, 6293.811185664437, 4090.8568200112854, 4115.36211887158, 4117.75293482386, 4133.937990930139, 4142.668586513072, 4194.664426845845, 4195.58044195578, 4195.888089656243, 4201.138766552849, 4206.432131662247, 4741.905161896742, 4806.855794326176, 4880.780364883589, 4881.29221262922, 4885.2427873679635, 5845.503132233723, 5890.49930755882, 5893.055291753711, 5896.852578685567, 5898.557608179318, 1413.8374086979923, 1417.9574612761633, 1424.408870318806, 1429.0711037825497, 1435.5406269993503, 929.6513807322254, 937.9073379512928, 938.784079661668, 956.1538038835541, 956.4834989105944, 4954.8761280968265, 4962.255661650781, 4962.503749625009, 4968.776405061781, 4980.929100243465, 6046.518602942308, 6080.118382834465, 6099.542534309944, 6100.54245931548, 6109.297430795426, 4735.455422626442, 4949.158643030693, 4974.1543937530705, 4992.725400102957, 5006.0, 3207.342494788563, 3224.9032529024166, 3237.838108094633, 3238.805671659708, 3240.902772916816, 5488.368837583649, 5652.463016013472, 5669.149627555899, 5700.144978253295, 5703.572232082611, 6082.908756368658, 6276.46650034743, 6288.5598008139905, 6297.937020629826, 6309.526785491106, 5641.266635337544, 5657.9434205658235, 5668.348139963874, 5671.51792097668, 5709.22925405065, 6121.204243448323, 6153.584675524565, 6154.169187159676, 6158.846028849314, 6179.0, 5909.970450147722, 5965.403459654, 6013.488853447506, 6038.818835434944, 6043.214382130295, 5646.407127251744, 5671.404502527175, 5673.177389278614, 5686.658800471985, 5697.914531281951, 4094.2016306821074, 4107.404426358221, 4125.360569111793, 4129.463169787909, 4439.4006809080365, 6068.908966365596, 6139.969300153471, 6154.1999540059505, 6163.506919446523, 6197.783077592263, 5956.302453800646, 5959.73181206838, 5968.253968253968, 5971.940280597139, 6003.489703375088, 5705.486506214461, 5898.262717160355, 5950.7917222896995, 5954.702264886825, 5985.371535988658, 5882.49998750111, 5890.941090589211, 5891.705414729332, 5897.292324921037, 5927.607012352008, 5727.513161381329, 5970.5522085844605, 6004.309504406874, 6027.336992930686, 6030.487408570145, 5773.220615216892, 5777.0, 5786.768529258951, 5793.275840519935, 5798.449147330997], "value": 4372.156424428035, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.2697849811454, 703.3388614702179, 742.7734540965005, 743.9628018599069, 766.9271419215172, 10846.349219046862, 11393.316401015945, 13127.94976401888, 14051.929740351297, 14135.363908624111, 14411.63970900728, 14584.343704533296, 15118.773218401706, 15141.924290378533, 15162.317695703692, 878.200837238115, 896.3367108339814, 906.1074841281365, 906.7869050773063, 907.1699395053552, 902.4269588811119, 904.0868722590199, 907.3285768531273, 912.6303846942, 912.8265629530368, 947.9857802132974, 950.8383574792267, 951.7525443384735, 952.4999375327939, 952.5284983932963, 943.3915124744535, 943.47165587271, 943.5235206220883, 943.6838659049226, 948.5541795356206, 696.7805141380449, 698.5319835710086, 698.7309885694044, 701.9262977387403, 703.1878180701298, 14304.213268270241, 14314.212718300489, 14510.056846304957, 14545.854541454555, 14619.78070328946, 15459.304331305118, 15495.147766872817, 15753.92123039389, 15832.208389580475, 15942.840571594368, 11154.219204655677, 11166.609168679139, 11213.271137376045, 11308.773824523545, 11351.772964540663, 2489.352768280242, 2502.774750272484, 2525.0783464035494, 2525.4949010198034, 2529.8868497861067, 65352.3464765351, 65917.3408265916, 66265.66867165682, 66902.66548667225, 67792.0, 10909.618163364403, 11029.83455248172, 11077.667669969915, 11162.107031437465, 11173.888261117447, 17334.653306934044, 17358.479245622653, 17701.38045168439, 17777.555561110818, 17939.282428702965, 5587.636803607753, 6254.280757712831, 6433.0, 6436.710348034349, 6461.450776683941, 2685.073649590888, 2733.275681944286, 2751.793615478847, 2753.8072334936764, 2756.4073724149403, 3127.4214270360058, 3181.2683082890603, 3189.0, 3211.566438530768, 3214.630317513469, 725.9274072592804, 729.5695539631643, 734.5005396330547, 736.8820988641792, 737.1706829816457, 546.0853071105961, 570.5378643298941, 573.7647564498619, 574.8534123798405, 578.719321129252, 8631.395802293904, 8955.373123881265, 9095.863562046574, 9180.357374983822, 9741.464219467856, 564.8503146666137, 568.6247076929207, 584.5002522842993, 588.094334724528, 597.9760809567568, 4161.271777438997, 4232.619064284229, 4257.489101307863, 4273.636740876998, 4314.0, 60206.69896650489, 60436.697816510634, 61883.381166188665, 63199.05201421982, 63528.0, 53415.0, 54256.72871635616, 54621.0, 54773.726131369884, 55766.72116639472, 49337.50662493329, 49869.0, 50669.0, 50805.491945080816, 51049.489505105215, 8401.075881653136, 8583.828323433621, 8596.78508037304, 8697.95651021741, 8884.822303553763, 26666.466670666865, 26671.466570668865, 26744.0, 26917.730822691523, 27751.861240693666, 31872.203194920312, 31917.36165276635, 32179.0, 32315.676843231267, 32923.34153316968, 10378.0, 10492.580296788043, 10536.52585633633, 10636.255462117577, 10763.085137763377, 14223.715525689222, 14578.416863325348, 14787.0, 15281.083135011935, 15434.691306174038, 11890.0, 12420.130590858915, 12650.936745316214, 12714.87285127137, 13059.281739504038, 12362.196457230251, 12362.258264504158, 13022.348882556023, 13597.79603305971, 13743.244121573409, 12456.626301210978, 12631.494740210655, 12767.233965962072, 12951.093423460645, 12962.35188240603, 8541.316694664287, 8684.0, 8704.347173962105, 8968.327375446737, 9105.726828195166, 9326.440413575207, 9635.56639951218, 9641.42151470914, 9754.80490390174, 9988.800223995335], "value": 6402.911608559377, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1557.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 118.0, 111.0, 111.0, 114.0, 112.0, 112.0, 111.0, 116.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 126.0, 126.0, 171.0, 130.0, 126.0, 126.0, 127.0, 147.0, 126.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 163.0, 162.0, 165.0, 168.0, 178.0, 163.0, 163.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 105.0, 77.0, 76.0, 75.0, 75.0, 96.0, 76.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 100.0, 82.0, 83.0, 82.0, 111.0, 84.0, 83.0, 109.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 115.0, 115.0, 115.0, 115.0, 114.0, 114.0, 114.0, 119.0], "value": 115.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 152.0, 151.0, 150.0, 150.0, 150.0, 151.0, 152.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 97.0, 94.0, 94.0, 94.0, 98.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 56.0, 58.0, 57.0, 57.0, 58.0, 56.0, 59.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 60.0, 61.0, 61.0, 60.0, 61.0, 61.0, 59.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 85.0, 83.0, 82.0, 81.0, 84.0, 82.0, 82.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 142.0, 132.0, 131.0, 144.0, 133.0, 141.0, 133.0, 191.0, 138.0], "value": 142.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 201.0, 187.0, 187.0, 188.0, 201.0, 196.0, 206.0, 198.0, 192.0], "value": 194.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 74.0, 78.0, 77.0, 73.0, 74.0, 77.0, 73.0, 73.0], "value": 75.4, "unit": "score"}]}]} 16:08:05 INFO - Return code: 0 16:08:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:08:05 INFO - # TBPL SUCCESS # 16:08:05 INFO - Running post-action listener: _resource_record_post_action 16:08:05 INFO - [mozharness: 2017-05-19 23:08:05.288796Z] Finished run-tests step (success) 16:08:05 INFO - Running post-run listener: _resource_record_post_run 16:08:05 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 400232448; Read time: 0; Write time: 243836 16:08:05 INFO - TinderboxPrint: CPU usage
13.2% 16:08:05 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:08:05 INFO - TinderboxPrint: I/O write bytes / time
400,232,448 / 243,836 16:08:05 INFO - TinderboxPrint: CPU idle
8,291.9 (86.7%) 16:08:05 INFO - TinderboxPrint: CPU user
1,212.7 (12.7%) 16:08:05 INFO - TinderboxPrint: Swap in / out
0 / 0 16:08:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 93802496; Read time: 0; Write time: 87696 16:08:05 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 305893376; Read time: 0; Write time: 156116 16:08:05 INFO - Running post-run listener: _upload_blobber_files 16:08:05 INFO - Blob upload gear active. 16:08:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:08:05 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 16:08:05 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:08:05 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:08:06 INFO - (blobuploader) - INFO - Open directory for files ... 16:08:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:08:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:08:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:10 INFO - (blobuploader) - INFO - Done attempting. 16:08:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:08:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:08:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:11 INFO - (blobuploader) - INFO - Done attempting. 16:08:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:08:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:08:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:12 INFO - (blobuploader) - INFO - Done attempting. 16:08:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:08:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:08:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:13 INFO - (blobuploader) - INFO - Done attempting. 16:08:13 INFO - (blobuploader) - INFO - Iteration through files over. 16:08:13 INFO - Return code: 0 16:08:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:08:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:08:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8a226d9284b23a782ea9c29ed0f2338b842e76d32f55875a4b6e3169347ab1f46183826a3eab459069f7fe30bb2f8f7f4da1cfb8a82f30cc7d091b6aa541908a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3d19a65449b5d3673cb65510d1c2bd8a06c03971311efbdf473becce962655f10e6ce3f4848b52418506bea0f9026b09c4f05adaed1765616c8b4e7f855dff0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d342bf93e8319e5779efe2747703c99b054339e00f73ca9338da6178ddc43a8030337185e928fbfc7e8e33fdf4fefd7dc06f32cca94e85317a28a49c9be33986", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f145786f4c83d47b3e1924b2a98ed3292bd8a640db07e598d33dd857cb272971883f131606c25cd89f3b7deec22250d5226c635402bd49fd6517c8c043b42620"} 16:08:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:08:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:08:13 INFO - Contents: 16:08:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8a226d9284b23a782ea9c29ed0f2338b842e76d32f55875a4b6e3169347ab1f46183826a3eab459069f7fe30bb2f8f7f4da1cfb8a82f30cc7d091b6aa541908a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3d19a65449b5d3673cb65510d1c2bd8a06c03971311efbdf473becce962655f10e6ce3f4848b52418506bea0f9026b09c4f05adaed1765616c8b4e7f855dff0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d342bf93e8319e5779efe2747703c99b054339e00f73ca9338da6178ddc43a8030337185e928fbfc7e8e33fdf4fefd7dc06f32cca94e85317a28a49c9be33986", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f145786f4c83d47b3e1924b2a98ed3292bd8a640db07e598d33dd857cb272971883f131606c25cd89f3b7deec22250d5226c635402bd49fd6517c8c043b42620"} 16:08:13 INFO - Running post-run listener: copy_logs_to_upload_dir 16:08:13 INFO - Copying logs to upload dir... 16:08:13 INFO - mkdir: /builds/slave/test/build/upload/logs 16:08:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.824034 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-05-19 16:08:12.957920) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-19 16:08:12.961329) ========= 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=199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8a226d9284b23a782ea9c29ed0f2338b842e76d32f55875a4b6e3169347ab1f46183826a3eab459069f7fe30bb2f8f7f4da1cfb8a82f30cc7d091b6aa541908a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3d19a65449b5d3673cb65510d1c2bd8a06c03971311efbdf473becce962655f10e6ce3f4848b52418506bea0f9026b09c4f05adaed1765616c8b4e7f855dff0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d342bf93e8319e5779efe2747703c99b054339e00f73ca9338da6178ddc43a8030337185e928fbfc7e8e33fdf4fefd7dc06f32cca94e85317a28a49c9be33986", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f145786f4c83d47b3e1924b2a98ed3292bd8a640db07e598d33dd857cb272971883f131606c25cd89f3b7deec22250d5226c635402bd49fd6517c8c043b42620"} build_url:https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011212 build_url: 'https://queue.taskcluster.net/v1/task/bFUxTHNvTiKLiEgp_rTjEg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8a226d9284b23a782ea9c29ed0f2338b842e76d32f55875a4b6e3169347ab1f46183826a3eab459069f7fe30bb2f8f7f4da1cfb8a82f30cc7d091b6aa541908a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3d19a65449b5d3673cb65510d1c2bd8a06c03971311efbdf473becce962655f10e6ce3f4848b52418506bea0f9026b09c4f05adaed1765616c8b4e7f855dff0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d342bf93e8319e5779efe2747703c99b054339e00f73ca9338da6178ddc43a8030337185e928fbfc7e8e33fdf4fefd7dc06f32cca94e85317a28a49c9be33986", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f145786f4c83d47b3e1924b2a98ed3292bd8a640db07e598d33dd857cb272971883f131606c25cd89f3b7deec22250d5226c635402bd49fd6517c8c043b42620"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-19 16:08:12.989708) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 16:08:12.990492) ========= 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=199fb4c72b90437b990b419b000001c5-1495231139.756337-1167128511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 16:08:13.072340) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-19 16:08:13.072697) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-19 16:08:13.073071) ========= ========= Total master_lag: 0.18 =========