builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-022 starttime: 1495497394.62 results: success (0) revision: d712c82c59ec5a277047a75d09bec48be4a64b87 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-22 16:56:34.621995) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-22 16:56:34.622373) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-22 16:56:34.622644) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-22 16:56:34.725178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 16:56:34.725444) ========= 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=930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-22 16:56:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.0M=0s 2017-05-22 16:56:35 (42.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099050 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 16:56:34.862107) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 16:56:34.862395) ========= 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=930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020721 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 16:56:34.921810) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-22 16:56:34.925128) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d712c82c59ec5a277047a75d09bec48be4a64b87 --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 d712c82c59ec5a277047a75d09bec48be4a64b87 --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=930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-22 16:56:36,090 truncating revision to first 12 chars 2017-05-22 16:56:36,091 Setting DEBUG logging. 2017-05-22 16:56:36,091 attempt 1/10 2017-05-22 16:56:36,091 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d712c82c59ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-22 16:56:37,169 unpacking tar archive at: mozilla-central-d712c82c59ec/testing/mozharness/ program finished with exit code 0 elapsedTime=1.389995 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-22 16:56:36.339600) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-22 16:56:36.339899) ========= script_repo_revision: d712c82c59ec5a277047a75d09bec48be4a64b87 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-22 16:56:36.344323) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-22 16:56:36.344594) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-22 16:56:36.359840) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-05-22 16:56:36.360125) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:56:37 INFO - MultiFileLogger online at 20170522 16:56:37 in /builds/slave/test 16:56:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:56:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:56:37 INFO - {'append_to_log': False, 16:56:37 INFO - 'base_work_dir': '/builds/slave/test', 16:56:37 INFO - 'blob_upload_branch': 'Firefox', 16:56:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:56:37 INFO - 'branch': 'Firefox', 16:56:37 INFO - 'buildbot_json_path': 'buildprops.json', 16:56:37 INFO - 'config_files': ('talos/linux_config.py',), 16:56:37 INFO - 'default_actions': ('clobber', 16:56:37 INFO - 'read-buildbot-config', 16:56:37 INFO - 'download-and-extract', 16:56:37 INFO - 'populate-webroot', 16:56:37 INFO - 'create-virtualenv', 16:56:37 INFO - 'install', 16:56:37 INFO - 'run-tests'), 16:56:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:56:37 INFO - 'download_minidump_stackwalk': True, 16:56:37 INFO - 'download_symbols': 'ondemand', 16:56:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:56:37 INFO - 'tooltool.py': '/tools/tooltool.py', 16:56:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:56:37 INFO - '/tools/misc-python/virtualenv.py')}, 16:56:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:56:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:56:37 INFO - 'gecko_profile': False, 16:56:37 INFO - 'gecko_profile_interval': 0, 16:56:37 INFO - 'installer_path': 'installer.exe', 16:56:37 INFO - 'log_level': 'info', 16:56:37 INFO - 'log_name': 'talos', 16:56:37 INFO - 'log_to_console': True, 16:56:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:56:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:56:37 INFO - 'opt_config_files': (), 16:56:37 INFO - 'pip_index': False, 16:56:37 INFO - 'suite': 'dromaeojs-e10s', 16:56:37 INFO - 'system_bits': '32', 16:56:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:56:37 INFO - 'title': 'talos-linux64-ix-022', 16:56:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:56:37 INFO - 'use_talos_json': True, 16:56:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:56:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:56:37 INFO - 'work_dir': 'build'} 16:56:37 INFO - [mozharness: 2017-05-22 23:56:37.628477Z] Running clobber step. 16:56:37 INFO - Running pre-action listener: _resource_record_pre_action 16:56:37 INFO - Running main action method: clobber 16:56:37 INFO - rmtree: /builds/slave/test/build 16:56:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:56:39 INFO - Running post-action listener: _resource_record_post_action 16:56:39 INFO - [mozharness: 2017-05-22 23:56:39.189227Z] Finished clobber step (success) 16:56:39 INFO - [mozharness: 2017-05-22 23:56:39.189337Z] Running read-buildbot-config step. 16:56:39 INFO - Running pre-action listener: _resource_record_pre_action 16:56:39 INFO - Running main action method: read_buildbot_config 16:56:39 INFO - Using buildbot properties: 16:56:39 INFO - { 16:56:39 INFO - "project": "", 16:56:39 INFO - "product": "firefox", 16:56:39 INFO - "who": "kwierso@gmail.com", 16:56:39 INFO - "installer_path": "public/build/target.tar.bz2", 16:56:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 16:56:39 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:56:39 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 16:56:39 INFO - "stage_platform": "linux64-stylo", 16:56:39 INFO - "basedir": "/builds/slave/test", 16:56:39 INFO - "buildnumber": 110, 16:56:39 INFO - "platform": "ubuntu64_hw_stylo", 16:56:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:56:39 INFO - "slavebuilddir": "test", 16:56:39 INFO - "taskId": "AauYHfuJRye0bcaEabheDg", 16:56:39 INFO - "branch": "mozilla-central", 16:56:39 INFO - "script_repo_revision": "production", 16:56:39 INFO - "revision": "d712c82c59ec5a277047a75d09bec48be4a64b87", 16:56:39 INFO - "slavename": "talos-linux64-ix-022", 16:56:39 INFO - "repo_path": "mozilla-central" 16:56:39 INFO - } 16:56:39 INFO - Finding installer, test and symbols from parent task. 16:56:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AauYHfuJRye0bcaEabheDg'}, attempt #1 16:56:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AauYHfuJRye0bcaEabheDg'}, attempt #1 16:56:40 INFO - Task dependencies: MRye_F3OSPiECJ5iTVsG5A 16:56:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A'}, attempt #1 16:56:40 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/target.tar.bz2 16:56:40 INFO - Set test_url: https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/test_packages.json 16:56:40 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/target.crashreporter-symbols.zip 16:56:40 INFO - Running post-action listener: _resource_record_post_action 16:56:40 INFO - [mozharness: 2017-05-22 23:56:40.566465Z] Finished read-buildbot-config step (success) 16:56:40 INFO - [mozharness: 2017-05-22 23:56:40.566684Z] Running download-and-extract step. 16:56:40 INFO - Running pre-action listener: _resource_record_pre_action 16:56:40 INFO - Running main action method: download_and_extract 16:56:40 INFO - mkdir: /builds/slave/test/build/tests 16:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:40 INFO - trying https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/target.test_packages.json 16:56:40 INFO - Downloading https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:56:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:56:41 INFO - Downloaded 986 bytes. 16:56:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:56:41 INFO - Using the following test package requirements: 16:56:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:56:41 INFO - u'common': [u'target.common.tests.zip'], 16:56:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:56:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:56:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:56:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:56:41 INFO - u'mozbase': [u'target.common.tests.zip'], 16:56:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:56:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:56:41 INFO - u'web-platform': [u'target.common.tests.zip', 16:56:41 INFO - u'target.web-platform.tests.zip'], 16:56:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:56:41 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:56:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/target.common.tests.zip 16:56:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:56:41 INFO - Fetch https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/target.common.tests.zip into memory 16:56:42 INFO - Content-Length response header: 63521819 16:56:42 INFO - Bytes received: 63521819 16:56:53 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:56:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/target.common.tests.zip 16:56:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:56:53 INFO - Fetch https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/target.common.tests.zip into memory 16:56:55 INFO - Content-Length response header: 63521819 16:56:55 INFO - Bytes received: 63521819 16:57:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/target.talos.tests.zip 16:57:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:57:08 INFO - Fetch https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/target.talos.tests.zip into memory 16:57:09 INFO - Content-Length response header: 14410000 16:57:09 INFO - Bytes received: 14410000 16:57:09 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')]} 16:57:09 INFO - trying https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/target.tar.bz2 16:57:09 INFO - Downloading https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:57:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:57:10 INFO - Downloaded 56505692 bytes. 16:57:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/target.tar.bz2 16:57:10 INFO - mkdir: /builds/slave/test/properties 16:57:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:57:10 INFO - Writing to file /builds/slave/test/properties/build_url 16:57:10 INFO - Contents: 16:57:10 INFO - build_url:https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/target.tar.bz2 16:57:10 INFO - Running post-action listener: _resource_record_post_action 16:57:10 INFO - Running post-action listener: set_extra_try_arguments 16:57:10 INFO - [mozharness: 2017-05-22 23:57:10.991766Z] Finished download-and-extract step (success) 16:57:10 INFO - [mozharness: 2017-05-22 23:57:10.991864Z] Running populate-webroot step. 16:57:10 INFO - Running pre-action listener: _resource_record_pre_action 16:57:10 INFO - Running main action method: populate_webroot 16:57:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:57:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:57:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:57:10 INFO - '--tppagecycles', 16:57:10 INFO - '7'], 16:57:10 INFO - 'tests': ['tsvgm']}}, 16:57:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:57:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:57:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:57:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:57:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:57:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:57:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:57:10 INFO - 'talos_options': ['--disable-e10s'], 16:57:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:57:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:57:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:57:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:57:10 INFO - 'talos_options': ['--disable-e10s'], 16:57:10 INFO - 'tests': ['damp', 'tps']}, 16:57:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:57:10 INFO - 'tests': ['damp', 'tps']}, 16:57:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:57:11 INFO - 'tests': ['dromaeo_dom']}, 16:57:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:57:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:57:11 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:57:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:57:11 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:57:11 INFO - 'tests': ['ts_paint', 'tp5o']}, 16:57:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:57:11 INFO - 'tests': ['a11yr', 16:57:11 INFO - 'ts_paint', 16:57:11 INFO - 'tpaint', 16:57:11 INFO - 'sessionrestore', 16:57:11 INFO - 'sessionrestore_no_auto_restore', 16:57:11 INFO - 'tabpaint']}, 16:57:11 INFO - 'other-e10s': {'tests': ['a11yr', 16:57:11 INFO - 'ts_paint', 16:57:11 INFO - 'tpaint', 16:57:11 INFO - 'sessionrestore', 16:57:11 INFO - 'sessionrestore_no_auto_restore', 16:57:11 INFO - 'tabpaint']}, 16:57:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:57:11 INFO - 'ts_paint', 16:57:11 INFO - 'tpaint', 16:57:11 INFO - 'sessionrestore', 16:57:11 INFO - 'sessionrestore_no_auto_restore', 16:57:11 INFO - 'tabpaint']}, 16:57:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:57:11 INFO - 'ts_paint', 16:57:11 INFO - 'tpaint', 16:57:11 INFO - 'sessionrestore', 16:57:11 INFO - 'sessionrestore_no_auto_restore', 16:57:11 INFO - 'tabpaint']}, 16:57:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:57:11 INFO - 'tests': ['a11yr', 16:57:11 INFO - 'ts_paint', 16:57:11 INFO - 'tpaint', 16:57:11 INFO - 'sessionrestore', 16:57:11 INFO - 'sessionrestore_no_auto_restore', 16:57:11 INFO - 'tabpaint']}, 16:57:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:57:11 INFO - 'tests': ['a11yr', 16:57:11 INFO - 'ts_paint', 16:57:11 INFO - 'tpaint', 16:57:11 INFO - 'sessionrestore', 16:57:11 INFO - 'sessionrestore_no_auto_restore', 16:57:11 INFO - 'tabpaint']}, 16:57:11 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:57:11 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:57:11 INFO - 'bloom_basic_ref']}, 16:57:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:57:11 INFO - 'tests': ['tsvgx', 16:57:11 INFO - 'tsvgr_opacity', 16:57:11 INFO - 'tart', 16:57:11 INFO - 'tscrollx', 16:57:11 INFO - 'cart', 16:57:11 INFO - 'tsvg_static']}, 16:57:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:57:11 INFO - 'tsvgr_opacity', 16:57:11 INFO - 'tart', 16:57:11 INFO - 'tscrollx', 16:57:11 INFO - 'cart', 16:57:11 INFO - 'tsvg_static']}, 16:57:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:57:11 INFO - 'talos_options': ['--disable-e10s'], 16:57:11 INFO - 'tests': ['tp5o']}, 16:57:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:57:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:57:11 INFO - 'talos_options': ['--disable-e10s', 16:57:11 INFO - '--xperf_path', 16:57:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:57:11 INFO - 'tests': ['tp5n']}, 16:57:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:57:11 INFO - 'talos_options': ['--xperf_path', 16:57:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:57:11 INFO - 'tests': ['tp5n']}}, 16:57:11 INFO - 'talos.zip': {'path': '', 16:57:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:57:11 INFO - Running post-action listener: _resource_record_post_action 16:57:11 INFO - [mozharness: 2017-05-22 23:57:11.005844Z] Finished populate-webroot step (success) 16:57:11 INFO - [mozharness: 2017-05-22 23:57:11.005933Z] Running create-virtualenv step. 16:57:11 INFO - Running pre-action listener: _resource_record_pre_action 16:57:11 INFO - Running main action method: create_virtualenv 16:57:11 INFO - Creating virtualenv /builds/slave/test/build/venv 16:57:11 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 16:57:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:57:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:57:11 INFO - Using real prefix '/usr' 16:57:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:57:11 INFO - Installing distribute.............................................................................................................................................................................................done. 16:57:13 INFO - Installing pip.................done. 16:57:13 INFO - Return code: 0 16:57:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:57:13 INFO - Reading from file tmpfile_stdout 16:57:13 INFO - Output received: 16:57:13 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:57:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1286a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14297a0>, '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 0x142a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142ab30>, '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': '930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080', '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 16:57:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:57:13 INFO - Using env: {'DISPLAY': ':0', 16:57:13 INFO - 'HOME': '/home/cltbld', 16:57:13 INFO - 'LANG': 'en_US.UTF-8', 16:57:13 INFO - 'LANGUAGE': 'en_US:en', 16:57:13 INFO - 'LOGNAME': 'cltbld', 16:57:13 INFO - 'MAIL': '/var/mail/cltbld', 16:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:13 INFO - 'MOZ_NO_REMOTE': '1', 16:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:13 INFO - 'NO_EM_RESTART': '1', 16:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:13 INFO - 'PWD': '/builds/slave/test', 16:57:13 INFO - 'SHELL': '/bin/bash', 16:57:13 INFO - 'SHLVL': '1', 16:57:13 INFO - 'TERM': 'linux', 16:57:13 INFO - 'TMOUT': '86400', 16:57:13 INFO - 'USER': 'cltbld', 16:57:13 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080', 16:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:13 INFO - '_': '/tools/buildbot/bin/python'} 16:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:57:14 INFO - Cleaning up... 16:57:14 INFO - Return code: 0 16:57:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1286a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14297a0>, '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 0x142a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142ab30>, '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': '930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080', '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 16:57:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:57:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:57:14 INFO - Using env: {'DISPLAY': ':0', 16:57:14 INFO - 'HOME': '/home/cltbld', 16:57:14 INFO - 'LANG': 'en_US.UTF-8', 16:57:14 INFO - 'LANGUAGE': 'en_US:en', 16:57:14 INFO - 'LOGNAME': 'cltbld', 16:57:14 INFO - 'MAIL': '/var/mail/cltbld', 16:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:14 INFO - 'MOZ_NO_REMOTE': '1', 16:57:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:14 INFO - 'NO_EM_RESTART': '1', 16:57:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:14 INFO - 'PWD': '/builds/slave/test', 16:57:14 INFO - 'SHELL': '/bin/bash', 16:57:14 INFO - 'SHLVL': '1', 16:57:14 INFO - 'TERM': 'linux', 16:57:14 INFO - 'TMOUT': '86400', 16:57:14 INFO - 'USER': 'cltbld', 16:57:14 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080', 16:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:14 INFO - '_': '/tools/buildbot/bin/python'} 16:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:14 INFO - Downloading/unpacking psutil>=3.1.1 16:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:57:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:57:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:57:15 INFO - Installing collected packages: psutil 16:57:15 INFO - Running setup.py install for psutil 16:57:15 INFO - building 'psutil._psutil_linux' extension 16:57:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:57:15 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 16:57:15 INFO - building 'psutil._psutil_posix' extension 16:57:15 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 16:57:15 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 16:57:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:57:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:57:16 INFO - Successfully installed psutil 16:57:16 INFO - Cleaning up... 16:57:16 INFO - Return code: 0 16:57:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:16 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 0x10b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1286a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14297a0>, '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 0x142a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142ab30>, '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': '930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080', '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 16:57:16 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 16:57:16 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 16:57:16 INFO - Using env: {'DISPLAY': ':0', 16:57:16 INFO - 'HOME': '/home/cltbld', 16:57:16 INFO - 'LANG': 'en_US.UTF-8', 16:57:16 INFO - 'LANGUAGE': 'en_US:en', 16:57:16 INFO - 'LOGNAME': 'cltbld', 16:57:16 INFO - 'MAIL': '/var/mail/cltbld', 16:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:16 INFO - 'MOZ_NO_REMOTE': '1', 16:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:16 INFO - 'NO_EM_RESTART': '1', 16:57:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:16 INFO - 'PWD': '/builds/slave/test', 16:57:16 INFO - 'SHELL': '/bin/bash', 16:57:16 INFO - 'SHLVL': '1', 16:57:16 INFO - 'TERM': 'linux', 16:57:16 INFO - 'TMOUT': '86400', 16:57:16 INFO - 'USER': 'cltbld', 16:57:16 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080', 16:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:16 INFO - '_': '/tools/buildbot/bin/python'} 16:57:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:57:16 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 16:57:16 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 16:57:16 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 16:57:16 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 16:57:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:57:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:57:17 INFO - Installing collected packages: mozsystemmonitor 16:57:17 INFO - Running setup.py install for mozsystemmonitor 16:57:17 INFO - Successfully installed mozsystemmonitor 16:57:17 INFO - Cleaning up... 16:57:17 INFO - Return code: 0 16:57:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1286a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14297a0>, '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 0x142a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142ab30>, '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': '930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080', '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 16:57:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:57:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:57:17 INFO - Using env: {'DISPLAY': ':0', 16:57:17 INFO - 'HOME': '/home/cltbld', 16:57:17 INFO - 'LANG': 'en_US.UTF-8', 16:57:17 INFO - 'LANGUAGE': 'en_US:en', 16:57:17 INFO - 'LOGNAME': 'cltbld', 16:57:17 INFO - 'MAIL': '/var/mail/cltbld', 16:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:17 INFO - 'MOZ_NO_REMOTE': '1', 16:57:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:17 INFO - 'NO_EM_RESTART': '1', 16:57:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:17 INFO - 'PWD': '/builds/slave/test', 16:57:17 INFO - 'SHELL': '/bin/bash', 16:57:17 INFO - 'SHLVL': '1', 16:57:17 INFO - 'TERM': 'linux', 16:57:17 INFO - 'TMOUT': '86400', 16:57:17 INFO - 'USER': 'cltbld', 16:57:17 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080', 16:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:17 INFO - '_': '/tools/buildbot/bin/python'} 16:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:17 INFO - Downloading/unpacking jsonschema==2.5.1 16:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:57:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:18 INFO - Downloading functools32-3.2.3-2.tar.gz 16:57:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:57:19 INFO - warning: no files found matching '*.txt' 16:57:19 INFO - no previously-included directories found matching 'build' 16:57:19 INFO - no previously-included directories found matching 'dist' 16:57:19 INFO - no previously-included directories found matching '.git*' 16:57:19 INFO - Installing collected packages: jsonschema, functools32 16:57:19 INFO - Running setup.py install for functools32 16:57:19 INFO - warning: no files found matching '*.txt' 16:57:19 INFO - no previously-included directories found matching 'build' 16:57:19 INFO - no previously-included directories found matching 'dist' 16:57:19 INFO - no previously-included directories found matching '.git*' 16:57:19 INFO - Successfully installed jsonschema functools32 16:57:19 INFO - Cleaning up... 16:57:19 INFO - Return code: 0 16:57:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:57: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')]} 16:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57: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')]} 16:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:19 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 0x10b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1286a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14297a0>, '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 0x142a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142ab30>, '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': '930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080', '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 16:57:19 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 16:57:19 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 16:57:19 INFO - Using env: {'DISPLAY': ':0', 16:57:19 INFO - 'HOME': '/home/cltbld', 16:57:19 INFO - 'LANG': 'en_US.UTF-8', 16:57:19 INFO - 'LANGUAGE': 'en_US:en', 16:57:19 INFO - 'LOGNAME': 'cltbld', 16:57:19 INFO - 'MAIL': '/var/mail/cltbld', 16:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:19 INFO - 'MOZ_NO_REMOTE': '1', 16:57:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:19 INFO - 'NO_EM_RESTART': '1', 16:57:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:19 INFO - 'PWD': '/builds/slave/test', 16:57:19 INFO - 'SHELL': '/bin/bash', 16:57:19 INFO - 'SHLVL': '1', 16:57:19 INFO - 'TERM': 'linux', 16:57:19 INFO - 'TMOUT': '86400', 16:57:19 INFO - 'USER': 'cltbld', 16:57:19 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080', 16:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:19 INFO - '_': '/tools/buildbot/bin/python'} 16:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:57:19 INFO - Cleaning up... 16:57:19 INFO - Return code: 0 16:57:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:57: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')]} 16:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57: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')]} 16:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:19 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 0x10b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1286a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14297a0>, '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 0x142a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142ab30>, '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': '930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080', '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 16:57:19 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 16:57:19 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 16:57:19 INFO - Using env: {'DISPLAY': ':0', 16:57:19 INFO - 'HOME': '/home/cltbld', 16:57:19 INFO - 'LANG': 'en_US.UTF-8', 16:57:19 INFO - 'LANGUAGE': 'en_US:en', 16:57:19 INFO - 'LOGNAME': 'cltbld', 16:57:19 INFO - 'MAIL': '/var/mail/cltbld', 16:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:19 INFO - 'MOZ_NO_REMOTE': '1', 16:57:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:19 INFO - 'NO_EM_RESTART': '1', 16:57:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:19 INFO - 'PWD': '/builds/slave/test', 16:57:19 INFO - 'SHELL': '/bin/bash', 16:57:19 INFO - 'SHLVL': '1', 16:57:19 INFO - 'TERM': 'linux', 16:57:19 INFO - 'TMOUT': '86400', 16:57:19 INFO - 'USER': 'cltbld', 16:57:19 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080', 16:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:19 INFO - '_': '/tools/buildbot/bin/python'} 16:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:19 INFO - Downloading/unpacking blobuploader==1.2.4 16:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:20 INFO - Downloading blobuploader-1.2.4.tar.gz 16:57:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:57:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:57:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:21 INFO - Downloading docopt-0.6.1.tar.gz 16:57:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:57:21 INFO - Installing collected packages: blobuploader, requests, docopt 16:57:21 INFO - Running setup.py install for blobuploader 16:57:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:57:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:57:21 INFO - Running setup.py install for requests 16:57:21 INFO - Running setup.py install for docopt 16:57:21 INFO - Successfully installed blobuploader requests docopt 16:57:21 INFO - Cleaning up... 16:57:21 INFO - Return code: 0 16:57:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:57:21 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')]} 16:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:21 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')]} 16:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:21 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 0x10b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1286a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14297a0>, '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 0x142a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142ab30>, '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': '930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080', '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 16:57:21 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 16:57:21 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 16:57:21 INFO - Using env: {'DISPLAY': ':0', 16:57:21 INFO - 'HOME': '/home/cltbld', 16:57:21 INFO - 'LANG': 'en_US.UTF-8', 16:57:21 INFO - 'LANGUAGE': 'en_US:en', 16:57:21 INFO - 'LOGNAME': 'cltbld', 16:57:21 INFO - 'MAIL': '/var/mail/cltbld', 16:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:21 INFO - 'MOZ_NO_REMOTE': '1', 16:57:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:21 INFO - 'NO_EM_RESTART': '1', 16:57:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:21 INFO - 'PWD': '/builds/slave/test', 16:57:21 INFO - 'SHELL': '/bin/bash', 16:57:21 INFO - 'SHLVL': '1', 16:57:21 INFO - 'TERM': 'linux', 16:57:21 INFO - 'TMOUT': '86400', 16:57:21 INFO - 'USER': 'cltbld', 16:57:21 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080', 16:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:21 INFO - '_': '/tools/buildbot/bin/python'} 16:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:57:22 INFO - Running setup.py (path:/tmp/pip-uG5kTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:57:22 INFO - Running setup.py (path:/tmp/pip-0JH6ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:57:22 INFO - Running setup.py (path:/tmp/pip-rqL3Yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:57:22 INFO - Running setup.py (path:/tmp/pip-RqEK5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:57:22 INFO - Running setup.py (path:/tmp/pip-qmMDxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:57:22 INFO - Running setup.py (path:/tmp/pip-05c_y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:57:22 INFO - Running setup.py (path:/tmp/pip-4tQYq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:57:22 INFO - Running setup.py (path:/tmp/pip-0D7YcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:57:22 INFO - Running setup.py (path:/tmp/pip-O7pRCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:57:22 INFO - Running setup.py (path:/tmp/pip-_9XT8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:57:22 INFO - Running setup.py (path:/tmp/pip-8rKV79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:57:22 INFO - Running setup.py (path:/tmp/pip-jforhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:57:23 INFO - Running setup.py (path:/tmp/pip-1pS8le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:57:23 INFO - Running setup.py (path:/tmp/pip-TG_rC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:23 INFO - Running setup.py (path:/tmp/pip-8vonl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:57:23 INFO - Running setup.py (path:/tmp/pip-yIl1Mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:57:23 INFO - Running setup.py (path:/tmp/pip-hNohVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:57:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:57:23 INFO - Running setup.py install for manifestparser 16:57:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:57:23 INFO - Running setup.py install for mozcrash 16:57:23 INFO - Running setup.py install for mozdebug 16:57:23 INFO - Running setup.py install for mozdevice 16:57:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:57:23 INFO - Running setup.py install for mozfile 16:57:23 INFO - Running setup.py install for mozhttpd 16:57:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:57:23 INFO - Running setup.py install for mozinfo 16:57:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:57:24 INFO - Running setup.py install for mozInstall 16:57:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:57:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:57:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:57:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:57:24 INFO - Running setup.py install for mozleak 16:57:24 INFO - Running setup.py install for mozlog 16:57:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:57:24 INFO - Running setup.py install for moznetwork 16:57:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:57:24 INFO - Running setup.py install for mozprocess 16:57:24 INFO - Running setup.py install for mozprofile 16:57:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:57:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:57:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:57:24 INFO - Running setup.py install for mozrunner 16:57:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:57:24 INFO - Running setup.py install for mozscreenshot 16:57:24 INFO - Running setup.py install for moztest 16:57:25 INFO - Running setup.py install for mozversion 16:57:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:57:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:57:25 INFO - Cleaning up... 16:57:25 INFO - Return code: 0 16:57:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:57:25 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')]} 16:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:25 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')]} 16:57:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:25 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 0x10b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1286a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14297a0>, '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 0x142a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142ab30>, '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': '930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080', '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 16:57:25 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 16:57:25 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 16:57:25 INFO - Using env: {'DISPLAY': ':0', 16:57:25 INFO - 'HOME': '/home/cltbld', 16:57:25 INFO - 'LANG': 'en_US.UTF-8', 16:57:25 INFO - 'LANGUAGE': 'en_US:en', 16:57:25 INFO - 'LOGNAME': 'cltbld', 16:57:25 INFO - 'MAIL': '/var/mail/cltbld', 16:57:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:25 INFO - 'MOZ_NO_REMOTE': '1', 16:57:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:25 INFO - 'NO_EM_RESTART': '1', 16:57:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:25 INFO - 'PWD': '/builds/slave/test', 16:57:25 INFO - 'SHELL': '/bin/bash', 16:57:25 INFO - 'SHLVL': '1', 16:57:25 INFO - 'TERM': 'linux', 16:57:25 INFO - 'TMOUT': '86400', 16:57:25 INFO - 'USER': 'cltbld', 16:57:25 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080', 16:57:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:25 INFO - '_': '/tools/buildbot/bin/python'} 16:57:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:57:25 INFO - Running setup.py (path:/tmp/pip-aUKxFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:57:25 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)) 16:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:57:25 INFO - Running setup.py (path:/tmp/pip-MyJsnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:57:25 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)) 16:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:57:25 INFO - Running setup.py (path:/tmp/pip-huke8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:57:25 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)) 16:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:57:25 INFO - Running setup.py (path:/tmp/pip-azUaDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:57:25 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)) 16:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:57:25 INFO - Running setup.py (path:/tmp/pip-HT5q00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:57:25 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)) 16:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:57:25 INFO - Running setup.py (path:/tmp/pip-pWXuRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:57:25 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)) 16:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:57:25 INFO - Running setup.py (path:/tmp/pip-fV0X5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:57:25 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)) 16:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:57:25 INFO - Running setup.py (path:/tmp/pip-Swie0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:57:25 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)) 16:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:57:25 INFO - Running setup.py (path:/tmp/pip-U8UCQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:57:26 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)) 16:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:57:26 INFO - Running setup.py (path:/tmp/pip-7TY0af-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:57:26 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)) 16:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:57:26 INFO - Running setup.py (path:/tmp/pip-GfgcBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:57:26 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)) 16:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:57:26 INFO - Running setup.py (path:/tmp/pip-Gb1NT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:57:26 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)) 16:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:57:26 INFO - Running setup.py (path:/tmp/pip-VjkJHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:57:26 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)) 16:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:57:26 INFO - Running setup.py (path:/tmp/pip-jxNal4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:57:26 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)) 16:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:26 INFO - Running setup.py (path:/tmp/pip-Y6__Q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:26 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)) 16:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:57:26 INFO - Running setup.py (path:/tmp/pip-BqbZfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:57:26 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)) 16:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:57:26 INFO - Running setup.py (path:/tmp/pip-fPm04c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:57:26 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)) 16:57:26 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)) 16:57:26 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)) 16:57:26 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)) 16:57:26 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)) 16:57:26 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)) 16:57:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:57:26 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 16:57:26 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 16:57:26 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 16:57:26 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 16:57:27 INFO - Downloading blessings-1.6.tar.gz 16:57:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:57:27 INFO - Installing collected packages: blessings 16:57:27 INFO - Running setup.py install for blessings 16:57:27 INFO - Successfully installed blessings 16:57:27 INFO - Cleaning up... 16:57:27 INFO - Return code: 0 16:57:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:57:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:57:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:57:28 INFO - Reading from file tmpfile_stdout 16:57:28 INFO - Current package versions: 16:57:28 INFO - argparse == 1.2.1 16:57:28 INFO - blessings == 1.6 16:57:28 INFO - blobuploader == 1.2.4 16:57:28 INFO - docopt == 0.6.1 16:57:28 INFO - functools32 == 3.2.3-2 16:57:28 INFO - jsonschema == 2.5.1 16:57:28 INFO - manifestparser == 1.1 16:57:28 INFO - mozInstall == 1.12 16:57:28 INFO - mozcrash == 1.0 16:57:28 INFO - mozdebug == 0.1 16:57:28 INFO - mozdevice == 0.50 16:57:28 INFO - mozfile == 1.2 16:57:28 INFO - mozhttpd == 0.7 16:57:28 INFO - mozinfo == 0.9 16:57:28 INFO - mozleak == 0.1 16:57:28 INFO - mozlog == 3.4 16:57:28 INFO - moznetwork == 0.27 16:57:28 INFO - mozprocess == 0.25 16:57:28 INFO - mozprofile == 0.28 16:57:28 INFO - mozrunner == 6.13 16:57:28 INFO - mozscreenshot == 0.1 16:57:28 INFO - mozsystemmonitor == 0.3 16:57:28 INFO - moztest == 0.8 16:57:28 INFO - mozversion == 1.4 16:57:28 INFO - psutil == 3.1.1 16:57:28 INFO - requests == 1.2.3 16:57:28 INFO - wsgiref == 0.1.2 16:57:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:57:28 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')]} 16:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:28 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')]} 16:57:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:28 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 0x10b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1286a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14297a0>, '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 0x142a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142ab30>, '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': '930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080', '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 16:57:28 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 16:57:28 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 16:57:28 INFO - Using env: {'DISPLAY': ':0', 16:57:28 INFO - 'HOME': '/home/cltbld', 16:57:28 INFO - 'LANG': 'en_US.UTF-8', 16:57:28 INFO - 'LANGUAGE': 'en_US:en', 16:57:28 INFO - 'LOGNAME': 'cltbld', 16:57:28 INFO - 'MAIL': '/var/mail/cltbld', 16:57:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:28 INFO - 'MOZ_NO_REMOTE': '1', 16:57:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:28 INFO - 'NO_EM_RESTART': '1', 16:57:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:28 INFO - 'PWD': '/builds/slave/test', 16:57:28 INFO - 'SHELL': '/bin/bash', 16:57:28 INFO - 'SHLVL': '1', 16:57:28 INFO - 'TERM': 'linux', 16:57:28 INFO - 'TMOUT': '86400', 16:57:28 INFO - 'USER': 'cltbld', 16:57:28 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080', 16:57:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:28 INFO - '_': '/tools/buildbot/bin/python'} 16:57:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:28 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)) 16:57:28 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)) 16:57:28 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)) 16:57:28 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)) 16:57:28 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)) 16:57:28 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)) 16:57:28 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)) 16:57:28 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)) 16:57:28 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)) 16:57:28 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)) 16:57:28 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)) 16:57:28 INFO - Cleaning up... 16:57:28 INFO - Return code: 0 16:57:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:57:28 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')]} 16:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:28 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')]} 16:57:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:28 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 0x10b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1286a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14297a0>, '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 0x142a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142ab30>, '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': '930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080', '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 16:57:28 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 16:57:28 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 16:57:28 INFO - Using env: {'DISPLAY': ':0', 16:57:28 INFO - 'HOME': '/home/cltbld', 16:57:28 INFO - 'LANG': 'en_US.UTF-8', 16:57:28 INFO - 'LANGUAGE': 'en_US:en', 16:57:28 INFO - 'LOGNAME': 'cltbld', 16:57:28 INFO - 'MAIL': '/var/mail/cltbld', 16:57:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:28 INFO - 'MOZ_NO_REMOTE': '1', 16:57:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:28 INFO - 'NO_EM_RESTART': '1', 16:57:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:28 INFO - 'PWD': '/builds/slave/test', 16:57:28 INFO - 'SHELL': '/bin/bash', 16:57:28 INFO - 'SHLVL': '1', 16:57:28 INFO - 'TERM': 'linux', 16:57:28 INFO - 'TMOUT': '86400', 16:57:28 INFO - 'USER': 'cltbld', 16:57:28 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080', 16:57:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:28 INFO - '_': '/tools/buildbot/bin/python'} 16:57:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:57:28 INFO - Cleaning up... 16:57:28 INFO - Return code: 0 16:57:28 INFO - Running post-action listener: _resource_record_post_action 16:57:28 INFO - Running post-action listener: _start_resource_monitoring 16:57:28 INFO - Starting resource monitoring. 16:57:28 INFO - [mozharness: 2017-05-22 23:57:28.679840Z] Finished create-virtualenv step (success) 16:57:28 INFO - [mozharness: 2017-05-22 23:57:28.680423Z] Running install step. 16:57:28 INFO - Running pre-action listener: _resource_record_pre_action 16:57:28 INFO - Running main action method: install 16:57:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:57:28 INFO - Reading from file tmpfile_stdout 16:57:28 INFO - Detecting whether we're running mozinstall >=1.0... 16:57:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:57:28 INFO - Reading from file tmpfile_stdout 16:57:28 INFO - Output received: 16:57:28 INFO - Usage: mozinstall [options] installer 16:57:28 INFO - Options: 16:57:28 INFO - -h, --help show this help message and exit 16:57:28 INFO - -d DEST, --destination=DEST 16:57:28 INFO - Directory to install application into. [default: 16:57:28 INFO - "/builds/slave/test"] 16:57:28 INFO - --app=APP Application being installed. [default: firefox] 16:57:28 INFO - mkdir: /builds/slave/test/build/application 16:57:28 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'] 16:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:57:45 INFO - Reading from file tmpfile_stdout 16:57:45 INFO - Output received: 16:57:45 INFO - /builds/slave/test/build/application/firefox/firefox 16:57:45 INFO - Running post-action listener: _resource_record_post_action 16:57:45 INFO - [mozharness: 2017-05-22 23:57:45.129360Z] Finished install step (success) 16:57:45 INFO - [mozharness: 2017-05-22 23:57:45.129637Z] Running run-tests step. 16:57:45 INFO - Running pre-action listener: _resource_record_pre_action 16:57:45 INFO - Running main action method: run_tests 16:57:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:57:45 INFO - Python 2.7.3 16:57:45 INFO - Return code: 0 16:57:45 INFO - grabbing minidump binary from tooltool 16:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:45 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 0x14297a0>, '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 0x142a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x142ab30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:57:45 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 16:57:45 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 16:57:45 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 16:57:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:57:45 INFO - Return code: 0 16:57:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:57:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:57:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:57:45 INFO - ENV: RUST_BACKTRACE is now 1 16:57:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:57:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:57:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 16:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 16:57:45 INFO - Using env: {'DISPLAY': ':0', 16:57:45 INFO - 'HOME': '/home/cltbld', 16:57:45 INFO - 'LANG': 'en_US.UTF-8', 16:57:45 INFO - 'LANGUAGE': 'en_US:en', 16:57:45 INFO - 'LOGNAME': 'cltbld', 16:57:45 INFO - 'MAIL': '/var/mail/cltbld', 16:57:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:57:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:45 INFO - 'MOZ_NO_REMOTE': '1', 16:57:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:57:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:45 INFO - 'NO_EM_RESTART': '1', 16:57:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:45 INFO - 'PWD': '/builds/slave/test', 16:57:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:57:45 INFO - 'RUST_BACKTRACE': '1', 16:57:45 INFO - 'SHELL': '/bin/bash', 16:57:45 INFO - 'SHLVL': '1', 16:57:45 INFO - 'TERM': 'linux', 16:57:45 INFO - 'TMOUT': '86400', 16:57:45 INFO - 'USER': 'cltbld', 16:57:45 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080', 16:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:45 INFO - '_': '/tools/buildbot/bin/python'} 16:57:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 16:57:45 INFO - mozversion application_buildid: 20170522232011 16:57:45 INFO - mozversion application_changeset: d712c82c59ec5a277047a75d09bec48be4a64b87 16:57:45 INFO - mozversion application_display_name: Nightly 16:57:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:57:45 INFO - mozversion application_name: Firefox 16:57:45 INFO - mozversion application_remotingname: firefox 16:57:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:57:45 INFO - mozversion application_vendor: Mozilla 16:57:45 INFO - mozversion application_version: 55.0a1 16:57:45 INFO - mozversion platform_buildid: 20170522232011 16:57:45 INFO - mozversion platform_changeset: d712c82c59ec5a277047a75d09bec48be4a64b87 16:57:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:57:45 INFO - mozversion platform_version: 55.0a1 16:57:45 INFO - using testdate: 1495497465 16:57:45 INFO - actual date: 1495497465 16:57:45 INFO - starting webserver on 'localhost:46747' 16:57:45 INFO - SUITE-START | Running 2 tests 16:57:45 INFO - TEST-START | dromaeo_css 16:57:45 INFO - operating with platform_type : linux_ 16:57:45 INFO - Initialising browser for dromaeo_css test... 16:57:45 INFO - TEST-INFO | started process 17571 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ4sb5V/profile http://localhost:46747/getInfo.html) 16:57:45 INFO - PID 17571 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2978: String.localeCompare is deprecated; use String.prototype.localeCompare instead 16:57:49 INFO - PID 17571 | __metrics Screen width/height:1600/1200 16:57:49 INFO - PID 17571 | colorDepth:24 16:57:49 INFO - PID 17571 | Browser inner width/height: 1024/695 16:57:49 INFO - PID 17571 | __metrics 16:57:51 INFO - TEST-INFO | 17571: exit 0 16:57:51 INFO - Browser initialized. 16:57:51 INFO - Running cycle 1/1 for dromaeo_css test... 16:57:51 INFO - TEST-INFO | started process 17750 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ4sb5V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:58:03 INFO - PID 17750 | RSS: Main: 170651648 16:58:03 INFO - PID 17750 | 17:01:07 INFO - PID 17750 | Cycle 1(1): loaded http://localhost:46747/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46747/tests/dromaeo/cssquery-ext.html) 17:01:09 INFO - PID 17750 | RSS: Main: 174264320 17:01:09 INFO - PID 17750 | 17:04:12 INFO - PID 17750 | Cycle 1(1): loaded http://localhost:46747/tests/dromaeo/cssquery-ext.html (next: http://localhost:46747/tests/dromaeo/cssquery-jquery.html) 17:04:12 INFO - PID 17750 | RSS: Main: 172351488 17:04:12 INFO - PID 17750 | 17:07:14 INFO - PID 17750 | Cycle 1(1): loaded http://localhost:46747/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46747/tests/dromaeo/cssquery-mootools.html) 17:07:15 INFO - PID 17750 | RSS: Main: 174075904 17:07:15 INFO - PID 17750 | 17:10:17 INFO - PID 17750 | Cycle 1(1): loaded http://localhost:46747/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46747/tests/dromaeo/cssquery-prototype.html) 17:10:17 INFO - PID 17750 | RSS: Main: 173838336 17:10:17 INFO - PID 17750 | 17:13:20 INFO - PID 17750 | Cycle 1(1): loaded http://localhost:46747/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46747/tests/dromaeo/cssquery-yui.html) 17:13:21 INFO - PID 17750 | RSS: Main: 172068864 17:13:21 INFO - PID 17750 | 17:16:23 INFO - PID 17750 | Cycle 1(1): loaded http://localhost:46747/tests/dromaeo/cssquery-yui.html (next: http://localhost:46747/tests/dromaeo/cssquery-dojo.html) 17:16:23 INFO - PID 17750 | RSS: Main: 179347456 17:16:23 INFO - PID 17750 | 17:16:23 INFO - PID 17750 | __start_tp_report 17:16:23 INFO - PID 17750 | _x_x_mozilla_page_load 17:16:23 INFO - PID 17750 | _x_x_mozilla_page_load_details 17:16:23 INFO - PID 17750 | |i|pagename|runs| 17:16:23 INFO - PID 17750 | |0;dojo.html;2680.664916885389;2688.798340124491;2692.5422678144714;2699.3116755227425;2724.9182524524267;5133.922991155136;5187.299714538536;5216.947830521698;5223.902980374117;5270.262163297137;5227.5295223429885;5257.447967963366;5303.469653034695;5309.73451327434;5313.548348390392;4408.537103604123;4501.189785838547;4622.191116554606;4683.367745354385;4689.015306785579;4713.151632706112;4740.810367585293;4760.619150467955;4772.117158325704;4773.785179666923;4599.609033232179;4688.038952014829;4699.107169637758;4749.358836557055;4773.212419950722;4638.884027899296;4664;4677.602403795681;4687.648426368036;4702;4646.303054541812;4652.767361631905;4653.464851542049;4658.697184683018;4674.415698037746;5136.614753893473;5203.401608814959;5215.295935048758;5234.81678141267;5269.314989051437;5553.194786755938;5587.106063029895;5631.774729010835;5635.408282130358;5655.095184770458;5679.4036626154075;5681.147827825818;5687.7156142192725;5695.686737229492;5715.142728590703;5262;5264.631475796734;5272.20916862466;5275.973620131875;5317.8404647860625;5668.376478587352;5754.424557544296;5758.596898217084;5808.854778630568;5810.1575271586225;5519.061759500894;5538.723063846792;5541.944580554143;5565.526930210977;5591;5474.0146773580345;5518.2826232589505;5518.889622207614;5548.55611551075;5636.126400407943;5492.972535137299;5598.468145526169;5607.43925607436;5609.5792815539;5612.943870561324;5595.944040559623;5608.831735047955;5610.018246806792;5610.97194514033;5613.101903695389;4619.307103934437;4651.534846515321;4652.837150699709;4685.672002959828;4713.6464765142755;4014.518257809023;4048.27131116396;4076.316600550809;4081.9387709184384;4109.260333140004;4714.528547145326;4729.243321068612;4786.8085276588545;4806.327114204014;4816.109019831342;5632.408597097246;5683.772649094072;5705.486506214461;5705.62913410627;5720.599558030981;4751.904961900743;4779.30700048498;4782.808687652525;4784.210605250095;4825.734584597811;4907.607391408679;4923.163062279421;5002.324686167393;5006.724630145377;5038.3198268234055;5209.140491818807;5243.030039442715;5250.291210686509;5263.447338029452;5267.78928842842;5553.111502159797;5607.355154157324;5616.410276921028;5626.831195064155;5639.7744090237575;5169.4830516948;5200.843974680765;5220.530152286161;5228.843134705965;5272.604554658493;5470;5563.638363506359;5577.916331255115;5586.608937374344;5603.80386686464;5639.915401268902;5648.85877853057;5649.604527683187;5655;5666.121751128581;5437.619366644455;5438.646487978269;5440.238366628754;5474.5894057945015;5484.396716361117;5381.246625472359;5432.945670543244;5438.891222175455;5522.116461366162;5525.806596769094;5359.544438722753;5426.213199086032;5433.538149257357;5436.0486914790545;5443.618946673695;5416.4041955385665;5507.394186639546;5509;5529.917051244315;5533.6403133796175;5248.422673505987;5304.416514183514;5306.2305965634;5322.175062865262;5326.25432439451 17:16:23 INFO - PID 17750 | |1;ext.html;663;685.0443631134569;1061.501094485592;1080.7622323088917;1149.919505634606;34335.14162145948;35319.646803531956;35347.293054138936;35362.64637353632;35409.822950885275;33344.83327583359;33750.15624609386;33773.15567110824;33817;33906.32187356251;5419.8374048778405;5566.610337276392;6619.470442364599;6751.662416879161;7039.296070392946;7115.181754098293;7262;7289.963550182269;7300.233475485051;7310.926890731104;7256.963715181417;7322.304381083815;7331.670074846645;7332.340089391953;7337.779866604011;7277.708891644328;7283.890741638879;7315.5244909081275;7317.890231646529;7337.6698048587405;7151.141862976424;7161.641917904084;7201.6039117848495;7210.639468026578;7212.062431883822;32124.839375803203;32566;32652.510212346835;32786.18034549132;32825.6717432825;3059.602251707264;3091.180837078176;3093.752499800011;3097.798643088192;3100.7364374028234;24939.376515587257;24999.500009999698;25041.87479062593;25060.373490662696;25079.12223072202;2989.0285657161508;3039.392121575672;3043.3152540678393;3049.9542506862413;3074.584931034304;141970;142534;142831;143110;143289;37423.4386484203;40698.38952415716;40832.591674082876;40846.59153408487;41259.39849624046;43390.7830460852;43580.346294805604;43704.3444348335;43712;43726.344104838456;11999.1600587958;12074.335911524775;12175.147739658316;12186.75626487483;12222.511099556095;9380.718578442658;9519.23846092311;9520.333576649567;9564.61741530331;9629.470379129216;12895.290759008158;12985.610431687064;12990.480380784662;13054.869451305556;13166.868331316757;5263.526282634504;5359.705216213146;5368.677879327252;5380.78476860929;5402.837914862561;863.8315528472014;931.5109567476993;945.6690158444627;945.6973768394048;951.6621599332276;21827.23604673829;22337.44156396103;22427.21504747326;22474.438139046655;22500.98745556454;1006.5571148694697;1017.3336464615688;1018.1091544898214;1020.285799940045;1035.5598870480017;11651.883481165249;11745.735634122819;11749.236299640495;11818.704532386759;11827.704307392383;180010;180023;180028;180497;181513;41369.58630413718;41579.376309355386;41700.79149604293;41773;41869.371959420634;1210.7820592293472;1249.1443361297358;1250.3873102180048;1256.7863463211277;1267.923924564529;20125.698114528586;20584;21559.35321940344;21580.89209553942;21709.674354884373;29626.851865740533;29655.555166672948;29664.70335296706;29698.40603187881;29728.256793580334;146162.2691886534;146594;147565;148058;148716;30048;30652;31580.210494737814;31709.8414507926;31853.681463185072;37034.25931481301;37994.240115198096;38095.61904380921;38312;38555.61444385633;27964.021259255827;28174.154775356772;28402.85798570994;28443.715562844107;30227.244318892204;28117;28235.576466353432;28492;28640.57039144373;30348.696513034585;32470.512942306355;32475.512867306537;32483.675163248066;33029.33941321208;33071.834640826644;26782.732172678025;27702.168934931986;27777.305567360978;27903.302417439725;29459.705402945696;20732.58534829325;23033.769662303162;23055;23106.768932311134;23176.377653564763 17:16:23 INFO - PID 17750 | |2;jquery.html;411.25973248153315;416.6021449515709;420.09259998403445;429.35810962610896;437.3177842565598;14862.777058344107;17203.569910752223;18015.099245037745;18044.278228870844;18266.086695665195;17517.474475765717;17613.383531576364;17730;17780.911095444506;17806.37677681278;5410.809621883199;5419.187121931712;5531.806386776443;5587.05020146576;5623.550115990711;5474.370447398541;5555.555555555566;5565.554755619561;5577.721113944307;5578;5387.973060134694;5500.559955203574;5506.972465137689;5512.897420515913;5523.917141242885;5478.04134276502;5507.284053073095;5523.309586301712;5537.667739935577;5545.667259964415;4824.541668541483;4968.552830245259;4986.850394488171;5001.649884508086;5005.199168133117;20212.595748084957;20589.485262868548;20751;20751.792482075136;20772.58454830895;1654.2142482320921;1683.7474378843149;1688.5694147992183;1691.2135856826635;1697.1344614246823;14202.644933876632;14701.558953231313;14710.485133020293;14839.777403338958;14971.775423368657;2071.4717746974575;2080.8855512946784;2112.41908475169;2119.6926445665445;2126.404606710108;79556;80464.59767701183;80536.59731701363;81810;82148.9999999994;10729.141668666643;10850.67447976562;10923.836142457869;11136.721581960353;11172.21794474379;14844.92577537127;15009.774853377208;15205.695886082216;15237;15293;7321.74373896911;7356.448266379936;7429.962850185714;7570.356519695888;7598.126215485179;6629.635370054597;6660.933390666129;6907.067545881342;6907.516473846783;6928.653567321614;6873.828154296182;6908.6545672716165;6974.686139123752;7089.149302083783;7100.337373484943;2084.218418093215;2085.384811480617;2090.143041353038;2102.1906565971904;2201.3726088064823;823.8022874510075;877.4954401219325;879.8680197970356;888.2938064238816;899.1458114790975;16813.831861681225;16864.747028794576;17415.3033878646;17881.642367152584;19966.304548885713;875.2735229759285;880.6477409036308;883.7172104926361;885.7209978856639;910.3809409601535;9235.815283694288;9239.953800231091;9716.514174291256;9738.90261097394;9789.46157961319;365987;375692;387935;390777;392214;80444.59777701074;83654.5817270922;84300.15699843045;84404;84761.40482439694;1059.6979860739652;1095.2497539185842;1118.2675347647305;1129.7345123895877;1130.0959232613875;16749.74875376895;17158;17583.560410989827;17591.82408175953;17726.018148964456;37682.246355073294;37870.81064594659;38222.63545431387;38230.2353952925;38841.417378739905;48416;49285.753571231915;50220.246696298855;50301.496985029684;50350.74824625853;8185.181481851767;8505.617247224014;8558.144185581392;8632.093630168742;8880.689175878813;12167;12263.75472490563;12428.751424971631;12443.626691199279;12717.236965782082;11077.944610276896;11106.111511079256;11183.105351571692;11351.489182986621;11572;10172.338797978107;10669.306495077795;10850.511726972463;10904.618338358438;10965;11471.885281147082;11811;11906.583269585522;12056.51773929033;12150.696232593902;8487.915120848713;8605.440646357967;8630.956845215735;8753.91246087531;8789.296856251356;11368.488418021043;11389;11522.308661480338;11703.824442633537;11705.765884682089 17:16:23 INFO - PID 17750 | |3;mootools.html;1229.2870135321511;1297.2864924291637;1302.7068909495365;1307.0589175793425;1311.6130741431273;9745.26910481714;9869.65456209031;10130.949345253264;10181.59273629055;10205.846912296303;9770.364926279786;9912.553935072921;9915.553800078997;9925.255605829556;9951.950240248807;2244.0574958517423;2278.7949084582383;2290.942726431844;2300.1029598456616;2308.0998410619873;2185.4754858833844;2235.273536100766;2242.1479837661664;2251.313349428424;2253;2184.541246338271;2199.439143018528;2210.027587861344;2216.656418255165;2237.552489502098;2174.662927246279;2182.8362872784605;2206.360155554887;2235.0389332586983;2247.1685476373764;1879.6710575649342;1946.805319468056;2160.4274867160216;2192.3094225318973;2208.0615738311153;9846.852297215548;9885.654002109963;9932.354396964247;9972.301938864282;9982.951790062085;5244.947550524484;5465.672059676393;5469.781208751645;5473.452654734535;5484.040292948758;3310.4278972414727;3393.355262500117;3400.4899265110184;3428.434308339121;3432.5880894292845;1075.7740874416381;1099.1701265544464;1117.5306371324064;1118.5693507999397;1121.9719507012308;13468.730625387536;13541.187528748209;13596.864031359659;13640.727185456235;13682.589522314347;4466.419365482531;4591.219492686251;4842;4864.051509955595;4870.951290487121;10369.429681367446;10381;10439.478026098664;10456;10463.895361046445;5328.733563321818;5396.379416367168;5401.270828438189;5414.377346605112;5419.376771671229;4664.930026049612;4674.298855171752;4766.547178018082;4930.433000205022;5142.485751424828;3713.33160031197;3761.8307176177136;3826.4642949987024;3855.4024126260474;3863.517060367454;1087.532361084741;1103.6358001859528;1109.8446217529552;1119.9664010079712;1125.8142406503;687.5840116729307;700.9264027277164;711.2780527764323;723.3634401726447;725.2602345607556;5112.795488180505;5223.634345595848;5257.921131183035;5322.175062865262;5410.458954104558;547.1683041776478;558.2909704675039;828.7306625346787;857.4041041476239;859.5959898847532;3434.261633748756;3583.122135076923;3588.946165807515;3626.818659067036;3770.4721339012012;12105;12493.12548121641;12721.300328482022;12826.871731282754;12892.162009469355;12540.686482838002;12544.184627999151;12760.489580416865;12779.936100319625;12780.872191278155;7270.200277969419;7456.105267367842;7476.289752473506;7515.549067055885;7529.360004399688;5491.972540137273;5667.546596272371;5679.943200567942;5748.195252664546;5897.233359663388;11276.887231127912;11458.484368203617;11502.94248528752;11652.533898644298;11684.824727628922;11456.770864582828;11859.34773587461;12009.159358845147;12020;12049.457774400349;8129.4715843469985;8209.630566624635;8310.168983101641;8332.50004999702;8350.958245208734;9279.350445468752;9302.16280534755;9371;9381.577828997848;9482.146606805421;7502.212267711811;7519.285667861764;7549.773506794805;7980.6408711606955;8054.718084867001;7811.7265895695655;7919.247671471201;7923.920760792318;8023;8123.309518690978;6227.377262273736;6343.492520598434;6351.364863513611;6365.013422919455;6373.7131829066875;4604.102200070954;4738.478767335521;4799.616030717464;4805.5915247204375;4829.058333624909;4997.500249975119;4998.525140111684;5000;5055.418626857959;5136.666116702402 17:16:23 INFO - PID 17750 | |4;prototype.html;383.40189304684674;386.9071422858515;389.4275415139744;390.2760379496035;402.16550657385915;5484.862878428041;5504.256925315081;5533.36366317874;5547.916781248279;5651.660900345983;5434.347878254615;5445.650924681322;5480.424555421673;5481.945180548193;5507.917381239285;4175.895602609929;4192.937105943413;4262.957370426303;4329.874232699489;4392.12157568486;4376.956230437702;4386.166628340605;4393.209222339978;4395.956040439587;4399.912001759963;4380.21856121362;4381.605655491006;4386.7059217530905;4404.889877753049;4406.603405693487;4306.5478124796755;4384.517703052662;4389.363542286383;4404.757738324391;4404.889877753049;3968.8214030368704;3985.6811455083525;4004.3192657248337;4017.337139372;4019.3970904364287;5454.372747134091;5460.453954604547;5472.960137573848;5479.972410208208;5498.780048798043;5045.520675535819;5204;5215.243789650517;5215.452377500345;5247.895042099137;5920.496757775594;5926.940730592682;5938.2280303560265;5942.286925568917;5958.910616340715;4496.595306422438;4505.414296141514;4526.615237704799;4527.637788976874;4533.886652833673;5959.702014899238;6157.784477543264;6214.9689251553455;6228.626282423069;6262.248530176363;4355.934660980024;4387.210302145644;4392.868213953522;4394.340848872695;4402.779861006937;4438.911221775546;4450.310201918708;4465.910681786346;4472;4476.2837945928495;4924;4980.9252861207115;5015.122353588107;5022.547970682656;5023.09584274834;5884.264466941632;5896.705164741746;5897.439743224387;5914.556408269397;5928.407159284037;1637.287779815784;1638.1154176744662;1655.0566177278836;1665.6341799724353;1666.4000959654516;1144.8397224388593;1175.5415387998687;1181.373871847922;1185.531714972581;1189.7085214122421;5013.799448022039;5016.598672106223;5028.396592408862;5034.370703662043;5038.345015148007;6062.696865156725;6093.177421048102;6100.542459315569;6114.877702445926;6127.5404344674325;4879.780409881493;4954.9752251238515;5010.749462526859;5028.195488721787;5033.17478716171;3149.2441813964483;3205.3108581655056;3225.3871764365167;3229.1119942016135;3240.6273278572794;5463.972680136574;5540.944590554042;5543.833684989457;5554.444555544494;5585.329760428694;6036.9094463582205;6132.95739724248;6145.508359331332;6180.412860778219;6267.435930766253;5581.6930068845795;5582.581306401955;5613.186088017214;5620.971895140498;5622.240997465372;6005.249343832021;6092.847678808065;6093.573449858467;6099.969500152471;6100.938990610037;5970.611910225822;6004.609700369462;6008.836818745161;6012.6993650316435;6029.547783916136;5635.126555383922;5636.577256705681;5645.181448689835;5656.264685590847;5672.801451949162;4069.6337329640473;4126.0097576582;4131.938020929749;4147.3778933160265;4155.439015732837;6107.175531303217;6112.572119951561;6125.816225513242;6144.354842741448;6151.6924153793025;5822.446867547576;5899.970500147472;5913.319968203712;5915.704214789157;5950.940490595039;5654.85862853432;5750.7987220447085;5792.4497172768515;5820.243368362086;5847.304281758243;5766.740496677743;5774.566907481872;5790.594658373873;5797.797077102281;5800;5736.827895163152;5824.679642619697;5893.907662779823;5900.763969441175;5937.33754548727;5716.42835716425;5716.54267658578;5727.455891690282;5728.312602487728;5736.483716465538 17:16:23 INFO - PID 17750 | |5;yui.html;658.1904257762955;658.262745724788;713.1691579310104;722.9024081748964;740.8629403560342;13289.269090200047;13659.248741319236;13812.654683632914;14834.332455039523;16343.673126537462;16153.919230403832;16259.105749183791;16492.587685307844;16523.33906643733;16720.08039557827;830.1449507007776;850.2475309351207;855.2559273432123;855.3542075732813;856.4989481153533;877.0265005843509;910.544727636182;913.155331318531;913.8126684029758;914.1863741270275;959.8224328499215;970.587500312368;971.708487453761;973.8782652168479;973.9318247722662;956.3496822160928;958.4297343080856;958.7794807194349;961.1589858873485;964.0744884910495;700.3696672994295;704.9048378468943;707.4057791455202;707.4906067631297;710.7370272998971;14395.2082635455;14476.493322733653;14620.122792632475;14626.414943402251;15000.624984375369;15966.121863297514;16144.354225830954;16238.350465981346;16375.918120409322;16421.507354779256;11969.700757481045;12134.939325303405;12167.817482737766;12207.633770986797;12302.81545776814;2703.148508219904;2739.356251280947;2754.1737478756295;2755.0495079197644;2756.4349308391734;68074.65962670205;69537;71057.64471177662;72648.27351726468;73292.90060649041;12132.393380331125;12324.32216228116;12386.81419778704;12399.504019839105;12426.316552589695;21213.787862121182;21342.35972920815;21775.23786667459;21924.671129933064;21926;6108.419700128481;6170.10533472644;6254.6247225166635;6308;6393.360663933569;2885.567164925278;2922.167182353019;2925.7220564046384;2937.9559306610417;2945.26368407898;3276.8689252430113;3364.5794275715534;3372;3375.4430518964587;3402.081438011723;757.0801476206435;767.7811823630238;768.1588660416946;768.7962689887185;770.8496843115539;541.1044720986773;547.6604505206798;547.7398235838025;548.9286392768914;575.246427180395;10032.849507257397;10245.600715274002;10658.987396197348;10828.620998265023;11057.391843448688;547.5428017605265;551.9558435325164;553.3802141601352;553.6484332448844;580.4369761331502;4476.932846007313;4625.606823419979;4629.421322334708;4681.7425041622355;4853.611711063107;62195.6890215546;63245.68377158085;63332.683336583024;63943.680281598296;65293;56748;57458.7127064362;58601;59101.70449147727;60455;50002.249966250536;50118.74940625347;50212;52090.47909520856;52871;9463.38487998278;9637.518124093627;9760.707178784647;10033.648822291185;10056.69829905104;25268;25831.095911643755;26043.218703438928;26384.868075660266;26403.075892343677;30578.694213057584;31074.53388199224;31104.06687799279;31593.684063159995;31847.522287165248;12124;12331.876681233072;12344.3827808611;12481.937590312353;12594.559190428658;13315.733685326046;13394.196348219139;13603.727925441633;13610.115342502706;13620.38708258111;12399.070069744987;12592.496300147892;12621.432035558239;12702.936485317514;12719.87280127187;11915.285082895054;11929.343886086348;12034;12043.397830108635;12204.633860984184;12013.939930300292;12069.879301207227;12148.331841748788;12165.878341216474;12339.568115115928;9208.401453905475;9216.124468175512;9277.67528136512;10138.847917281395;10189.54147063369;11396.316221026766;12162.635120946386;12419.379031048593;12432.689182770504;12546.87453125457 17:16:23 INFO - PID 17750 | __end_tp_report 17:16:23 INFO - PID 17750 | __start_cc_report 17:16:23 INFO - PID 17750 | _x_x_mozilla_cycle_collect,280 17:16:23 INFO - PID 17750 | __end_cc_report 17:16:23 INFO - PID 17750 | __startTimestamp1495498583606__endTimestamp 17:16:23 INFO - PID 17750 | 17:16:23 INFO - PID 17750 | ------- Summary: start ------- 17:16:23 INFO - PID 17750 | Number of tests: 6 17:16:23 INFO - PID 17750 | 17:16:23 INFO - PID 17750 | [#0] dojo.html Cycles:165 Average:5144.32 Median:5303.47 stddev:602.64 (11.4%) stddev-sans-first:572.66 17:16:23 INFO - PID 17750 | Values: 2680.7 2688.8 2692.5 2699.3 2724.9 5133.9 5187.3 5216.9 5223.9 5270.3 5227.5 5257.4 5303.5 5309.7 5313.5 4408.5 4501.2 4622.2 4683.4 4689.0 4713.2 4740.8 4760.6 4772.1 4773.8 4599.6 4688.0 4699.1 4749.4 4773.2 4638.9 4664.0 4677.6 4687.6 4702.0 4646.3 4652.8 4653.5 4658.7 4674.4 5136.6 5203.4 5215.3 5234.8 5269.3 5553.2 5587.1 5631.8 5635.4 5655.1 5679.4 5681.1 5687.7 5695.7 5715.1 5262.0 5264.6 5272.2 5276.0 5317.8 5668.4 5754.4 5758.6 5808.9 5810.2 5519.1 5538.7 5541.9 5565.5 5591.0 5474.0 5518.3 5518.9 5548.6 5636.1 5493.0 5598.5 5607.4 5609.6 5612.9 5595.9 5608.8 5610.0 5611.0 5613.1 4619.3 4651.5 4652.8 4685.7 4713.6 4014.5 4048.3 4076.3 4081.9 4109.3 4714.5 4729.2 4786.8 4806.3 4816.1 5632.4 5683.8 5705.5 5705.6 5720.6 4751.9 4779.3 4782.8 4784.2 4825.7 4907.6 4923.2 5002.3 5006.7 5038.3 5209.1 5243.0 5250.3 5263.4 5267.8 5553.1 5607.4 5616.4 5626.8 5639.8 5169.5 5200.8 5220.5 5228.8 5272.6 5470.0 5563.6 5577.9 5586.6 5603.8 5639.9 5648.9 5649.6 5655.0 5666.1 5437.6 5438.6 5440.2 5474.6 5484.4 5381.2 5432.9 5438.9 5522.1 5525.8 5359.5 5426.2 5433.5 5436.0 5443.6 5416.4 5507.4 5509.0 5529.9 5533.6 5248.4 5304.4 5306.2 5322.2 5326.3 17:16:23 INFO - PID 17750 | 17:16:23 INFO - PID 17750 | [#1] ext.html Cycles:180 Average:30635.34 Median:3082.88 stddev:40696.86 (1320.1%) stddev-sans-first:40748.80 17:16:23 INFO - PID 17750 | Values: 663.0 685.0 1061.5 1080.8 1149.9 34335.1 35319.6 35347.3 35362.6 35409.8 33344.8 33750.2 33773.2 33817.0 33906.3 5419.8 5566.6 6619.5 6751.7 7039.3 7115.2 7262.0 7290.0 7300.2 7310.9 7257.0 7322.3 7331.7 7332.3 7337.8 7277.7 7283.9 7315.5 7317.9 7337.7 7151.1 7161.6 7201.6 7210.6 7212.1 32124.8 32566.0 32652.5 32786.2 32825.7 3059.6 3091.2 3093.8 3097.8 3100.7 24939.4 24999.5 25041.9 25060.4 25079.1 2989.0 3039.4 3043.3 3050.0 3074.6 141970.0 142534.0 142831.0 143110.0 143289.0 37423.4 40698.4 40832.6 40846.6 41259.4 43390.8 43580.3 43704.3 43712.0 43726.3 11999.2 12074.3 12175.1 12186.8 12222.5 9380.7 9519.2 9520.3 9564.6 9629.5 12895.3 12985.6 12990.5 13054.9 13166.9 5263.5 5359.7 5368.7 5380.8 5402.8 863.8 931.5 945.7 945.7 951.7 21827.2 22337.4 22427.2 22474.4 22501.0 1006.6 1017.3 1018.1 1020.3 1035.6 11651.9 11745.7 11749.2 11818.7 11827.7 180010.0 180023.0 180028.0 180497.0 181513.0 41369.6 41579.4 41700.8 41773.0 41869.4 1210.8 1249.1 1250.4 1256.8 1267.9 20125.7 20584.0 21559.4 21580.9 21709.7 29626.9 29655.6 29664.7 29698.4 29728.3 146162.3 146594.0 147565.0 148058.0 148716.0 30048.0 30652.0 31580.2 31709.8 31853.7 37034.3 37994.2 38095.6 38312.0 38555.6 27964.0 28174.2 28402.9 28443.7 30227.2 28117.0 28235.6 28492.0 28640.6 30348.7 32470.5 32475.5 32483.7 33029.3 33071.8 26782.7 27702.2 27777.3 27903.3 29459.7 20732.6 23033.8 23055.0 23106.8 23176.4 17:16:23 INFO - PID 17750 | 17:16:23 INFO - PID 17750 | [#2] jquery.html Cycles:180 Average:25231.37 Median:213082.62 stddev:63510.30 (29.8%) stddev-sans-first:63661.13 17:16:23 INFO - PID 17750 | Values: 411.3 416.6 420.1 429.4 437.3 14862.8 17203.6 18015.1 18044.3 18266.1 17517.5 17613.4 17730.0 17780.9 17806.4 5410.8 5419.2 5531.8 5587.1 5623.6 5474.4 5555.6 5565.6 5577.7 5578.0 5388.0 5500.6 5507.0 5512.9 5523.9 5478.0 5507.3 5523.3 5537.7 5545.7 4824.5 4968.6 4986.9 5001.6 5005.2 20212.6 20589.5 20751.0 20751.8 20772.6 1654.2 1683.7 1688.6 1691.2 1697.1 14202.6 14701.6 14710.5 14839.8 14971.8 2071.5 2080.9 2112.4 2119.7 2126.4 79556.0 80464.6 80536.6 81810.0 82149.0 10729.1 10850.7 10923.8 11136.7 11172.2 14844.9 15009.8 15205.7 15237.0 15293.0 7321.7 7356.4 7430.0 7570.4 7598.1 6629.6 6660.9 6907.1 6907.5 6928.7 6873.8 6908.7 6974.7 7089.1 7100.3 2084.2 2085.4 2090.1 2102.2 2201.4 823.8 877.5 879.9 888.3 899.1 16813.8 16864.7 17415.3 17881.6 19966.3 875.3 880.6 883.7 885.7 910.4 9235.8 9240.0 9716.5 9738.9 9789.5 365987.0 375692.0 387935.0 390777.0 392214.0 80444.6 83654.6 84300.2 84404.0 84761.4 1059.7 1095.2 1118.3 1129.7 1130.1 16749.7 17158.0 17583.6 17591.8 17726.0 37682.2 37870.8 38222.6 38230.2 38841.4 48416.0 49285.8 50220.2 50301.5 50350.7 8185.2 8505.6 8558.1 8632.1 8880.7 12167.0 12263.8 12428.8 12443.6 12717.2 11077.9 11106.1 11183.1 11351.5 11572.0 10172.3 10669.3 10850.5 10904.6 10965.0 11471.9 11811.0 11906.6 12056.5 12150.7 8487.9 8605.4 8631.0 8753.9 8789.3 11368.5 11389.0 11522.3 11703.8 11705.8 17:16:23 INFO - PID 17750 | 17:16:23 INFO - PID 17750 | [#3] mootools.html Cycles:180 Average:6042.36 Median:4634.52 stddev:3829.90 (82.6%) stddev-sans-first:3823.57 17:16:23 INFO - PID 17750 | Values: 1229.3 1297.3 1302.7 1307.1 1311.6 9745.3 9869.7 10130.9 10181.6 10205.8 9770.4 9912.6 9915.6 9925.3 9952.0 2244.1 2278.8 2290.9 2300.1 2308.1 2185.5 2235.3 2242.1 2251.3 2253.0 2184.5 2199.4 2210.0 2216.7 2237.6 2174.7 2182.8 2206.4 2235.0 2247.2 1879.7 1946.8 2160.4 2192.3 2208.1 9846.9 9885.7 9932.4 9972.3 9983.0 5244.9 5465.7 5469.8 5473.5 5484.0 3310.4 3393.4 3400.5 3428.4 3432.6 1075.8 1099.2 1117.5 1118.6 1122.0 13468.7 13541.2 13596.9 13640.7 13682.6 4466.4 4591.2 4842.0 4864.1 4871.0 10369.4 10381.0 10439.5 10456.0 10463.9 5328.7 5396.4 5401.3 5414.4 5419.4 4664.9 4674.3 4766.5 4930.4 5142.5 3713.3 3761.8 3826.5 3855.4 3863.5 1087.5 1103.6 1109.8 1120.0 1125.8 687.6 700.9 711.3 723.4 725.3 5112.8 5223.6 5257.9 5322.2 5410.5 547.2 558.3 828.7 857.4 859.6 3434.3 3583.1 3588.9 3626.8 3770.5 12105.0 12493.1 12721.3 12826.9 12892.2 12540.7 12544.2 12760.5 12779.9 12780.9 7270.2 7456.1 7476.3 7515.5 7529.4 5492.0 5667.5 5679.9 5748.2 5897.2 11276.9 11458.5 11502.9 11652.5 11684.8 11456.8 11859.3 12009.2 12020.0 12049.5 8129.5 8209.6 8310.2 8332.5 8351.0 9279.4 9302.2 9371.0 9381.6 9482.1 7502.2 7519.3 7549.8 7980.6 8054.7 7811.7 7919.2 7923.9 8023.0 8123.3 6227.4 6343.5 6351.4 6365.0 6373.7 4604.1 4738.5 4799.6 4805.6 4829.1 4997.5 4998.5 5000.0 5055.4 5136.7 17:16:23 INFO - PID 17750 | 17:16:23 INFO - PID 17750 | [#4] prototype.html Cycles:180 Average:4898.04 Median:5476.47 stddev:1383.01 (25.3%) stddev-sans-first:1344.74 17:16:23 INFO - PID 17750 | Values: 383.4 386.9 389.4 390.3 402.2 5484.9 5504.3 5533.4 5547.9 5651.7 5434.3 5445.7 5480.4 5481.9 5507.9 4175.9 4192.9 4263.0 4329.9 4392.1 4377.0 4386.2 4393.2 4396.0 4399.9 4380.2 4381.6 4386.7 4404.9 4406.6 4306.5 4384.5 4389.4 4404.8 4404.9 3968.8 3985.7 4004.3 4017.3 4019.4 5454.4 5460.5 5473.0 5480.0 5498.8 5045.5 5204.0 5215.2 5215.5 5247.9 5920.5 5926.9 5938.2 5942.3 5958.9 4496.6 4505.4 4526.6 4527.6 4533.9 5959.7 6157.8 6215.0 6228.6 6262.2 4355.9 4387.2 4392.9 4394.3 4402.8 4438.9 4450.3 4465.9 4472.0 4476.3 4924.0 4980.9 5015.1 5022.5 5023.1 5884.3 5896.7 5897.4 5914.6 5928.4 1637.3 1638.1 1655.1 1665.6 1666.4 1144.8 1175.5 1181.4 1185.5 1189.7 5013.8 5016.6 5028.4 5034.4 5038.3 6062.7 6093.2 6100.5 6114.9 6127.5 4879.8 4955.0 5010.7 5028.2 5033.2 3149.2 3205.3 3225.4 3229.1 3240.6 5464.0 5540.9 5543.8 5554.4 5585.3 6036.9 6133.0 6145.5 6180.4 6267.4 5581.7 5582.6 5613.2 5621.0 5622.2 6005.2 6092.8 6093.6 6100.0 6100.9 5970.6 6004.6 6008.8 6012.7 6029.5 5635.1 5636.6 5645.2 5656.3 5672.8 4069.6 4126.0 4131.9 4147.4 4155.4 6107.2 6112.6 6125.8 6144.4 6151.7 5822.4 5900.0 5913.3 5915.7 5950.9 5654.9 5750.8 5792.4 5820.2 5847.3 5766.7 5774.6 5790.6 5797.8 5800.0 5736.8 5824.7 5893.9 5900.8 5937.3 5716.4 5716.5 5727.5 5728.3 5736.5 17:16:23 INFO - PID 17750 | 17:16:23 INFO - PID 17750 | [#5] yui.html Cycles:180 Average:15021.83 Median:31089.30 stddev:18070.45 (58.1%) stddev-sans-first:18088.95 17:16:23 INFO - PID 17750 | Values: 658.2 658.3 713.2 722.9 740.9 13289.3 13659.2 13812.7 14834.3 16343.7 16153.9 16259.1 16492.6 16523.3 16720.1 830.1 850.2 855.3 855.4 856.5 877.0 910.5 913.2 913.8 914.2 959.8 970.6 971.7 973.9 973.9 956.3 958.4 958.8 961.2 964.1 700.4 704.9 707.4 707.5 710.7 14395.2 14476.5 14620.1 14626.4 15000.6 15966.1 16144.4 16238.4 16375.9 16421.5 11969.7 12134.9 12167.8 12207.6 12302.8 2703.1 2739.4 2754.2 2755.0 2756.4 68074.7 69537.0 71057.6 72648.3 73292.9 12132.4 12324.3 12386.8 12399.5 12426.3 21213.8 21342.4 21775.2 21924.7 21926.0 6108.4 6170.1 6254.6 6308.0 6393.4 2885.6 2922.2 2925.7 2938.0 2945.3 3276.9 3364.6 3372.0 3375.4 3402.1 757.1 767.8 768.2 768.8 770.8 541.1 547.7 547.7 548.9 575.2 10032.8 10245.6 10659.0 10828.6 11057.4 547.5 552.0 553.4 553.6 580.4 4476.9 4625.6 4629.4 4681.7 4853.6 62195.7 63245.7 63332.7 63943.7 65293.0 56748.0 57458.7 58601.0 59101.7 60455.0 50002.2 50118.7 50212.0 52090.5 52871.0 9463.4 9637.5 9760.7 10033.6 10056.7 25268.0 25831.1 26043.2 26384.9 26403.1 30578.7 31074.5 31104.1 31593.7 31847.5 12124.0 12331.9 12344.4 12481.9 12594.6 13315.7 13394.2 13603.7 13610.1 13620.4 12399.1 12592.5 12621.4 12702.9 12719.9 11915.3 11929.3 12034.0 12043.4 12204.6 12013.9 12069.9 12148.3 12165.9 12339.6 9208.4 9216.1 9277.7 10138.8 10189.5 11396.3 12162.6 12419.4 12432.7 12546.9 17:16:23 INFO - PID 17750 | -------- Summary: end -------- 17:16:23 INFO - PID 17750 | 17:16:24 INFO - TEST-INFO | 17750: exit 0 17:16:24 INFO - TEST-OK | dromaeo_css | took 1119014ms 17:16:24 INFO - TEST-START | kraken 17:16:24 INFO - operating with platform_type : linux_ 17:16:24 INFO - Initialising browser for kraken test... 17:16:24 INFO - TEST-INFO | started process 18176 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbUQb7q/profile http://localhost:46747/getInfo.html) 17:16:25 INFO - PID 18176 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2978: String.localeCompare is deprecated; use String.prototype.localeCompare instead 17:16:28 INFO - PID 18176 | __metrics Screen width/height:1600/1200 17:16:28 INFO - PID 18176 | colorDepth:24 17:16:28 INFO - PID 18176 | Browser inner width/height: 1024/695 17:16:28 INFO - PID 18176 | __metrics 17:16:30 INFO - TEST-INFO | 18176: exit 0 17:16:30 INFO - Browser initialized. 17:16:30 INFO - Running cycle 1/1 for kraken test... 17:16:30 INFO - TEST-INFO | started process 18359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbUQb7q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:16:42 INFO - PID 18359 | RSS: Main: 169402368 17:16:42 INFO - PID 18359 | 17:16:44 INFO - PID 18359 | Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46747/tests/kraken/driver.html?testName=audio-beat-detection) 17:16:45 INFO - PID 18359 | RSS: Main: 174477312 17:16:45 INFO - PID 18359 | 17:16:48 INFO - PID 18359 | Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46747/tests/kraken/driver.html?testName=audio-dft) 17:16:49 INFO - PID 18359 | RSS: Main: 174100480 17:16:49 INFO - PID 18359 | 17:16:52 INFO - PID 18359 | Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46747/tests/kraken/driver.html?testName=audio-fft) 17:16:52 INFO - PID 18359 | RSS: Main: 169426944 17:16:52 INFO - PID 18359 | 17:16:54 INFO - PID 18359 | Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46747/tests/kraken/driver.html?testName=audio-oscillator) 17:16:55 INFO - PID 18359 | RSS: Main: 169787392 17:16:55 INFO - PID 18359 | 17:16:57 INFO - PID 18359 | Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46747/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:16:58 INFO - PID 18359 | RSS: Main: 170409984 17:16:58 INFO - PID 18359 | 17:17:01 INFO - PID 18359 | Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46747/tests/kraken/driver.html?testName=imaging-darkroom) 17:17:02 INFO - PID 18359 | RSS: Main: 174174208 17:17:02 INFO - PID 18359 | 17:17:05 INFO - PID 18359 | Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46747/tests/kraken/driver.html?testName=imaging-desaturate) 17:17:06 INFO - PID 18359 | RSS: Main: 172199936 17:17:06 INFO - PID 18359 | 17:17:09 INFO - PID 18359 | Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46747/tests/kraken/driver.html?testName=json-parse-financial) 17:17:09 INFO - PID 18359 | RSS: Main: 173195264 17:17:09 INFO - PID 18359 | 17:17:11 INFO - PID 18359 | Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46747/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:17:12 INFO - PID 18359 | RSS: Main: 173461504 17:17:12 INFO - PID 18359 | 17:17:13 INFO - PID 18359 | Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46747/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:17:14 INFO - PID 18359 | RSS: Main: 173019136 17:17:14 INFO - PID 18359 | 17:17:16 INFO - PID 18359 | Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46747/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:17:17 INFO - PID 18359 | RSS: Main: 173064192 17:17:17 INFO - PID 18359 | 17:17:20 INFO - PID 18359 | Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:17:21 INFO - PID 18359 | RSS: Main: 173146112 17:17:21 INFO - PID 18359 | 17:17:24 INFO - PID 18359 | Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:17:24 INFO - PID 18359 | RSS: Main: 172785664 17:17:24 INFO - PID 18359 | 17:17:26 INFO - PID 18359 | Cycle 1(1): loaded http://localhost:46747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46747/tests/kraken/driver.html?testName=ai-astar) 17:17:26 INFO - PID 18359 | RSS: Main: 174845952 17:17:26 INFO - PID 18359 | 17:17:26 INFO - PID 18359 | __start_tp_report 17:17:26 INFO - PID 18359 | _x_x_mozilla_page_load 17:17:26 INFO - PID 18359 | _x_x_mozilla_page_load_details 17:17:26 INFO - PID 18359 | |i|pagename|runs| 17:17:26 INFO - PID 18359 | |0;ai-astar;105;113;112;112;113;116;113;117;115;118 17:17:26 INFO - PID 18359 | |1;audio-beat-detection;149;123;132;178;127;126;124;125;150;126 17:17:26 INFO - PID 18359 | |2;audio-dft;164;163;163;163;164;166;177;170;168;163 17:17:26 INFO - PID 18359 | |3;audio-fft;77;77;78;104;75;77;78;76;98;75 17:17:26 INFO - PID 18359 | |4;audio-oscillator;85;86;105;84;84;83;97;84;84;116 17:17:26 INFO - PID 18359 | |5;imaging-gaussian-blur;114;115;118;114;114;114;121;114;117;114 17:17:26 INFO - PID 18359 | |6;imaging-darkroom;151;151;151;151;150;152;151;149;151;153 17:17:26 INFO - PID 18359 | |7;imaging-desaturate;97;103;100;100;94;95;95;94;100;95 17:17:26 INFO - PID 18359 | |8;json-parse-financial;63;56;57;60;59;59;57;57;64;59 17:17:26 INFO - PID 18359 | |9;json-stringify-tinderbox;57;61;56;56;60;56;56;56;57;56 17:17:26 INFO - PID 18359 | |10;stanford-crypto-aes;91;81;83;88;82;84;81;82;82;82 17:17:26 INFO - PID 18359 | |11;stanford-crypto-ccm;143;138;138;150;140;131;136;143;197;134 17:17:26 INFO - PID 18359 | |12;stanford-crypto-pbkdf2;185;194;204;194;201;193;198;192;191;197 17:17:26 INFO - PID 18359 | |13;stanford-crypto-sha256-iterative;75;78;78;74;77;76;74;75;75;74 17:17:26 INFO - PID 18359 | __end_tp_report 17:17:26 INFO - PID 18359 | __start_cc_report 17:17:26 INFO - PID 18359 | _x_x_mozilla_cycle_collect,763 17:17:26 INFO - PID 18359 | __end_cc_report 17:17:26 INFO - PID 18359 | __startTimestamp1495498646939__endTimestamp 17:17:26 INFO - PID 18359 | 17:17:26 INFO - PID 18359 | ------- Summary: start ------- 17:17:26 INFO - PID 18359 | Number of tests: 14 17:17:26 INFO - PID 18359 | 17:17:26 INFO - PID 18359 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:3.63 (3.2%) stddev-sans-first:2.24 17:17:26 INFO - PID 18359 | Values: 105.0 113.0 112.0 112.0 113.0 116.0 113.0 117.0 115.0 118.0 17:17:26 INFO - PID 18359 | 17:17:26 INFO - PID 18359 | [#1] audio-beat-detection Cycles:10 Average:136.00 Median:129.50 stddev:17.83 (13.8%) stddev-sans-first:18.28 17:17:26 INFO - PID 18359 | Values: 149.0 123.0 132.0 178.0 127.0 126.0 124.0 125.0 150.0 126.0 17:17:26 INFO - PID 18359 | 17:17:26 INFO - PID 18359 | [#2] audio-dft Cycles:10 Average:166.10 Median:165.00 stddev:4.53 (2.7%) stddev-sans-first:4.74 17:17:26 INFO - PID 18359 | Values: 164.0 163.0 163.0 163.0 164.0 166.0 177.0 170.0 168.0 163.0 17:17:26 INFO - PID 18359 | 17:17:26 INFO - PID 18359 | [#3] audio-fft Cycles:10 Average:81.50 Median:77.00 stddev:10.43 (13.5%) stddev-sans-first:10.93 17:17:26 INFO - PID 18359 | Values: 77.0 77.0 78.0 104.0 75.0 77.0 78.0 76.0 98.0 75.0 17:17:26 INFO - PID 18359 | 17:17:26 INFO - PID 18359 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:84.00 stddev:11.44 (13.6%) stddev-sans-first:11.94 17:17:26 INFO - PID 18359 | Values: 85.0 86.0 105.0 84.0 84.0 83.0 97.0 84.0 84.0 116.0 17:17:26 INFO - PID 18359 | 17:17:26 INFO - PID 18359 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:114.50 stddev:2.42 (2.1%) stddev-sans-first:2.50 17:17:26 INFO - PID 18359 | Values: 114.0 115.0 118.0 114.0 114.0 114.0 121.0 114.0 117.0 114.0 17:17:26 INFO - PID 18359 | 17:17:26 INFO - PID 18359 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:1.05 (0.7%) stddev-sans-first:1.12 17:17:26 INFO - PID 18359 | Values: 151.0 151.0 151.0 151.0 150.0 152.0 151.0 149.0 151.0 153.0 17:17:26 INFO - PID 18359 | 17:17:26 INFO - PID 18359 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:94.50 stddev:3.20 (3.4%) stddev-sans-first:3.39 17:17:26 INFO - PID 18359 | Values: 97.0 103.0 100.0 100.0 94.0 95.0 95.0 94.0 100.0 95.0 17:17:26 INFO - PID 18359 | 17:17:26 INFO - PID 18359 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:59.00 stddev:2.64 (4.5%) stddev-sans-first:2.40 17:17:26 INFO - PID 18359 | Values: 63.0 56.0 57.0 60.0 59.0 59.0 57.0 57.0 64.0 59.0 17:17:26 INFO - PID 18359 | 17:17:26 INFO - PID 18359 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:56.50 stddev:1.85 (3.3%) stddev-sans-first:1.96 17:17:26 INFO - PID 18359 | Values: 57.0 61.0 56.0 56.0 60.0 56.0 56.0 56.0 57.0 56.0 17:17:26 INFO - PID 18359 | 17:17:26 INFO - PID 18359 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:82.50 stddev:3.31 (4.0%) stddev-sans-first:2.17 17:17:26 INFO - PID 18359 | Values: 91.0 81.0 83.0 88.0 82.0 84.0 81.0 82.0 82.0 82.0 17:17:26 INFO - PID 18359 | 17:17:26 INFO - PID 18359 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:141.50 stddev:19.03 (13.4%) stddev-sans-first:20.17 17:17:26 INFO - PID 18359 | Values: 143.0 138.0 138.0 150.0 140.0 131.0 136.0 143.0 197.0 134.0 17:17:26 INFO - PID 18359 | 17:17:26 INFO - PID 18359 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.90 Median:195.50 stddev:5.38 (2.8%) stddev-sans-first:4.36 17:17:26 INFO - PID 18359 | Values: 185.0 194.0 204.0 194.0 201.0 193.0 198.0 192.0 191.0 197.0 17:17:26 INFO - PID 18359 | 17:17:26 INFO - PID 18359 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.60 Median:75.50 stddev:1.58 (2.1%) stddev-sans-first:1.66 17:17:26 INFO - PID 18359 | Values: 75.0 78.0 78.0 74.0 77.0 76.0 74.0 75.0 75.0 74.0 17:17:26 INFO - PID 18359 | -------- Summary: end -------- 17:17:26 INFO - PID 18359 | 17:17:28 INFO - TEST-INFO | 18359: exit 0 17:17:28 INFO - TEST-OK | kraken | took 63632ms 17:17:28 INFO - SUITE-END | took 1182s 17:17:28 INFO - Completed test suite (00:19:42) 17:17:28 INFO - javascript benchmark 17:17:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6721.074510159092, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2680.664916885389, 2688.798340124491, 2692.5422678144714, 2699.3116755227425, 2724.9182524524267, 5133.922991155136, 5187.299714538536, 5216.947830521698, 5223.902980374117, 5270.262163297137, 5227.5295223429885, 5257.447967963366, 5303.469653034695, 5309.73451327434, 5313.548348390392, 4408.537103604123, 4501.189785838547, 4622.191116554606, 4683.367745354385, 4689.015306785579, 4713.151632706112, 4740.810367585293, 4760.619150467955, 4772.117158325704, 4773.785179666923, 4599.609033232179, 4688.038952014829, 4699.107169637758, 4749.358836557055, 4773.212419950722, 4638.884027899296, 4664.0, 4677.602403795681, 4687.648426368036, 4702.0, 4646.303054541812, 4652.767361631905, 4653.464851542049, 4658.697184683018, 4674.415698037746, 5136.614753893473, 5203.401608814959, 5215.295935048758, 5234.81678141267, 5269.314989051437, 5553.194786755938, 5587.106063029895, 5631.774729010835, 5635.408282130358, 5655.095184770458, 5679.4036626154075, 5681.147827825818, 5687.7156142192725, 5695.686737229492, 5715.142728590703, 5262.0, 5264.631475796734, 5272.20916862466, 5275.973620131875, 5317.8404647860625, 5668.376478587352, 5754.424557544296, 5758.596898217084, 5808.854778630568, 5810.1575271586225, 5519.061759500894, 5538.723063846792, 5541.944580554143, 5565.526930210977, 5591.0, 5474.0146773580345, 5518.2826232589505, 5518.889622207614, 5548.55611551075, 5636.126400407943, 5492.972535137299, 5598.468145526169, 5607.43925607436, 5609.5792815539, 5612.943870561324, 5595.944040559623, 5608.831735047955, 5610.018246806792, 5610.97194514033, 5613.101903695389, 4619.307103934437, 4651.534846515321, 4652.837150699709, 4685.672002959828, 4713.6464765142755, 4014.518257809023, 4048.27131116396, 4076.316600550809, 4081.9387709184384, 4109.260333140004, 4714.528547145326, 4729.243321068612, 4786.8085276588545, 4806.327114204014, 4816.109019831342, 5632.408597097246, 5683.772649094072, 5705.486506214461, 5705.62913410627, 5720.599558030981, 4751.904961900743, 4779.30700048498, 4782.808687652525, 4784.210605250095, 4825.734584597811, 4907.607391408679, 4923.163062279421, 5002.324686167393, 5006.724630145377, 5038.3198268234055, 5209.140491818807, 5243.030039442715, 5250.291210686509, 5263.447338029452, 5267.78928842842, 5553.111502159797, 5607.355154157324, 5616.410276921028, 5626.831195064155, 5639.7744090237575, 5169.4830516948, 5200.843974680765, 5220.530152286161, 5228.843134705965, 5272.604554658493, 5470.0, 5563.638363506359, 5577.916331255115, 5586.608937374344, 5603.80386686464, 5639.915401268902, 5648.85877853057, 5649.604527683187, 5655.0, 5666.121751128581, 5437.619366644455, 5438.646487978269, 5440.238366628754, 5474.5894057945015, 5484.396716361117, 5381.246625472359, 5432.945670543244, 5438.891222175455, 5522.116461366162, 5525.806596769094, 5359.544438722753, 5426.213199086032, 5433.538149257357, 5436.0486914790545, 5443.618946673695, 5416.4041955385665, 5507.394186639546, 5509.0, 5529.917051244315, 5533.6403133796175, 5248.422673505987, 5304.416514183514, 5306.2305965634, 5322.175062865262, 5326.25432439451], "value": 5100.356712755122, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.0, 685.0443631134569, 1061.501094485592, 1080.7622323088917, 1149.919505634606, 34335.14162145948, 35319.646803531956, 35347.293054138936, 35362.64637353632, 35409.822950885275, 33344.83327583359, 33750.15624609386, 33773.15567110824, 33817.0, 33906.32187356251, 5419.8374048778405, 5566.610337276392, 6619.470442364599, 6751.662416879161, 7039.296070392946, 7115.181754098293, 7262.0, 7289.963550182269, 7300.233475485051, 7310.926890731104, 7256.963715181417, 7322.304381083815, 7331.670074846645, 7332.340089391953, 7337.779866604011, 7277.708891644328, 7283.890741638879, 7315.5244909081275, 7317.890231646529, 7337.6698048587405, 7151.141862976424, 7161.641917904084, 7201.6039117848495, 7210.639468026578, 7212.062431883822, 32124.839375803203, 32566.0, 32652.510212346835, 32786.18034549132, 32825.6717432825, 3059.602251707264, 3091.180837078176, 3093.752499800011, 3097.798643088192, 3100.7364374028234, 24939.376515587257, 24999.500009999698, 25041.87479062593, 25060.373490662696, 25079.12223072202, 2989.0285657161508, 3039.392121575672, 3043.3152540678393, 3049.9542506862413, 3074.584931034304, 141970.0, 142534.0, 142831.0, 143110.0, 143289.0, 37423.4386484203, 40698.38952415716, 40832.591674082876, 40846.59153408487, 41259.39849624046, 43390.7830460852, 43580.346294805604, 43704.3444348335, 43712.0, 43726.344104838456, 11999.1600587958, 12074.335911524775, 12175.147739658316, 12186.75626487483, 12222.511099556095, 9380.718578442658, 9519.23846092311, 9520.333576649567, 9564.61741530331, 9629.470379129216, 12895.290759008158, 12985.610431687064, 12990.480380784662, 13054.869451305556, 13166.868331316757, 5263.526282634504, 5359.705216213146, 5368.677879327252, 5380.78476860929, 5402.837914862561, 863.8315528472014, 931.5109567476993, 945.6690158444627, 945.6973768394048, 951.6621599332276, 21827.23604673829, 22337.44156396103, 22427.21504747326, 22474.438139046655, 22500.98745556454, 1006.5571148694697, 1017.3336464615688, 1018.1091544898214, 1020.285799940045, 1035.5598870480017, 11651.883481165249, 11745.735634122819, 11749.236299640495, 11818.704532386759, 11827.704307392383, 180010.0, 180023.0, 180028.0, 180497.0, 181513.0, 41369.58630413718, 41579.376309355386, 41700.79149604293, 41773.0, 41869.371959420634, 1210.7820592293472, 1249.1443361297358, 1250.3873102180048, 1256.7863463211277, 1267.923924564529, 20125.698114528586, 20584.0, 21559.35321940344, 21580.89209553942, 21709.674354884373, 29626.851865740533, 29655.555166672948, 29664.70335296706, 29698.40603187881, 29728.256793580334, 146162.2691886534, 146594.0, 147565.0, 148058.0, 148716.0, 30048.0, 30652.0, 31580.210494737814, 31709.8414507926, 31853.681463185072, 37034.25931481301, 37994.240115198096, 38095.61904380921, 38312.0, 38555.61444385633, 27964.021259255827, 28174.154775356772, 28402.85798570994, 28443.715562844107, 30227.244318892204, 28117.0, 28235.576466353432, 28492.0, 28640.57039144373, 30348.696513034585, 32470.512942306355, 32475.512867306537, 32483.675163248066, 33029.33941321208, 33071.834640826644, 26782.732172678025, 27702.168934931986, 27777.305567360978, 27903.302417439725, 29459.705402945696, 20732.58534829325, 23033.769662303162, 23055.0, 23106.768932311134, 23176.377653564763], "value": 14783.065107795579, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.25973248153315, 416.6021449515709, 420.09259998403445, 429.35810962610896, 437.3177842565598, 14862.777058344107, 17203.569910752223, 18015.099245037745, 18044.278228870844, 18266.086695665195, 17517.474475765717, 17613.383531576364, 17730.0, 17780.911095444506, 17806.37677681278, 5410.809621883199, 5419.187121931712, 5531.806386776443, 5587.05020146576, 5623.550115990711, 5474.370447398541, 5555.555555555566, 5565.554755619561, 5577.721113944307, 5578.0, 5387.973060134694, 5500.559955203574, 5506.972465137689, 5512.897420515913, 5523.917141242885, 5478.04134276502, 5507.284053073095, 5523.309586301712, 5537.667739935577, 5545.667259964415, 4824.541668541483, 4968.552830245259, 4986.850394488171, 5001.649884508086, 5005.199168133117, 20212.595748084957, 20589.485262868548, 20751.0, 20751.792482075136, 20772.58454830895, 1654.2142482320921, 1683.7474378843149, 1688.5694147992183, 1691.2135856826635, 1697.1344614246823, 14202.644933876632, 14701.558953231313, 14710.485133020293, 14839.777403338958, 14971.775423368657, 2071.4717746974575, 2080.8855512946784, 2112.41908475169, 2119.6926445665445, 2126.404606710108, 79556.0, 80464.59767701183, 80536.59731701363, 81810.0, 82148.9999999994, 10729.141668666643, 10850.67447976562, 10923.836142457869, 11136.721581960353, 11172.21794474379, 14844.92577537127, 15009.774853377208, 15205.695886082216, 15237.0, 15293.0, 7321.74373896911, 7356.448266379936, 7429.962850185714, 7570.356519695888, 7598.126215485179, 6629.635370054597, 6660.933390666129, 6907.067545881342, 6907.516473846783, 6928.653567321614, 6873.828154296182, 6908.6545672716165, 6974.686139123752, 7089.149302083783, 7100.337373484943, 2084.218418093215, 2085.384811480617, 2090.143041353038, 2102.1906565971904, 2201.3726088064823, 823.8022874510075, 877.4954401219325, 879.8680197970356, 888.2938064238816, 899.1458114790975, 16813.831861681225, 16864.747028794576, 17415.3033878646, 17881.642367152584, 19966.304548885713, 875.2735229759285, 880.6477409036308, 883.7172104926361, 885.7209978856639, 910.3809409601535, 9235.815283694288, 9239.953800231091, 9716.514174291256, 9738.90261097394, 9789.46157961319, 365987.0, 375692.0, 387935.0, 390777.0, 392214.0, 80444.59777701074, 83654.5817270922, 84300.15699843045, 84404.0, 84761.40482439694, 1059.6979860739652, 1095.2497539185842, 1118.2675347647305, 1129.7345123895877, 1130.0959232613875, 16749.74875376895, 17158.0, 17583.560410989827, 17591.82408175953, 17726.018148964456, 37682.246355073294, 37870.81064594659, 38222.63545431387, 38230.2353952925, 38841.417378739905, 48416.0, 49285.753571231915, 50220.246696298855, 50301.496985029684, 50350.74824625853, 8185.181481851767, 8505.617247224014, 8558.144185581392, 8632.093630168742, 8880.689175878813, 12167.0, 12263.75472490563, 12428.751424971631, 12443.626691199279, 12717.236965782082, 11077.944610276896, 11106.111511079256, 11183.105351571692, 11351.489182986621, 11572.0, 10172.338797978107, 10669.306495077795, 10850.511726972463, 10904.618338358438, 10965.0, 11471.885281147082, 11811.0, 11906.583269585522, 12056.51773929033, 12150.696232593902, 8487.915120848713, 8605.440646357967, 8630.956845215735, 8753.91246087531, 8789.296856251356, 11368.488418021043, 11389.0, 11522.308661480338, 11703.824442633537, 11705.765884682089], "value": 8898.022985502252, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1229.2870135321511, 1297.2864924291637, 1302.7068909495365, 1307.0589175793425, 1311.6130741431273, 9745.26910481714, 9869.65456209031, 10130.949345253264, 10181.59273629055, 10205.846912296303, 9770.364926279786, 9912.553935072921, 9915.553800078997, 9925.255605829556, 9951.950240248807, 2244.0574958517423, 2278.7949084582383, 2290.942726431844, 2300.1029598456616, 2308.0998410619873, 2185.4754858833844, 2235.273536100766, 2242.1479837661664, 2251.313349428424, 2253.0, 2184.541246338271, 2199.439143018528, 2210.027587861344, 2216.656418255165, 2237.552489502098, 2174.662927246279, 2182.8362872784605, 2206.360155554887, 2235.0389332586983, 2247.1685476373764, 1879.6710575649342, 1946.805319468056, 2160.4274867160216, 2192.3094225318973, 2208.0615738311153, 9846.852297215548, 9885.654002109963, 9932.354396964247, 9972.301938864282, 9982.951790062085, 5244.947550524484, 5465.672059676393, 5469.781208751645, 5473.452654734535, 5484.040292948758, 3310.4278972414727, 3393.355262500117, 3400.4899265110184, 3428.434308339121, 3432.5880894292845, 1075.7740874416381, 1099.1701265544464, 1117.5306371324064, 1118.5693507999397, 1121.9719507012308, 13468.730625387536, 13541.187528748209, 13596.864031359659, 13640.727185456235, 13682.589522314347, 4466.419365482531, 4591.219492686251, 4842.0, 4864.051509955595, 4870.951290487121, 10369.429681367446, 10381.0, 10439.478026098664, 10456.0, 10463.895361046445, 5328.733563321818, 5396.379416367168, 5401.270828438189, 5414.377346605112, 5419.376771671229, 4664.930026049612, 4674.298855171752, 4766.547178018082, 4930.433000205022, 5142.485751424828, 3713.33160031197, 3761.8307176177136, 3826.4642949987024, 3855.4024126260474, 3863.517060367454, 1087.532361084741, 1103.6358001859528, 1109.8446217529552, 1119.9664010079712, 1125.8142406503, 687.5840116729307, 700.9264027277164, 711.2780527764323, 723.3634401726447, 725.2602345607556, 5112.795488180505, 5223.634345595848, 5257.921131183035, 5322.175062865262, 5410.458954104558, 547.1683041776478, 558.2909704675039, 828.7306625346787, 857.4041041476239, 859.5959898847532, 3434.261633748756, 3583.122135076923, 3588.946165807515, 3626.818659067036, 3770.4721339012012, 12105.0, 12493.12548121641, 12721.300328482022, 12826.871731282754, 12892.162009469355, 12540.686482838002, 12544.184627999151, 12760.489580416865, 12779.936100319625, 12780.872191278155, 7270.200277969419, 7456.105267367842, 7476.289752473506, 7515.549067055885, 7529.360004399688, 5491.972540137273, 5667.546596272371, 5679.943200567942, 5748.195252664546, 5897.233359663388, 11276.887231127912, 11458.484368203617, 11502.94248528752, 11652.533898644298, 11684.824727628922, 11456.770864582828, 11859.34773587461, 12009.159358845147, 12020.0, 12049.457774400349, 8129.4715843469985, 8209.630566624635, 8310.168983101641, 8332.50004999702, 8350.958245208734, 9279.350445468752, 9302.16280534755, 9371.0, 9381.577828997848, 9482.146606805421, 7502.212267711811, 7519.285667861764, 7549.773506794805, 7980.6408711606955, 8054.718084867001, 7811.7265895695655, 7919.247671471201, 7923.920760792318, 8023.0, 8123.309518690978, 6227.377262273736, 6343.492520598434, 6351.364863513611, 6365.013422919455, 6373.7131829066875, 4604.102200070954, 4738.478767335521, 4799.616030717464, 4805.5915247204375, 4829.058333624909, 4997.500249975119, 4998.525140111684, 5000.0, 5055.418626857959, 5136.666116702402], "value": 4586.6476032027185, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.40189304684674, 386.9071422858515, 389.4275415139744, 390.2760379496035, 402.16550657385915, 5484.862878428041, 5504.256925315081, 5533.36366317874, 5547.916781248279, 5651.660900345983, 5434.347878254615, 5445.650924681322, 5480.424555421673, 5481.945180548193, 5507.917381239285, 4175.895602609929, 4192.937105943413, 4262.957370426303, 4329.874232699489, 4392.12157568486, 4376.956230437702, 4386.166628340605, 4393.209222339978, 4395.956040439587, 4399.912001759963, 4380.21856121362, 4381.605655491006, 4386.7059217530905, 4404.889877753049, 4406.603405693487, 4306.5478124796755, 4384.517703052662, 4389.363542286383, 4404.757738324391, 4404.889877753049, 3968.8214030368704, 3985.6811455083525, 4004.3192657248337, 4017.337139372, 4019.3970904364287, 5454.372747134091, 5460.453954604547, 5472.960137573848, 5479.972410208208, 5498.780048798043, 5045.520675535819, 5204.0, 5215.243789650517, 5215.452377500345, 5247.895042099137, 5920.496757775594, 5926.940730592682, 5938.2280303560265, 5942.286925568917, 5958.910616340715, 4496.595306422438, 4505.414296141514, 4526.615237704799, 4527.637788976874, 4533.886652833673, 5959.702014899238, 6157.784477543264, 6214.9689251553455, 6228.626282423069, 6262.248530176363, 4355.934660980024, 4387.210302145644, 4392.868213953522, 4394.340848872695, 4402.779861006937, 4438.911221775546, 4450.310201918708, 4465.910681786346, 4472.0, 4476.2837945928495, 4924.0, 4980.9252861207115, 5015.122353588107, 5022.547970682656, 5023.09584274834, 5884.264466941632, 5896.705164741746, 5897.439743224387, 5914.556408269397, 5928.407159284037, 1637.287779815784, 1638.1154176744662, 1655.0566177278836, 1665.6341799724353, 1666.4000959654516, 1144.8397224388593, 1175.5415387998687, 1181.373871847922, 1185.531714972581, 1189.7085214122421, 5013.799448022039, 5016.598672106223, 5028.396592408862, 5034.370703662043, 5038.345015148007, 6062.696865156725, 6093.177421048102, 6100.542459315569, 6114.877702445926, 6127.5404344674325, 4879.780409881493, 4954.9752251238515, 5010.749462526859, 5028.195488721787, 5033.17478716171, 3149.2441813964483, 3205.3108581655056, 3225.3871764365167, 3229.1119942016135, 3240.6273278572794, 5463.972680136574, 5540.944590554042, 5543.833684989457, 5554.444555544494, 5585.329760428694, 6036.9094463582205, 6132.95739724248, 6145.508359331332, 6180.412860778219, 6267.435930766253, 5581.6930068845795, 5582.581306401955, 5613.186088017214, 5620.971895140498, 5622.240997465372, 6005.249343832021, 6092.847678808065, 6093.573449858467, 6099.969500152471, 6100.938990610037, 5970.611910225822, 6004.609700369462, 6008.836818745161, 6012.6993650316435, 6029.547783916136, 5635.126555383922, 5636.577256705681, 5645.181448689835, 5656.264685590847, 5672.801451949162, 4069.6337329640473, 4126.0097576582, 4131.938020929749, 4147.3778933160265, 4155.439015732837, 6107.175531303217, 6112.572119951561, 6125.816225513242, 6144.354842741448, 6151.6924153793025, 5822.446867547576, 5899.970500147472, 5913.319968203712, 5915.704214789157, 5950.940490595039, 5654.85862853432, 5750.7987220447085, 5792.4497172768515, 5820.243368362086, 5847.304281758243, 5766.740496677743, 5774.566907481872, 5790.594658373873, 5797.797077102281, 5800.0, 5736.827895163152, 5824.679642619697, 5893.907662779823, 5900.763969441175, 5937.33754548727, 5716.42835716425, 5716.54267658578, 5727.455891690282, 5728.312602487728, 5736.483716465538], "value": 4484.880077334782, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.1904257762955, 658.262745724788, 713.1691579310104, 722.9024081748964, 740.8629403560342, 13289.269090200047, 13659.248741319236, 13812.654683632914, 14834.332455039523, 16343.673126537462, 16153.919230403832, 16259.105749183791, 16492.587685307844, 16523.33906643733, 16720.08039557827, 830.1449507007776, 850.2475309351207, 855.2559273432123, 855.3542075732813, 856.4989481153533, 877.0265005843509, 910.544727636182, 913.155331318531, 913.8126684029758, 914.1863741270275, 959.8224328499215, 970.587500312368, 971.708487453761, 973.8782652168479, 973.9318247722662, 956.3496822160928, 958.4297343080856, 958.7794807194349, 961.1589858873485, 964.0744884910495, 700.3696672994295, 704.9048378468943, 707.4057791455202, 707.4906067631297, 710.7370272998971, 14395.2082635455, 14476.493322733653, 14620.122792632475, 14626.414943402251, 15000.624984375369, 15966.121863297514, 16144.354225830954, 16238.350465981346, 16375.918120409322, 16421.507354779256, 11969.700757481045, 12134.939325303405, 12167.817482737766, 12207.633770986797, 12302.81545776814, 2703.148508219904, 2739.356251280947, 2754.1737478756295, 2755.0495079197644, 2756.4349308391734, 68074.65962670205, 69537.0, 71057.64471177662, 72648.27351726468, 73292.90060649041, 12132.393380331125, 12324.32216228116, 12386.81419778704, 12399.504019839105, 12426.316552589695, 21213.787862121182, 21342.35972920815, 21775.23786667459, 21924.671129933064, 21926.0, 6108.419700128481, 6170.10533472644, 6254.6247225166635, 6308.0, 6393.360663933569, 2885.567164925278, 2922.167182353019, 2925.7220564046384, 2937.9559306610417, 2945.26368407898, 3276.8689252430113, 3364.5794275715534, 3372.0, 3375.4430518964587, 3402.081438011723, 757.0801476206435, 767.7811823630238, 768.1588660416946, 768.7962689887185, 770.8496843115539, 541.1044720986773, 547.6604505206798, 547.7398235838025, 548.9286392768914, 575.246427180395, 10032.849507257397, 10245.600715274002, 10658.987396197348, 10828.620998265023, 11057.391843448688, 547.5428017605265, 551.9558435325164, 553.3802141601352, 553.6484332448844, 580.4369761331502, 4476.932846007313, 4625.606823419979, 4629.421322334708, 4681.7425041622355, 4853.611711063107, 62195.6890215546, 63245.68377158085, 63332.683336583024, 63943.680281598296, 65293.0, 56748.0, 57458.7127064362, 58601.0, 59101.70449147727, 60455.0, 50002.249966250536, 50118.74940625347, 50212.0, 52090.47909520856, 52871.0, 9463.38487998278, 9637.518124093627, 9760.707178784647, 10033.648822291185, 10056.69829905104, 25268.0, 25831.095911643755, 26043.218703438928, 26384.868075660266, 26403.075892343677, 30578.694213057584, 31074.53388199224, 31104.06687799279, 31593.684063159995, 31847.522287165248, 12124.0, 12331.876681233072, 12344.3827808611, 12481.937590312353, 12594.559190428658, 13315.733685326046, 13394.196348219139, 13603.727925441633, 13610.115342502706, 13620.38708258111, 12399.070069744987, 12592.496300147892, 12621.432035558239, 12702.936485317514, 12719.87280127187, 11915.285082895054, 11929.343886086348, 12034.0, 12043.397830108635, 12204.633860984184, 12013.939930300292, 12069.879301207227, 12148.331841748788, 12165.878341216474, 12339.568115115928, 9208.401453905475, 9216.124468175512, 9277.67528136512, 10138.847917281395, 10189.54147063369, 11396.316221026766, 12162.635120946386, 12419.379031048593, 12432.689182770504, 12546.87453125457], "value": 6678.751942171443, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1566.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 112.0, 112.0, 113.0, 116.0, 113.0, 117.0, 115.0, 118.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 132.0, 178.0, 127.0, 126.0, 124.0, 125.0, 150.0, 126.0], "value": 136.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 163.0, 164.0, 166.0, 177.0, 170.0, 168.0, 163.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 104.0, 75.0, 77.0, 78.0, 76.0, 98.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 105.0, 84.0, 84.0, 83.0, 97.0, 84.0, 84.0, 116.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 118.0, 114.0, 114.0, 114.0, 121.0, 114.0, 117.0, 114.0], "value": 115.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 151.0, 150.0, 152.0, 151.0, 149.0, 151.0, 153.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 103.0, 100.0, 100.0, 94.0, 95.0, 95.0, 94.0, 100.0, 95.0], "value": 97.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 56.0, 57.0, 60.0, 59.0, 59.0, 57.0, 57.0, 64.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 61.0, 56.0, 56.0, 60.0, 56.0, 56.0, 56.0, 57.0, 56.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 81.0, 83.0, 88.0, 82.0, 84.0, 81.0, 82.0, 82.0, 82.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 138.0, 138.0, 150.0, 140.0, 131.0, 136.0, 143.0, 197.0, 134.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 194.0, 204.0, 194.0, 201.0, 193.0, 198.0, 192.0, 191.0, 197.0], "value": 194.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 78.0, 74.0, 77.0, 76.0, 74.0, 75.0, 75.0, 74.0], "value": 75.6, "unit": "score"}]}]} 17:17:28 INFO - Return code: 0 17:17:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:17:28 INFO - # TBPL SUCCESS # 17:17:28 INFO - Running post-action listener: _resource_record_post_action 17:17:28 INFO - [mozharness: 2017-05-23 00:17:28.227221Z] Finished run-tests step (success) 17:17:28 INFO - Running post-run listener: _resource_record_post_run 17:17:28 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 12288; Write bytes: 407785472; Read time: 40; Write time: 291120 17:17:28 INFO - TinderboxPrint: CPU usage
13.3% 17:17:28 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 40 17:17:28 INFO - TinderboxPrint: I/O write bytes / time
407,785,472 / 291,120 17:17:28 INFO - TinderboxPrint: CPU idle
8,291.1 (86.6%) 17:17:28 INFO - TinderboxPrint: CPU user
1,220.8 (12.8%) 17:17:28 INFO - TinderboxPrint: Swap in / out
0 / 0 17:17:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 87441408; Read time: 24; Write time: 69764 17:17:28 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 8192; Write bytes: 320344064; Read time: 16; Write time: 221356 17:17:28 INFO - Running post-run listener: _upload_blobber_files 17:17:28 INFO - Blob upload gear active. 17:17:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:17:28 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 17:17:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:17:29 INFO - (blobuploader) - INFO - Open directory for files ... 17:17:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:17:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:17:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:17:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:17:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:17:30 INFO - (blobuploader) - INFO - Done attempting. 17:17:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:17:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:17:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:17:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:17:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:17:33 INFO - (blobuploader) - INFO - Done attempting. 17:17:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:17:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:17:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:17:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:17:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:17:34 INFO - (blobuploader) - INFO - Done attempting. 17:17:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:17:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:17:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:17:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:17:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:17:35 INFO - (blobuploader) - INFO - Done attempting. 17:17:35 INFO - (blobuploader) - INFO - Iteration through files over. 17:17:35 INFO - Return code: 0 17:17:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:17:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:17:35 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b63a80ee135775e86fb04c51d8e6e6355aaeab783fcdac83ce05a09dfe398f659b248973fabc2bbd17b4c278f98ebf557abde042b4068466d7eb8e7eeea99c00", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4572f043fc3975e76a1e666f0bbc90e88c0e06f86da5eb9f2142031bc4054537ec28bd889e6c8fa8dbe336275cafb6cbfc510015c7451e13ab9542a7a957acb4", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/864863a10f27bb96b7e91f31cf4a74850a095d65be9177ef9eddca2ebd43411a52ebe740c2f353bed457c63b2fb99394eab8af2a86efe8f081d9d10db5aaf89c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75e111f892aec245bd68ed06c184a73f06d8ca35682b0796a644aec5fb7f15c344f264f094f906cf969c5cf0e187cdac2f9ddca8b1a9f0298e73746db77de325"} 17:17:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:17:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:17:35 INFO - Contents: 17:17:35 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b63a80ee135775e86fb04c51d8e6e6355aaeab783fcdac83ce05a09dfe398f659b248973fabc2bbd17b4c278f98ebf557abde042b4068466d7eb8e7eeea99c00", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4572f043fc3975e76a1e666f0bbc90e88c0e06f86da5eb9f2142031bc4054537ec28bd889e6c8fa8dbe336275cafb6cbfc510015c7451e13ab9542a7a957acb4", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/864863a10f27bb96b7e91f31cf4a74850a095d65be9177ef9eddca2ebd43411a52ebe740c2f353bed457c63b2fb99394eab8af2a86efe8f081d9d10db5aaf89c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75e111f892aec245bd68ed06c184a73f06d8ca35682b0796a644aec5fb7f15c344f264f094f906cf969c5cf0e187cdac2f9ddca8b1a9f0298e73746db77de325"} 17:17:35 INFO - Running post-run listener: copy_logs_to_upload_dir 17:17:35 INFO - Copying logs to upload dir... 17:17:35 INFO - mkdir: /builds/slave/test/build/upload/logs 17:17:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.806433 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-05-22 17:17:34.200413) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-22 17:17:34.205315) ========= 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=930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b63a80ee135775e86fb04c51d8e6e6355aaeab783fcdac83ce05a09dfe398f659b248973fabc2bbd17b4c278f98ebf557abde042b4068466d7eb8e7eeea99c00", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4572f043fc3975e76a1e666f0bbc90e88c0e06f86da5eb9f2142031bc4054537ec28bd889e6c8fa8dbe336275cafb6cbfc510015c7451e13ab9542a7a957acb4", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/864863a10f27bb96b7e91f31cf4a74850a095d65be9177ef9eddca2ebd43411a52ebe740c2f353bed457c63b2fb99394eab8af2a86efe8f081d9d10db5aaf89c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75e111f892aec245bd68ed06c184a73f06d8ca35682b0796a644aec5fb7f15c344f264f094f906cf969c5cf0e187cdac2f9ddca8b1a9f0298e73746db77de325"} build_url:https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011517 build_url: 'https://queue.taskcluster.net/v1/task/MRye_F3OSPiECJ5iTVsG5A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b63a80ee135775e86fb04c51d8e6e6355aaeab783fcdac83ce05a09dfe398f659b248973fabc2bbd17b4c278f98ebf557abde042b4068466d7eb8e7eeea99c00", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4572f043fc3975e76a1e666f0bbc90e88c0e06f86da5eb9f2142031bc4054537ec28bd889e6c8fa8dbe336275cafb6cbfc510015c7451e13ab9542a7a957acb4", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/864863a10f27bb96b7e91f31cf4a74850a095d65be9177ef9eddca2ebd43411a52ebe740c2f353bed457c63b2fb99394eab8af2a86efe8f081d9d10db5aaf89c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75e111f892aec245bd68ed06c184a73f06d8ca35682b0796a644aec5fb7f15c344f264f094f906cf969c5cf0e187cdac2f9ddca8b1a9f0298e73746db77de325"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-22 17:17:34.230084) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 17:17:34.230368) ========= 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=930c87414c89fc706ee2024c000001c6-1495488278.178975-299122080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 17:17:34.314516) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-22 17:17:34.314804) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-22 17:17:34.315106) ========= ========= Total master_lag: 0.23 =========