builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-018 starttime: 1495550247.54 results: success (0) revision: 4f874bc1e42463e30bc5595e84e5aaa450d81167 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-23 07:37:27.542469) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-23 07:37:27.542961) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-23 07:37:27.543277) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-23 07:37:27.563434) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 07:37:27.563730) ========= 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=62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-23 07:37:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2017-05-23 07:37:28 (45.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.346506 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 07:37:27.923769) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 07:37:27.924150) ========= 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=62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016141 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 07:37:27.974680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-23 07:37:27.975055) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4f874bc1e42463e30bc5595e84e5aaa450d81167 --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 4f874bc1e42463e30bc5595e84e5aaa450d81167 --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=62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-23 07:37:28,475 truncating revision to first 12 chars 2017-05-23 07:37:28,475 Setting DEBUG logging. 2017-05-23 07:37:28,475 attempt 1/10 2017-05-23 07:37:28,475 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4f874bc1e424?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-23 07:37:29,818 unpacking tar archive at: mozilla-central-4f874bc1e424/testing/mozharness/ program finished with exit code 0 elapsedTime=1.667682 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-23 07:37:29.655990) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-23 07:37:29.656365) ========= script_repo_revision: 4f874bc1e42463e30bc5595e84e5aaa450d81167 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-23 07:37:29.656843) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-23 07:37:29.657170) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-23 07:37:29.664770) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-05-23 07:37:29.665082) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:37:30 INFO - MultiFileLogger online at 20170523 07:37:30 in /builds/slave/test 07:37:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:37:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:37:30 INFO - {'append_to_log': False, 07:37:30 INFO - 'base_work_dir': '/builds/slave/test', 07:37:30 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:37:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:37:30 INFO - 'branch': 'Firefox-Non-PGO', 07:37:30 INFO - 'buildbot_json_path': 'buildprops.json', 07:37:30 INFO - 'config_files': ('talos/linux_config.py',), 07:37:30 INFO - 'default_actions': ('clobber', 07:37:30 INFO - 'read-buildbot-config', 07:37:30 INFO - 'download-and-extract', 07:37:30 INFO - 'populate-webroot', 07:37:30 INFO - 'create-virtualenv', 07:37:30 INFO - 'install', 07:37:30 INFO - 'run-tests'), 07:37:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:37:30 INFO - 'download_minidump_stackwalk': True, 07:37:30 INFO - 'download_symbols': 'ondemand', 07:37:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:37:30 INFO - 'tooltool.py': '/tools/tooltool.py', 07:37:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:37:30 INFO - '/tools/misc-python/virtualenv.py')}, 07:37:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:37:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:37:30 INFO - 'gecko_profile': False, 07:37:30 INFO - 'gecko_profile_interval': 0, 07:37:30 INFO - 'installer_path': 'installer.exe', 07:37:30 INFO - 'log_level': 'info', 07:37:30 INFO - 'log_name': 'talos', 07:37:30 INFO - 'log_to_console': True, 07:37:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:37:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:37:30 INFO - 'opt_config_files': (), 07:37:30 INFO - 'pip_index': False, 07:37:30 INFO - 'suite': 'dromaeojs-e10s', 07:37:30 INFO - 'system_bits': '32', 07:37:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:37:30 INFO - 'title': 'talos-linux64-ix-018', 07:37:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:37:30 INFO - 'use_talos_json': True, 07:37:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:37:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:37:30 INFO - 'work_dir': 'build'} 07:37:30 INFO - [mozharness: 2017-05-23 14:37:30.265081Z] Running clobber step. 07:37:30 INFO - Running pre-action listener: _resource_record_pre_action 07:37:30 INFO - Running main action method: clobber 07:37:30 INFO - rmtree: /builds/slave/test/build 07:37:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:37:31 INFO - Running post-action listener: _resource_record_post_action 07:37:31 INFO - [mozharness: 2017-05-23 14:37:31.293423Z] Finished clobber step (success) 07:37:31 INFO - [mozharness: 2017-05-23 14:37:31.293525Z] Running read-buildbot-config step. 07:37:31 INFO - Running pre-action listener: _resource_record_pre_action 07:37:31 INFO - Running main action method: read_buildbot_config 07:37:31 INFO - Using buildbot properties: 07:37:31 INFO - { 07:37:31 INFO - "project": "", 07:37:31 INFO - "product": "firefox", 07:37:31 INFO - "who": "ryanvm@gmail.com", 07:37:31 INFO - "installer_path": "public/build/target.tar.bz2", 07:37:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:37:31 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:37:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:37:31 INFO - "stage_platform": "linux64", 07:37:31 INFO - "basedir": "/builds/slave/test", 07:37:31 INFO - "buildnumber": 897, 07:37:31 INFO - "platform": "ubuntu64_hw", 07:37:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:37:31 INFO - "slavebuilddir": "test", 07:37:31 INFO - "taskId": "KIWvZ69LSV6jg4lvogpDgQ", 07:37:31 INFO - "branch": "mozilla-central", 07:37:31 INFO - "script_repo_revision": "production", 07:37:31 INFO - "revision": "4f874bc1e42463e30bc5595e84e5aaa450d81167", 07:37:31 INFO - "slavename": "talos-linux64-ix-018", 07:37:31 INFO - "repo_path": "mozilla-central" 07:37:31 INFO - } 07:37:31 INFO - Finding installer, test and symbols from parent task. 07:37:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KIWvZ69LSV6jg4lvogpDgQ'}, attempt #1 07:37:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KIWvZ69LSV6jg4lvogpDgQ'}, attempt #1 07:37:32 INFO - Task dependencies: LfK3GZVWR42LZZfzrFZZUg 07:37:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg'}, attempt #1 07:37:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/target.tar.bz2 07:37:32 INFO - Set test_url: https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/test_packages.json 07:37:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/target.crashreporter-symbols.zip 07:37:32 INFO - Running post-action listener: _resource_record_post_action 07:37:32 INFO - [mozharness: 2017-05-23 14:37:32.639734Z] Finished read-buildbot-config step (success) 07:37:32 INFO - [mozharness: 2017-05-23 14:37:32.639956Z] Running download-and-extract step. 07:37:32 INFO - Running pre-action listener: _resource_record_pre_action 07:37:32 INFO - Running main action method: download_and_extract 07:37:32 INFO - mkdir: /builds/slave/test/build/tests 07:37:32 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')]} 07:37:32 INFO - trying https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/target.test_packages.json 07:37:32 INFO - Downloading https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:37:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:37:33 INFO - Downloaded 986 bytes. 07:37:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:37:33 INFO - Using the following test package requirements: 07:37:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:37:33 INFO - u'common': [u'target.common.tests.zip'], 07:37:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:37:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:37:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:37:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:37:33 INFO - u'mozbase': [u'target.common.tests.zip'], 07:37:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:37:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:37:33 INFO - u'web-platform': [u'target.common.tests.zip', 07:37:33 INFO - u'target.web-platform.tests.zip'], 07:37:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:37:33 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:37:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/target.common.tests.zip 07:37:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:37:33 INFO - Fetch https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/target.common.tests.zip into memory 07:37:34 INFO - Content-Length response header: 63526974 07:37:34 INFO - Bytes received: 63526974 07:37:45 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:37:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/target.common.tests.zip 07:37:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:37:45 INFO - Fetch https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/target.common.tests.zip into memory 07:37:48 INFO - Content-Length response header: 63526974 07:37:48 INFO - Bytes received: 63526974 07:38:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/target.talos.tests.zip 07:38:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:38:00 INFO - Fetch https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/target.talos.tests.zip into memory 07:38:00 INFO - Content-Length response header: 14410000 07:38:00 INFO - Bytes received: 14410000 07:38:01 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')]} 07:38:01 INFO - trying https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/target.tar.bz2 07:38:01 INFO - Downloading https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:38:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:38:02 INFO - Downloaded 54880560 bytes. 07:38:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/target.tar.bz2 07:38:02 INFO - mkdir: /builds/slave/test/properties 07:38:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:38:02 INFO - Writing to file /builds/slave/test/properties/build_url 07:38:02 INFO - Contents: 07:38:02 INFO - build_url:https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/target.tar.bz2 07:38:02 INFO - Running post-action listener: _resource_record_post_action 07:38:02 INFO - Running post-action listener: set_extra_try_arguments 07:38:02 INFO - [mozharness: 2017-05-23 14:38:02.305184Z] Finished download-and-extract step (success) 07:38:02 INFO - [mozharness: 2017-05-23 14:38:02.305307Z] Running populate-webroot step. 07:38:02 INFO - Running pre-action listener: _resource_record_pre_action 07:38:02 INFO - Running main action method: populate_webroot 07:38:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:38:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:38:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:38:02 INFO - '--tppagecycles', 07:38:02 INFO - '7'], 07:38:02 INFO - 'tests': ['tsvgm']}}, 07:38:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:38:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:38:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:38:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:38:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:38:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:38:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:38:02 INFO - 'talos_options': ['--disable-e10s'], 07:38:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:38:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:38:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:38:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:38:02 INFO - 'talos_options': ['--disable-e10s'], 07:38:02 INFO - 'tests': ['damp', 'tps']}, 07:38:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:38:02 INFO - 'tests': ['damp', 'tps']}, 07:38:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:38:02 INFO - 'tests': ['dromaeo_dom']}, 07:38:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:38:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:38:02 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 07:38:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:38:02 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:38:02 INFO - 'tests': ['ts_paint', 'tp5o']}, 07:38:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:38:02 INFO - 'tests': ['a11yr', 07:38:02 INFO - 'ts_paint', 07:38:02 INFO - 'tpaint', 07:38:02 INFO - 'sessionrestore', 07:38:02 INFO - 'sessionrestore_no_auto_restore', 07:38:02 INFO - 'tabpaint']}, 07:38:02 INFO - 'other-e10s': {'tests': ['a11yr', 07:38:02 INFO - 'ts_paint', 07:38:02 INFO - 'tpaint', 07:38:02 INFO - 'sessionrestore', 07:38:02 INFO - 'sessionrestore_no_auto_restore', 07:38:02 INFO - 'tabpaint']}, 07:38:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:38:02 INFO - 'ts_paint', 07:38:02 INFO - 'tpaint', 07:38:02 INFO - 'sessionrestore', 07:38:02 INFO - 'sessionrestore_no_auto_restore', 07:38:02 INFO - 'tabpaint']}, 07:38:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:38:02 INFO - 'ts_paint', 07:38:02 INFO - 'tpaint', 07:38:02 INFO - 'sessionrestore', 07:38:02 INFO - 'sessionrestore_no_auto_restore', 07:38:02 INFO - 'tabpaint']}, 07:38:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:38:02 INFO - 'tests': ['a11yr', 07:38:02 INFO - 'ts_paint', 07:38:02 INFO - 'tpaint', 07:38:02 INFO - 'sessionrestore', 07:38:02 INFO - 'sessionrestore_no_auto_restore', 07:38:02 INFO - 'tabpaint']}, 07:38:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:38:02 INFO - 'tests': ['a11yr', 07:38:02 INFO - 'ts_paint', 07:38:02 INFO - 'tpaint', 07:38:02 INFO - 'sessionrestore', 07:38:02 INFO - 'sessionrestore_no_auto_restore', 07:38:02 INFO - 'tabpaint']}, 07:38:02 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 07:38:02 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 07:38:02 INFO - 'bloom_basic_ref']}, 07:38:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:38:02 INFO - 'tests': ['tsvgx', 07:38:02 INFO - 'tsvgr_opacity', 07:38:02 INFO - 'tart', 07:38:02 INFO - 'tscrollx', 07:38:02 INFO - 'cart', 07:38:02 INFO - 'tsvg_static']}, 07:38:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:38:02 INFO - 'tsvgr_opacity', 07:38:02 INFO - 'tart', 07:38:02 INFO - 'tscrollx', 07:38:02 INFO - 'cart', 07:38:02 INFO - 'tsvg_static']}, 07:38:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:38:02 INFO - 'talos_options': ['--disable-e10s'], 07:38:02 INFO - 'tests': ['tp5o']}, 07:38:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:38:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:38:02 INFO - 'talos_options': ['--disable-e10s', 07:38:02 INFO - '--xperf_path', 07:38:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:38:02 INFO - 'tests': ['tp5n']}, 07:38:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:38:02 INFO - 'talos_options': ['--xperf_path', 07:38:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:38:02 INFO - 'tests': ['tp5n']}}, 07:38:02 INFO - 'talos.zip': {'path': '', 07:38:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:38:02 INFO - Running post-action listener: _resource_record_post_action 07:38:02 INFO - [mozharness: 2017-05-23 14:38:02.322176Z] Finished populate-webroot step (success) 07:38:02 INFO - [mozharness: 2017-05-23 14:38:02.322266Z] Running create-virtualenv step. 07:38:02 INFO - Running pre-action listener: _resource_record_pre_action 07:38:02 INFO - Running main action method: create_virtualenv 07:38:02 INFO - Creating virtualenv /builds/slave/test/build/venv 07:38:02 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 07:38:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:38:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:38:02 INFO - Using real prefix '/usr' 07:38:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:38:02 INFO - Installing distribute.............................................................................................................................................................................................done. 07:38:04 INFO - Installing pip.................done. 07:38:04 INFO - Return code: 0 07:38:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:38:05 INFO - Reading from file tmpfile_stdout 07:38:05 INFO - Output received: 07:38:05 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) 07:38:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:38:05 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')]} 07:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:05 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')]} 07:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:05 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 0x1f741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2141a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e47a0>, '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 0x22e56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e5b30>, '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': '62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845', '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 07:38:05 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 07:38:05 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 07:38:05 INFO - Using env: {'DISPLAY': ':0', 07:38:05 INFO - 'HOME': '/home/cltbld', 07:38:05 INFO - 'LANG': 'en_US.UTF-8', 07:38:05 INFO - 'LANGUAGE': 'en_US:en', 07:38:05 INFO - 'LOGNAME': 'cltbld', 07:38:05 INFO - 'MAIL': '/var/mail/cltbld', 07:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:05 INFO - 'MOZ_NO_REMOTE': '1', 07:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:05 INFO - 'NO_EM_RESTART': '1', 07:38:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:05 INFO - 'PWD': '/builds/slave/test', 07:38:05 INFO - 'SHELL': '/bin/bash', 07:38:05 INFO - 'SHLVL': '1', 07:38:05 INFO - 'TERM': 'linux', 07:38:05 INFO - 'TMOUT': '86400', 07:38:05 INFO - 'USER': 'cltbld', 07:38:05 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845', 07:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:05 INFO - '_': '/tools/buildbot/bin/python'} 07:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:05 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 07:38:05 INFO - Cleaning up... 07:38:05 INFO - Return code: 0 07:38:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:38:05 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')]} 07:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:05 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')]} 07:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:05 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 0x1f741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2141a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e47a0>, '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 0x22e56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e5b30>, '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': '62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845', '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 07:38:05 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 07:38:05 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 07:38:05 INFO - Using env: {'DISPLAY': ':0', 07:38:05 INFO - 'HOME': '/home/cltbld', 07:38:05 INFO - 'LANG': 'en_US.UTF-8', 07:38:05 INFO - 'LANGUAGE': 'en_US:en', 07:38:05 INFO - 'LOGNAME': 'cltbld', 07:38:05 INFO - 'MAIL': '/var/mail/cltbld', 07:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:05 INFO - 'MOZ_NO_REMOTE': '1', 07:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:05 INFO - 'NO_EM_RESTART': '1', 07:38:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:05 INFO - 'PWD': '/builds/slave/test', 07:38:05 INFO - 'SHELL': '/bin/bash', 07:38:05 INFO - 'SHLVL': '1', 07:38:05 INFO - 'TERM': 'linux', 07:38:05 INFO - 'TMOUT': '86400', 07:38:05 INFO - 'USER': 'cltbld', 07:38:05 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845', 07:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:05 INFO - '_': '/tools/buildbot/bin/python'} 07:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:05 INFO - Downloading/unpacking psutil>=3.1.1 07:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:38:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:06 INFO - Installing collected packages: psutil 07:38:06 INFO - Running setup.py install for psutil 07:38:06 INFO - building 'psutil._psutil_linux' extension 07:38:06 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 07:38:07 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 07:38:07 INFO - building 'psutil._psutil_posix' extension 07:38:07 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 07:38:07 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 07:38:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:07 INFO - Successfully installed psutil 07:38:07 INFO - Cleaning up... 07:38:07 INFO - Return code: 0 07:38:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:38:07 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')]} 07:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:07 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')]} 07:38:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:07 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 0x1f741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2141a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e47a0>, '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 0x22e56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e5b30>, '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': '62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845', '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 07:38:07 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 07:38:07 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 07:38:07 INFO - Using env: {'DISPLAY': ':0', 07:38:07 INFO - 'HOME': '/home/cltbld', 07:38:07 INFO - 'LANG': 'en_US.UTF-8', 07:38:07 INFO - 'LANGUAGE': 'en_US:en', 07:38:07 INFO - 'LOGNAME': 'cltbld', 07:38:07 INFO - 'MAIL': '/var/mail/cltbld', 07:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:07 INFO - 'MOZ_NO_REMOTE': '1', 07:38:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:07 INFO - 'NO_EM_RESTART': '1', 07:38:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:07 INFO - 'PWD': '/builds/slave/test', 07:38:07 INFO - 'SHELL': '/bin/bash', 07:38:07 INFO - 'SHLVL': '1', 07:38:07 INFO - 'TERM': 'linux', 07:38:07 INFO - 'TMOUT': '86400', 07:38:07 INFO - 'USER': 'cltbld', 07:38:07 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845', 07:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:07 INFO - '_': '/tools/buildbot/bin/python'} 07:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:38:07 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 07:38:07 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 07:38:07 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 07:38:07 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 07:38:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:38:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:38:08 INFO - Installing collected packages: mozsystemmonitor 07:38:08 INFO - Running setup.py install for mozsystemmonitor 07:38:08 INFO - Successfully installed mozsystemmonitor 07:38:08 INFO - Cleaning up... 07:38:08 INFO - Return code: 0 07:38:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2141a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e47a0>, '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 0x22e56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e5b30>, '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': '62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845', '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 07:38:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:38:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:38:08 INFO - Using env: {'DISPLAY': ':0', 07:38:08 INFO - 'HOME': '/home/cltbld', 07:38:08 INFO - 'LANG': 'en_US.UTF-8', 07:38:08 INFO - 'LANGUAGE': 'en_US:en', 07:38:08 INFO - 'LOGNAME': 'cltbld', 07:38:08 INFO - 'MAIL': '/var/mail/cltbld', 07:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:08 INFO - 'MOZ_NO_REMOTE': '1', 07:38:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:08 INFO - 'NO_EM_RESTART': '1', 07:38:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:08 INFO - 'PWD': '/builds/slave/test', 07:38:08 INFO - 'SHELL': '/bin/bash', 07:38:08 INFO - 'SHLVL': '1', 07:38:08 INFO - 'TERM': 'linux', 07:38:08 INFO - 'TMOUT': '86400', 07:38:08 INFO - 'USER': 'cltbld', 07:38:08 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845', 07:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:08 INFO - '_': '/tools/buildbot/bin/python'} 07:38:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:09 INFO - Downloading/unpacking jsonschema==2.5.1 07:38:09 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 07:38:09 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 07:38:09 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 07:38:09 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 07:38:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:38:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:10 INFO - Downloading functools32-3.2.3-2.tar.gz 07:38:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:38:10 INFO - warning: no files found matching '*.txt' 07:38:10 INFO - no previously-included directories found matching 'build' 07:38:10 INFO - no previously-included directories found matching 'dist' 07:38:10 INFO - no previously-included directories found matching '.git*' 07:38:10 INFO - Installing collected packages: jsonschema, functools32 07:38:10 INFO - Running setup.py install for functools32 07:38:10 INFO - warning: no files found matching '*.txt' 07:38:10 INFO - no previously-included directories found matching 'build' 07:38:10 INFO - no previously-included directories found matching 'dist' 07:38:10 INFO - no previously-included directories found matching '.git*' 07:38:10 INFO - Successfully installed jsonschema functools32 07:38:10 INFO - Cleaning up... 07:38:10 INFO - Return code: 0 07:38:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2141a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e47a0>, '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 0x22e56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e5b30>, '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': '62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845', '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 07:38:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:38:10 INFO - Using env: {'DISPLAY': ':0', 07:38:10 INFO - 'HOME': '/home/cltbld', 07:38:10 INFO - 'LANG': 'en_US.UTF-8', 07:38:10 INFO - 'LANGUAGE': 'en_US:en', 07:38:10 INFO - 'LOGNAME': 'cltbld', 07:38:10 INFO - 'MAIL': '/var/mail/cltbld', 07:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:10 INFO - 'MOZ_NO_REMOTE': '1', 07:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:10 INFO - 'NO_EM_RESTART': '1', 07:38:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:10 INFO - 'PWD': '/builds/slave/test', 07:38:10 INFO - 'SHELL': '/bin/bash', 07:38:10 INFO - 'SHLVL': '1', 07:38:10 INFO - 'TERM': 'linux', 07:38:10 INFO - 'TMOUT': '86400', 07:38:10 INFO - 'USER': 'cltbld', 07:38:10 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845', 07:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:10 INFO - '_': '/tools/buildbot/bin/python'} 07:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:38:10 INFO - Cleaning up... 07:38:10 INFO - Return code: 0 07:38:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2141a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e47a0>, '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 0x22e56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e5b30>, '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': '62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845', '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 07:38:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:38:10 INFO - Using env: {'DISPLAY': ':0', 07:38:10 INFO - 'HOME': '/home/cltbld', 07:38:10 INFO - 'LANG': 'en_US.UTF-8', 07:38:10 INFO - 'LANGUAGE': 'en_US:en', 07:38:10 INFO - 'LOGNAME': 'cltbld', 07:38:10 INFO - 'MAIL': '/var/mail/cltbld', 07:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:10 INFO - 'MOZ_NO_REMOTE': '1', 07:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:10 INFO - 'NO_EM_RESTART': '1', 07:38:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:10 INFO - 'PWD': '/builds/slave/test', 07:38:10 INFO - 'SHELL': '/bin/bash', 07:38:10 INFO - 'SHLVL': '1', 07:38:10 INFO - 'TERM': 'linux', 07:38:10 INFO - 'TMOUT': '86400', 07:38:10 INFO - 'USER': 'cltbld', 07:38:10 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845', 07:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:10 INFO - '_': '/tools/buildbot/bin/python'} 07:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:10 INFO - Downloading/unpacking blobuploader==1.2.4 07:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:11 INFO - Downloading blobuploader-1.2.4.tar.gz 07:38:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:38:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:38:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:12 INFO - Downloading docopt-0.6.1.tar.gz 07:38:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:38:12 INFO - Installing collected packages: blobuploader, requests, docopt 07:38:12 INFO - Running setup.py install for blobuploader 07:38:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:38:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:38:12 INFO - Running setup.py install for requests 07:38:13 INFO - Running setup.py install for docopt 07:38:13 INFO - Successfully installed blobuploader requests docopt 07:38:13 INFO - Cleaning up... 07:38:13 INFO - Return code: 0 07:38:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38: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')]} 07:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:13 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 0x1f741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2141a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e47a0>, '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 0x22e56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e5b30>, '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': '62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845', '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 07:38:13 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 07:38:13 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 07:38:13 INFO - Using env: {'DISPLAY': ':0', 07:38:13 INFO - 'HOME': '/home/cltbld', 07:38:13 INFO - 'LANG': 'en_US.UTF-8', 07:38:13 INFO - 'LANGUAGE': 'en_US:en', 07:38:13 INFO - 'LOGNAME': 'cltbld', 07:38:13 INFO - 'MAIL': '/var/mail/cltbld', 07:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:13 INFO - 'MOZ_NO_REMOTE': '1', 07:38:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:13 INFO - 'NO_EM_RESTART': '1', 07:38:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:13 INFO - 'PWD': '/builds/slave/test', 07:38:13 INFO - 'SHELL': '/bin/bash', 07:38:13 INFO - 'SHLVL': '1', 07:38:13 INFO - 'TERM': 'linux', 07:38:13 INFO - 'TMOUT': '86400', 07:38:13 INFO - 'USER': 'cltbld', 07:38:13 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845', 07:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:13 INFO - '_': '/tools/buildbot/bin/python'} 07:38:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:13 INFO - Running setup.py (path:/tmp/pip-oKX7Zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:13 INFO - Running setup.py (path:/tmp/pip-njI6JB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:13 INFO - Running setup.py (path:/tmp/pip-AJXQNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:13 INFO - Running setup.py (path:/tmp/pip-JwYFnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:13 INFO - Running setup.py (path:/tmp/pip-AqaPay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:13 INFO - Running setup.py (path:/tmp/pip-Knm0Ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:13 INFO - Running setup.py (path:/tmp/pip-v9kdnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:13 INFO - Running setup.py (path:/tmp/pip-1A0UmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:13 INFO - Running setup.py (path:/tmp/pip-QdDICO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:14 INFO - Running setup.py (path:/tmp/pip-roRepD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:14 INFO - Running setup.py (path:/tmp/pip-wLzwPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:14 INFO - Running setup.py (path:/tmp/pip-Ukku2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:14 INFO - Running setup.py (path:/tmp/pip-crRZdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:14 INFO - Running setup.py (path:/tmp/pip-mK9Xsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:14 INFO - Running setup.py (path:/tmp/pip-rQVK_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:14 INFO - Running setup.py (path:/tmp/pip-FVDwUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:14 INFO - Running setup.py (path:/tmp/pip-U1R4m9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:38:14 INFO - Running setup.py install for manifestparser 07:38:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:38:14 INFO - Running setup.py install for mozcrash 07:38:14 INFO - Running setup.py install for mozdebug 07:38:14 INFO - Running setup.py install for mozdevice 07:38:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:38:15 INFO - Running setup.py install for mozfile 07:38:15 INFO - Running setup.py install for mozhttpd 07:38:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:38:15 INFO - Running setup.py install for mozinfo 07:38:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:38:15 INFO - Running setup.py install for mozInstall 07:38:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:38:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:38:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:38:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:38:15 INFO - Running setup.py install for mozleak 07:38:15 INFO - Running setup.py install for mozlog 07:38:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:38:15 INFO - Running setup.py install for moznetwork 07:38:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:38:15 INFO - Running setup.py install for mozprocess 07:38:15 INFO - Running setup.py install for mozprofile 07:38:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:38:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:38:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:38:15 INFO - Running setup.py install for mozrunner 07:38:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:38:16 INFO - Running setup.py install for mozscreenshot 07:38:16 INFO - Running setup.py install for moztest 07:38:16 INFO - Running setup.py install for mozversion 07:38:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:38:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:38:16 INFO - Cleaning up... 07:38:16 INFO - Return code: 0 07:38:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38: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')]} 07:38:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:16 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 0x1f741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2141a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e47a0>, '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 0x22e56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e5b30>, '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': '62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845', '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 07:38:16 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 07:38:16 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 07:38:16 INFO - Using env: {'DISPLAY': ':0', 07:38:16 INFO - 'HOME': '/home/cltbld', 07:38:16 INFO - 'LANG': 'en_US.UTF-8', 07:38:16 INFO - 'LANGUAGE': 'en_US:en', 07:38:16 INFO - 'LOGNAME': 'cltbld', 07:38:16 INFO - 'MAIL': '/var/mail/cltbld', 07:38:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:16 INFO - 'MOZ_NO_REMOTE': '1', 07:38:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:16 INFO - 'NO_EM_RESTART': '1', 07:38:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:16 INFO - 'PWD': '/builds/slave/test', 07:38:16 INFO - 'SHELL': '/bin/bash', 07:38:16 INFO - 'SHLVL': '1', 07:38:16 INFO - 'TERM': 'linux', 07:38:16 INFO - 'TMOUT': '86400', 07:38:16 INFO - 'USER': 'cltbld', 07:38:16 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845', 07:38:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:16 INFO - '_': '/tools/buildbot/bin/python'} 07:38:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:16 INFO - Running setup.py (path:/tmp/pip-EOtWB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:16 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)) 07:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:16 INFO - Running setup.py (path:/tmp/pip-9daqVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:16 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)) 07:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:16 INFO - Running setup.py (path:/tmp/pip-eXOzBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:16 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)) 07:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:16 INFO - Running setup.py (path:/tmp/pip-d1nPHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:16 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)) 07:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:16 INFO - Running setup.py (path:/tmp/pip-IoGHPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:17 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)) 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:17 INFO - Running setup.py (path:/tmp/pip-1L1cvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:17 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)) 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:17 INFO - Running setup.py (path:/tmp/pip-Y1uY4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:17 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)) 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:17 INFO - Running setup.py (path:/tmp/pip-I6eZ7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:17 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)) 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:17 INFO - Running setup.py (path:/tmp/pip-flh2PO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:17 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)) 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:17 INFO - Running setup.py (path:/tmp/pip-18i7Wi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:17 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)) 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:17 INFO - Running setup.py (path:/tmp/pip-D5Ljfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:17 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)) 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:17 INFO - Running setup.py (path:/tmp/pip-6Mq6gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:17 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)) 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:17 INFO - Running setup.py (path:/tmp/pip-n4jZHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:17 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)) 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:17 INFO - Running setup.py (path:/tmp/pip-1Ue56Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:17 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)) 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:17 INFO - Running setup.py (path:/tmp/pip-2K4hb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:17 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)) 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:17 INFO - Running setup.py (path:/tmp/pip-yf_vYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:17 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)) 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:17 INFO - Running setup.py (path:/tmp/pip-fDnIqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:17 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)) 07:38:17 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)) 07:38:17 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)) 07:38:17 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)) 07:38:17 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)) 07:38:17 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)) 07:38:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:38: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 07:38: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 07:38: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 07:38: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 07:38:18 INFO - Downloading blessings-1.6.tar.gz 07:38:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:38:19 INFO - Installing collected packages: blessings 07:38:19 INFO - Running setup.py install for blessings 07:38:19 INFO - Successfully installed blessings 07:38:19 INFO - Cleaning up... 07:38:19 INFO - Return code: 0 07:38:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:38:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:19 INFO - Reading from file tmpfile_stdout 07:38:19 INFO - Current package versions: 07:38:19 INFO - argparse == 1.2.1 07:38:19 INFO - blessings == 1.6 07:38:19 INFO - blobuploader == 1.2.4 07:38:19 INFO - docopt == 0.6.1 07:38:19 INFO - functools32 == 3.2.3-2 07:38:19 INFO - jsonschema == 2.5.1 07:38:19 INFO - manifestparser == 1.1 07:38:19 INFO - mozInstall == 1.12 07:38:19 INFO - mozcrash == 1.0 07:38:19 INFO - mozdebug == 0.1 07:38:19 INFO - mozdevice == 0.50 07:38:19 INFO - mozfile == 1.2 07:38:19 INFO - mozhttpd == 0.7 07:38:19 INFO - mozinfo == 0.9 07:38:19 INFO - mozleak == 0.1 07:38:19 INFO - mozlog == 3.4 07:38:19 INFO - moznetwork == 0.27 07:38:19 INFO - mozprocess == 0.25 07:38:19 INFO - mozprofile == 0.28 07:38:19 INFO - mozrunner == 6.13 07:38:19 INFO - mozscreenshot == 0.1 07:38:19 INFO - mozsystemmonitor == 0.3 07:38:19 INFO - moztest == 0.8 07:38:19 INFO - mozversion == 1.4 07:38:19 INFO - psutil == 3.1.1 07:38:19 INFO - requests == 1.2.3 07:38:19 INFO - wsgiref == 0.1.2 07:38:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38: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')]} 07:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:19 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 0x1f741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2141a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e47a0>, '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 0x22e56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e5b30>, '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': '62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845', '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 07:38:19 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 07:38:19 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 07:38:19 INFO - Using env: {'DISPLAY': ':0', 07:38:19 INFO - 'HOME': '/home/cltbld', 07:38:19 INFO - 'LANG': 'en_US.UTF-8', 07:38:19 INFO - 'LANGUAGE': 'en_US:en', 07:38:19 INFO - 'LOGNAME': 'cltbld', 07:38:19 INFO - 'MAIL': '/var/mail/cltbld', 07:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:19 INFO - 'MOZ_NO_REMOTE': '1', 07:38:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:19 INFO - 'NO_EM_RESTART': '1', 07:38:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:19 INFO - 'PWD': '/builds/slave/test', 07:38:19 INFO - 'SHELL': '/bin/bash', 07:38:19 INFO - 'SHLVL': '1', 07:38:19 INFO - 'TERM': 'linux', 07:38:19 INFO - 'TMOUT': '86400', 07:38:19 INFO - 'USER': 'cltbld', 07:38:19 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845', 07:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:19 INFO - '_': '/tools/buildbot/bin/python'} 07:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:19 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)) 07:38:19 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)) 07:38:19 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)) 07:38:19 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)) 07:38:19 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)) 07:38:19 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)) 07:38:19 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)) 07:38:19 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)) 07:38:19 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)) 07:38:19 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)) 07:38:19 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)) 07:38:19 INFO - Cleaning up... 07:38:19 INFO - Return code: 0 07:38:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38: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')]} 07:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2141a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e47a0>, '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 0x22e56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e5b30>, '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': '62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845', '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 07:38: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', 'jsonschema'] in /builds/slave/test/build 07:38: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 jsonschema 07:38:19 INFO - Using env: {'DISPLAY': ':0', 07:38:19 INFO - 'HOME': '/home/cltbld', 07:38:19 INFO - 'LANG': 'en_US.UTF-8', 07:38:19 INFO - 'LANGUAGE': 'en_US:en', 07:38:19 INFO - 'LOGNAME': 'cltbld', 07:38:19 INFO - 'MAIL': '/var/mail/cltbld', 07:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:19 INFO - 'MOZ_NO_REMOTE': '1', 07:38:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:19 INFO - 'NO_EM_RESTART': '1', 07:38:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:19 INFO - 'PWD': '/builds/slave/test', 07:38:19 INFO - 'SHELL': '/bin/bash', 07:38:19 INFO - 'SHLVL': '1', 07:38:19 INFO - 'TERM': 'linux', 07:38:19 INFO - 'TMOUT': '86400', 07:38:19 INFO - 'USER': 'cltbld', 07:38:19 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845', 07:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:19 INFO - '_': '/tools/buildbot/bin/python'} 07:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:38:19 INFO - Cleaning up... 07:38:19 INFO - Return code: 0 07:38:19 INFO - Running post-action listener: _resource_record_post_action 07:38:19 INFO - Running post-action listener: _start_resource_monitoring 07:38:19 INFO - Starting resource monitoring. 07:38:19 INFO - [mozharness: 2017-05-23 14:38:19.913052Z] Finished create-virtualenv step (success) 07:38:19 INFO - [mozharness: 2017-05-23 14:38:19.913704Z] Running install step. 07:38:19 INFO - Running pre-action listener: _resource_record_pre_action 07:38:19 INFO - Running main action method: install 07:38:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:20 INFO - Reading from file tmpfile_stdout 07:38:20 INFO - Detecting whether we're running mozinstall >=1.0... 07:38:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:38:20 INFO - Reading from file tmpfile_stdout 07:38:20 INFO - Output received: 07:38:20 INFO - Usage: mozinstall [options] installer 07:38:20 INFO - Options: 07:38:20 INFO - -h, --help show this help message and exit 07:38:20 INFO - -d DEST, --destination=DEST 07:38:20 INFO - Directory to install application into. [default: 07:38:20 INFO - "/builds/slave/test"] 07:38:20 INFO - --app=APP Application being installed. [default: firefox] 07:38:20 INFO - mkdir: /builds/slave/test/build/application 07:38:20 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'] 07:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:38:35 INFO - Reading from file tmpfile_stdout 07:38:35 INFO - Output received: 07:38:35 INFO - /builds/slave/test/build/application/firefox/firefox 07:38:35 INFO - Running post-action listener: _resource_record_post_action 07:38:35 INFO - [mozharness: 2017-05-23 14:38:35.873131Z] Finished install step (success) 07:38:35 INFO - [mozharness: 2017-05-23 14:38:35.873515Z] Running run-tests step. 07:38:35 INFO - Running pre-action listener: _resource_record_pre_action 07:38:35 INFO - Running main action method: run_tests 07:38:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:38:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:38:35 INFO - Python 2.7.3 07:38:35 INFO - Return code: 0 07:38:35 INFO - grabbing minidump binary from tooltool 07:38:35 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')]} 07:38:35 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 0x22e47a0>, '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 0x22e56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e5b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:38:35 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 07:38:35 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 07:38:35 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 07:38:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:38:35 INFO - Return code: 0 07:38:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:38:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:38:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:38:35 INFO - ENV: RUST_BACKTRACE is now 1 07:38:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:38:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:38:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 07:38:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 07:38:35 INFO - Using env: {'DISPLAY': ':0', 07:38:35 INFO - 'HOME': '/home/cltbld', 07:38:35 INFO - 'LANG': 'en_US.UTF-8', 07:38:35 INFO - 'LANGUAGE': 'en_US:en', 07:38:35 INFO - 'LOGNAME': 'cltbld', 07:38:35 INFO - 'MAIL': '/var/mail/cltbld', 07:38:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:38:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:38:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:35 INFO - 'MOZ_NO_REMOTE': '1', 07:38:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:38:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:35 INFO - 'NO_EM_RESTART': '1', 07:38:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:35 INFO - 'PWD': '/builds/slave/test', 07:38:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:38:35 INFO - 'RUST_BACKTRACE': '1', 07:38:35 INFO - 'SHELL': '/bin/bash', 07:38:35 INFO - 'SHLVL': '1', 07:38:35 INFO - 'TERM': 'linux', 07:38:35 INFO - 'TMOUT': '86400', 07:38:35 INFO - 'USER': 'cltbld', 07:38:35 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845', 07:38:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:35 INFO - '_': '/tools/buildbot/bin/python'} 07:38:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 07:38:36 INFO - mozversion application_buildid: 20170523140901 07:38:36 INFO - mozversion application_changeset: 4f874bc1e42463e30bc5595e84e5aaa450d81167 07:38:36 INFO - mozversion application_display_name: Nightly 07:38:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:38:36 INFO - mozversion application_name: Firefox 07:38:36 INFO - mozversion application_remotingname: firefox 07:38:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:38:36 INFO - mozversion application_vendor: Mozilla 07:38:36 INFO - mozversion application_version: 55.0a1 07:38:36 INFO - mozversion platform_buildid: 20170523140901 07:38:36 INFO - mozversion platform_changeset: 4f874bc1e42463e30bc5595e84e5aaa450d81167 07:38:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:38:36 INFO - mozversion platform_version: 55.0a1 07:38:36 INFO - using testdate: 1495550316 07:38:36 INFO - actual date: 1495550316 07:38:36 INFO - starting webserver on 'localhost:56043' 07:38:36 INFO - SUITE-START | Running 2 tests 07:38:36 INFO - TEST-START | dromaeo_css 07:38:36 INFO - operating with platform_type : linux_ 07:38:36 INFO - Initialising browser for dromaeo_css test... 07:38:36 INFO - TEST-INFO | started process 21286 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaYafnc/profile http://localhost:56043/getInfo.html) 07:38:36 INFO - PID 21286 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2978: String.localeCompare is deprecated; use String.prototype.localeCompare instead 07:38:40 INFO - PID 21286 | __metrics Screen width/height:1600/1200 07:38:40 INFO - PID 21286 | colorDepth:24 07:38:40 INFO - PID 21286 | Browser inner width/height: 1024/695 07:38:40 INFO - PID 21286 | __metrics 07:38:42 INFO - TEST-INFO | 21286: exit 0 07:38:42 INFO - Browser initialized. 07:38:42 INFO - Running cycle 1/1 for dromaeo_css test... 07:38:42 INFO - TEST-INFO | started process 21447 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaYafnc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:53 INFO - PID 21447 | RSS: Main: 167448576 07:38:53 INFO - PID 21447 | 07:41:57 INFO - PID 21447 | Cycle 1(1): loaded http://localhost:56043/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56043/tests/dromaeo/cssquery-ext.html) 07:42:00 INFO - PID 21447 | RSS: Main: 171929600 07:42:00 INFO - PID 21447 | 07:45:02 INFO - PID 21447 | Cycle 1(1): loaded http://localhost:56043/tests/dromaeo/cssquery-ext.html (next: http://localhost:56043/tests/dromaeo/cssquery-jquery.html) 07:45:02 INFO - PID 21447 | RSS: Main: 170225664 07:45:02 INFO - PID 21447 | 07:48:04 INFO - PID 21447 | Cycle 1(1): loaded http://localhost:56043/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56043/tests/dromaeo/cssquery-mootools.html) 07:48:05 INFO - PID 21447 | RSS: Main: 172834816 07:48:05 INFO - PID 21447 | 07:51:06 INFO - PID 21447 | Cycle 1(1): loaded http://localhost:56043/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56043/tests/dromaeo/cssquery-prototype.html) 07:51:07 INFO - PID 21447 | RSS: Main: 170717184 07:51:07 INFO - PID 21447 | 07:54:10 INFO - PID 21447 | Cycle 1(1): loaded http://localhost:56043/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56043/tests/dromaeo/cssquery-yui.html) 07:54:11 INFO - PID 21447 | RSS: Main: 171118592 07:54:11 INFO - PID 21447 | 07:57:13 INFO - PID 21447 | Cycle 1(1): loaded http://localhost:56043/tests/dromaeo/cssquery-yui.html (next: http://localhost:56043/tests/dromaeo/cssquery-dojo.html) 07:57:13 INFO - PID 21447 | RSS: Main: 178188288 07:57:13 INFO - PID 21447 | 07:57:13 INFO - PID 21447 | __start_tp_report 07:57:13 INFO - PID 21447 | _x_x_mozilla_page_load 07:57:13 INFO - PID 21447 | _x_x_mozilla_page_load_details 07:57:13 INFO - PID 21447 | |i|pagename|runs| 07:57:13 INFO - PID 21447 | |0;dojo.html;2641.0360218520245;2643.312738687941;2656.9867150664245;2677.0496473751828;2681.6916054653716;4990.925136122956;5021.849344519661;5047.0915235257635;5057.924131138036;5117.155669314563;5043.814703544664;5119.334486516747;5121.180611102224;5133.666311689738;5149.098907691148;4521.841735539257;4527.139843429746;4527.886802829923;4577.33628623851;4606.078784243148;4545.272756358983;4572.565606267416;4598.2183028885;4610.446746390421;4642.257238841786;4524.864254072383;4541.069080838421;4553.430821147356;4597.264437689971;4607.608353289975;4516.819327226907;4580;4582.1064892346;4601.217792975202;4622.422197225347;4514;4516.390287311204;4517.909641807179;4558.58972692456;4576.794044267983;4987.825426110105;5054.873628159288;5061;5068.037072956126;5113.411957624883;5344.225087362311;5347.304850369466;5404.216388623667;5404.891902161935;5505.862353441156;5488.1493368527945;5508.504234618864;5511.944880551183;5545.334559852843;5576.33084029919;5125.974370128126;5148.176291793295;5153.7165455900285;5156.2007888776925;5168.7415629218385;5593.580481463907;5634.464725851038;5635.971820140873;5647.096464565732;5705.4579814917515;5311.9734401328515;5323.467653234646;5348.384935732441;5378.515933565998;5379.435159308295;5407.270018547524;5415.512603865671;5437.592180586472;5484.314460692413;5542.0301447246575;5485.4788795064405;5489.615726899158;5489.972550137224;5495.6153069285565;5496.587755918322;5371.785128594891;5481.232627432163;5488.1767734839295;5490.066688662937;5493.23094766733;4659.464161621457;4659.487456379796;4665.743384113838;4665.953340466552;4674.252119660838;4014.116894283253;4031.9920019995;4071.816768245377;4073.490813648294;4075.3479443289525;4657.464391594942;4662.976685116552;4674.345591617176;4724.102420540086;4725.527447255316;5400.162974738922;5470.890582188334;5491.28613280271;5492.615516913857;5513.58648101394;4643.233866412072;4661.184292748755;4661.720296782204;4669.929951050737;4699.318598803223;4806.134895718735;4878.463369029404;4885.218365061644;4913.778879950411;4927.989762098761;4993.725345105909;5061;5079.898402032012;5093.337866077386;5108.233764935289;5462.098753705594;5483.75323110453;5492.5605951524585;5494.587905906993;5504.4495550444635;5047.41954675217;5052.570531504716;5070.569001634903;5080.390353157644;5080.517350851663;5409.0804563223555;5454.4545545445135;5475.069238229431;5476.452354764491;5476.780928762964;5393.1370980642905;5452.282531002721;5493.121100623881;5500.22996780443;5557;5304;5318.468153184651;5320.733963301742;5332.440093790251;5334.546563542142;5327.467253274642;5336.733163341895;5344.625876188629;5345.705986170798;5386.919196212139;5109.156989096758;5213.687178769286;5248.685078895279;5325.2810870531985;5328.973355133355;5133.537981581526;5342.358916929993;5356.223347614497;5364.597655175799;5401.594880383908;5164.586833053271;5211.452797456364;5214.113600687968;5214.661047031931;5218.26944227816 07:57:13 INFO - PID 21447 | |1;ext.html;717.9676914538845;731.9898540014779;1052.763128296133;1055.1084333737992;1140.0879296562748;32996;34014.48978265328;34064.148396290104;34081.829590852074;34130.31739365211;31468.370632587335;31794.682053179462;31817.522737158903;31844.36311273779;31864.36271274573;6458.095866578683;6462.739765745681;6589.604623722568;7108.609026503566;7111.502194846363;7042.4718146138985;7092;7122.9287707122785;7157.749478768244;7160.140783106034;7118.1458225013075;7179.425645948311;7182.245864184264;7190.352868241857;7211.531250468703;7098.68055937484;7132.57204567725;7167.42660587157;7171.748988785367;7188.137423509213;7030.367266945948;7054.929450705478;7056.682449289794;7061.540999834994;7086.291370862924;32320.676793232004;32457.837710811295;32579.51130733041;32590.511142332885;32685.83657081723;3073.5389691546225;3096.690330966908;3109.471389863706;3114.8131112133347;3120.8127512349333;24022;24074.27777166688;24211.515769684684;24237.63643545348;24403.511929761306;2991.476491613959;3057.1745628680355;3060.4491191585507;3070.048285031625;3105.021918095815;143864;144271;144353;144809.2759536206;144930;38511;40450.797746011085;40461.39307910384;40620.79689601533;41641.79179104085;42873.35689964653;42888.35667464928;43099.13801723948;45324.546754532035;46109.769451152526;12036.63890083299;12085.637430877088;12142.332171730639;12142.514299427923;12171.14801963854;9565.90434095664;9571.952140239255;9580.76048098803;9583.760405989906;9599.664011759694;12961.870381296067;13035.804462933063;13062.085654004128;13124.540641077516;13226.140300880412;5435.239066530688;5483.095289277225;5494.120940649477;5506.394296627368;5520.227168196456;870.6256309786726;916.903725108854;927.2674587076269;932.2588542109039;949.1457688080644;20257.696134557995;20941.685874711893;21297.68053479199;21430.678539821914;21485.14059437605;980.7450062983532;987.1905037869022;987.7234374375187;1002.4987506246877;1016.2784423059562;11224.66326010221;11407.828882566768;11419.828702569468;11498.42507874603;11514.194006419637;182092;182999;183159;183405.08297458428;183684;41145;41181.97045073837;41359.37960930528;41496.792516037225;41625.1674966499;1200.8258802473767;1256.886880180788;1261.892739117167;1262.456150856026;1275.3049587974576;19809.801901981373;19896.801031990075;20411.795882041584;21474.24840130588;21520;29685.554716678835;30084.699153009064;30163.245918852204;30204.395912081196;30234;148139;149276;149337.25331373274;149449;149698;28372.716272837006;28445;29225;29390.559141612466;29558.556621650263;35884.820575898;36205.81897090498;36441;36466.63533364632;36619;26831.86584067067;27232.455350893266;27507.17478475649;27533.724662753917;28086.438271234052;27058.1882543524;27227.72772272331;27746.306342341602;27801.165965021082;28673.42653146967;31105.68894311028;31164.909228176904;31172.37655246928;31173.8441307792;31221.687783122787;25722;26486;26848.50969373969;27052.05317813867;27335.49654769007;20497.59004819925;21247.575048499253;21436.17792487656;21575.35273941784;21585.676214857103 07:57:13 INFO - PID 21447 | |2;jquery.html;385.63172170577104;395.800120938926;402.43457941592067;411.8682021753039;415.88147377997257;12846.614601561969;17362;17376.218070186842;18026.098695065244;18145.092745362745;18344.357947471806;18640.627187456244;18800.24799008038;19064.2374305028;19377.418677439666;5249.86875328117;5340.25236466893;5499.862503437426;5547.77808887644;5580.135079062752;5477.397486276506;5526.364468086182;5553.055980483307;5557.027520183951;5581;5315.468453154673;5450.890982180354;5484.396716361197;5490.039243132456;5507.03626865299;5400.783968641269;5498.890022199574;5498.972505137469;5510.338759348904;5551.8889622207535;4706.576408123286;4803.3995750531185;4850.369451971256;4861.73260470674;4892.217245240744;21378.144874205012;21633.891830540902;21658;21780.673289900664;21857.781422185733;1617.2883931070292;1625.9756103658456;1648.4230519318262;1649.381481944271;1653.37998250656;14615;15111.622209444742;15133.470328538559;15181;15242.695146097127;2024.8076432738867;2080.512433609976;2128.287023847013;2138.134055707441;2141.3468891987936;78316;78692;80021.99999999942;80111.59944200242;82219.58890205571;9997.550110245056;10219.540120694586;10394.844077338847;10410.635627752992;10590.682279531626;13984.650383740285;14036.649083772783;14057.929710351384;14058.367373468218;14228.928855355656;7343.37581305595;7575.924240757632;7587.772366829004;7798.298153166129;7820.843583128306;6988.231294557595;7058.470614703918;7159;7224.422046236288;7291.270872912666;6935.549189302679;6962.303769623099;6982.546134501241;6998.265182155902;7023.789286321418;1901.4865986183654;1903.7620297462818;1936.7191757195128;1961.4409893180375;2004.368623883472;838.9748307550783;865.8398196333699;875.6584931876573;879.7404765594165;906.2342320738965;16896;16903.154842257838;16999.74500382495;17236.310547577956;17808.46574602764;852.8507511185642;862.7023676831483;868.4832524647825;877.3814460805245;896.7130518234233;9172.220361269367;9335.673251436167;9657.179139773058;9719.514024298898;9792.265580081523;366809;367353;370459;374155;375459;73206.26793731995;73466;75166;76360.61819690866;76786;1038.7558923652934;1048.496721573649;1051.8211903976342;1065;1101.11910471624;17342.393016244372;18129.637407252045;18329.81670183281;18593.90703046476;18717;39651.60348396595;39960.999999998836;40040.799796002;40077.39883901685;40275;46816.7659161702;48228.03543929172;48508.51491485181;48663.513364865896;49134.26298605452;7821.843563128819;7923.801904952422;8032.759017229492;8182.959085204536;8266.586670666564;13259.469621215043;13445.663858403617;13534.120282181626;13916.234607096301;14041.297935103408;11080.390578517936;11105.389203593557;11258.268212566158;11586.304821710724;11748.353840538852;10799.838002429813;10822.729431764268;10855.968682975104;10905.727356816144;11095;11060.281081729661;11363.772724545297;11615.593454229062;11649.475773590038;11712.180147389601;8047.959760201162;8092.433529652868;8100.756977290691;8209.548474833942;8224.177582241728;10919.781604368027;11066.667999960015;11134.944325278322;11619.593314233962;11639.127065469955 07:57:13 INFO - PID 21447 | |3;mootools.html;1225.8528976522816;1267.8922291605213;1271.5486002469117;1279.3219593615388;1286.6526037969752;9345.859812102815;9780.119789218968;9790;9862.654807081753;10124.038216369452;10037.598496060167;10099.848502272473;10162.288639795217;10201.285909986304;10211.132053775438;2236.915096178352;2262.5474905018978;2285.9657105143438;2288.794008539231;2290.9541809163807;2175.869447833135;2212.6791615215784;2218.8890555472244;2225.020990764067;2242.2936774915847;2157.180271496829;2194.7037149984785;2232.955340893181;2238.03764381316;2242.2712618399005;2068.617305798417;2153.353993801861;2174.065151984646;2175.216921908112;2183.9563208735735;1962.774280957694;2105.357865850915;2152.5802468518646;2154.2998525479284;2166.8049875511124;9690.75773105671;9763;9770.804583908353;9806.607735690564;9825.754356141082;5360.088784906575;5520.1443776214755;5562.972185139049;5577.8605534861545;5579.804706835242;3088.8764449421997;3315;3369.494575813623;3382.0530251529613;3383.3064221834466;1018.6689325969089;1038.4651904269308;1061.5435362793996;1071.6356438810842;1072.9570817167305;14416.567502974927;14495.782563261559;14542.418303267857;14547.418103275962;14555.78166327506;4468.374427580141;4498.280275155959;4668.253079507331;4670;4696.201645720235;10265.846012309821;10359.741006474898;10374.429406382722;10382.584696612203;10425.635102771366;5364.329458817648;5372.167314066326;5372.301600791872;5399.83800485986;5411.702356370437;4931.827386041471;5081.18701007837;5090.160123579642;5157.793688252503;5188.844334669966;3574.857005719794;3670.22925185714;3691.981540092336;3723.2925744108534;3734.3091528067393;1014.6499457687086;1030.258214085857;1039.443897514826;1039.4646756920192;1046.2414749306693;671.4997326991422;704.9400800931876;707.2891743797553;719.8704233237962;722.9602371869597;5137.33214682089;5218.765155568009;5238.057149713012;5330.813421530228;5428.212909128154;535.9088954877681;540.9343593121545;544.7739188236837;544.9209864569615;548.2571116137656;3126.6248050234117;3147.779655424144;3270.8037517749012;3403.557537520156;3742.401215805458;12462.688432789253;12527.248365098123;12828.35858207086;12830.29433381173;12884;12512.562060327844;12551.372431378395;12646.683832904067;12677.683057923625;12702.80945785814;7031.437485001187;7154.785356439315;7333.523320984119;7339.376153026946;7359.264073592705;5666.914996275142;5698.458646428583;5794.681292528951;5795.304563452412;5967.134765458897;10929.234953553176;11446.828297575377;11481.483333249857;11521.53913843437;11560.595379162025;11361.54553817838;11371.715707107389;11396.430178490877;11578.594749183738;11584.42077896085;7826.295633393022;7875.291223789886;7987.840243194987;8040.195980402147;8041.517508949481;9090.272778177863;9366.812663746823;9377.906220937975;9388.67139650109;9393.201577865684;7809.765707028798;7937.563434011185;8073.717419890276;8187.672493100447;8266.008079030315;7619.619019048914;7628.389728821792;7760.146383897654;7836.255555722198;7903.446758726834;6173.56785025044;6184.474319682878;6213.782517612042;6255.31191568918;6267.373262673878;4408.096340250177;4440.178566965122;4463.018136010072;4511.3458548510935;4661.510541393105;4504.842330518416;4649.325847752125;4740.928886066643;5016.523430274118;5073.264376665436 07:57:13 INFO - PID 21447 | |4;prototype.html;375.3206695880458;380.61177598849173;385.5027015150456;385.5354298070825;390.4514157608561;5356.276902618145;5446.455354464551;5453.863653408666;5454.427285135063;5522.91715624266;5251.527362537371;5336.6531175473565;5343.145096784515;5347.59893008024;5348.518633323;3937.4290727844586;4007.5992400759837;4016.875274923026;4028.7582745035247;4039.7374170678813;4034.314166591672;4052.6555242804247;4053.148838743867;4056.634902858742;4070.409790580364;4022.074922767765;4025.9798701006603;4028.254772867029;4031.8790436286813;4039.353703407455;3851.826667799956;3992.301347264217;4015.698822588303;4030.6573941215033;4036.737612055207;3498.877539286138;3503.2117773501013;3504.5794504659602;3511.139096278976;3531.4349704047486;5263.31576895005;5272.393674727417;5278.762455689503;5290.523852853262;5296.25852380667;4540.910181556403;4709.811607535728;4713.293006049086;4730.290456431563;4744.952550474485;5576.302962129734;5617.522510586605;5641.266635337421;5646.20953066571;5679.659220446786;3913.745606535566;3926.6858651307825;3935.1736135411597;3935.897948574404;3936.2717897189114;5560.6941618210985;5919.289685237756;5978.641281523122;5994.940050599482;6022.97609406402;4392.748066800947;4441.4892287387365;4445.355423463579;4453.688241823106;4467.977660111678;4504.459464864237;4537.591616754508;4541.114482675913;4541.5231400703115;4561.794719237576;4894.681845680019;4996.675216110941;5006.774695138727;5033.144365457881;5039.571636410873;5663.320401551758;5714.314282286069;5715.342735585377;5729.25519682447;5745.2243947067445;1565.3816742386693;1579.5498282989292;1583.7307657698218;1585.72249856277;1587.1350114187796;1084.8446404579097;1147.2141583015662;1154.285885460091;1156.9942150289194;1168.1355796710372;4908.828191013297;4935.925961110586;4942.382202224722;4964.578010869117;4975.800967961313;5859.1797148399255;5904.202932604129;5907.700305932688;5909.113632955091;5930.762769489258;4872.902541949212;4874.683145595596;4922.187839006596;4936.358273424504;4947.777350019258;3118.641356244061;3144.261098641817;3144.955778743835;3150.228194092462;3154.747620190379;5306.867328316745;5448.645838020516;5450.100733379028;5450.8909821803345;5455.372632147354;5943.435373639497;6017;6024.57827952048;6028.156058151862;6135.601185922901;5438.564914806885;5439.510444059974;5454.154606036071;5464.098423760035;5465.453454654503;5936;5950.672713000827;5976.820695379146;5977.342492325927;5996.850078748066;5676.205331253545;5756.2229099072765;5782.884342313214;5811.79658711943;5887.1757953887345;5411.972940135274;5444;5468.261784659179;5470.72646367688;5484;3880.5343358797127;4037.798110094542;4053.9391909120795;4070.104576993057;4075.694322925733;5992.460678538952;5998.70006499682;6004.099385092097;6005.879882402415;6018.247719035121;5782.681952492653;5783.190353350618;5799.536037117105;5806.535477161732;5827.155062515827;5636.746346414339;5701.828945131652;5720.48515633595;5753.597248192586;5781.884362312814;5625.493705566519;5661.915071274017;5676.602637815313;5683.460071293221;5689.601727879009;5587.552995760248;5747.08046712524;5799.623024503394;5800.303963524404;5815.5929084963645;5598.412166722435;5623.775048998158;5627.634203776742;5632.746526406239;5644.3508996465935 07:57:13 INFO - PID 21447 | |5;yui.html;688.8622275544891;714.4998501049264;715.3204455767022;742.9257074292575;771.0131032278686;11944.581939632115;12450.813237801418;13465.46138154474;14310.427582896684;14317.427302907885;14984.175870327128;15173;15409.69180616387;15612;15706.293216805243;851.6806197675857;866.1079088538816;866.4281574161055;866.4627930682954;870.3124531620012;922.3220932614523;922.598669578732;923.0677016213639;924.0713083351222;926.9073092690744;943.2689665509216;958.6021800952597;959.501059449086;963.0754475703299;963.4219468318987;940.9529523523796;945.2957546627738;948.9715308540755;949.1789601994225;956.0535070280407;701.7368486817444;701.8455939693259;706.6819931031005;707.0207762249271;708.9149302083731;13771.655708607264;13941.790873136912;14056.156630602094;14250.85749142516;14691.485797997018;15298;15390.384384624602;15674.216289185495;15687.68624627501;15876.761848572165;11980.70048248792;12118.757624847454;12313.815292770616;12569.560065397667;12646.620601381974;2862.7423531882023;2866.6846646868826;2874.726900944407;2892.522733748929;2910.941781164386;66222;66841;66842;66980;68477.3152268476;10588.417637029883;10725;10747.355158690503;10771.353718776898;10886.292390994719;16902.83097169037;17179;17287.913560432116;17302.307907683804;17343.21955512005;6004.42957918997;6301.558890877594;6504.3495650435525;6527.608343499405;6538;3063.8008529445515;3133.592632957701;3147.0716138739126;3147.417727720379;3153.0856051745195;3224.290656055664;3301.1417031571964;3304.2400247943106;3317.950230746541;3326.3679900818765;699.867025265198;701.3652644356865;702.5363260248212;703.989440158398;705.9647017649097;611.8317462697794;621.3848290192676;623.2365352443221;627.5230824573357;636.3954243468723;9429.2928030398;9637.132658060807;9779.315447918578;9919.702408927744;10087.49562521871;613.1569092497815;615.9876802463925;627.1032423634156;628.6919409489409;636.4876274598993;4290.549492303326;4440.489343725449;4456.398386217884;4463.35281384204;4507.864764057018;62142;62396.37603623905;62410;63245.68377158177;64054.67972660107;55996.72001639966;56474.717626411606;56592;56737.43262567404;57081.42918570761;50379.24431133536;50561.49438505568;51062.74468627633;51091.48908510942;51226;8995.415298005608;9031.232345250728;9063.546822658973;9084.727458176265;9388.483633400228;25020.74979250257;25058.74941250564;25676.229713108638;26678.866605666848;27525.31186720348;42354.364684530374;43206.351904720825;43830.561694382646;43834.342484862114;45576;14318.57044288673;14400.135991840523;14500;14641;14791.112533248039;14909.85090149128;15275.847241527443;15372.23138843031;16010.839891600936;16489;13953.162810231419;14126.717465650423;14130.434782608581;14573.854261457675;14728.410863565767;14214.857851421353;14223.644408889446;14699.265036748333;15214;15240.542783716506;12926.703690558847;13172.60482185536;13285.13646612967;14065.156090634595;14193.716125677634;9178;9340.626374944926;9511.476868772284;10725.463726813785;10971.780564388828;11106.222564420414;11191.272567283426;11855.525778968744;12295.631131066082;12427.254364738144 07:57:13 INFO - PID 21447 | __end_tp_report 07:57:13 INFO - PID 21447 | __start_cc_report 07:57:13 INFO - PID 21447 | _x_x_mozilla_cycle_collect,291 07:57:13 INFO - PID 21447 | __end_cc_report 07:57:13 INFO - PID 21447 | __startTimestamp1495551433266__endTimestamp 07:57:13 INFO - PID 21447 | 07:57:13 INFO - PID 21447 | ------- Summary: start ------- 07:57:13 INFO - PID 21447 | Number of tests: 6 07:57:13 INFO - PID 21447 | 07:57:13 INFO - PID 21447 | [#0] dojo.html Cycles:165 Average:5018.71 Median:5148.18 stddev:571.40 (11.1%) stddev-sans-first:541.85 07:57:13 INFO - PID 21447 | Values: 2641.0 2643.3 2657.0 2677.0 2681.7 4990.9 5021.8 5047.1 5057.9 5117.2 5043.8 5119.3 5121.2 5133.7 5149.1 4521.8 4527.1 4527.9 4577.3 4606.1 4545.3 4572.6 4598.2 4610.4 4642.3 4524.9 4541.1 4553.4 4597.3 4607.6 4516.8 4580.0 4582.1 4601.2 4622.4 4514.0 4516.4 4517.9 4558.6 4576.8 4987.8 5054.9 5061.0 5068.0 5113.4 5344.2 5347.3 5404.2 5404.9 5505.9 5488.1 5508.5 5511.9 5545.3 5576.3 5126.0 5148.2 5153.7 5156.2 5168.7 5593.6 5634.5 5636.0 5647.1 5705.5 5312.0 5323.5 5348.4 5378.5 5379.4 5407.3 5415.5 5437.6 5484.3 5542.0 5485.5 5489.6 5490.0 5495.6 5496.6 5371.8 5481.2 5488.2 5490.1 5493.2 4659.5 4659.5 4665.7 4666.0 4674.3 4014.1 4032.0 4071.8 4073.5 4075.3 4657.5 4663.0 4674.3 4724.1 4725.5 5400.2 5470.9 5491.3 5492.6 5513.6 4643.2 4661.2 4661.7 4669.9 4699.3 4806.1 4878.5 4885.2 4913.8 4928.0 4993.7 5061.0 5079.9 5093.3 5108.2 5462.1 5483.8 5492.6 5494.6 5504.4 5047.4 5052.6 5070.6 5080.4 5080.5 5409.1 5454.5 5475.1 5476.5 5476.8 5393.1 5452.3 5493.1 5500.2 5557.0 5304.0 5318.5 5320.7 5332.4 5334.5 5327.5 5336.7 5344.6 5345.7 5386.9 5109.2 5213.7 5248.7 5325.3 5329.0 5133.5 5342.4 5356.2 5364.6 5401.6 5164.6 5211.5 5214.1 5214.7 5218.3 07:57:13 INFO - PID 21447 | 07:57:13 INFO - PID 21447 | [#1] ext.html Cycles:180 Average:30370.56 Median:3100.86 stddev:41259.37 (1330.6%) stddev-sans-first:41315.03 07:57:13 INFO - PID 21447 | Values: 718.0 732.0 1052.8 1055.1 1140.1 32996.0 34014.5 34064.1 34081.8 34130.3 31468.4 31794.7 31817.5 31844.4 31864.4 6458.1 6462.7 6589.6 7108.6 7111.5 7042.5 7092.0 7122.9 7157.7 7160.1 7118.1 7179.4 7182.2 7190.4 7211.5 7098.7 7132.6 7167.4 7171.7 7188.1 7030.4 7054.9 7056.7 7061.5 7086.3 32320.7 32457.8 32579.5 32590.5 32685.8 3073.5 3096.7 3109.5 3114.8 3120.8 24022.0 24074.3 24211.5 24237.6 24403.5 2991.5 3057.2 3060.4 3070.0 3105.0 143864.0 144271.0 144353.0 144809.3 144930.0 38511.0 40450.8 40461.4 40620.8 41641.8 42873.4 42888.4 43099.1 45324.5 46109.8 12036.6 12085.6 12142.3 12142.5 12171.1 9565.9 9572.0 9580.8 9583.8 9599.7 12961.9 13035.8 13062.1 13124.5 13226.1 5435.2 5483.1 5494.1 5506.4 5520.2 870.6 916.9 927.3 932.3 949.1 20257.7 20941.7 21297.7 21430.7 21485.1 980.7 987.2 987.7 1002.5 1016.3 11224.7 11407.8 11419.8 11498.4 11514.2 182092.0 182999.0 183159.0 183405.1 183684.0 41145.0 41182.0 41359.4 41496.8 41625.2 1200.8 1256.9 1261.9 1262.5 1275.3 19809.8 19896.8 20411.8 21474.2 21520.0 29685.6 30084.7 30163.2 30204.4 30234.0 148139.0 149276.0 149337.3 149449.0 149698.0 28372.7 28445.0 29225.0 29390.6 29558.6 35884.8 36205.8 36441.0 36466.6 36619.0 26831.9 27232.5 27507.2 27533.7 28086.4 27058.2 27227.7 27746.3 27801.2 28673.4 31105.7 31164.9 31172.4 31173.8 31221.7 25722.0 26486.0 26848.5 27052.1 27335.5 20497.6 21247.6 21436.2 21575.4 21585.7 07:57:13 INFO - PID 21447 | 07:57:13 INFO - PID 21447 | [#2] jquery.html Cycles:180 Average:24662.27 Median:20023.70 stddev:61426.26 (306.8%) stddev-sans-first:61571.53 07:57:13 INFO - PID 21447 | Values: 385.6 395.8 402.4 411.9 415.9 12846.6 17362.0 17376.2 18026.1 18145.1 18344.4 18640.6 18800.2 19064.2 19377.4 5249.9 5340.3 5499.9 5547.8 5580.1 5477.4 5526.4 5553.1 5557.0 5581.0 5315.5 5450.9 5484.4 5490.0 5507.0 5400.8 5498.9 5499.0 5510.3 5551.9 4706.6 4803.4 4850.4 4861.7 4892.2 21378.1 21633.9 21658.0 21780.7 21857.8 1617.3 1626.0 1648.4 1649.4 1653.4 14615.0 15111.6 15133.5 15181.0 15242.7 2024.8 2080.5 2128.3 2138.1 2141.3 78316.0 78692.0 80022.0 80111.6 82219.6 9997.6 10219.5 10394.8 10410.6 10590.7 13984.7 14036.6 14057.9 14058.4 14228.9 7343.4 7575.9 7587.8 7798.3 7820.8 6988.2 7058.5 7159.0 7224.4 7291.3 6935.5 6962.3 6982.5 6998.3 7023.8 1901.5 1903.8 1936.7 1961.4 2004.4 839.0 865.8 875.7 879.7 906.2 16896.0 16903.2 16999.7 17236.3 17808.5 852.9 862.7 868.5 877.4 896.7 9172.2 9335.7 9657.2 9719.5 9792.3 366809.0 367353.0 370459.0 374155.0 375459.0 73206.3 73466.0 75166.0 76360.6 76786.0 1038.8 1048.5 1051.8 1065.0 1101.1 17342.4 18129.6 18329.8 18593.9 18717.0 39651.6 39961.0 40040.8 40077.4 40275.0 46816.8 48228.0 48508.5 48663.5 49134.3 7821.8 7923.8 8032.8 8183.0 8266.6 13259.5 13445.7 13534.1 13916.2 14041.3 11080.4 11105.4 11258.3 11586.3 11748.4 10799.8 10822.7 10856.0 10905.7 11095.0 11060.3 11363.8 11615.6 11649.5 11712.2 8048.0 8092.4 8100.8 8209.5 8224.2 10919.8 11066.7 11134.9 11619.6 11639.1 07:57:13 INFO - PID 21447 | 07:57:13 INFO - PID 21447 | [#3] mootools.html Cycles:180 Average:6003.15 Median:4075.25 stddev:3877.32 (95.1%) stddev-sans-first:3871.58 07:57:13 INFO - PID 21447 | Values: 1225.9 1267.9 1271.5 1279.3 1286.7 9345.9 9780.1 9790.0 9862.7 10124.0 10037.6 10099.8 10162.3 10201.3 10211.1 2236.9 2262.5 2286.0 2288.8 2291.0 2175.9 2212.7 2218.9 2225.0 2242.3 2157.2 2194.7 2233.0 2238.0 2242.3 2068.6 2153.4 2174.1 2175.2 2184.0 1962.8 2105.4 2152.6 2154.3 2166.8 9690.8 9763.0 9770.8 9806.6 9825.8 5360.1 5520.1 5563.0 5577.9 5579.8 3088.9 3315.0 3369.5 3382.1 3383.3 1018.7 1038.5 1061.5 1071.6 1073.0 14416.6 14495.8 14542.4 14547.4 14555.8 4468.4 4498.3 4668.3 4670.0 4696.2 10265.8 10359.7 10374.4 10382.6 10425.6 5364.3 5372.2 5372.3 5399.8 5411.7 4931.8 5081.2 5090.2 5157.8 5188.8 3574.9 3670.2 3692.0 3723.3 3734.3 1014.6 1030.3 1039.4 1039.5 1046.2 671.5 704.9 707.3 719.9 723.0 5137.3 5218.8 5238.1 5330.8 5428.2 535.9 540.9 544.8 544.9 548.3 3126.6 3147.8 3270.8 3403.6 3742.4 12462.7 12527.2 12828.4 12830.3 12884.0 12512.6 12551.4 12646.7 12677.7 12702.8 7031.4 7154.8 7333.5 7339.4 7359.3 5666.9 5698.5 5794.7 5795.3 5967.1 10929.2 11446.8 11481.5 11521.5 11560.6 11361.5 11371.7 11396.4 11578.6 11584.4 7826.3 7875.3 7987.8 8040.2 8041.5 9090.3 9366.8 9377.9 9388.7 9393.2 7809.8 7937.6 8073.7 8187.7 8266.0 7619.6 7628.4 7760.1 7836.3 7903.4 6173.6 6184.5 6213.8 6255.3 6267.4 4408.1 4440.2 4463.0 4511.3 4661.5 4504.8 4649.3 4740.9 5016.5 5073.3 07:57:13 INFO - PID 21447 | 07:57:13 INFO - PID 21447 | [#4] prototype.html Cycles:180 Average:4727.05 Median:5301.56 stddev:1370.30 (25.8%) stddev-sans-first:1334.65 07:57:13 INFO - PID 21447 | Values: 375.3 380.6 385.5 385.5 390.5 5356.3 5446.5 5453.9 5454.4 5522.9 5251.5 5336.7 5343.1 5347.6 5348.5 3937.4 4007.6 4016.9 4028.8 4039.7 4034.3 4052.7 4053.1 4056.6 4070.4 4022.1 4026.0 4028.3 4031.9 4039.4 3851.8 3992.3 4015.7 4030.7 4036.7 3498.9 3503.2 3504.6 3511.1 3531.4 5263.3 5272.4 5278.8 5290.5 5296.3 4540.9 4709.8 4713.3 4730.3 4745.0 5576.3 5617.5 5641.3 5646.2 5679.7 3913.7 3926.7 3935.2 3935.9 3936.3 5560.7 5919.3 5978.6 5994.9 6023.0 4392.7 4441.5 4445.4 4453.7 4468.0 4504.5 4537.6 4541.1 4541.5 4561.8 4894.7 4996.7 5006.8 5033.1 5039.6 5663.3 5714.3 5715.3 5729.3 5745.2 1565.4 1579.5 1583.7 1585.7 1587.1 1084.8 1147.2 1154.3 1157.0 1168.1 4908.8 4935.9 4942.4 4964.6 4975.8 5859.2 5904.2 5907.7 5909.1 5930.8 4872.9 4874.7 4922.2 4936.4 4947.8 3118.6 3144.3 3145.0 3150.2 3154.7 5306.9 5448.6 5450.1 5450.9 5455.4 5943.4 6017.0 6024.6 6028.2 6135.6 5438.6 5439.5 5454.2 5464.1 5465.5 5936.0 5950.7 5976.8 5977.3 5996.9 5676.2 5756.2 5782.9 5811.8 5887.2 5412.0 5444.0 5468.3 5470.7 5484.0 3880.5 4037.8 4053.9 4070.1 4075.7 5992.5 5998.7 6004.1 6005.9 6018.2 5782.7 5783.2 5799.5 5806.5 5827.2 5636.7 5701.8 5720.5 5753.6 5781.9 5625.5 5661.9 5676.6 5683.5 5689.6 5587.6 5747.1 5799.6 5800.3 5815.6 5598.4 5623.8 5627.6 5632.7 5644.4 07:57:13 INFO - PID 21447 | 07:57:13 INFO - PID 21447 | [#5] yui.html Cycles:180 Average:15174.29 Median:43518.46 stddev:17949.46 (41.2%) stddev-sans-first:17966.85 07:57:13 INFO - PID 21447 | Values: 688.9 714.5 715.3 742.9 771.0 11944.6 12450.8 13465.5 14310.4 14317.4 14984.2 15173.0 15409.7 15612.0 15706.3 851.7 866.1 866.4 866.5 870.3 922.3 922.6 923.1 924.1 926.9 943.3 958.6 959.5 963.1 963.4 941.0 945.3 949.0 949.2 956.1 701.7 701.8 706.7 707.0 708.9 13771.7 13941.8 14056.2 14250.9 14691.5 15298.0 15390.4 15674.2 15687.7 15876.8 11980.7 12118.8 12313.8 12569.6 12646.6 2862.7 2866.7 2874.7 2892.5 2910.9 66222.0 66841.0 66842.0 66980.0 68477.3 10588.4 10725.0 10747.4 10771.4 10886.3 16902.8 17179.0 17287.9 17302.3 17343.2 6004.4 6301.6 6504.3 6527.6 6538.0 3063.8 3133.6 3147.1 3147.4 3153.1 3224.3 3301.1 3304.2 3318.0 3326.4 699.9 701.4 702.5 704.0 706.0 611.8 621.4 623.2 627.5 636.4 9429.3 9637.1 9779.3 9919.7 10087.5 613.2 616.0 627.1 628.7 636.5 4290.5 4440.5 4456.4 4463.4 4507.9 62142.0 62396.4 62410.0 63245.7 64054.7 55996.7 56474.7 56592.0 56737.4 57081.4 50379.2 50561.5 51062.7 51091.5 51226.0 8995.4 9031.2 9063.5 9084.7 9388.5 25020.7 25058.7 25676.2 26678.9 27525.3 42354.4 43206.4 43830.6 43834.3 45576.0 14318.6 14400.1 14500.0 14641.0 14791.1 14909.9 15275.8 15372.2 16010.8 16489.0 13953.2 14126.7 14130.4 14573.9 14728.4 14214.9 14223.6 14699.3 15214.0 15240.5 12926.7 13172.6 13285.1 14065.2 14193.7 9178.0 9340.6 9511.5 10725.5 10971.8 11106.2 11191.3 11855.5 12295.6 12427.3 07:57:13 INFO - PID 21447 | -------- Summary: end -------- 07:57:13 INFO - PID 21447 | 07:57:14 INFO - TEST-INFO | 21447: exit 0 07:57:14 INFO - TEST-OK | dromaeo_css | took 1117928ms 07:57:14 INFO - TEST-START | kraken 07:57:14 INFO - operating with platform_type : linux_ 07:57:14 INFO - Initialising browser for kraken test... 07:57:14 INFO - TEST-INFO | started process 21856 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeXKq4y/profile http://localhost:56043/getInfo.html) 07:57:14 INFO - PID 21856 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2978: String.localeCompare is deprecated; use String.prototype.localeCompare instead 07:57:17 INFO - PID 21856 | __metrics Screen width/height:1600/1200 07:57:17 INFO - PID 21856 | colorDepth:24 07:57:17 INFO - PID 21856 | Browser inner width/height: 1024/695 07:57:17 INFO - PID 21856 | __metrics 07:57:19 INFO - TEST-INFO | 21856: exit 0 07:57:19 INFO - Browser initialized. 07:57:19 INFO - Running cycle 1/1 for kraken test... 07:57:19 INFO - TEST-INFO | started process 22019 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeXKq4y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:31 INFO - PID 22019 | RSS: Main: 167538688 07:57:31 INFO - PID 22019 | 07:57:34 INFO - PID 22019 | Cycle 1(1): loaded http://localhost:56043/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56043/tests/kraken/driver.html?testName=audio-beat-detection) 07:57:35 INFO - PID 22019 | RSS: Main: 172044288 07:57:35 INFO - PID 22019 | 07:57:37 INFO - PID 22019 | Cycle 1(1): loaded http://localhost:56043/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56043/tests/kraken/driver.html?testName=audio-dft) 07:57:38 INFO - PID 22019 | RSS: Main: 170008576 07:57:38 INFO - PID 22019 | 07:57:41 INFO - PID 22019 | Cycle 1(1): loaded http://localhost:56043/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56043/tests/kraken/driver.html?testName=audio-fft) 07:57:42 INFO - PID 22019 | RSS: Main: 165146624 07:57:42 INFO - PID 22019 | 07:57:44 INFO - PID 22019 | Cycle 1(1): loaded http://localhost:56043/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56043/tests/kraken/driver.html?testName=audio-oscillator) 07:57:44 INFO - PID 22019 | RSS: Main: 166043648 07:57:44 INFO - PID 22019 | 07:57:46 INFO - PID 22019 | Cycle 1(1): loaded http://localhost:56043/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56043/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:57:47 INFO - PID 22019 | RSS: Main: 166830080 07:57:47 INFO - PID 22019 | 07:57:50 INFO - PID 22019 | Cycle 1(1): loaded http://localhost:56043/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56043/tests/kraken/driver.html?testName=imaging-darkroom) 07:57:51 INFO - PID 22019 | RSS: Main: 170635264 07:57:51 INFO - PID 22019 | 07:57:54 INFO - PID 22019 | Cycle 1(1): loaded http://localhost:56043/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56043/tests/kraken/driver.html?testName=imaging-desaturate) 07:57:55 INFO - PID 22019 | RSS: Main: 168144896 07:57:55 INFO - PID 22019 | 07:57:58 INFO - PID 22019 | Cycle 1(1): loaded http://localhost:56043/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56043/tests/kraken/driver.html?testName=json-parse-financial) 07:57:59 INFO - PID 22019 | RSS: Main: 169328640 07:57:59 INFO - PID 22019 | 07:58:00 INFO - PID 22019 | Cycle 1(1): loaded http://localhost:56043/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56043/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:58:01 INFO - PID 22019 | RSS: Main: 169455616 07:58:01 INFO - PID 22019 | 07:58:03 INFO - PID 22019 | Cycle 1(1): loaded http://localhost:56043/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56043/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:58:03 INFO - PID 22019 | RSS: Main: 169254912 07:58:03 INFO - PID 22019 | 07:58:05 INFO - PID 22019 | Cycle 1(1): loaded http://localhost:56043/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56043/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:58:06 INFO - PID 22019 | RSS: Main: 168865792 07:58:06 INFO - PID 22019 | 07:58:09 INFO - PID 22019 | Cycle 1(1): loaded http://localhost:56043/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56043/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:58:10 INFO - PID 22019 | RSS: Main: 169111552 07:58:10 INFO - PID 22019 | 07:58:13 INFO - PID 22019 | Cycle 1(1): loaded http://localhost:56043/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56043/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:58:13 INFO - PID 22019 | RSS: Main: 167837696 07:58:13 INFO - PID 22019 | 07:58:15 INFO - PID 22019 | Cycle 1(1): loaded http://localhost:56043/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56043/tests/kraken/driver.html?testName=ai-astar) 07:58:16 INFO - PID 22019 | RSS: Main: 169324544 07:58:16 INFO - PID 22019 | 07:58:16 INFO - PID 22019 | __start_tp_report 07:58:16 INFO - PID 22019 | _x_x_mozilla_page_load 07:58:16 INFO - PID 22019 | _x_x_mozilla_page_load_details 07:58:16 INFO - PID 22019 | |i|pagename|runs| 07:58:16 INFO - PID 22019 | |0;ai-astar;104;113;112;112;113;111;113;112;112;113 07:58:16 INFO - PID 22019 | |1;audio-beat-detection;159;125;129;171;126;130;129;136;157;124 07:58:16 INFO - PID 22019 | |2;audio-dft;170;165;165;164;165;167;168;170;165;165 07:58:16 INFO - PID 22019 | |3;audio-fft;77;74;74;115;79;75;75;76;93;75 07:58:16 INFO - PID 22019 | |4;audio-oscillator;84;83;105;83;83;83;100;83;83;108 07:58:16 INFO - PID 22019 | |5;imaging-gaussian-blur;114;115;115;114;114;114;114;114;114;118 07:58:16 INFO - PID 22019 | |6;imaging-darkroom;150;150;151;150;151;150;151;151;152;151 07:58:16 INFO - PID 22019 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;95;94 07:58:16 INFO - PID 22019 | |8;json-parse-financial;55;56;55;56;57;57;57;55;56;57 07:58:16 INFO - PID 22019 | |9;json-stringify-tinderbox;57;57;56;57;58;57;57;60;57;58 07:58:16 INFO - PID 22019 | |10;stanford-crypto-aes;92;84;84;83;83;81;81;85;86;83 07:58:16 INFO - PID 22019 | |11;stanford-crypto-ccm;138;133;134;147;142;137;141;141;181;139 07:58:16 INFO - PID 22019 | |12;stanford-crypto-pbkdf2;198;209;201;205;209;204;203;206;205;192 07:58:16 INFO - PID 22019 | |13;stanford-crypto-sha256-iterative;75;73;74;74;75;77;73;74;77;72 07:58:16 INFO - PID 22019 | __end_tp_report 07:58:16 INFO - PID 22019 | __start_cc_report 07:58:16 INFO - PID 22019 | _x_x_mozilla_cycle_collect,798 07:58:16 INFO - PID 22019 | __end_cc_report 07:58:16 INFO - PID 22019 | __startTimestamp1495551496047__endTimestamp 07:58:16 INFO - PID 22019 | 07:58:16 INFO - PID 22019 | ------- Summary: start ------- 07:58:16 INFO - PID 22019 | Number of tests: 14 07:58:16 INFO - PID 22019 | 07:58:16 INFO - PID 22019 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.50 stddev:2.72 (2.4%) stddev-sans-first:0.71 07:58:16 INFO - PID 22019 | Values: 104.0 113.0 112.0 112.0 113.0 111.0 113.0 112.0 112.0 113.0 07:58:16 INFO - PID 22019 | 07:58:16 INFO - PID 22019 | [#1] audio-beat-detection Cycles:10 Average:138.60 Median:133.00 stddev:17.08 (12.8%) stddev-sans-first:16.45 07:58:16 INFO - PID 22019 | Values: 159.0 125.0 129.0 171.0 126.0 130.0 129.0 136.0 157.0 124.0 07:58:16 INFO - PID 22019 | 07:58:16 INFO - PID 22019 | [#2] audio-dft Cycles:10 Average:166.40 Median:166.00 stddev:2.22 (1.3%) stddev-sans-first:1.94 07:58:16 INFO - PID 22019 | Values: 170.0 165.0 165.0 164.0 165.0 167.0 168.0 170.0 165.0 165.0 07:58:16 INFO - PID 22019 | 07:58:16 INFO - PID 22019 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.50 stddev:13.12 (17.4%) stddev-sans-first:13.83 07:58:16 INFO - PID 22019 | Values: 77.0 74.0 74.0 115.0 79.0 75.0 75.0 76.0 93.0 75.0 07:58:16 INFO - PID 22019 | 07:58:16 INFO - PID 22019 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:83.00 stddev:10.42 (12.5%) stddev-sans-first:10.86 07:58:16 INFO - PID 22019 | Values: 84.0 83.0 105.0 83.0 83.0 83.0 100.0 83.0 83.0 108.0 07:58:16 INFO - PID 22019 | 07:58:16 INFO - PID 22019 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.00 stddev:1.26 (1.1%) stddev-sans-first:1.32 07:58:16 INFO - PID 22019 | Values: 114.0 115.0 115.0 114.0 114.0 114.0 114.0 114.0 114.0 118.0 07:58:16 INFO - PID 22019 | 07:58:16 INFO - PID 22019 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 07:58:16 INFO - PID 22019 | Values: 150.0 150.0 151.0 150.0 151.0 150.0 151.0 151.0 152.0 151.0 07:58:16 INFO - PID 22019 | 07:58:16 INFO - PID 22019 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:58:16 INFO - PID 22019 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 07:58:16 INFO - PID 22019 | 07:58:16 INFO - PID 22019 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.50 stddev:0.88 (1.5%) stddev-sans-first:0.83 07:58:16 INFO - PID 22019 | Values: 55.0 56.0 55.0 56.0 57.0 57.0 57.0 55.0 56.0 57.0 07:58:16 INFO - PID 22019 | 07:58:16 INFO - PID 22019 | [#9] json-stringify-tinderbox Cycles:10 Average:57.40 Median:57.00 stddev:1.07 (1.9%) stddev-sans-first:1.13 07:58:16 INFO - PID 22019 | Values: 57.0 57.0 56.0 57.0 58.0 57.0 57.0 60.0 57.0 58.0 07:58:16 INFO - PID 22019 | 07:58:16 INFO - PID 22019 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:3.16 (3.8%) stddev-sans-first:1.66 07:58:16 INFO - PID 22019 | Values: 92.0 84.0 84.0 83.0 83.0 81.0 81.0 85.0 86.0 83.0 07:58:16 INFO - PID 22019 | 07:58:16 INFO - PID 22019 | [#11] stanford-crypto-ccm Cycles:10 Average:143.30 Median:141.00 stddev:13.85 (9.8%) stddev-sans-first:14.56 07:58:16 INFO - PID 22019 | Values: 138.0 133.0 134.0 147.0 142.0 137.0 141.0 141.0 181.0 139.0 07:58:16 INFO - PID 22019 | 07:58:16 INFO - PID 22019 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:203.20 Median:205.00 stddev:5.16 (2.5%) stddev-sans-first:5.12 07:58:16 INFO - PID 22019 | Values: 198.0 209.0 201.0 205.0 209.0 204.0 203.0 206.0 205.0 192.0 07:58:16 INFO - PID 22019 | 07:58:16 INFO - PID 22019 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.40 Median:74.50 stddev:1.65 (2.2%) stddev-sans-first:1.73 07:58:16 INFO - PID 22019 | Values: 75.0 73.0 74.0 74.0 75.0 77.0 73.0 74.0 77.0 72.0 07:58:16 INFO - PID 22019 | -------- Summary: end -------- 07:58:16 INFO - PID 22019 | 07:58:17 INFO - TEST-INFO | 22019: exit 0 07:58:17 INFO - TEST-OK | kraken | took 63127ms 07:58:17 INFO - SUITE-END | took 1181s 07:58:17 INFO - Completed test suite (00:19:41) 07:58:17 INFO - javascript benchmark 07:58:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6617.787516214712, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2641.0360218520245, 2643.312738687941, 2656.9867150664245, 2677.0496473751828, 2681.6916054653716, 4990.925136122956, 5021.849344519661, 5047.0915235257635, 5057.924131138036, 5117.155669314563, 5043.814703544664, 5119.334486516747, 5121.180611102224, 5133.666311689738, 5149.098907691148, 4521.841735539257, 4527.139843429746, 4527.886802829923, 4577.33628623851, 4606.078784243148, 4545.272756358983, 4572.565606267416, 4598.2183028885, 4610.446746390421, 4642.257238841786, 4524.864254072383, 4541.069080838421, 4553.430821147356, 4597.264437689971, 4607.608353289975, 4516.819327226907, 4580.0, 4582.1064892346, 4601.217792975202, 4622.422197225347, 4514.0, 4516.390287311204, 4517.909641807179, 4558.58972692456, 4576.794044267983, 4987.825426110105, 5054.873628159288, 5061.0, 5068.037072956126, 5113.411957624883, 5344.225087362311, 5347.304850369466, 5404.216388623667, 5404.891902161935, 5505.862353441156, 5488.1493368527945, 5508.504234618864, 5511.944880551183, 5545.334559852843, 5576.33084029919, 5125.974370128126, 5148.176291793295, 5153.7165455900285, 5156.2007888776925, 5168.7415629218385, 5593.580481463907, 5634.464725851038, 5635.971820140873, 5647.096464565732, 5705.4579814917515, 5311.9734401328515, 5323.467653234646, 5348.384935732441, 5378.515933565998, 5379.435159308295, 5407.270018547524, 5415.512603865671, 5437.592180586472, 5484.314460692413, 5542.0301447246575, 5485.4788795064405, 5489.615726899158, 5489.972550137224, 5495.6153069285565, 5496.587755918322, 5371.785128594891, 5481.232627432163, 5488.1767734839295, 5490.066688662937, 5493.23094766733, 4659.464161621457, 4659.487456379796, 4665.743384113838, 4665.953340466552, 4674.252119660838, 4014.116894283253, 4031.9920019995, 4071.816768245377, 4073.490813648294, 4075.3479443289525, 4657.464391594942, 4662.976685116552, 4674.345591617176, 4724.102420540086, 4725.527447255316, 5400.162974738922, 5470.890582188334, 5491.28613280271, 5492.615516913857, 5513.58648101394, 4643.233866412072, 4661.184292748755, 4661.720296782204, 4669.929951050737, 4699.318598803223, 4806.134895718735, 4878.463369029404, 4885.218365061644, 4913.778879950411, 4927.989762098761, 4993.725345105909, 5061.0, 5079.898402032012, 5093.337866077386, 5108.233764935289, 5462.098753705594, 5483.75323110453, 5492.5605951524585, 5494.587905906993, 5504.4495550444635, 5047.41954675217, 5052.570531504716, 5070.569001634903, 5080.390353157644, 5080.517350851663, 5409.0804563223555, 5454.4545545445135, 5475.069238229431, 5476.452354764491, 5476.780928762964, 5393.1370980642905, 5452.282531002721, 5493.121100623881, 5500.22996780443, 5557.0, 5304.0, 5318.468153184651, 5320.733963301742, 5332.440093790251, 5334.546563542142, 5327.467253274642, 5336.733163341895, 5344.625876188629, 5345.705986170798, 5386.919196212139, 5109.156989096758, 5213.687178769286, 5248.685078895279, 5325.2810870531985, 5328.973355133355, 5133.537981581526, 5342.358916929993, 5356.223347614497, 5364.597655175799, 5401.594880383908, 5164.586833053271, 5211.452797456364, 5214.113600687968, 5214.661047031931, 5218.26944227816], "value": 4978.2075010251665, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.9676914538845, 731.9898540014779, 1052.763128296133, 1055.1084333737992, 1140.0879296562748, 32996.0, 34014.48978265328, 34064.148396290104, 34081.829590852074, 34130.31739365211, 31468.370632587335, 31794.682053179462, 31817.522737158903, 31844.36311273779, 31864.36271274573, 6458.095866578683, 6462.739765745681, 6589.604623722568, 7108.609026503566, 7111.502194846363, 7042.4718146138985, 7092.0, 7122.9287707122785, 7157.749478768244, 7160.140783106034, 7118.1458225013075, 7179.425645948311, 7182.245864184264, 7190.352868241857, 7211.531250468703, 7098.68055937484, 7132.57204567725, 7167.42660587157, 7171.748988785367, 7188.137423509213, 7030.367266945948, 7054.929450705478, 7056.682449289794, 7061.540999834994, 7086.291370862924, 32320.676793232004, 32457.837710811295, 32579.51130733041, 32590.511142332885, 32685.83657081723, 3073.5389691546225, 3096.690330966908, 3109.471389863706, 3114.8131112133347, 3120.8127512349333, 24022.0, 24074.27777166688, 24211.515769684684, 24237.63643545348, 24403.511929761306, 2991.476491613959, 3057.1745628680355, 3060.4491191585507, 3070.048285031625, 3105.021918095815, 143864.0, 144271.0, 144353.0, 144809.2759536206, 144930.0, 38511.0, 40450.797746011085, 40461.39307910384, 40620.79689601533, 41641.79179104085, 42873.35689964653, 42888.35667464928, 43099.13801723948, 45324.546754532035, 46109.769451152526, 12036.63890083299, 12085.637430877088, 12142.332171730639, 12142.514299427923, 12171.14801963854, 9565.90434095664, 9571.952140239255, 9580.76048098803, 9583.760405989906, 9599.664011759694, 12961.870381296067, 13035.804462933063, 13062.085654004128, 13124.540641077516, 13226.140300880412, 5435.239066530688, 5483.095289277225, 5494.120940649477, 5506.394296627368, 5520.227168196456, 870.6256309786726, 916.903725108854, 927.2674587076269, 932.2588542109039, 949.1457688080644, 20257.696134557995, 20941.685874711893, 21297.68053479199, 21430.678539821914, 21485.14059437605, 980.7450062983532, 987.1905037869022, 987.7234374375187, 1002.4987506246877, 1016.2784423059562, 11224.66326010221, 11407.828882566768, 11419.828702569468, 11498.42507874603, 11514.194006419637, 182092.0, 182999.0, 183159.0, 183405.08297458428, 183684.0, 41145.0, 41181.97045073837, 41359.37960930528, 41496.792516037225, 41625.1674966499, 1200.8258802473767, 1256.886880180788, 1261.892739117167, 1262.456150856026, 1275.3049587974576, 19809.801901981373, 19896.801031990075, 20411.795882041584, 21474.24840130588, 21520.0, 29685.554716678835, 30084.699153009064, 30163.245918852204, 30204.395912081196, 30234.0, 148139.0, 149276.0, 149337.25331373274, 149449.0, 149698.0, 28372.716272837006, 28445.0, 29225.0, 29390.559141612466, 29558.556621650263, 35884.820575898, 36205.81897090498, 36441.0, 36466.63533364632, 36619.0, 26831.86584067067, 27232.455350893266, 27507.17478475649, 27533.724662753917, 28086.438271234052, 27058.1882543524, 27227.72772272331, 27746.306342341602, 27801.165965021082, 28673.42653146967, 31105.68894311028, 31164.909228176904, 31172.37655246928, 31173.8441307792, 31221.687783122787, 25722.0, 26486.0, 26848.50969373969, 27052.05317813867, 27335.49654769007, 20497.59004819925, 21247.575048499253, 21436.17792487656, 21575.35273941784, 21585.676214857103], "value": 14571.522410309537, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.63172170577104, 395.800120938926, 402.43457941592067, 411.8682021753039, 415.88147377997257, 12846.614601561969, 17362.0, 17376.218070186842, 18026.098695065244, 18145.092745362745, 18344.357947471806, 18640.627187456244, 18800.24799008038, 19064.2374305028, 19377.418677439666, 5249.86875328117, 5340.25236466893, 5499.862503437426, 5547.77808887644, 5580.135079062752, 5477.397486276506, 5526.364468086182, 5553.055980483307, 5557.027520183951, 5581.0, 5315.468453154673, 5450.890982180354, 5484.396716361197, 5490.039243132456, 5507.03626865299, 5400.783968641269, 5498.890022199574, 5498.972505137469, 5510.338759348904, 5551.8889622207535, 4706.576408123286, 4803.3995750531185, 4850.369451971256, 4861.73260470674, 4892.217245240744, 21378.144874205012, 21633.891830540902, 21658.0, 21780.673289900664, 21857.781422185733, 1617.2883931070292, 1625.9756103658456, 1648.4230519318262, 1649.381481944271, 1653.37998250656, 14615.0, 15111.622209444742, 15133.470328538559, 15181.0, 15242.695146097127, 2024.8076432738867, 2080.512433609976, 2128.287023847013, 2138.134055707441, 2141.3468891987936, 78316.0, 78692.0, 80021.99999999942, 80111.59944200242, 82219.58890205571, 9997.550110245056, 10219.540120694586, 10394.844077338847, 10410.635627752992, 10590.682279531626, 13984.650383740285, 14036.649083772783, 14057.929710351384, 14058.367373468218, 14228.928855355656, 7343.37581305595, 7575.924240757632, 7587.772366829004, 7798.298153166129, 7820.843583128306, 6988.231294557595, 7058.470614703918, 7159.0, 7224.422046236288, 7291.270872912666, 6935.549189302679, 6962.303769623099, 6982.546134501241, 6998.265182155902, 7023.789286321418, 1901.4865986183654, 1903.7620297462818, 1936.7191757195128, 1961.4409893180375, 2004.368623883472, 838.9748307550783, 865.8398196333699, 875.6584931876573, 879.7404765594165, 906.2342320738965, 16896.0, 16903.154842257838, 16999.74500382495, 17236.310547577956, 17808.46574602764, 852.8507511185642, 862.7023676831483, 868.4832524647825, 877.3814460805245, 896.7130518234233, 9172.220361269367, 9335.673251436167, 9657.179139773058, 9719.514024298898, 9792.265580081523, 366809.0, 367353.0, 370459.0, 374155.0, 375459.0, 73206.26793731995, 73466.0, 75166.0, 76360.61819690866, 76786.0, 1038.7558923652934, 1048.496721573649, 1051.8211903976342, 1065.0, 1101.11910471624, 17342.393016244372, 18129.637407252045, 18329.81670183281, 18593.90703046476, 18717.0, 39651.60348396595, 39960.999999998836, 40040.799796002, 40077.39883901685, 40275.0, 46816.7659161702, 48228.03543929172, 48508.51491485181, 48663.513364865896, 49134.26298605452, 7821.843563128819, 7923.801904952422, 8032.759017229492, 8182.959085204536, 8266.586670666564, 13259.469621215043, 13445.663858403617, 13534.120282181626, 13916.234607096301, 14041.297935103408, 11080.390578517936, 11105.389203593557, 11258.268212566158, 11586.304821710724, 11748.353840538852, 10799.838002429813, 10822.729431764268, 10855.968682975104, 10905.727356816144, 11095.0, 11060.281081729661, 11363.772724545297, 11615.593454229062, 11649.475773590038, 11712.180147389601, 8047.959760201162, 8092.433529652868, 8100.756977290691, 8209.548474833942, 8224.177582241728, 10919.781604368027, 11066.667999960015, 11134.944325278322, 11619.593314233962, 11639.127065469955], "value": 8796.907731501156, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1225.8528976522816, 1267.8922291605213, 1271.5486002469117, 1279.3219593615388, 1286.6526037969752, 9345.859812102815, 9780.119789218968, 9790.0, 9862.654807081753, 10124.038216369452, 10037.598496060167, 10099.848502272473, 10162.288639795217, 10201.285909986304, 10211.132053775438, 2236.915096178352, 2262.5474905018978, 2285.9657105143438, 2288.794008539231, 2290.9541809163807, 2175.869447833135, 2212.6791615215784, 2218.8890555472244, 2225.020990764067, 2242.2936774915847, 2157.180271496829, 2194.7037149984785, 2232.955340893181, 2238.03764381316, 2242.2712618399005, 2068.617305798417, 2153.353993801861, 2174.065151984646, 2175.216921908112, 2183.9563208735735, 1962.774280957694, 2105.357865850915, 2152.5802468518646, 2154.2998525479284, 2166.8049875511124, 9690.75773105671, 9763.0, 9770.804583908353, 9806.607735690564, 9825.754356141082, 5360.088784906575, 5520.1443776214755, 5562.972185139049, 5577.8605534861545, 5579.804706835242, 3088.8764449421997, 3315.0, 3369.494575813623, 3382.0530251529613, 3383.3064221834466, 1018.6689325969089, 1038.4651904269308, 1061.5435362793996, 1071.6356438810842, 1072.9570817167305, 14416.567502974927, 14495.782563261559, 14542.418303267857, 14547.418103275962, 14555.78166327506, 4468.374427580141, 4498.280275155959, 4668.253079507331, 4670.0, 4696.201645720235, 10265.846012309821, 10359.741006474898, 10374.429406382722, 10382.584696612203, 10425.635102771366, 5364.329458817648, 5372.167314066326, 5372.301600791872, 5399.83800485986, 5411.702356370437, 4931.827386041471, 5081.18701007837, 5090.160123579642, 5157.793688252503, 5188.844334669966, 3574.857005719794, 3670.22925185714, 3691.981540092336, 3723.2925744108534, 3734.3091528067393, 1014.6499457687086, 1030.258214085857, 1039.443897514826, 1039.4646756920192, 1046.2414749306693, 671.4997326991422, 704.9400800931876, 707.2891743797553, 719.8704233237962, 722.9602371869597, 5137.33214682089, 5218.765155568009, 5238.057149713012, 5330.813421530228, 5428.212909128154, 535.9088954877681, 540.9343593121545, 544.7739188236837, 544.9209864569615, 548.2571116137656, 3126.6248050234117, 3147.779655424144, 3270.8037517749012, 3403.557537520156, 3742.401215805458, 12462.688432789253, 12527.248365098123, 12828.35858207086, 12830.29433381173, 12884.0, 12512.562060327844, 12551.372431378395, 12646.683832904067, 12677.683057923625, 12702.80945785814, 7031.437485001187, 7154.785356439315, 7333.523320984119, 7339.376153026946, 7359.264073592705, 5666.914996275142, 5698.458646428583, 5794.681292528951, 5795.304563452412, 5967.134765458897, 10929.234953553176, 11446.828297575377, 11481.483333249857, 11521.53913843437, 11560.595379162025, 11361.54553817838, 11371.715707107389, 11396.430178490877, 11578.594749183738, 11584.42077896085, 7826.295633393022, 7875.291223789886, 7987.840243194987, 8040.195980402147, 8041.517508949481, 9090.272778177863, 9366.812663746823, 9377.906220937975, 9388.67139650109, 9393.201577865684, 7809.765707028798, 7937.563434011185, 8073.717419890276, 8187.672493100447, 8266.008079030315, 7619.619019048914, 7628.389728821792, 7760.146383897654, 7836.255555722198, 7903.446758726834, 6173.56785025044, 6184.474319682878, 6213.782517612042, 6255.31191568918, 6267.373262673878, 4408.096340250177, 4440.178566965122, 4463.018136010072, 4511.3458548510935, 4661.510541393105, 4504.842330518416, 4649.325847752125, 4740.928886066643, 5016.523430274118, 5073.264376665436], "value": 4495.671768622197, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.3206695880458, 380.61177598849173, 385.5027015150456, 385.5354298070825, 390.4514157608561, 5356.276902618145, 5446.455354464551, 5453.863653408666, 5454.427285135063, 5522.91715624266, 5251.527362537371, 5336.6531175473565, 5343.145096784515, 5347.59893008024, 5348.518633323, 3937.4290727844586, 4007.5992400759837, 4016.875274923026, 4028.7582745035247, 4039.7374170678813, 4034.314166591672, 4052.6555242804247, 4053.148838743867, 4056.634902858742, 4070.409790580364, 4022.074922767765, 4025.9798701006603, 4028.254772867029, 4031.8790436286813, 4039.353703407455, 3851.826667799956, 3992.301347264217, 4015.698822588303, 4030.6573941215033, 4036.737612055207, 3498.877539286138, 3503.2117773501013, 3504.5794504659602, 3511.139096278976, 3531.4349704047486, 5263.31576895005, 5272.393674727417, 5278.762455689503, 5290.523852853262, 5296.25852380667, 4540.910181556403, 4709.811607535728, 4713.293006049086, 4730.290456431563, 4744.952550474485, 5576.302962129734, 5617.522510586605, 5641.266635337421, 5646.20953066571, 5679.659220446786, 3913.745606535566, 3926.6858651307825, 3935.1736135411597, 3935.897948574404, 3936.2717897189114, 5560.6941618210985, 5919.289685237756, 5978.641281523122, 5994.940050599482, 6022.97609406402, 4392.748066800947, 4441.4892287387365, 4445.355423463579, 4453.688241823106, 4467.977660111678, 4504.459464864237, 4537.591616754508, 4541.114482675913, 4541.5231400703115, 4561.794719237576, 4894.681845680019, 4996.675216110941, 5006.774695138727, 5033.144365457881, 5039.571636410873, 5663.320401551758, 5714.314282286069, 5715.342735585377, 5729.25519682447, 5745.2243947067445, 1565.3816742386693, 1579.5498282989292, 1583.7307657698218, 1585.72249856277, 1587.1350114187796, 1084.8446404579097, 1147.2141583015662, 1154.285885460091, 1156.9942150289194, 1168.1355796710372, 4908.828191013297, 4935.925961110586, 4942.382202224722, 4964.578010869117, 4975.800967961313, 5859.1797148399255, 5904.202932604129, 5907.700305932688, 5909.113632955091, 5930.762769489258, 4872.902541949212, 4874.683145595596, 4922.187839006596, 4936.358273424504, 4947.777350019258, 3118.641356244061, 3144.261098641817, 3144.955778743835, 3150.228194092462, 3154.747620190379, 5306.867328316745, 5448.645838020516, 5450.100733379028, 5450.8909821803345, 5455.372632147354, 5943.435373639497, 6017.0, 6024.57827952048, 6028.156058151862, 6135.601185922901, 5438.564914806885, 5439.510444059974, 5454.154606036071, 5464.098423760035, 5465.453454654503, 5936.0, 5950.672713000827, 5976.820695379146, 5977.342492325927, 5996.850078748066, 5676.205331253545, 5756.2229099072765, 5782.884342313214, 5811.79658711943, 5887.1757953887345, 5411.972940135274, 5444.0, 5468.261784659179, 5470.72646367688, 5484.0, 3880.5343358797127, 4037.798110094542, 4053.9391909120795, 4070.104576993057, 4075.694322925733, 5992.460678538952, 5998.70006499682, 6004.099385092097, 6005.879882402415, 6018.247719035121, 5782.681952492653, 5783.190353350618, 5799.536037117105, 5806.535477161732, 5827.155062515827, 5636.746346414339, 5701.828945131652, 5720.48515633595, 5753.597248192586, 5781.884362312814, 5625.493705566519, 5661.915071274017, 5676.602637815313, 5683.460071293221, 5689.601727879009, 5587.552995760248, 5747.08046712524, 5799.623024503394, 5800.303963524404, 5815.5929084963645, 5598.412166722435, 5623.775048998158, 5627.634203776742, 5632.746526406239, 5644.3508996465935], "value": 4320.89338282809, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.8622275544891, 714.4998501049264, 715.3204455767022, 742.9257074292575, 771.0131032278686, 11944.581939632115, 12450.813237801418, 13465.46138154474, 14310.427582896684, 14317.427302907885, 14984.175870327128, 15173.0, 15409.69180616387, 15612.0, 15706.293216805243, 851.6806197675857, 866.1079088538816, 866.4281574161055, 866.4627930682954, 870.3124531620012, 922.3220932614523, 922.598669578732, 923.0677016213639, 924.0713083351222, 926.9073092690744, 943.2689665509216, 958.6021800952597, 959.501059449086, 963.0754475703299, 963.4219468318987, 940.9529523523796, 945.2957546627738, 948.9715308540755, 949.1789601994225, 956.0535070280407, 701.7368486817444, 701.8455939693259, 706.6819931031005, 707.0207762249271, 708.9149302083731, 13771.655708607264, 13941.790873136912, 14056.156630602094, 14250.85749142516, 14691.485797997018, 15298.0, 15390.384384624602, 15674.216289185495, 15687.68624627501, 15876.761848572165, 11980.70048248792, 12118.757624847454, 12313.815292770616, 12569.560065397667, 12646.620601381974, 2862.7423531882023, 2866.6846646868826, 2874.726900944407, 2892.522733748929, 2910.941781164386, 66222.0, 66841.0, 66842.0, 66980.0, 68477.3152268476, 10588.417637029883, 10725.0, 10747.355158690503, 10771.353718776898, 10886.292390994719, 16902.83097169037, 17179.0, 17287.913560432116, 17302.307907683804, 17343.21955512005, 6004.42957918997, 6301.558890877594, 6504.3495650435525, 6527.608343499405, 6538.0, 3063.8008529445515, 3133.592632957701, 3147.0716138739126, 3147.417727720379, 3153.0856051745195, 3224.290656055664, 3301.1417031571964, 3304.2400247943106, 3317.950230746541, 3326.3679900818765, 699.867025265198, 701.3652644356865, 702.5363260248212, 703.989440158398, 705.9647017649097, 611.8317462697794, 621.3848290192676, 623.2365352443221, 627.5230824573357, 636.3954243468723, 9429.2928030398, 9637.132658060807, 9779.315447918578, 9919.702408927744, 10087.49562521871, 613.1569092497815, 615.9876802463925, 627.1032423634156, 628.6919409489409, 636.4876274598993, 4290.549492303326, 4440.489343725449, 4456.398386217884, 4463.35281384204, 4507.864764057018, 62142.0, 62396.37603623905, 62410.0, 63245.68377158177, 64054.67972660107, 55996.72001639966, 56474.717626411606, 56592.0, 56737.43262567404, 57081.42918570761, 50379.24431133536, 50561.49438505568, 51062.74468627633, 51091.48908510942, 51226.0, 8995.415298005608, 9031.232345250728, 9063.546822658973, 9084.727458176265, 9388.483633400228, 25020.74979250257, 25058.74941250564, 25676.229713108638, 26678.866605666848, 27525.31186720348, 42354.364684530374, 43206.351904720825, 43830.561694382646, 43834.342484862114, 45576.0, 14318.57044288673, 14400.135991840523, 14500.0, 14641.0, 14791.112533248039, 14909.85090149128, 15275.847241527443, 15372.23138843031, 16010.839891600936, 16489.0, 13953.162810231419, 14126.717465650423, 14130.434782608581, 14573.854261457675, 14728.410863565767, 14214.857851421353, 14223.644408889446, 14699.265036748333, 15214.0, 15240.542783716506, 12926.703690558847, 13172.60482185536, 13285.13646612967, 14065.156090634595, 14193.716125677634, 9178.0, 9340.626374944926, 9511.476868772284, 10725.463726813785, 10971.780564388828, 11106.222564420414, 11191.272567283426, 11855.525778968744, 12295.631131066082, 12427.254364738144], "value": 6775.899384519679, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1566.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 112.0, 112.0, 113.0, 111.0, 113.0, 112.0, 112.0, 113.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 125.0, 129.0, 171.0, 126.0, 130.0, 129.0, 136.0, 157.0, 124.0], "value": 138.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 165.0, 165.0, 164.0, 165.0, 167.0, 168.0, 170.0, 165.0, 165.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 74.0, 115.0, 79.0, 75.0, 75.0, 76.0, 93.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 105.0, 83.0, 83.0, 83.0, 100.0, 83.0, 83.0, 108.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 118.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 150.0, 151.0, 150.0, 151.0, 151.0, 152.0, 151.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 56.0, 57.0, 57.0, 57.0, 55.0, 56.0, 57.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 57.0, 58.0, 57.0, 57.0, 60.0, 57.0, 58.0], "value": 57.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 84.0, 84.0, 83.0, 83.0, 81.0, 81.0, 85.0, 86.0, 83.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 133.0, 134.0, 147.0, 142.0, 137.0, 141.0, 141.0, 181.0, 139.0], "value": 143.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 209.0, 201.0, 205.0, 209.0, 204.0, 203.0, 206.0, 205.0, 192.0], "value": 203.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 74.0, 74.0, 75.0, 77.0, 73.0, 74.0, 77.0, 72.0], "value": 74.4, "unit": "score"}]}]} 07:58:17 INFO - Return code: 0 07:58:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:58:17 INFO - # TBPL SUCCESS # 07:58:17 INFO - Running post-action listener: _resource_record_post_action 07:58:17 INFO - [mozharness: 2017-05-23 14:58:17.865851Z] Finished run-tests step (success) 07:58:17 INFO - Running post-run listener: _resource_record_post_run 07:58:17 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 12288; Write bytes: 402083840; Read time: 32; Write time: 296604 07:58:17 INFO - TinderboxPrint: CPU usage
13.3% 07:58:17 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 32 07:58:17 INFO - TinderboxPrint: I/O write bytes / time
402,083,840 / 296,604 07:58:17 INFO - TinderboxPrint: CPU idle
8,283.6 (86.7%) 07:58:17 INFO - TinderboxPrint: CPU user
1,214.7 (12.7%) 07:58:17 INFO - TinderboxPrint: Swap in / out
0 / 0 07:58:17 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 94257152; Read time: 0; Write time: 106740 07:58:17 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 12288; Write bytes: 307826688; Read time: 32; Write time: 189864 07:58:18 INFO - Running post-run listener: _upload_blobber_files 07:58:18 INFO - Blob upload gear active. 07:58:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:58:18 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 07:58:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:58:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:58:18 INFO - (blobuploader) - INFO - Open directory for files ... 07:58:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:58:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:58:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:20 INFO - (blobuploader) - INFO - Done attempting. 07:58:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:58:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:58:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:20 INFO - (blobuploader) - INFO - Done attempting. 07:58:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:58:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:58:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:27 INFO - (blobuploader) - INFO - Done attempting. 07:58:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:58:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:58:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:28 INFO - (blobuploader) - INFO - Done attempting. 07:58:28 INFO - (blobuploader) - INFO - Iteration through files over. 07:58:28 INFO - Return code: 0 07:58:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:58:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:58:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/638dc9d2edeb8946ac212ce81fe5ced3f779f5b06e7d55c2bd3d9d3bb9384593dec54fe6a2895cb449ba4d0bcd2d361d576f0d8219ff174c020d2363d0b32d90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/727734a1e5345d237e0958ad2dce42852b4d147a57b60918d37522b4fb348e5540e7a8aa3e16c8eeb71800db15851fb2157d1b1793a301a46893dd45e8763f83", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b4f4c7f2893b89cb283ec8bcd26bb7926292683ad0825cc317c5df4ee0e61ce1e83d85ecf290eb9ca7805fe9d41c53b492a7ff0df542708199ea393d4452e10", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c299b752d7f838b3db9f5a5e132ae72673c62686140541274c6cc07540a9c07c9de0e951102d746819edd3a3c13413facfd837372a60095c652a16ccc65606c6"} 07:58:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:58:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:58:28 INFO - Contents: 07:58:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/638dc9d2edeb8946ac212ce81fe5ced3f779f5b06e7d55c2bd3d9d3bb9384593dec54fe6a2895cb449ba4d0bcd2d361d576f0d8219ff174c020d2363d0b32d90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/727734a1e5345d237e0958ad2dce42852b4d147a57b60918d37522b4fb348e5540e7a8aa3e16c8eeb71800db15851fb2157d1b1793a301a46893dd45e8763f83", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b4f4c7f2893b89cb283ec8bcd26bb7926292683ad0825cc317c5df4ee0e61ce1e83d85ecf290eb9ca7805fe9d41c53b492a7ff0df542708199ea393d4452e10", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c299b752d7f838b3db9f5a5e132ae72673c62686140541274c6cc07540a9c07c9de0e951102d746819edd3a3c13413facfd837372a60095c652a16ccc65606c6"} 07:58:28 INFO - Running post-run listener: copy_logs_to_upload_dir 07:58:28 INFO - Copying logs to upload dir... 07:58:28 INFO - mkdir: /builds/slave/test/build/upload/logs 07:58:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.374722 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-05-23 07:58:28.059762) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-23 07:58:28.063403) ========= 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=62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/638dc9d2edeb8946ac212ce81fe5ced3f779f5b06e7d55c2bd3d9d3bb9384593dec54fe6a2895cb449ba4d0bcd2d361d576f0d8219ff174c020d2363d0b32d90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/727734a1e5345d237e0958ad2dce42852b4d147a57b60918d37522b4fb348e5540e7a8aa3e16c8eeb71800db15851fb2157d1b1793a301a46893dd45e8763f83", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b4f4c7f2893b89cb283ec8bcd26bb7926292683ad0825cc317c5df4ee0e61ce1e83d85ecf290eb9ca7805fe9d41c53b492a7ff0df542708199ea393d4452e10", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c299b752d7f838b3db9f5a5e132ae72673c62686140541274c6cc07540a9c07c9de0e951102d746819edd3a3c13413facfd837372a60095c652a16ccc65606c6"} build_url:https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011196 build_url: 'https://queue.taskcluster.net/v1/task/LfK3GZVWR42LZZfzrFZZUg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/638dc9d2edeb8946ac212ce81fe5ced3f779f5b06e7d55c2bd3d9d3bb9384593dec54fe6a2895cb449ba4d0bcd2d361d576f0d8219ff174c020d2363d0b32d90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/727734a1e5345d237e0958ad2dce42852b4d147a57b60918d37522b4fb348e5540e7a8aa3e16c8eeb71800db15851fb2157d1b1793a301a46893dd45e8763f83", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b4f4c7f2893b89cb283ec8bcd26bb7926292683ad0825cc317c5df4ee0e61ce1e83d85ecf290eb9ca7805fe9d41c53b492a7ff0df542708199ea393d4452e10", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c299b752d7f838b3db9f5a5e132ae72673c62686140541274c6cc07540a9c07c9de0e951102d746819edd3a3c13413facfd837372a60095c652a16ccc65606c6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-23 07:58:28.089211) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 07:58:28.090120) ========= 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=62c568580acbfdaac3eec7be000001dc-1495548661.619636-2021675845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 07:58:28.173172) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-23 07:58:28.173491) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-23 07:58:28.173781) ========= ========= Total master_lag: 0.17 =========