builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-076 starttime: 1498021952.01 results: success (0) revision: e1e4a481b7e88dce163b9cccc2fb72032023befa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-20 22:12:32.007913) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-20 22:12:32.008388) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-20 22:12:32.008663) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-20 22:12:32.029159) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-20 22:12:32.029416) ========= 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=9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-20 22:12:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 210M=0s 2017-06-20 22:12:32 (210 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083628 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-20 22:12:32.128119) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-20 22:12:32.128439) ========= 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=9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022836 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-20 22:12:32.180682) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-20 22:12:32.181007) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e1e4a481b7e88dce163b9cccc2fb72032023befa --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 e1e4a481b7e88dce163b9cccc2fb72032023befa --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=9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-20 22:12:32,508 truncating revision to first 12 chars 2017-06-20 22:12:32,508 Setting DEBUG logging. 2017-06-20 22:12:32,508 attempt 1/10 2017-06-20 22:12:32,508 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e1e4a481b7e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-20 22:12:32,968 unpacking tar archive at: mozilla-central-e1e4a481b7e8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.805184 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-20 22:12:33.001041) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-20 22:12:33.004379) ========= script_repo_revision: e1e4a481b7e88dce163b9cccc2fb72032023befa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-20 22:12:33.004759) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-20 22:12:33.005021) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-20 22:12:33.014457) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-06-20 22:12:33.014760) ========= /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=9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:12:33 INFO - MultiFileLogger online at 20170620 22:12:33 in /builds/slave/test 22:12:33 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 22:12:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:12:33 INFO - {'append_to_log': False, 22:12:33 INFO - 'base_work_dir': '/builds/slave/test', 22:12:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 22:12:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:12:33 INFO - 'branch': 'Firefox-Non-PGO', 22:12:33 INFO - 'buildbot_json_path': 'buildprops.json', 22:12:33 INFO - 'config_files': ('talos/linux_config.py',), 22:12:33 INFO - 'default_actions': ('clobber', 22:12:33 INFO - 'read-buildbot-config', 22:12:33 INFO - 'download-and-extract', 22:12:33 INFO - 'populate-webroot', 22:12:33 INFO - 'create-virtualenv', 22:12:33 INFO - 'install', 22:12:33 INFO - 'setup-mitmproxy', 22:12:33 INFO - 'run-tests'), 22:12:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:12:33 INFO - 'download_minidump_stackwalk': True, 22:12:33 INFO - 'download_symbols': 'ondemand', 22:12:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:12:33 INFO - 'tooltool.py': '/tools/tooltool.py', 22:12:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:12:33 INFO - '/tools/misc-python/virtualenv.py')}, 22:12:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:12:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:12:33 INFO - 'gecko_profile': False, 22:12:33 INFO - 'gecko_profile_interval': 0, 22:12:33 INFO - 'installer_path': 'installer.exe', 22:12:33 INFO - 'log_level': 'info', 22:12:33 INFO - 'log_name': 'talos', 22:12:33 INFO - 'log_to_console': True, 22:12:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:12:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:12:33 INFO - 'opt_config_files': (), 22:12:33 INFO - 'pip_index': False, 22:12:33 INFO - 'suite': 'dromaeojs-e10s', 22:12:33 INFO - 'system_bits': '32', 22:12:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:12:33 INFO - 'title': 'talos-linux64-ix-076', 22:12:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:12:33 INFO - 'use_talos_json': True, 22:12:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:12:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:12:33 INFO - 'work_dir': 'build'} 22:12:33 INFO - [mozharness: 2017-06-21 05:12:33.438148Z] Running clobber step. 22:12:33 INFO - Running pre-action listener: _resource_record_pre_action 22:12:33 INFO - Running main action method: clobber 22:12:33 INFO - rmtree: /builds/slave/test/build 22:12:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:12:34 INFO - Running post-action listener: _resource_record_post_action 22:12:34 INFO - [mozharness: 2017-06-21 05:12:34.958471Z] Finished clobber step (success) 22:12:34 INFO - [mozharness: 2017-06-21 05:12:34.958570Z] Running read-buildbot-config step. 22:12:34 INFO - Running pre-action listener: _resource_record_pre_action 22:12:34 INFO - Running main action method: read_buildbot_config 22:12:34 INFO - Using buildbot properties: 22:12:34 INFO - { 22:12:34 INFO - "project": "", 22:12:34 INFO - "product": "firefox", 22:12:34 INFO - "who": "philringnalda@gmail.com", 22:12:34 INFO - "installer_path": "public/build/target.tar.bz2", 22:12:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 22:12:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 22:12:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 22:12:34 INFO - "stage_platform": "linux64", 22:12:34 INFO - "basedir": "/builds/slave/test", 22:12:34 INFO - "buildnumber": 679, 22:12:34 INFO - "platform": "ubuntu64_hw", 22:12:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:12:34 INFO - "slavebuilddir": "test", 22:12:34 INFO - "taskId": "DfHZpne3SpGimTfRBAK7Tg", 22:12:34 INFO - "branch": "mozilla-central", 22:12:34 INFO - "script_repo_revision": "production", 22:12:34 INFO - "revision": "e1e4a481b7e88dce163b9cccc2fb72032023befa", 22:12:34 INFO - "slavename": "talos-linux64-ix-076", 22:12:34 INFO - "repo_path": "mozilla-central" 22:12:34 INFO - } 22:12:34 INFO - Finding installer, test and symbols from parent task. 22:12:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DfHZpne3SpGimTfRBAK7Tg'}, attempt #1 22:12:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DfHZpne3SpGimTfRBAK7Tg'}, attempt #1 22:12:35 INFO - Task dependencies: bkPDzM7oQv-AtHhPukd0vg 22:12:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bkPDzM7oQv-AtHhPukd0vg'}, attempt #1 22:12:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/target.tar.bz2 22:12:36 INFO - Set test_url: https://queue.taskcluster.net/v1/task/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/test_packages.json 22:12:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/target.crashreporter-symbols.zip 22:12:36 INFO - Running post-action listener: _resource_record_post_action 22:12:36 INFO - [mozharness: 2017-06-21 05:12:36.335561Z] Finished read-buildbot-config step (success) 22:12:36 INFO - [mozharness: 2017-06-21 05:12:36.335782Z] Running download-and-extract step. 22:12:36 INFO - Running pre-action listener: _resource_record_pre_action 22:12:36 INFO - Running main action method: download_and_extract 22:12:36 INFO - mkdir: /builds/slave/test/build/tests 22:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:12:36 INFO - trying https://queue.taskcluster.net/v1/task/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/target.test_packages.json 22:12:36 INFO - Downloading https://queue.taskcluster.net/v1/task/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 22:12:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 22:12:36 INFO - Downloaded 989 bytes. 22:12:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 22:12:36 INFO - Using the following test package requirements: 22:12:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 22:12:36 INFO - u'common': [u'target.common.tests.zip'], 22:12:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 22:12:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 22:12:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 22:12:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 22:12:36 INFO - u'mozbase': [u'target.common.tests.zip'], 22:12:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 22:12:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 22:12:36 INFO - u'web-platform': [u'target.common.tests.zip', 22:12:36 INFO - u'target.web-platform.tests.tar.gz'], 22:12:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 22:12:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 22:12:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/target.common.tests.zip 22:12:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:12:36 INFO - Fetch https://queue.taskcluster.net/v1/task/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/target.common.tests.zip into memory 22:12:38 INFO - Content-Length response header: 67979902 22:12:38 INFO - Bytes received: 67979902 22:12:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 22:12:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/target.common.tests.zip 22:12:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:12:49 INFO - Fetch https://queue.taskcluster.net/v1/task/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/target.common.tests.zip into memory 22:12:50 INFO - Content-Length response header: 67979902 22:12:50 INFO - Bytes received: 67979902 22:13:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/target.talos.tests.zip 22:13:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 22:13:02 INFO - Fetch https://queue.taskcluster.net/v1/task/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/target.talos.tests.zip into memory 22:13:03 INFO - Content-Length response header: 14457064 22:13:03 INFO - Bytes received: 14457064 22:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:04 INFO - trying https://queue.taskcluster.net/v1/task/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/target.tar.bz2 22:13:04 INFO - Downloading https://queue.taskcluster.net/v1/task/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 22:13:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 22:13:05 INFO - Downloaded 59423044 bytes. 22:13:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/target.tar.bz2 22:13:05 INFO - mkdir: /builds/slave/test/properties 22:13:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:13:05 INFO - Writing to file /builds/slave/test/properties/build_url 22:13:05 INFO - Contents: 22:13:05 INFO - build_url:https://queue.taskcluster.net/v1/task/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/target.tar.bz2 22:13:05 INFO - Running post-action listener: _resource_record_post_action 22:13:05 INFO - Running post-action listener: set_extra_try_arguments 22:13:05 INFO - [mozharness: 2017-06-21 05:13:05.942730Z] Finished download-and-extract step (success) 22:13:05 INFO - [mozharness: 2017-06-21 05:13:05.942827Z] Running populate-webroot step. 22:13:05 INFO - Running pre-action listener: _resource_record_pre_action 22:13:05 INFO - Running main action method: populate_webroot 22:13:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:13:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:13:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:13:05 INFO - '--tppagecycles', 22:13:05 INFO - '7'], 22:13:05 INFO - 'tests': ['tsvgm']}}, 22:13:05 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:13:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:13:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:13:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:13:05 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:13:05 INFO - 'talos_options': ['--disable-e10s'], 22:13:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:13:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:13:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:13:05 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:13:05 INFO - 'talos_options': ['--disable-e10s'], 22:13:05 INFO - 'tests': ['damp', 'tps']}, 22:13:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:13:05 INFO - 'tests': ['damp', 'tps']}, 22:13:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:13:05 INFO - 'tests': ['dromaeo_dom']}, 22:13:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:13:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:13:05 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 22:13:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 22:13:05 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 22:13:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 22:13:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:13:05 INFO - 'tests': ['a11yr', 22:13:05 INFO - 'ts_paint', 22:13:05 INFO - 'tpaint', 22:13:05 INFO - 'sessionrestore', 22:13:05 INFO - 'sessionrestore_no_auto_restore', 22:13:05 INFO - 'tabpaint']}, 22:13:05 INFO - 'other-e10s': {'tests': ['a11yr', 22:13:05 INFO - 'ts_paint', 22:13:05 INFO - 'tpaint', 22:13:05 INFO - 'sessionrestore', 22:13:05 INFO - 'sessionrestore_no_auto_restore', 22:13:05 INFO - 'tabpaint']}, 22:13:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:13:05 INFO - 'ts_paint', 22:13:05 INFO - 'tpaint', 22:13:05 INFO - 'sessionrestore', 22:13:05 INFO - 'sessionrestore_no_auto_restore', 22:13:05 INFO - 'tabpaint']}, 22:13:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:13:05 INFO - 'ts_paint', 22:13:05 INFO - 'tpaint', 22:13:05 INFO - 'sessionrestore', 22:13:05 INFO - 'sessionrestore_no_auto_restore', 22:13:05 INFO - 'tabpaint']}, 22:13:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:13:05 INFO - 'tests': ['a11yr', 22:13:05 INFO - 'ts_paint', 22:13:05 INFO - 'tpaint', 22:13:05 INFO - 'sessionrestore', 22:13:05 INFO - 'sessionrestore_no_auto_restore', 22:13:05 INFO - 'tabpaint']}, 22:13:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:13:05 INFO - 'tests': ['a11yr', 22:13:05 INFO - 'ts_paint', 22:13:05 INFO - 'tpaint', 22:13:05 INFO - 'sessionrestore', 22:13:05 INFO - 'sessionrestore_no_auto_restore', 22:13:05 INFO - 'tabpaint']}, 22:13:05 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 22:13:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 22:13:05 INFO - 'bloom_basic_ref']}, 22:13:05 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 22:13:05 INFO - 'talos_options': ['--mitmproxy', 22:13:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 22:13:05 INFO - '--firstNonBlankPaint'], 22:13:05 INFO - 'tests': ['quantum_pageload_google', 22:13:05 INFO - 'quantum_pageload_youtube', 22:13:05 INFO - 'quantum_pageload_amazon', 22:13:05 INFO - 'quantum_pageload_facebook']}, 22:13:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:13:05 INFO - 'tests': ['tsvgx', 22:13:05 INFO - 'tsvgr_opacity', 22:13:05 INFO - 'tart', 22:13:05 INFO - 'tscrollx', 22:13:05 INFO - 'cart', 22:13:05 INFO - 'tsvg_static']}, 22:13:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:13:05 INFO - 'tsvgr_opacity', 22:13:05 INFO - 'tart', 22:13:05 INFO - 'tscrollx', 22:13:05 INFO - 'cart', 22:13:05 INFO - 'tsvg_static']}, 22:13:05 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:13:05 INFO - 'talos_options': ['--disable-e10s'], 22:13:05 INFO - 'tests': ['tp5o']}, 22:13:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:13:05 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:13:05 INFO - 'talos_options': ['--disable-e10s', 22:13:05 INFO - '--xperf_path', 22:13:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:13:05 INFO - 'tests': ['tp5n']}, 22:13:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:13:05 INFO - 'talos_options': ['--xperf_path', 22:13:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:13:05 INFO - 'tests': ['tp5n']}}, 22:13:05 INFO - 'talos.zip': {'path': '', 22:13:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:13:05 INFO - Running post-action listener: _resource_record_post_action 22:13:05 INFO - [mozharness: 2017-06-21 05:13:05.957692Z] Finished populate-webroot step (success) 22:13:05 INFO - [mozharness: 2017-06-21 05:13:05.957782Z] Running create-virtualenv step. 22:13:05 INFO - Running pre-action listener: _resource_record_pre_action 22:13:05 INFO - Running main action method: create_virtualenv 22:13:05 INFO - Creating virtualenv /builds/slave/test/build/venv 22:13:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:13:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:13:05 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 22:13:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:13:06 INFO - Using real prefix '/usr' 22:13:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:13:06 INFO - Installing distribute.............................................................................................................................................................................................done. 22:13:08 INFO - Installing pip.................done. 22:13:08 INFO - Return code: 0 22:13:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:13:08 INFO - Reading from file tmpfile_stdout 22:13:08 INFO - Output received: 22:13:08 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 22:13:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:13: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')]} 22:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13: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')]} 22:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151a140>, '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 0x151aa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151aed0>, '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': '9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070', '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 22:13:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:13:08 INFO - Using env: {'DISPLAY': ':0', 22:13:08 INFO - 'HOME': '/home/cltbld', 22:13:08 INFO - 'LANG': 'en_US.UTF-8', 22:13:08 INFO - 'LANGUAGE': 'en_US:en', 22:13:08 INFO - 'LOGNAME': 'cltbld', 22:13:08 INFO - 'MAIL': '/var/mail/cltbld', 22:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:08 INFO - 'MOZ_NO_REMOTE': '1', 22:13:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:08 INFO - 'NO_EM_RESTART': '1', 22:13:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:08 INFO - 'PWD': '/builds/slave/test', 22:13:08 INFO - 'SHELL': '/bin/bash', 22:13:08 INFO - 'SHLVL': '1', 22:13:08 INFO - 'TERM': 'linux', 22:13:08 INFO - 'TMOUT': '86400', 22:13:08 INFO - 'USER': 'cltbld', 22:13:08 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070', 22:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:08 INFO - '_': '/tools/buildbot/bin/python'} 22:13:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:13:08 INFO - Cleaning up... 22:13:08 INFO - Return code: 0 22:13:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:13: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')]} 22:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13: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')]} 22:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151a140>, '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 0x151aa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151aed0>, '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': '9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070', '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 22:13:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:13:08 INFO - Using env: {'DISPLAY': ':0', 22:13:08 INFO - 'HOME': '/home/cltbld', 22:13:08 INFO - 'LANG': 'en_US.UTF-8', 22:13:08 INFO - 'LANGUAGE': 'en_US:en', 22:13:08 INFO - 'LOGNAME': 'cltbld', 22:13:08 INFO - 'MAIL': '/var/mail/cltbld', 22:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:08 INFO - 'MOZ_NO_REMOTE': '1', 22:13:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:08 INFO - 'NO_EM_RESTART': '1', 22:13:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:08 INFO - 'PWD': '/builds/slave/test', 22:13:08 INFO - 'SHELL': '/bin/bash', 22:13:08 INFO - 'SHLVL': '1', 22:13:08 INFO - 'TERM': 'linux', 22:13:08 INFO - 'TMOUT': '86400', 22:13:08 INFO - 'USER': 'cltbld', 22:13:08 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070', 22:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:08 INFO - '_': '/tools/buildbot/bin/python'} 22:13:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:09 INFO - Downloading/unpacking psutil>=3.1.1 22:13: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 22:13: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 22:13: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 22:13: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 22:13:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:13:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:13:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:13:10 INFO - Installing collected packages: psutil 22:13:10 INFO - Running setup.py install for psutil 22:13:10 INFO - building 'psutil._psutil_linux' extension 22:13:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:13:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:13:10 INFO - building 'psutil._psutil_posix' extension 22:13:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:13:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:13:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:13:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:13:10 INFO - Successfully installed psutil 22:13:10 INFO - Cleaning up... 22:13:10 INFO - Return code: 0 22:13:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:13: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')]} 22:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13: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')]} 22:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151a140>, '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 0x151aa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151aed0>, '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': '9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070', '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 22:13:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:13:10 INFO - Using env: {'DISPLAY': ':0', 22:13:10 INFO - 'HOME': '/home/cltbld', 22:13:10 INFO - 'LANG': 'en_US.UTF-8', 22:13:10 INFO - 'LANGUAGE': 'en_US:en', 22:13:10 INFO - 'LOGNAME': 'cltbld', 22:13:10 INFO - 'MAIL': '/var/mail/cltbld', 22:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:10 INFO - 'MOZ_NO_REMOTE': '1', 22:13:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:10 INFO - 'NO_EM_RESTART': '1', 22:13:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:10 INFO - 'PWD': '/builds/slave/test', 22:13:10 INFO - 'SHELL': '/bin/bash', 22:13:10 INFO - 'SHLVL': '1', 22:13:10 INFO - 'TERM': 'linux', 22:13:10 INFO - 'TMOUT': '86400', 22:13:10 INFO - 'USER': 'cltbld', 22:13:10 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070', 22:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:10 INFO - '_': '/tools/buildbot/bin/python'} 22:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:13:11 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 22:13:11 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 22:13:11 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 22:13:11 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 22:13:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:13:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:13:12 INFO - Installing collected packages: mozsystemmonitor 22:13:12 INFO - Running setup.py install for mozsystemmonitor 22:13:12 INFO - Successfully installed mozsystemmonitor 22:13:12 INFO - Cleaning up... 22:13:12 INFO - Return code: 0 22:13:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:13:12 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')]} 22:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:12 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')]} 22:13:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:12 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 0x119e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151a140>, '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 0x151aa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151aed0>, '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': '9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070', '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 22:13:12 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 22:13:12 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 22:13:12 INFO - Using env: {'DISPLAY': ':0', 22:13:12 INFO - 'HOME': '/home/cltbld', 22:13:12 INFO - 'LANG': 'en_US.UTF-8', 22:13:12 INFO - 'LANGUAGE': 'en_US:en', 22:13:12 INFO - 'LOGNAME': 'cltbld', 22:13:12 INFO - 'MAIL': '/var/mail/cltbld', 22:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:12 INFO - 'MOZ_NO_REMOTE': '1', 22:13:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:12 INFO - 'NO_EM_RESTART': '1', 22:13:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:12 INFO - 'PWD': '/builds/slave/test', 22:13:12 INFO - 'SHELL': '/bin/bash', 22:13:12 INFO - 'SHLVL': '1', 22:13:12 INFO - 'TERM': 'linux', 22:13:12 INFO - 'TMOUT': '86400', 22:13:12 INFO - 'USER': 'cltbld', 22:13:12 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070', 22:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:12 INFO - '_': '/tools/buildbot/bin/python'} 22:13:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:12 INFO - Downloading/unpacking jsonschema==2.5.1 22:13: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 22:13: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 22:13: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 22:13: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 22:13:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:13:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:14 INFO - Downloading functools32-3.2.3-2.tar.gz 22:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:13:14 INFO - warning: no files found matching '*.txt' 22:13:14 INFO - no previously-included directories found matching 'build' 22:13:14 INFO - no previously-included directories found matching 'dist' 22:13:14 INFO - no previously-included directories found matching '.git*' 22:13:14 INFO - Installing collected packages: jsonschema, functools32 22:13:14 INFO - Running setup.py install for functools32 22:13:14 INFO - warning: no files found matching '*.txt' 22:13:14 INFO - no previously-included directories found matching 'build' 22:13:14 INFO - no previously-included directories found matching 'dist' 22:13:14 INFO - no previously-included directories found matching '.git*' 22:13:14 INFO - Successfully installed jsonschema functools32 22:13:14 INFO - Cleaning up... 22:13:14 INFO - Return code: 0 22:13:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x119e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151a140>, '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 0x151aa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151aed0>, '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': '9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070', '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 22:13:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:13:14 INFO - Using env: {'DISPLAY': ':0', 22:13:14 INFO - 'HOME': '/home/cltbld', 22:13:14 INFO - 'LANG': 'en_US.UTF-8', 22:13:14 INFO - 'LANGUAGE': 'en_US:en', 22:13:14 INFO - 'LOGNAME': 'cltbld', 22:13:14 INFO - 'MAIL': '/var/mail/cltbld', 22:13:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:14 INFO - 'MOZ_NO_REMOTE': '1', 22:13:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:14 INFO - 'NO_EM_RESTART': '1', 22:13:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:14 INFO - 'PWD': '/builds/slave/test', 22:13:14 INFO - 'SHELL': '/bin/bash', 22:13:14 INFO - 'SHLVL': '1', 22:13:14 INFO - 'TERM': 'linux', 22:13:14 INFO - 'TMOUT': '86400', 22:13:14 INFO - 'USER': 'cltbld', 22:13:14 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070', 22:13:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:14 INFO - '_': '/tools/buildbot/bin/python'} 22:13:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:13:14 INFO - Cleaning up... 22:13:14 INFO - Return code: 0 22:13:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x119e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151a140>, '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 0x151aa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151aed0>, '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': '9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070', '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 22:13:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:13:14 INFO - Using env: {'DISPLAY': ':0', 22:13:14 INFO - 'HOME': '/home/cltbld', 22:13:14 INFO - 'LANG': 'en_US.UTF-8', 22:13:14 INFO - 'LANGUAGE': 'en_US:en', 22:13:14 INFO - 'LOGNAME': 'cltbld', 22:13:14 INFO - 'MAIL': '/var/mail/cltbld', 22:13:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:14 INFO - 'MOZ_NO_REMOTE': '1', 22:13:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:14 INFO - 'NO_EM_RESTART': '1', 22:13:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:14 INFO - 'PWD': '/builds/slave/test', 22:13:14 INFO - 'SHELL': '/bin/bash', 22:13:14 INFO - 'SHLVL': '1', 22:13:14 INFO - 'TERM': 'linux', 22:13:14 INFO - 'TMOUT': '86400', 22:13:14 INFO - 'USER': 'cltbld', 22:13:14 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070', 22:13:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:14 INFO - '_': '/tools/buildbot/bin/python'} 22:13:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:14 INFO - Downloading/unpacking blobuploader==1.2.4 22:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:15 INFO - Downloading blobuploader-1.2.4.tar.gz 22:13:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:13:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:13:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:16 INFO - Downloading docopt-0.6.1.tar.gz 22:13:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:13:16 INFO - Installing collected packages: blobuploader, requests, docopt 22:13:16 INFO - Running setup.py install for blobuploader 22:13:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:13:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:13:16 INFO - Running setup.py install for requests 22:13:16 INFO - Running setup.py install for docopt 22:13:16 INFO - Successfully installed blobuploader requests docopt 22:13:16 INFO - Cleaning up... 22:13:16 INFO - Return code: 0 22:13:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:17 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 0x119e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151a140>, '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 0x151aa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151aed0>, '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': '9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070', '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 22:13:17 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 22:13:17 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 22:13:17 INFO - Using env: {'DISPLAY': ':0', 22:13:17 INFO - 'HOME': '/home/cltbld', 22:13:17 INFO - 'LANG': 'en_US.UTF-8', 22:13:17 INFO - 'LANGUAGE': 'en_US:en', 22:13:17 INFO - 'LOGNAME': 'cltbld', 22:13:17 INFO - 'MAIL': '/var/mail/cltbld', 22:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:17 INFO - 'MOZ_NO_REMOTE': '1', 22:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:17 INFO - 'NO_EM_RESTART': '1', 22:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:17 INFO - 'PWD': '/builds/slave/test', 22:13:17 INFO - 'SHELL': '/bin/bash', 22:13:17 INFO - 'SHLVL': '1', 22:13:17 INFO - 'TERM': 'linux', 22:13:17 INFO - 'TMOUT': '86400', 22:13:17 INFO - 'USER': 'cltbld', 22:13:17 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070', 22:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:17 INFO - '_': '/tools/buildbot/bin/python'} 22:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:13:17 INFO - Running setup.py (path:/tmp/pip-eo88nv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:13:17 INFO - Running setup.py (path:/tmp/pip-MwvgVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:13:17 INFO - Running setup.py (path:/tmp/pip-ly3khK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:13:17 INFO - Running setup.py (path:/tmp/pip-P5Lyth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:13:17 INFO - Running setup.py (path:/tmp/pip-d5l6NT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:13:17 INFO - Running setup.py (path:/tmp/pip-yyJQbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:13:17 INFO - Running setup.py (path:/tmp/pip-KSaqTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:13:17 INFO - Running setup.py (path:/tmp/pip-9p6nOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:13:17 INFO - Running setup.py (path:/tmp/pip-G9fi_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:13:17 INFO - Running setup.py (path:/tmp/pip-rhqb4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:13:17 INFO - Running setup.py (path:/tmp/pip-zTWpcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:13:18 INFO - Running setup.py (path:/tmp/pip-oxieSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:13:18 INFO - Running setup.py (path:/tmp/pip-5O_5u3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:13:18 INFO - Running setup.py (path:/tmp/pip-xqxyiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:18 INFO - Running setup.py (path:/tmp/pip-_E48nJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:13:18 INFO - Running setup.py (path:/tmp/pip-81h1Ku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:13:18 INFO - Running setup.py (path:/tmp/pip-2AQolT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:13:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:13:18 INFO - Running setup.py install for manifestparser 22:13:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:13:18 INFO - Running setup.py install for mozcrash 22:13:18 INFO - Running setup.py install for mozdebug 22:13:18 INFO - Running setup.py install for mozdevice 22:13:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:13:18 INFO - Running setup.py install for mozfile 22:13:18 INFO - Running setup.py install for mozhttpd 22:13:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:13:19 INFO - Running setup.py install for mozinfo 22:13:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:13:19 INFO - Running setup.py install for mozInstall 22:13:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:13:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:13:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:13:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:13:19 INFO - Running setup.py install for mozleak 22:13:19 INFO - Running setup.py install for mozlog 22:13:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:13:19 INFO - Running setup.py install for moznetwork 22:13:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:13:19 INFO - Running setup.py install for mozprocess 22:13:19 INFO - Running setup.py install for mozprofile 22:13:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:13:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:13:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:13:19 INFO - Running setup.py install for mozrunner 22:13:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:13:19 INFO - Running setup.py install for mozscreenshot 22:13:20 INFO - Running setup.py install for moztest 22:13:20 INFO - Running setup.py install for mozversion 22:13:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:13:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:13:20 INFO - Cleaning up... 22:13:20 INFO - Return code: 0 22:13:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:20 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 0x119e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151a140>, '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 0x151aa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151aed0>, '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': '9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070', '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 22:13:20 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 22:13:20 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 22:13:20 INFO - Using env: {'DISPLAY': ':0', 22:13:20 INFO - 'HOME': '/home/cltbld', 22:13:20 INFO - 'LANG': 'en_US.UTF-8', 22:13:20 INFO - 'LANGUAGE': 'en_US:en', 22:13:20 INFO - 'LOGNAME': 'cltbld', 22:13:20 INFO - 'MAIL': '/var/mail/cltbld', 22:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:20 INFO - 'MOZ_NO_REMOTE': '1', 22:13:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:20 INFO - 'NO_EM_RESTART': '1', 22:13:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:20 INFO - 'PWD': '/builds/slave/test', 22:13:20 INFO - 'SHELL': '/bin/bash', 22:13:20 INFO - 'SHLVL': '1', 22:13:20 INFO - 'TERM': 'linux', 22:13:20 INFO - 'TMOUT': '86400', 22:13:20 INFO - 'USER': 'cltbld', 22:13:20 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070', 22:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:20 INFO - '_': '/tools/buildbot/bin/python'} 22:13:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:13:20 INFO - Running setup.py (path:/tmp/pip-poVw0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:13:20 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)) 22:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:13:20 INFO - Running setup.py (path:/tmp/pip-3ZMIP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:13:20 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)) 22:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:13:20 INFO - Running setup.py (path:/tmp/pip-6IeOgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:13:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:13:20 INFO - Running setup.py (path:/tmp/pip-PIIouB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:13:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 22:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:13:20 INFO - Running setup.py (path:/tmp/pip-iro42q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:13:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:13:20 INFO - Running setup.py (path:/tmp/pip-aT0WnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:13:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:13:20 INFO - Running setup.py (path:/tmp/pip-MVc007-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:13:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 22:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:13:20 INFO - Running setup.py (path:/tmp/pip-861CIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:13:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 22:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:13:21 INFO - Running setup.py (path:/tmp/pip-ltpV_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:13:21 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)) 22:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:13:21 INFO - Running setup.py (path:/tmp/pip-wOyF3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:13:21 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)) 22:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:13:21 INFO - Running setup.py (path:/tmp/pip-evVa5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:13:21 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)) 22:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:13:21 INFO - Running setup.py (path:/tmp/pip-ZVcn_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:13:21 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)) 22:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:13:21 INFO - Running setup.py (path:/tmp/pip-LGBT9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:13:21 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)) 22:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:13:21 INFO - Running setup.py (path:/tmp/pip-r7BQlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:13:21 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)) 22:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:21 INFO - Running setup.py (path:/tmp/pip-2e1cMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:21 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)) 22:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:13:21 INFO - Running setup.py (path:/tmp/pip-i8BBY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:13:21 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)) 22:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:13:21 INFO - Running setup.py (path:/tmp/pip-AXcc9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:13:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:13:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:13:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:13:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:13:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:13:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:13:21 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:13:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:22 INFO - Downloading blessings-1.6.tar.gz 22:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:13:22 INFO - Installing collected packages: blessings 22:13:22 INFO - Running setup.py install for blessings 22:13:22 INFO - Successfully installed blessings 22:13:22 INFO - Cleaning up... 22:13:23 INFO - Return code: 0 22:13:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:13:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:13:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:13:23 INFO - Reading from file tmpfile_stdout 22:13:23 INFO - Current package versions: 22:13:23 INFO - argparse == 1.2.1 22:13:23 INFO - blessings == 1.6 22:13:23 INFO - blobuploader == 1.2.4 22:13:23 INFO - docopt == 0.6.1 22:13:23 INFO - functools32 == 3.2.3-2 22:13:23 INFO - jsonschema == 2.5.1 22:13:23 INFO - manifestparser == 1.1 22:13:23 INFO - mozInstall == 1.13 22:13:23 INFO - mozcrash == 1.0 22:13:23 INFO - mozdebug == 0.1 22:13:23 INFO - mozdevice == 0.51 22:13:23 INFO - mozfile == 1.2 22:13:23 INFO - mozhttpd == 0.7 22:13:23 INFO - mozinfo == 0.10 22:13:23 INFO - mozleak == 0.1 22:13:23 INFO - mozlog == 3.4 22:13:23 INFO - moznetwork == 0.27 22:13:23 INFO - mozprocess == 0.25 22:13:23 INFO - mozprofile == 0.28 22:13:23 INFO - mozrunner == 6.13 22:13:23 INFO - mozscreenshot == 0.1 22:13:23 INFO - mozsystemmonitor == 0.3 22:13:23 INFO - moztest == 0.8 22:13:23 INFO - mozversion == 1.4 22:13:23 INFO - psutil == 3.1.1 22:13:23 INFO - requests == 1.2.3 22:13:23 INFO - wsgiref == 0.1.2 22:13:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:23 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 0x119e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151a140>, '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 0x151aa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151aed0>, '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': '9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070', '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 22:13:23 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 22:13:23 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 22:13:23 INFO - Using env: {'DISPLAY': ':0', 22:13:23 INFO - 'HOME': '/home/cltbld', 22:13:23 INFO - 'LANG': 'en_US.UTF-8', 22:13:23 INFO - 'LANGUAGE': 'en_US:en', 22:13:23 INFO - 'LOGNAME': 'cltbld', 22:13:23 INFO - 'MAIL': '/var/mail/cltbld', 22:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:23 INFO - 'MOZ_NO_REMOTE': '1', 22:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:23 INFO - 'NO_EM_RESTART': '1', 22:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:23 INFO - 'PWD': '/builds/slave/test', 22:13:23 INFO - 'SHELL': '/bin/bash', 22:13:23 INFO - 'SHLVL': '1', 22:13:23 INFO - 'TERM': 'linux', 22:13:23 INFO - 'TMOUT': '86400', 22:13:23 INFO - 'USER': 'cltbld', 22:13:23 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070', 22:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:23 INFO - '_': '/tools/buildbot/bin/python'} 22:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:23 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)) 22:13:23 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)) 22:13:23 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)) 22:13:23 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)) 22:13:23 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)) 22:13:23 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)) 22:13:23 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)) 22:13:23 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)) 22:13:23 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)) 22:13:23 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 22:13:23 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 22:13:23 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 22:13:23 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 22:13:23 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 22:13:24 INFO - Downloading marionette_driver-1.4.0.tar.gz 22:13:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 22:13:24 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)) 22:13:24 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)) 22:13:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 22:13:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 22:13:24 INFO - Installing collected packages: marionette-driver 22:13:24 INFO - Running setup.py install for marionette-driver 22:13:24 INFO - Successfully installed marionette-driver 22:13:24 INFO - Cleaning up... 22:13:24 INFO - Return code: 0 22:13:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1378a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151c9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151a140>, '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 0x151aa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151aed0>, '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': '9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070', '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 22:13:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:13:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:13:24 INFO - Using env: {'DISPLAY': ':0', 22:13:24 INFO - 'HOME': '/home/cltbld', 22:13:24 INFO - 'LANG': 'en_US.UTF-8', 22:13:24 INFO - 'LANGUAGE': 'en_US:en', 22:13:24 INFO - 'LOGNAME': 'cltbld', 22:13:24 INFO - 'MAIL': '/var/mail/cltbld', 22:13:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:24 INFO - 'MOZ_NO_REMOTE': '1', 22:13:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:24 INFO - 'NO_EM_RESTART': '1', 22:13:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:24 INFO - 'PWD': '/builds/slave/test', 22:13:24 INFO - 'SHELL': '/bin/bash', 22:13:24 INFO - 'SHLVL': '1', 22:13:24 INFO - 'TERM': 'linux', 22:13:24 INFO - 'TMOUT': '86400', 22:13:24 INFO - 'USER': 'cltbld', 22:13:24 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070', 22:13:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:24 INFO - '_': '/tools/buildbot/bin/python'} 22:13:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:13:25 INFO - Cleaning up... 22:13:25 INFO - Return code: 0 22:13:25 INFO - Running post-action listener: _resource_record_post_action 22:13:25 INFO - Running post-action listener: _start_resource_monitoring 22:13:25 INFO - Starting resource monitoring. 22:13:25 INFO - [mozharness: 2017-06-21 05:13:25.048022Z] Finished create-virtualenv step (success) 22:13:25 INFO - [mozharness: 2017-06-21 05:13:25.048481Z] Running install step. 22:13:25 INFO - Running pre-action listener: _resource_record_pre_action 22:13:25 INFO - Running main action method: install 22:13:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:13:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:13:25 INFO - Reading from file tmpfile_stdout 22:13:25 INFO - Detecting whether we're running mozinstall >=1.0... 22:13:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:13:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:13:25 INFO - Reading from file tmpfile_stdout 22:13:25 INFO - Output received: 22:13:25 INFO - Usage: mozinstall [options] installer 22:13:25 INFO - Options: 22:13:25 INFO - -h, --help show this help message and exit 22:13:25 INFO - -d DEST, --destination=DEST 22:13:25 INFO - Directory to install application into. [default: 22:13:25 INFO - "/builds/slave/test"] 22:13:25 INFO - --app=APP Application being installed. [default: firefox] 22:13:25 INFO - mkdir: /builds/slave/test/build/application 22:13:25 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'] 22:13:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 22:13:42 INFO - Reading from file tmpfile_stdout 22:13:42 INFO - Output received: 22:13:42 INFO - /builds/slave/test/build/application/firefox/firefox 22:13:42 INFO - Running post-action listener: _resource_record_post_action 22:13:42 INFO - [mozharness: 2017-06-21 05:13:42.695617Z] Finished install step (success) 22:13:42 INFO - [mozharness: 2017-06-21 05:13:42.695894Z] Running setup-mitmproxy step. 22:13:42 INFO - Running pre-action listener: _resource_record_pre_action 22:13:42 INFO - Running main action method: setup_mitmproxy 22:13:42 INFO - Skipping: mitmproxy is not required 22:13:42 INFO - Running post-action listener: _resource_record_post_action 22:13:42 INFO - [mozharness: 2017-06-21 05:13:42.697022Z] Finished setup-mitmproxy step (success) 22:13:42 INFO - [mozharness: 2017-06-21 05:13:42.697252Z] Running run-tests step. 22:13:42 INFO - Running pre-action listener: _resource_record_pre_action 22:13:42 INFO - Running main action method: run_tests 22:13:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:13:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:13:42 INFO - Python 2.7.3 22:13:42 INFO - Return code: 0 22:13:42 INFO - grabbing minidump binary from tooltool 22:13:42 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')]} 22:13:42 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 0x151a140>, '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 0x151aa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x151aed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:13:42 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 22:13:42 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 22:13:42 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 22:13:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:13:42 INFO - Return code: 0 22:13:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:13:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:13:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:13:42 INFO - ENV: RUST_BACKTRACE is now 1 22:13:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:13:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:13:42 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/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 22:13:42 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/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-076 --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 22:13:42 INFO - Using env: {'DISPLAY': ':0', 22:13:42 INFO - 'HOME': '/home/cltbld', 22:13:42 INFO - 'LANG': 'en_US.UTF-8', 22:13:42 INFO - 'LANGUAGE': 'en_US:en', 22:13:42 INFO - 'LOGNAME': 'cltbld', 22:13:42 INFO - 'MAIL': '/var/mail/cltbld', 22:13:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:13:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:13:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:42 INFO - 'MOZ_NO_REMOTE': '1', 22:13:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:13:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:42 INFO - 'NO_EM_RESTART': '1', 22:13:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:42 INFO - 'PWD': '/builds/slave/test', 22:13:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:13:42 INFO - 'RUST_BACKTRACE': '1', 22:13:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 22:13:42 INFO - 'SHELL': '/bin/bash', 22:13:42 INFO - 'SHLVL': '1', 22:13:42 INFO - 'TERM': 'linux', 22:13:42 INFO - 'TMOUT': '86400', 22:13:42 INFO - 'USER': 'cltbld', 22:13:42 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070', 22:13:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:42 INFO - '_': '/tools/buildbot/bin/python'} 22:13:42 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/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 22:13:43 INFO - mozversion application_buildid: 20170621044126 22:13:43 INFO - mozversion application_changeset: e1e4a481b7e88dce163b9cccc2fb72032023befa 22:13:43 INFO - mozversion application_display_name: Nightly 22:13:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:13:43 INFO - mozversion application_name: Firefox 22:13:43 INFO - mozversion application_remotingname: firefox 22:13:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:13:43 INFO - mozversion application_vendor: Mozilla 22:13:43 INFO - mozversion application_version: 56.0a1 22:13:43 INFO - mozversion platform_buildid: 20170621044126 22:13:43 INFO - mozversion platform_changeset: e1e4a481b7e88dce163b9cccc2fb72032023befa 22:13:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:13:43 INFO - mozversion platform_version: 56.0a1 22:13:43 INFO - using testdate: 1498022023 22:13:43 INFO - actual date: 1498022023 22:13:43 INFO - starting webserver on 'localhost:58826' 22:13:43 INFO - SUITE-START | Running 2 tests 22:13:43 INFO - TEST-START | dromaeo_css 22:13:43 INFO - operating with platform_type : linux_ 22:13:43 INFO - Initialising browser for dromaeo_css test... 22:13:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58826/getInfo.html -profile /tmp/tmpebeeX5/profile 22:13:43 INFO - TEST-INFO | started process 10935 (/builds/slave/test/build/application/firefox/firefox http://localhost:58826/getInfo.html) 22:13:49 INFO - TEST-INFO | 10935: exit 0 22:13:50 INFO - Browser initialized. 22:13:50 INFO - Running cycle 1/1 for dromaeo_css test... 22:13:50 INFO - TEST-INFO | started process 11147 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpebeeX5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:14:01 INFO - PID 11147 | RSS: Main: 175509504 22:14:01 INFO - PID 11147 | 22:17:06 INFO - PID 11147 | Cycle 1(1): loaded http://localhost:58826/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58826/tests/dromaeo/cssquery-ext.html) 22:17:08 INFO - PID 11147 | RSS: Main: 177668096 22:17:08 INFO - PID 11147 | 22:20:09 INFO - PID 11147 | Cycle 1(1): loaded http://localhost:58826/tests/dromaeo/cssquery-ext.html (next: http://localhost:58826/tests/dromaeo/cssquery-jquery.html) 22:20:10 INFO - PID 11147 | RSS: Main: 177328128 22:20:10 INFO - PID 11147 | 22:23:11 INFO - PID 11147 | Cycle 1(1): loaded http://localhost:58826/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58826/tests/dromaeo/cssquery-mootools.html) 22:23:12 INFO - PID 11147 | RSS: Main: 181751808 22:23:12 INFO - PID 11147 | 22:26:14 INFO - PID 11147 | Cycle 1(1): loaded http://localhost:58826/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58826/tests/dromaeo/cssquery-prototype.html) 22:26:14 INFO - PID 11147 | RSS: Main: 179085312 22:26:14 INFO - PID 11147 | 22:29:17 INFO - PID 11147 | Cycle 1(1): loaded http://localhost:58826/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58826/tests/dromaeo/cssquery-yui.html) 22:29:18 INFO - PID 11147 | RSS: Main: 180076544 22:29:18 INFO - PID 11147 | 22:32:19 INFO - PID 11147 | Cycle 1(1): loaded http://localhost:58826/tests/dromaeo/cssquery-yui.html (next: http://localhost:58826/tests/dromaeo/cssquery-dojo.html) 22:32:20 INFO - PID 11147 | RSS: Main: 180035584 22:32:20 INFO - PID 11147 | 22:32:20 INFO - PID 11147 | __start_tp_report 22:32:20 INFO - PID 11147 | _x_x_mozilla_page_load 22:32:20 INFO - PID 11147 | _x_x_mozilla_page_load_details 22:32:20 INFO - PID 11147 | |i|pagename|runs| 22:32:20 INFO - PID 11147 | |0;dojo.html;3103.410352033115;3135.9059228223146;3174.936501269973;3180.888668896589;3196.2968147007664;6002.159697642333;6046.879062418754;6115;6125.693326622244;6168.167297414848;6123.755049798014;6148.631809799135;6188.5358598105095;6193.349698281683;6196.411340922617;5662.943370566283;5669.291338582677;5724.542036637059;5743.655380677152;5764.135379693059;5521.668699878021;5618.91571626426;5703.116017017348;5705.885882282352;5712.542996560286;5497.5601951843755;5611.663300202001;5631.493165615073;5728.3126024876865;5734.254546908875;5700.173474846124;5717.142428635696;5719.456651618089;5743.195952566644;5747.195392645033;5624.521915637176;5665.008623490914;5686.601937864351;5696.857578560528;5711.314642242916;5982.132590774313;6146.815595532141;6169.105479705462;6200.720967556471;6208.50331973441;6444.645544495051;6486.318936511692;6542.084108224853;6599.60402375859;6687.197536295627;6544.803655890331;6606.669666516655;6681.164854393201;6704.731810727614;6712.127423434922;5901.76392944286;6152.16945712332;6176.536759743038;6183.474404675653;6190.659513726789;6647.86704265912;6699.564528305742;6719.193696756421;6719.865602688016;6748.392644662004;6278;6349.142865713162;6378.74485020594;6405.263394709575;6421.229452465641;6578.210614726264;6581.177352830896;6622.4039836413995;6635.834104147435;6665.833354166088;6659.9001014984815;6663.033860090357;6670.96664516684;6674.16572928384;6687.364700353459;6635.270120286765;6649.069130321662;6692.163479565054;6695;6715.630640314732;5188.45521220274;5207.140821764367;5249.265102885599;5312.601554883399;5423.240746295522;4561.133384656904;4591.79336929839;4615.192341340252;4651.651126165551;4657.371254880615;5779.162021506942;5800.0429929062075;5803.390643982321;5820.82537523875;5850.531957443394;6601.900971485432;6687.76592819249;6703.865922681519;6711.765088221987;6722.462203023746;5627.155926611041;5796.208106737793;5796.739146738322;5800.361960184377;5804.767809287666;5751.051076572318;5756.481916627524;5761.798337058267;5829.300483941955;5884.35272120075;6314.557980941474;6336.398042185985;6339.049142628458;6410.743570257137;6443.774467893789;6639.435647969976;6651.800445986628;6653.534252602271;6664.83337916556;6671.33286671329;6375.075614036032;6387.489000879826;6390.329015453496;6396;6400.9039864403;6216.906746398898;6382.776602818879;6452.93526568111;6457.225132984072;6511.9348806511325;6479.902801457888;6550.115734375799;6624.171978502687;6650.301718319701;6656.434203092791;6469.644169570719;6475.417212450902;6481.578697384655;6492;6492.318306577741;6448.9032664511005;6457.61254324742;6457.773977910751;6471.385218404244;6486.902696459462;6193.411625895533;6250.843728906813;6306.621602703853;6349.301576826453;6366.77716279928;6261.906071409024;6345.7144428499905;6364.904526432199;6410.262819775786;6450;6239.500839932885;6278.277998030102;6308.968455157695;6355.523335749745;6358.1734374531015 22:32:20 INFO - PID 11147 | |1;ext.html;751.9323260906517;781.8201813582872;795.7016118955391;813.9023317201935;821.2321479416746;38558.61441385585;39699;39731.60268397315;39764.40353394698;39948.20103597926;36225.27549449016;36473.452898206546;36587.817060914655;36657.63342366576;36707.63292367075;6805.455563554904;6899.344562266577;6957.965210173942;7475.813104672399;7613.7335193268245;7539.886901696452;7647.311741943224;7649.235076492334;7654.11977622575;7657.966174566446;7594.5822979736095;7685.577293248869;7687.2697093776005;7699.384049276045;7703.1526532081425;7594.430417718693;7635.350995165418;7636.77089687313;7653.732119375823;7661.655225514865;7514.0231769870115;7561;7591.658375373121;7596.962015189889;7598.6200689965835;36571.08572285714;36736.08159796;36986.630133698585;37017.25965480675;37069.62930370689;3494.318607871466;3519.2433626770367;3523.365794157051;3524.7356448266482;3526;29287.2678183045;29336.559951600742;29489.557656634952;29553;29691.257718556993;3711.1464363196615;3750.2124553843723;3758.9436158457647;3761.360568703327;3817.1983883384523;172786;174971;175242;183188;184099;41115.58884411177;47179.5282047182;48158;48354.27468587974;48503.75748121237;49390.25914611284;49723.50276497261;49839.75080124576;49972;50077;15183.16492592918;15356.923215384075;15417.691646167239;15419.229038548028;15433.691326173413;12706.110572260039;12719.745605088032;12721.93639031799;12732.490700372067;12741.745165096647;14121.152730836182;14141.646458838406;14183.432662693584;14235;14329.283535823168;5861.3845546217035;5874.530037596982;5881.735321910524;5900.468957793733;5962.612430192024;972.8540718892223;976.2043934193609;995.8605795188679;1021.667957913681;1027.6403258859339;21303.25438609641;21542;21582.136714531243;22429.21497747571;22433.878306084956;1063.186662203415;1066.4401189375485;1077.3966578715945;1097.8902109789117;1118.3178261260625;11849;11888.583899563473;12046.51813927433;12101.455434505293;12291.754164916652;237399;239139;239389;239408;239455;48640.51359486431;48682;48791;49296.260556091685;49423.75288123536;1425.3300948554163;1445.8881318332935;1480.970380592382;1482.636753995278;1493.410103009327;21382.893085534473;21691.8289391533;22143.667844982017;22289.888550557793;22522.662160067284;35289;35688.82155589309;35765.642343577274;35796.463053054744;35882.64117358793;197988;198138;198213;198251;199252;32397.51403728993;34572.654273456945;35297.29405411929;36939.26121477609;37102.628973711;42308.94227644333;43383.34924976065;44733.10533789241;44867.55132448634;44951.1009779796;30168.84915575408;30544.08367748971;31515.52726709147;32095.197620058752;33266.33467330688;30843;31226.21934451657;31361.8431907839;32159.839200803846;32671.673283266864;34072;34840.30319393547;34932.12669683278;35807;35828.283434331686;28676.283092922844;30658.386832263677;31084.844575776977;31114.844425777726;31693;22495.601055746174;24645.137420190207;24855.627165592894;24951.87524062368;25405.872970635028 22:32:20 INFO - PID 11147 | |2;jquery.html;561.2675458526624;561.3067861191425;564.5540023381528;576.4811669497452;592.4431034827262;21011.36965891022;22230.221942232027;22330.441738956535;22332.665010024863;22339;23960;24993.12524061658;26052.73947260527;26097.86951065242;26266.474670506577;6505.967470162666;6678.632675202862;6680.498962577802;6681.331866813304;6688.364605362507;6533.31400202979;6575.178102737158;6598.307177746339;6625.238097618787;6627.966860165717;6178.84552886177;6294.43350098491;6413.005984072476;6418.743250269984;6598;6399.456046236052;6476.093346931433;6482.902756458657;6489.740410383555;6496.512761542903;6058.485028772559;6067.939320606782;6072.332043475214;6079;6080.391960803929;26930.326741831414;28054.579181312296;28379.57430638542;28395.57406638902;28549.714502854913;1943.9902800485906;2003.2087325506488;2004.6491863923754;2008.2770202727006;2014.5265862522297;17951.640967180585;18241.452756417195;18383.26466941321;18456;18483.815161848343;2343.402432379732;2366.9053237870467;2403.9639405408934;2418.4558474343307;2421.067888862783;115296;120131.3993430036;120211;120771;120802.99999999913;14288.642783930485;14446.422143114158;14662.853371466148;14937.850621493862;15146.318415671321;23222.65166022511;23386.532269354517;23475.41311467227;23522.882385587964;23546.058157673844;9719.271054670786;9761.463119528353;9779.41323520591;9850.064243896819;9874.753131171778;8744.8688269676;8777.736667899973;8782.033976262606;8890.73327800167;8958.641654333753;8547.529885856338;8917.955410223038;9085.68200113006;9145.759288974245;9232.446053236827;2697;2700.9729902701115;2706.6210730497746;2804.9859750701116;2873.48277310082;969.1277849934974;983.3755565216139;984.1827768014144;1005.7284533176002;1022.8670272864629;18790.436286911416;19564.217431302874;19617.705734413994;19703.525920319295;19760.505987350145;966.9129778319844;978.848278516831;1025.179856115105;1039.875214974208;1046.2780681329857;10503.317284376491;10697.518611662494;10711.517981690842;10844.024037836632;10868.402237876993;420010;427390;444398;448098;450091;93474;94716.52641736747;94780.52609737046;94878;101460.49269753751;1127.419379019822;1129.711923459529;1142.6971852459105;1157.8379026936236;1165.877582853805;15883.920580397024;16110.677786443972;16925.322987080872;17077.91461042687;17090.65818683644;46323.1406195438;47734.522654773005;47798.5220147808;47872.521274788196;48635;60256.69871650614;60296;61062.38937610567;61127.08309375452;61456.385436145065;12287.017038637066;12543.749125017266;12545.49818007306;12739.745205096031;13085.018623603077;18617;18703.438896833115;18820.52948676294;19027.71458428097;19058;14929.776053358992;15605;15866.04803711781;15962.281697323417;16029.118398487728;13612.795808063085;14066.226357550433;14178.220197889215;14204.502842400467;15153.318100685716;15948.760768588712;15987.920060399623;16105.677886441972;16130;16175.110368929822;12979.480820767063;12993.870061299644;13017.544385946447;13043.673908152372;13055.673608159492;14865.10809351399;15198.544043678707;15203.391864325304;15545.84454155444;15661.138637375054 22:32:20 INFO - PID 11147 | |3;mootools.html;1375.2229990055619;1391.6590435343342;1407.7958695989082;1411.5130280053384;1417.7518934186514;12807.935960320197;13186.340682965838;13371.531996380128;13443.395047222873;13450.327483625828;12398.256104633729;13106.279154646514;13143.342832858367;13149.47402103917;13180.20918744876;2487.800975921931;2557.181701855407;2559.296193546771;2561.6669832921693;2577.536043512167;2484.3292311075998;2535.4548772014014;2538.809589280802;2540.7078186008566;2540.745925407463;2477.715062767778;2492.750724927502;2508.3102146909655;2510.535550923076;2514.371407148213;2433.7201221859445;2452.0927256914965;2462.064415522099;2462.6429167770575;2470.987645061781;2408.253441433144;2408.987955060231;2423.345696661909;2431.58663027284;2485.7389974052826;12256.264624122492;12412.937935310356;12414.193077450027;12419.379031048502;12423.378831058411;6808.080909077261;7006.684699188498;7019.859602807966;7022.052022976884;7031.1211098612675;4129.318662420727;4282.828686852522;4340.262155433584;4359.6948213625055;4396.626286765629;1544.637010302578;1558.1897413344998;1578.5580037589493;1604.237986956198;1622.1970124788306;18262.90868545662;18952.336668216685;18956.146973386094;19146.425607231806;19182.712259316122;5476.7535460904355;5629.605927585111;5868.295804503487;6061.757529698851;6259.0924315973925;14590.270486475634;14600.561983140522;14622.195779232032;14629;14634.12195268266;7078.893816592756;7113.359797618135;7147.035150254649;7149.53528020677;7154.177269613957;6383.2978372379;6599.340065993362;6676.399124078856;6686.5653732507235;6717.865642687118;4672.672912896064;4803.663743537989;4923;4968.056069346812;5038.874028149252;1430.034726559568;1431.191376872064;1432.1120905038943;1442.3941944383384;1462.6928345047447;881.0396667632311;896.6278994217326;898.5327629632554;919.5999740113073;927.5779520318239;7879.842403151905;8015.47899386538;8039.959800200962;8151.103378628346;8328.500289982621;970.9174720148725;1000.1448761308976;1011.6610935336597;1026.430331166195;1052.3843551522446;4799.760011999386;4908.975455122773;4957.975210123926;5093.286939828427;5110.591152707774;16414.589635259214;17375.13124343803;17379.826201737822;17388.565285867953;17412.303507859797;17013.319467221172;18054.548636283937;18120.456386308168;18154.273829046953;18196.454106376565;10076.395416275047;10233.48832558369;10239.692809215736;10296.279260451696;10330.741731456623;7505.474616776992;8106.067802202586;8130.959345203236;8315.293200078062;8418.663253469793;13582.660433489242;14161.291935402982;14171.716565668423;15532.844671553592;15539.84460155384;13241.867581324064;13819.101758385672;14009.929950350182;14049;14106.083104598169;10885.401302928414;11111.777764444827;11118.277311974696;11122.721931951766;11123.833142502706;12004.39978001114;12560.811587826007;12658;12697.301648409426;12710.110292279453;9761.658341957997;10146.949265253626;10167.135793457343;10427.322224055411;10466.842997354894;9905.257105716955;9951.452670103214;10192.643257485952;10283.537240824331;10452.477376131315;8370.497770133812;8712.91287087121;8823.382363234768;8887.73336799897;8922.197002269826;6617.636030018202;6795.38841504267;6870.690818913061;6999.1950925644205;7067.328603782633;6846.486513511407;6924.272951340238;7035;7206.89189662166;7308.524945878501 22:32:20 INFO - PID 11147 | |4;prototype.html;491.26186202837636;493.00613614849755;508.1437777345176;517.3171413733871;518.7639623971094;6253.218347706536;6381.4575761060305;6422.903656445157;6432.42108210261;6435.259945106314;6078.696065196734;6253.499720022399;6266.968665156679;6290.905636415458;6298.834715577621;4989.950100499003;5013.924791128136;5019;5022.221555658879;5027.421846487664;5032.949670503303;5036.82371117011;5042.596592272609;5047.394312682465;5054.00366855092;4818.156822556039;5007.774650140753;5010.148274793276;5015.699058056528;5025.84922452327;4975.676581022222;4984.87537811554;4995.675281106753;4999.375078115236;5019.723915184663;4458.799354029076;4481.596656300916;4482.977585112086;4523.954760452386;4530.62794403399;6110.358412366682;6128.3258841527395;6132.325444201134;6136.6011209271255;6140.508759299245;5682.886342273131;5683.589846092353;5690.146478028288;5722.341930677942;5733.770649174028;6653.833654158685;6658.001299805068;6662.5003124765835;6686.331366863324;6687.164104486939;4876.268559716035;4891.4863939286215;4893.975530122362;4903.41159060915;4905.337779399771;7038.859222815515;7039.436845052383;7051.6474176291495;7069.151701795818;7135.072440582691;5007.549320561094;5050.191969284897;5064.620153488503;5078.21287700407;5082.822101226513;5094.5160209780015;5105.5149760772665;5112.207607820794;5131.589472842164;5150.536451719363;5716.885662286731;5740.56945729072;5759.366469688331;5769.682667453247;5772.09372033768;6748.527603067836;6754.797356079325;6759.966200169066;6760.357766012221;6810.523263371616;1664.0514906503176;1744.3633073927924;1770.2564922732483;1774.3523613881098;1775.0947017021413;1184.3604453594962;1207.3902679146975;1231.4396949388006;1238.2694210415898;1246.7818131826893;5629.549636029108;5787.1319302104175;5842.211301474332;5897.174395584621;5905.911411328833;6741.2921643226755;6779.966100169468;6820.079289295981;6843.418309443654;6856.725730970706;5866.823995280063;5889.882202355929;5890.587658863838;5899.318694172141;5903.35063143054;3620.185458271868;3632.328019316435;3642.85428582859;3644.835982380799;3649.50731651229;6588.53880228389;6638.933610663928;6652.434543063797;6664.000799760052;6686.331366863372;6969.930300697029;7018.473614478832;7055.7177712891935;7059.788206353817;7067.187273463514;6624.171978502687;6636.942547810194;6637.1703537057865;6657.500687448461;6677.232118306457;6745.5952642841585;6828.692708828214;6846.4522838173825;6856.760013399507;6863.862722745417;6780.1524809398825;6792.286809884891;6796.966015169893;6808.761693340709;6837.418819400406;6390.025326319906;6628.635425051669;6673.564149085646;6674.866502670016;6679.732810687518;5369.19462080691;5386.676799392049;5495.835124946258;5520.834374968757;5574.9721251393485;6839.179298484015;6880.449564034965;6897.896531552131;6905;6917.169939607279;6634.170728658918;6656.400923916871;6657.3009833966735;6706.597604143767;6708.966455167693;6675.429959465738;6691.933080669131;6701.865962680621;6719.160104986877;6734.427573656294;6614.603123812587;6615.702293396905;6622.377517508241;6666.633335166613;6678.933210667831;6682.131322927989;6725.764598239038;6758.391744742997;6764.425023872829;6765.830854228684;6454.870902581828;6494.7077381517;6499.5775274607;6507.893658078044;6546.901796472961 22:32:20 INFO - PID 11147 | |5;yui.html;827.520038377741;872.4242000279814;872.8690696395544;873.0570983337996;882.7484167012401;17354.392596259135;17765.20056597453;18003.369882054132;18055.548611284725;18143.36498222561;16856.66286674269;16885.83114168858;16972.4059657912;17872.195751191197;19154.521136971583;1058.5077938758495;1073.1629329123257;1075.6289080267295;1081.361996422111;1082.3289560472517;1078.6494389323461;1080.8756992945832;1082.5615625671576;1083.0360978728938;1083.5611577311201;1131.9264247823864;1139.0375133012592;1139.6524060161648;1147.1339138950123;1147.741758104428;1019;1050.4852622215099;1090.5310716391948;1100.4882729530727;1110.2062025651658;795.9005124359455;797.1908512859452;797.2904115337354;798.3134504326275;801.9719309824128;18052.54868628295;18187.54531136732;18286;18321.08394580279;18421.907890460596;19300.420987370402;19938.60122797536;20172.29396971099;20206.29277975264;20250.189992400286;15440.536783896501;15818.604534886605;15819.762703559456;15902.681946361125;15963.92018039914;3499.947500787465;3577.8568857245677;3580.3555360035184;3595.856165753393;3611.20553478237;94823;95200.52399738027;97819.51090244575;98382.50808745911;100145;16304.918475407785;16530.09084500364;16582.668346633;16674.49976500707;16740.41408550695;26905.596416053773;27792.44415111727;28286.009989650265;28381.432371352457;28500.572491412644;8622.78443038929;8650.913490865136;8690;8700.477971321741;8711.60797764102;4063.89840253996;4114.7119701620595;4162.167566486714;4189.497260328719;4302.806373713191;4907.533784290486;5040.193569028937;5047.268146118792;5047.4952504749235;5057.393112826484;1009.8030883977553;1032.1330082730392;1044.1698849414734;1044.827603445423;1050.3487837540774;670.7216505150406;670.872534218497;674.1573033707865;701.03607539633;706.2231545300232;11432.828507572392;11533;11534.884651153548;11883.643490695293;11941.52233910634;672.8351553869236;683.7435961514432;688.5834070387443;706.7385067524946;717.6447658409121;5147.3051138096625;5234.424213336606;5312.707801070978;5407.405185429599;5543.445655434505;88895;91342.54328728447;91428.54285728528;93269.06730932604;95166;75940.62029689817;79181.60409197917;82581;86149;88015.55992219997;67969.3203067973;72563.2743672567;73055;73166.26833731595;73244.63377683077;11541.480633371686;12358.62924112278;12368.319742414255;12382.81425778596;12404;32740.67259327376;33021.33957320888;33450.49824252687;33471.330573388885;33619.327613448084;41252;41309.58690413057;59624.70187649034;61021.42378825817;64263;17628.471145865133;18636.534086647942;18718;19036.238550457827;19120.23519059222;19633.901830490755;20216.49458763484;20493.692594610795;20786.688199676715;21008.894955525124;19005.71491427602;19070.809291906902;19079;19202.519937001685;19472.221111155395;18555.35056273024;18640;18867.90566047161;19076.713849292548;19351;17827.732584011508;18039.909800450914;18513.166907489463;18547.44357669272;18734.812651873854;11970.700732481757;12526.624201273977;12531.18547294423;12881.806772898226;13732.65668358299;13781.86218137846;14605.561833145022;14646.26768661584;14670.63323416923;14741.484048058266 22:32:20 INFO - PID 11147 | __end_tp_report 22:32:20 INFO - PID 11147 | __start_cc_report 22:32:20 INFO - PID 11147 | _x_x_mozilla_cycle_collect,336 22:32:20 INFO - PID 11147 | __end_cc_report 22:32:20 INFO - PID 11147 | __startTimestamp1498023140123__endTimestamp 22:32:20 INFO - PID 11147 | 22:32:20 INFO - PID 11147 | ------- Summary: start ------- 22:32:20 INFO - PID 11147 | Number of tests: 6 22:32:20 INFO - PID 11147 | 22:32:20 INFO - PID 11147 | [#0] dojo.html Cycles:165 Average:6079.00 Median:6306.62 stddev:703.83 (11.2%) stddev-sans-first:666.16 22:32:20 INFO - PID 11147 | Values: 3103.4 3135.9 3174.9 3180.9 3196.3 6002.2 6046.9 6115.0 6125.7 6168.2 6123.8 6148.6 6188.5 6193.3 6196.4 5662.9 5669.3 5724.5 5743.7 5764.1 5521.7 5618.9 5703.1 5705.9 5712.5 5497.6 5611.7 5631.5 5728.3 5734.3 5700.2 5717.1 5719.5 5743.2 5747.2 5624.5 5665.0 5686.6 5696.9 5711.3 5982.1 6146.8 6169.1 6200.7 6208.5 6444.6 6486.3 6542.1 6599.6 6687.2 6544.8 6606.7 6681.2 6704.7 6712.1 5901.8 6152.2 6176.5 6183.5 6190.7 6647.9 6699.6 6719.2 6719.9 6748.4 6278.0 6349.1 6378.7 6405.3 6421.2 6578.2 6581.2 6622.4 6635.8 6665.8 6659.9 6663.0 6671.0 6674.2 6687.4 6635.3 6649.1 6692.2 6695.0 6715.6 5188.5 5207.1 5249.3 5312.6 5423.2 4561.1 4591.8 4615.2 4651.7 4657.4 5779.2 5800.0 5803.4 5820.8 5850.5 6601.9 6687.8 6703.9 6711.8 6722.5 5627.2 5796.2 5796.7 5800.4 5804.8 5751.1 5756.5 5761.8 5829.3 5884.4 6314.6 6336.4 6339.0 6410.7 6443.8 6639.4 6651.8 6653.5 6664.8 6671.3 6375.1 6387.5 6390.3 6396.0 6400.9 6216.9 6382.8 6452.9 6457.2 6511.9 6479.9 6550.1 6624.2 6650.3 6656.4 6469.6 6475.4 6481.6 6492.0 6492.3 6448.9 6457.6 6457.8 6471.4 6486.9 6193.4 6250.8 6306.6 6349.3 6366.8 6261.9 6345.7 6364.9 6410.3 6450.0 6239.5 6278.3 6309.0 6355.5 6358.2 22:32:20 INFO - PID 11147 | 22:32:20 INFO - PID 11147 | [#1] ext.html Cycles:180 Average:36804.90 Median:3525.37 stddev:53609.81 (1520.7%) stddev-sans-first:53691.85 22:32:20 INFO - PID 11147 | Values: 751.9 781.8 795.7 813.9 821.2 38558.6 39699.0 39731.6 39764.4 39948.2 36225.3 36473.5 36587.8 36657.6 36707.6 6805.5 6899.3 6958.0 7475.8 7613.7 7539.9 7647.3 7649.2 7654.1 7658.0 7594.6 7685.6 7687.3 7699.4 7703.2 7594.4 7635.4 7636.8 7653.7 7661.7 7514.0 7561.0 7591.7 7597.0 7598.6 36571.1 36736.1 36986.6 37017.3 37069.6 3494.3 3519.2 3523.4 3524.7 3526.0 29287.3 29336.6 29489.6 29553.0 29691.3 3711.1 3750.2 3758.9 3761.4 3817.2 172786.0 174971.0 175242.0 183188.0 184099.0 41115.6 47179.5 48158.0 48354.3 48503.8 49390.3 49723.5 49839.8 49972.0 50077.0 15183.2 15356.9 15417.7 15419.2 15433.7 12706.1 12719.7 12721.9 12732.5 12741.7 14121.2 14141.6 14183.4 14235.0 14329.3 5861.4 5874.5 5881.7 5900.5 5962.6 972.9 976.2 995.9 1021.7 1027.6 21303.3 21542.0 21582.1 22429.2 22433.9 1063.2 1066.4 1077.4 1097.9 1118.3 11849.0 11888.6 12046.5 12101.5 12291.8 237399.0 239139.0 239389.0 239408.0 239455.0 48640.5 48682.0 48791.0 49296.3 49423.8 1425.3 1445.9 1481.0 1482.6 1493.4 21382.9 21691.8 22143.7 22289.9 22522.7 35289.0 35688.8 35765.6 35796.5 35882.6 197988.0 198138.0 198213.0 198251.0 199252.0 32397.5 34572.7 35297.3 36939.3 37102.6 42308.9 43383.3 44733.1 44867.6 44951.1 30168.8 30544.1 31515.5 32095.2 33266.3 30843.0 31226.2 31361.8 32159.8 32671.7 34072.0 34840.3 34932.1 35807.0 35828.3 28676.3 30658.4 31084.8 31114.8 31693.0 22495.6 24645.1 24855.6 24951.9 25405.9 22:32:20 INFO - PID 11147 | 22:32:20 INFO - PID 11147 | [#2] jquery.html Cycles:180 Average:31030.14 Median:23534.47 stddev:73361.23 (311.7%) stddev-sans-first:73531.36 22:32:20 INFO - PID 11147 | Values: 561.3 561.3 564.6 576.5 592.4 21011.4 22230.2 22330.4 22332.7 22339.0 23960.0 24993.1 26052.7 26097.9 26266.5 6506.0 6678.6 6680.5 6681.3 6688.4 6533.3 6575.2 6598.3 6625.2 6628.0 6178.8 6294.4 6413.0 6418.7 6598.0 6399.5 6476.1 6482.9 6489.7 6496.5 6058.5 6067.9 6072.3 6079.0 6080.4 26930.3 28054.6 28379.6 28395.6 28549.7 1944.0 2003.2 2004.6 2008.3 2014.5 17951.6 18241.5 18383.3 18456.0 18483.8 2343.4 2366.9 2404.0 2418.5 2421.1 115296.0 120131.4 120211.0 120771.0 120803.0 14288.6 14446.4 14662.9 14937.9 15146.3 23222.7 23386.5 23475.4 23522.9 23546.1 9719.3 9761.5 9779.4 9850.1 9874.8 8744.9 8777.7 8782.0 8890.7 8958.6 8547.5 8918.0 9085.7 9145.8 9232.4 2697.0 2701.0 2706.6 2805.0 2873.5 969.1 983.4 984.2 1005.7 1022.9 18790.4 19564.2 19617.7 19703.5 19760.5 966.9 978.8 1025.2 1039.9 1046.3 10503.3 10697.5 10711.5 10844.0 10868.4 420010.0 427390.0 444398.0 448098.0 450091.0 93474.0 94716.5 94780.5 94878.0 101460.5 1127.4 1129.7 1142.7 1157.8 1165.9 15883.9 16110.7 16925.3 17077.9 17090.7 46323.1 47734.5 47798.5 47872.5 48635.0 60256.7 60296.0 61062.4 61127.1 61456.4 12287.0 12543.7 12545.5 12739.7 13085.0 18617.0 18703.4 18820.5 19027.7 19058.0 14929.8 15605.0 15866.0 15962.3 16029.1 13612.8 14066.2 14178.2 14204.5 15153.3 15948.8 15987.9 16105.7 16130.0 16175.1 12979.5 12993.9 13017.5 13043.7 13055.7 14865.1 15198.5 15203.4 15545.8 15661.1 22:32:20 INFO - PID 11147 | 22:32:20 INFO - PID 11147 | [#3] mootools.html Cycles:180 Average:8007.58 Median:2442.91 stddev:5187.05 (212.3%) stddev-sans-first:5177.66 22:32:20 INFO - PID 11147 | Values: 1375.2 1391.7 1407.8 1411.5 1417.8 12807.9 13186.3 13371.5 13443.4 13450.3 12398.3 13106.3 13143.3 13149.5 13180.2 2487.8 2557.2 2559.3 2561.7 2577.5 2484.3 2535.5 2538.8 2540.7 2540.7 2477.7 2492.8 2508.3 2510.5 2514.4 2433.7 2452.1 2462.1 2462.6 2471.0 2408.3 2409.0 2423.3 2431.6 2485.7 12256.3 12412.9 12414.2 12419.4 12423.4 6808.1 7006.7 7019.9 7022.1 7031.1 4129.3 4282.8 4340.3 4359.7 4396.6 1544.6 1558.2 1578.6 1604.2 1622.2 18262.9 18952.3 18956.1 19146.4 19182.7 5476.8 5629.6 5868.3 6061.8 6259.1 14590.3 14600.6 14622.2 14629.0 14634.1 7078.9 7113.4 7147.0 7149.5 7154.2 6383.3 6599.3 6676.4 6686.6 6717.9 4672.7 4803.7 4923.0 4968.1 5038.9 1430.0 1431.2 1432.1 1442.4 1462.7 881.0 896.6 898.5 919.6 927.6 7879.8 8015.5 8040.0 8151.1 8328.5 970.9 1000.1 1011.7 1026.4 1052.4 4799.8 4909.0 4958.0 5093.3 5110.6 16414.6 17375.1 17379.8 17388.6 17412.3 17013.3 18054.5 18120.5 18154.3 18196.5 10076.4 10233.5 10239.7 10296.3 10330.7 7505.5 8106.1 8131.0 8315.3 8418.7 13582.7 14161.3 14171.7 15532.8 15539.8 13241.9 13819.1 14009.9 14049.0 14106.1 10885.4 11111.8 11118.3 11122.7 11123.8 12004.4 12560.8 12658.0 12697.3 12710.1 9761.7 10146.9 10167.1 10427.3 10466.8 9905.3 9951.5 10192.6 10283.5 10452.5 8370.5 8712.9 8823.4 8887.7 8922.2 6617.6 6795.4 6870.7 6999.2 7067.3 6846.5 6924.3 7035.0 7206.9 7308.5 22:32:20 INFO - PID 11147 | 22:32:20 INFO - PID 11147 | [#4] prototype.html Cycles:180 Average:5614.08 Median:6196.86 stddev:1590.67 (25.7%) stddev-sans-first:1547.96 22:32:20 INFO - PID 11147 | Values: 491.3 493.0 508.1 517.3 518.8 6253.2 6381.5 6422.9 6432.4 6435.3 6078.7 6253.5 6267.0 6290.9 6298.8 4990.0 5013.9 5019.0 5022.2 5027.4 5032.9 5036.8 5042.6 5047.4 5054.0 4818.2 5007.8 5010.1 5015.7 5025.8 4975.7 4984.9 4995.7 4999.4 5019.7 4458.8 4481.6 4483.0 4524.0 4530.6 6110.4 6128.3 6132.3 6136.6 6140.5 5682.9 5683.6 5690.1 5722.3 5733.8 6653.8 6658.0 6662.5 6686.3 6687.2 4876.3 4891.5 4894.0 4903.4 4905.3 7038.9 7039.4 7051.6 7069.2 7135.1 5007.5 5050.2 5064.6 5078.2 5082.8 5094.5 5105.5 5112.2 5131.6 5150.5 5716.9 5740.6 5759.4 5769.7 5772.1 6748.5 6754.8 6760.0 6760.4 6810.5 1664.1 1744.4 1770.3 1774.4 1775.1 1184.4 1207.4 1231.4 1238.3 1246.8 5629.5 5787.1 5842.2 5897.2 5905.9 6741.3 6780.0 6820.1 6843.4 6856.7 5866.8 5889.9 5890.6 5899.3 5903.4 3620.2 3632.3 3642.9 3644.8 3649.5 6588.5 6638.9 6652.4 6664.0 6686.3 6969.9 7018.5 7055.7 7059.8 7067.2 6624.2 6636.9 6637.2 6657.5 6677.2 6745.6 6828.7 6846.5 6856.8 6863.9 6780.2 6792.3 6797.0 6808.8 6837.4 6390.0 6628.6 6673.6 6674.9 6679.7 5369.2 5386.7 5495.8 5520.8 5575.0 6839.2 6880.4 6897.9 6905.0 6917.2 6634.2 6656.4 6657.3 6706.6 6709.0 6675.4 6691.9 6701.9 6719.2 6734.4 6614.6 6615.7 6622.4 6666.6 6678.9 6682.1 6725.8 6758.4 6764.4 6765.8 6454.9 6494.7 6499.6 6507.9 6546.9 22:32:20 INFO - PID 11147 | 22:32:20 INFO - PID 11147 | [#5] yui.html Cycles:180 Average:20726.43 Median:19411.61 stddev:25812.77 (133.0%) stddev-sans-first:25841.93 22:32:20 INFO - PID 11147 | Values: 827.5 872.4 872.9 873.1 882.7 17354.4 17765.2 18003.4 18055.5 18143.4 16856.7 16885.8 16972.4 17872.2 19154.5 1058.5 1073.2 1075.6 1081.4 1082.3 1078.6 1080.9 1082.6 1083.0 1083.6 1131.9 1139.0 1139.7 1147.1 1147.7 1019.0 1050.5 1090.5 1100.5 1110.2 795.9 797.2 797.3 798.3 802.0 18052.5 18187.5 18286.0 18321.1 18421.9 19300.4 19938.6 20172.3 20206.3 20250.2 15440.5 15818.6 15819.8 15902.7 15963.9 3499.9 3577.9 3580.4 3595.9 3611.2 94823.0 95200.5 97819.5 98382.5 100145.0 16304.9 16530.1 16582.7 16674.5 16740.4 26905.6 27792.4 28286.0 28381.4 28500.6 8622.8 8650.9 8690.0 8700.5 8711.6 4063.9 4114.7 4162.2 4189.5 4302.8 4907.5 5040.2 5047.3 5047.5 5057.4 1009.8 1032.1 1044.2 1044.8 1050.3 670.7 670.9 674.2 701.0 706.2 11432.8 11533.0 11534.9 11883.6 11941.5 672.8 683.7 688.6 706.7 717.6 5147.3 5234.4 5312.7 5407.4 5543.4 88895.0 91342.5 91428.5 93269.1 95166.0 75940.6 79181.6 82581.0 86149.0 88015.6 67969.3 72563.3 73055.0 73166.3 73244.6 11541.5 12358.6 12368.3 12382.8 12404.0 32740.7 33021.3 33450.5 33471.3 33619.3 41252.0 41309.6 59624.7 61021.4 64263.0 17628.5 18636.5 18718.0 19036.2 19120.2 19633.9 20216.5 20493.7 20786.7 21008.9 19005.7 19070.8 19079.0 19202.5 19472.2 18555.4 18640.0 18867.9 19076.7 19351.0 17827.7 18039.9 18513.2 18547.4 18734.8 11970.7 12526.6 12531.2 12881.8 13732.7 13781.9 14605.6 14646.3 14670.6 14741.5 22:32:20 INFO - PID 11147 | -------- Summary: end -------- 22:32:20 INFO - PID 11147 | 22:32:20 INFO - TEST-INFO | 11147: exit 0 22:32:20 INFO - TEST-OK | dromaeo_css | took 1117717ms 22:32:20 INFO - TEST-START | kraken 22:32:20 INFO - operating with platform_type : linux_ 22:32:20 INFO - Initialising browser for kraken test... 22:32:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58826/getInfo.html -profile /tmp/tmp6AOv_9/profile 22:32:20 INFO - TEST-INFO | started process 11552 (/builds/slave/test/build/application/firefox/firefox http://localhost:58826/getInfo.html) 22:32:27 INFO - TEST-INFO | 11552: exit 0 22:32:27 INFO - Browser initialized. 22:32:27 INFO - Running cycle 1/1 for kraken test... 22:32:27 INFO - TEST-INFO | started process 11763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6AOv_9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:32:38 INFO - PID 11763 | RSS: Main: 175435776 22:32:38 INFO - PID 11763 | 22:32:41 INFO - PID 11763 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58826/tests/kraken/driver.html?testName=audio-beat-detection) 22:32:42 INFO - PID 11763 | RSS: Main: 178692096 22:32:42 INFO - PID 11763 | 22:32:45 INFO - PID 11763 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58826/tests/kraken/driver.html?testName=audio-dft) 22:32:45 INFO - PID 11763 | RSS: Main: 179167232 22:32:45 INFO - PID 11763 | 22:32:48 INFO - PID 11763 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58826/tests/kraken/driver.html?testName=audio-fft) 22:32:49 INFO - PID 11763 | RSS: Main: 175226880 22:32:49 INFO - PID 11763 | 22:32:51 INFO - PID 11763 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58826/tests/kraken/driver.html?testName=audio-oscillator) 22:32:51 INFO - PID 11763 | RSS: Main: 176414720 22:32:51 INFO - PID 11763 | 22:32:54 INFO - PID 11763 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58826/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:32:54 INFO - PID 11763 | RSS: Main: 176025600 22:32:54 INFO - PID 11763 | 22:32:57 INFO - PID 11763 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58826/tests/kraken/driver.html?testName=imaging-darkroom) 22:32:58 INFO - PID 11763 | RSS: Main: 179486720 22:32:58 INFO - PID 11763 | 22:33:01 INFO - PID 11763 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58826/tests/kraken/driver.html?testName=imaging-desaturate) 22:33:02 INFO - PID 11763 | RSS: Main: 180801536 22:33:02 INFO - PID 11763 | 22:33:05 INFO - PID 11763 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58826/tests/kraken/driver.html?testName=json-parse-financial) 22:33:05 INFO - PID 11763 | RSS: Main: 180441088 22:33:05 INFO - PID 11763 | 22:33:07 INFO - PID 11763 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58826/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:33:08 INFO - PID 11763 | RSS: Main: 179982336 22:33:08 INFO - PID 11763 | 22:33:09 INFO - PID 11763 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58826/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:33:10 INFO - PID 11763 | RSS: Main: 180027392 22:33:10 INFO - PID 11763 | 22:33:12 INFO - PID 11763 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58826/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:33:13 INFO - PID 11763 | RSS: Main: 179625984 22:33:13 INFO - PID 11763 | 22:33:15 INFO - PID 11763 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:33:16 INFO - PID 11763 | RSS: Main: 179781632 22:33:16 INFO - PID 11763 | 22:33:19 INFO - PID 11763 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:33:20 INFO - PID 11763 | RSS: Main: 179601408 22:33:20 INFO - PID 11763 | 22:33:21 INFO - PID 11763 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58826/tests/kraken/driver.html?testName=ai-astar) 22:33:22 INFO - PID 11763 | RSS: Main: 181071872 22:33:22 INFO - PID 11763 | 22:33:22 INFO - PID 11763 | __start_tp_report 22:33:22 INFO - PID 11763 | _x_x_mozilla_page_load 22:33:22 INFO - PID 11763 | _x_x_mozilla_page_load_details 22:33:22 INFO - PID 11763 | |i|pagename|runs| 22:33:22 INFO - PID 11763 | |0;ai-astar;100;109;108;107;106;107;108;110;112;108 22:33:22 INFO - PID 11763 | |1;audio-beat-detection;152;119;150;176;122;147;144;127;168;121 22:33:22 INFO - PID 11763 | |2;audio-dft;166;164;162;163;162;164;164;171;177;166 22:33:22 INFO - PID 11763 | |3;audio-fft;74;74;76;167;78;74;74;73;97;75 22:33:22 INFO - PID 11763 | |4;audio-oscillator;82;81;144;82;82;82;152;83;83;150 22:33:22 INFO - PID 11763 | |5;imaging-gaussian-blur;113;113;114;114;115;114;113;113;114;114 22:33:22 INFO - PID 11763 | |6;imaging-darkroom;152;150;151;152;151;150;150;150;150;150 22:33:22 INFO - PID 11763 | |7;imaging-desaturate;94;95;95;95;95;94;94;94;95;95 22:33:22 INFO - PID 11763 | |8;json-parse-financial;54;55;57;54;56;57;57;54;55;59 22:33:22 INFO - PID 11763 | |9;json-stringify-tinderbox;54;54;54;53;53;54;54;53;61;53 22:33:22 INFO - PID 11763 | |10;stanford-crypto-aes;79;78;77;77;77;85;75;77;75;79 22:33:22 INFO - PID 11763 | |11;stanford-crypto-ccm;142;137;133;133;127;130;131;133;131;157 22:33:22 INFO - PID 11763 | |12;stanford-crypto-pbkdf2;183;193;179;181;183;198;183;179;179;187 22:33:22 INFO - PID 11763 | |13;stanford-crypto-sha256-iterative;69;70;66;68;69;69;67;66;68;66 22:33:22 INFO - PID 11763 | __end_tp_report 22:33:22 INFO - PID 11763 | __start_cc_report 22:33:22 INFO - PID 11763 | _x_x_mozilla_cycle_collect,966 22:33:22 INFO - PID 11763 | __end_cc_report 22:33:22 INFO - PID 11763 | __startTimestamp1498023202186__endTimestamp 22:33:22 INFO - PID 11763 | 22:33:22 INFO - PID 11763 | ------- Summary: start ------- 22:33:22 INFO - PID 11763 | Number of tests: 14 22:33:22 INFO - PID 11763 | 22:33:22 INFO - PID 11763 | [#0] ai-astar Cycles:10 Average:107.50 Median:108.00 stddev:3.14 (2.9%) stddev-sans-first:1.80 22:33:22 INFO - PID 11763 | Values: 100.0 109.0 108.0 107.0 106.0 107.0 108.0 110.0 112.0 108.0 22:33:22 INFO - PID 11763 | 22:33:22 INFO - PID 11763 | [#1] audio-beat-detection Cycles:10 Average:142.60 Median:148.50 stddev:20.05 (13.5%) stddev-sans-first:20.97 22:33:22 INFO - PID 11763 | Values: 152.0 119.0 150.0 176.0 122.0 147.0 144.0 127.0 168.0 121.0 22:33:22 INFO - PID 11763 | 22:33:22 INFO - PID 11763 | [#2] audio-dft Cycles:10 Average:165.90 Median:165.00 stddev:4.70 (2.8%) stddev-sans-first:4.99 22:33:22 INFO - PID 11763 | Values: 166.0 164.0 162.0 163.0 162.0 164.0 164.0 171.0 177.0 166.0 22:33:22 INFO - PID 11763 | 22:33:22 INFO - PID 11763 | [#3] audio-fft Cycles:10 Average:86.20 Median:74.50 stddev:29.27 (39.3%) stddev-sans-first:30.71 22:33:22 INFO - PID 11763 | Values: 74.0 74.0 76.0 167.0 78.0 74.0 74.0 73.0 97.0 75.0 22:33:22 INFO - PID 11763 | 22:33:22 INFO - PID 11763 | [#4] audio-oscillator Cycles:10 Average:102.10 Median:82.00 stddev:32.20 (39.3%) stddev-sans-first:33.32 22:33:22 INFO - PID 11763 | Values: 82.0 81.0 144.0 82.0 82.0 82.0 152.0 83.0 83.0 150.0 22:33:22 INFO - PID 11763 | 22:33:22 INFO - PID 11763 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 22:33:22 INFO - PID 11763 | Values: 113.0 113.0 114.0 114.0 115.0 114.0 113.0 113.0 114.0 114.0 22:33:22 INFO - PID 11763 | 22:33:22 INFO - PID 11763 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:150.50 stddev:0.84 (0.6%) stddev-sans-first:0.73 22:33:22 INFO - PID 11763 | Values: 152.0 150.0 151.0 152.0 151.0 150.0 150.0 150.0 150.0 150.0 22:33:22 INFO - PID 11763 | 22:33:22 INFO - PID 11763 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 22:33:22 INFO - PID 11763 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 22:33:22 INFO - PID 11763 | 22:33:22 INFO - PID 11763 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.50 stddev:1.69 (3.0%) stddev-sans-first:1.66 22:33:22 INFO - PID 11763 | Values: 54.0 55.0 57.0 54.0 56.0 57.0 57.0 54.0 55.0 59.0 22:33:22 INFO - PID 11763 | 22:33:22 INFO - PID 11763 | [#9] json-stringify-tinderbox Cycles:10 Average:54.30 Median:54.00 stddev:2.41 (4.5%) stddev-sans-first:2.55 22:33:22 INFO - PID 11763 | Values: 54.0 54.0 54.0 53.0 53.0 54.0 54.0 53.0 61.0 53.0 22:33:22 INFO - PID 11763 | 22:33:22 INFO - PID 11763 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:77.50 stddev:2.85 (3.7%) stddev-sans-first:2.99 22:33:22 INFO - PID 11763 | Values: 79.0 78.0 77.0 77.0 77.0 85.0 75.0 77.0 75.0 79.0 22:33:22 INFO - PID 11763 | 22:33:22 INFO - PID 11763 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:133.00 stddev:8.62 (6.5%) stddev-sans-first:8.80 22:33:22 INFO - PID 11763 | Values: 142.0 137.0 133.0 133.0 127.0 130.0 131.0 133.0 131.0 157.0 22:33:22 INFO - PID 11763 | 22:33:22 INFO - PID 11763 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.50 Median:183.00 stddev:6.42 (3.5%) stddev-sans-first:6.78 22:33:22 INFO - PID 11763 | Values: 183.0 193.0 179.0 181.0 183.0 198.0 183.0 179.0 179.0 187.0 22:33:22 INFO - PID 11763 | 22:33:22 INFO - PID 11763 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.50 stddev:1.48 (2.2%) stddev-sans-first:1.50 22:33:22 INFO - PID 11763 | Values: 69.0 70.0 66.0 68.0 69.0 69.0 67.0 66.0 68.0 66.0 22:33:22 INFO - PID 11763 | -------- Summary: end -------- 22:33:22 INFO - PID 11763 | 22:33:23 INFO - TEST-INFO | 11763: exit 0 22:33:23 INFO - TEST-OK | kraken | took 62290ms 22:33:23 INFO - SUITE-END | took 1180s 22:33:23 INFO - Completed test suite (00:19:40) 22:33:23 INFO - javascript benchmark 22:33:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8190.963145341297, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.410352033115, 3135.9059228223146, 3174.936501269973, 3180.888668896589, 3196.2968147007664, 6002.159697642333, 6046.879062418754, 6115.0, 6125.693326622244, 6168.167297414848, 6123.755049798014, 6148.631809799135, 6188.5358598105095, 6193.349698281683, 6196.411340922617, 5662.943370566283, 5669.291338582677, 5724.542036637059, 5743.655380677152, 5764.135379693059, 5521.668699878021, 5618.91571626426, 5703.116017017348, 5705.885882282352, 5712.542996560286, 5497.5601951843755, 5611.663300202001, 5631.493165615073, 5728.3126024876865, 5734.254546908875, 5700.173474846124, 5717.142428635696, 5719.456651618089, 5743.195952566644, 5747.195392645033, 5624.521915637176, 5665.008623490914, 5686.601937864351, 5696.857578560528, 5711.314642242916, 5982.132590774313, 6146.815595532141, 6169.105479705462, 6200.720967556471, 6208.50331973441, 6444.645544495051, 6486.318936511692, 6542.084108224853, 6599.60402375859, 6687.197536295627, 6544.803655890331, 6606.669666516655, 6681.164854393201, 6704.731810727614, 6712.127423434922, 5901.76392944286, 6152.16945712332, 6176.536759743038, 6183.474404675653, 6190.659513726789, 6647.86704265912, 6699.564528305742, 6719.193696756421, 6719.865602688016, 6748.392644662004, 6278.0, 6349.142865713162, 6378.74485020594, 6405.263394709575, 6421.229452465641, 6578.210614726264, 6581.177352830896, 6622.4039836413995, 6635.834104147435, 6665.833354166088, 6659.9001014984815, 6663.033860090357, 6670.96664516684, 6674.16572928384, 6687.364700353459, 6635.270120286765, 6649.069130321662, 6692.163479565054, 6695.0, 6715.630640314732, 5188.45521220274, 5207.140821764367, 5249.265102885599, 5312.601554883399, 5423.240746295522, 4561.133384656904, 4591.79336929839, 4615.192341340252, 4651.651126165551, 4657.371254880615, 5779.162021506942, 5800.0429929062075, 5803.390643982321, 5820.82537523875, 5850.531957443394, 6601.900971485432, 6687.76592819249, 6703.865922681519, 6711.765088221987, 6722.462203023746, 5627.155926611041, 5796.208106737793, 5796.739146738322, 5800.361960184377, 5804.767809287666, 5751.051076572318, 5756.481916627524, 5761.798337058267, 5829.300483941955, 5884.35272120075, 6314.557980941474, 6336.398042185985, 6339.049142628458, 6410.743570257137, 6443.774467893789, 6639.435647969976, 6651.800445986628, 6653.534252602271, 6664.83337916556, 6671.33286671329, 6375.075614036032, 6387.489000879826, 6390.329015453496, 6396.0, 6400.9039864403, 6216.906746398898, 6382.776602818879, 6452.93526568111, 6457.225132984072, 6511.9348806511325, 6479.902801457888, 6550.115734375799, 6624.171978502687, 6650.301718319701, 6656.434203092791, 6469.644169570719, 6475.417212450902, 6481.578697384655, 6492.0, 6492.318306577741, 6448.9032664511005, 6457.61254324742, 6457.773977910751, 6471.385218404244, 6486.902696459462, 6193.411625895533, 6250.843728906813, 6306.621602703853, 6349.301576826453, 6366.77716279928, 6261.906071409024, 6345.7144428499905, 6364.904526432199, 6410.262819775786, 6450.0, 6239.500839932885, 6278.277998030102, 6308.968455157695, 6355.523335749745, 6358.1734374531015], "value": 6027.322063089357, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.9323260906517, 781.8201813582872, 795.7016118955391, 813.9023317201935, 821.2321479416746, 38558.61441385585, 39699.0, 39731.60268397315, 39764.40353394698, 39948.20103597926, 36225.27549449016, 36473.452898206546, 36587.817060914655, 36657.63342366576, 36707.63292367075, 6805.455563554904, 6899.344562266577, 6957.965210173942, 7475.813104672399, 7613.7335193268245, 7539.886901696452, 7647.311741943224, 7649.235076492334, 7654.11977622575, 7657.966174566446, 7594.5822979736095, 7685.577293248869, 7687.2697093776005, 7699.384049276045, 7703.1526532081425, 7594.430417718693, 7635.350995165418, 7636.77089687313, 7653.732119375823, 7661.655225514865, 7514.0231769870115, 7561.0, 7591.658375373121, 7596.962015189889, 7598.6200689965835, 36571.08572285714, 36736.08159796, 36986.630133698585, 37017.25965480675, 37069.62930370689, 3494.318607871466, 3519.2433626770367, 3523.365794157051, 3524.7356448266482, 3526.0, 29287.2678183045, 29336.559951600742, 29489.557656634952, 29553.0, 29691.257718556993, 3711.1464363196615, 3750.2124553843723, 3758.9436158457647, 3761.360568703327, 3817.1983883384523, 172786.0, 174971.0, 175242.0, 183188.0, 184099.0, 41115.58884411177, 47179.5282047182, 48158.0, 48354.27468587974, 48503.75748121237, 49390.25914611284, 49723.50276497261, 49839.75080124576, 49972.0, 50077.0, 15183.16492592918, 15356.923215384075, 15417.691646167239, 15419.229038548028, 15433.691326173413, 12706.110572260039, 12719.745605088032, 12721.93639031799, 12732.490700372067, 12741.745165096647, 14121.152730836182, 14141.646458838406, 14183.432662693584, 14235.0, 14329.283535823168, 5861.3845546217035, 5874.530037596982, 5881.735321910524, 5900.468957793733, 5962.612430192024, 972.8540718892223, 976.2043934193609, 995.8605795188679, 1021.667957913681, 1027.6403258859339, 21303.25438609641, 21542.0, 21582.136714531243, 22429.21497747571, 22433.878306084956, 1063.186662203415, 1066.4401189375485, 1077.3966578715945, 1097.8902109789117, 1118.3178261260625, 11849.0, 11888.583899563473, 12046.51813927433, 12101.455434505293, 12291.754164916652, 237399.0, 239139.0, 239389.0, 239408.0, 239455.0, 48640.51359486431, 48682.0, 48791.0, 49296.260556091685, 49423.75288123536, 1425.3300948554163, 1445.8881318332935, 1480.970380592382, 1482.636753995278, 1493.410103009327, 21382.893085534473, 21691.8289391533, 22143.667844982017, 22289.888550557793, 22522.662160067284, 35289.0, 35688.82155589309, 35765.642343577274, 35796.463053054744, 35882.64117358793, 197988.0, 198138.0, 198213.0, 198251.0, 199252.0, 32397.51403728993, 34572.654273456945, 35297.29405411929, 36939.26121477609, 37102.628973711, 42308.94227644333, 43383.34924976065, 44733.10533789241, 44867.55132448634, 44951.1009779796, 30168.84915575408, 30544.08367748971, 31515.52726709147, 32095.197620058752, 33266.33467330688, 30843.0, 31226.21934451657, 31361.8431907839, 32159.839200803846, 32671.673283266864, 34072.0, 34840.30319393547, 34932.12669683278, 35807.0, 35828.283434331686, 28676.283092922844, 30658.386832263677, 31084.844575776977, 31114.844425777726, 31693.0, 22495.601055746174, 24645.137420190207, 24855.627165592894, 24951.87524062368, 25405.872970635028], "value": 16601.18914782613, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.2675458526624, 561.3067861191425, 564.5540023381528, 576.4811669497452, 592.4431034827262, 21011.36965891022, 22230.221942232027, 22330.441738956535, 22332.665010024863, 22339.0, 23960.0, 24993.12524061658, 26052.73947260527, 26097.86951065242, 26266.474670506577, 6505.967470162666, 6678.632675202862, 6680.498962577802, 6681.331866813304, 6688.364605362507, 6533.31400202979, 6575.178102737158, 6598.307177746339, 6625.238097618787, 6627.966860165717, 6178.84552886177, 6294.43350098491, 6413.005984072476, 6418.743250269984, 6598.0, 6399.456046236052, 6476.093346931433, 6482.902756458657, 6489.740410383555, 6496.512761542903, 6058.485028772559, 6067.939320606782, 6072.332043475214, 6079.0, 6080.391960803929, 26930.326741831414, 28054.579181312296, 28379.57430638542, 28395.57406638902, 28549.714502854913, 1943.9902800485906, 2003.2087325506488, 2004.6491863923754, 2008.2770202727006, 2014.5265862522297, 17951.640967180585, 18241.452756417195, 18383.26466941321, 18456.0, 18483.815161848343, 2343.402432379732, 2366.9053237870467, 2403.9639405408934, 2418.4558474343307, 2421.067888862783, 115296.0, 120131.3993430036, 120211.0, 120771.0, 120802.99999999913, 14288.642783930485, 14446.422143114158, 14662.853371466148, 14937.850621493862, 15146.318415671321, 23222.65166022511, 23386.532269354517, 23475.41311467227, 23522.882385587964, 23546.058157673844, 9719.271054670786, 9761.463119528353, 9779.41323520591, 9850.064243896819, 9874.753131171778, 8744.8688269676, 8777.736667899973, 8782.033976262606, 8890.73327800167, 8958.641654333753, 8547.529885856338, 8917.955410223038, 9085.68200113006, 9145.759288974245, 9232.446053236827, 2697.0, 2700.9729902701115, 2706.6210730497746, 2804.9859750701116, 2873.48277310082, 969.1277849934974, 983.3755565216139, 984.1827768014144, 1005.7284533176002, 1022.8670272864629, 18790.436286911416, 19564.217431302874, 19617.705734413994, 19703.525920319295, 19760.505987350145, 966.9129778319844, 978.848278516831, 1025.179856115105, 1039.875214974208, 1046.2780681329857, 10503.317284376491, 10697.518611662494, 10711.517981690842, 10844.024037836632, 10868.402237876993, 420010.0, 427390.0, 444398.0, 448098.0, 450091.0, 93474.0, 94716.52641736747, 94780.52609737046, 94878.0, 101460.49269753751, 1127.419379019822, 1129.711923459529, 1142.6971852459105, 1157.8379026936236, 1165.877582853805, 15883.920580397024, 16110.677786443972, 16925.322987080872, 17077.91461042687, 17090.65818683644, 46323.1406195438, 47734.522654773005, 47798.5220147808, 47872.521274788196, 48635.0, 60256.69871650614, 60296.0, 61062.38937610567, 61127.08309375452, 61456.385436145065, 12287.017038637066, 12543.749125017266, 12545.49818007306, 12739.745205096031, 13085.018623603077, 18617.0, 18703.438896833115, 18820.52948676294, 19027.71458428097, 19058.0, 14929.776053358992, 15605.0, 15866.04803711781, 15962.281697323417, 16029.118398487728, 13612.795808063085, 14066.226357550433, 14178.220197889215, 14204.502842400467, 15153.318100685716, 15948.760768588712, 15987.920060399623, 16105.677886441972, 16130.0, 16175.110368929822, 12979.480820767063, 12993.870061299644, 13017.544385946447, 13043.673908152372, 13055.673608159492, 14865.10809351399, 15198.544043678707, 15203.391864325304, 15545.84454155444, 15661.138637375054], "value": 11221.010600735099, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1375.2229990055619, 1391.6590435343342, 1407.7958695989082, 1411.5130280053384, 1417.7518934186514, 12807.935960320197, 13186.340682965838, 13371.531996380128, 13443.395047222873, 13450.327483625828, 12398.256104633729, 13106.279154646514, 13143.342832858367, 13149.47402103917, 13180.20918744876, 2487.800975921931, 2557.181701855407, 2559.296193546771, 2561.6669832921693, 2577.536043512167, 2484.3292311075998, 2535.4548772014014, 2538.809589280802, 2540.7078186008566, 2540.745925407463, 2477.715062767778, 2492.750724927502, 2508.3102146909655, 2510.535550923076, 2514.371407148213, 2433.7201221859445, 2452.0927256914965, 2462.064415522099, 2462.6429167770575, 2470.987645061781, 2408.253441433144, 2408.987955060231, 2423.345696661909, 2431.58663027284, 2485.7389974052826, 12256.264624122492, 12412.937935310356, 12414.193077450027, 12419.379031048502, 12423.378831058411, 6808.080909077261, 7006.684699188498, 7019.859602807966, 7022.052022976884, 7031.1211098612675, 4129.318662420727, 4282.828686852522, 4340.262155433584, 4359.6948213625055, 4396.626286765629, 1544.637010302578, 1558.1897413344998, 1578.5580037589493, 1604.237986956198, 1622.1970124788306, 18262.90868545662, 18952.336668216685, 18956.146973386094, 19146.425607231806, 19182.712259316122, 5476.7535460904355, 5629.605927585111, 5868.295804503487, 6061.757529698851, 6259.0924315973925, 14590.270486475634, 14600.561983140522, 14622.195779232032, 14629.0, 14634.12195268266, 7078.893816592756, 7113.359797618135, 7147.035150254649, 7149.53528020677, 7154.177269613957, 6383.2978372379, 6599.340065993362, 6676.399124078856, 6686.5653732507235, 6717.865642687118, 4672.672912896064, 4803.663743537989, 4923.0, 4968.056069346812, 5038.874028149252, 1430.034726559568, 1431.191376872064, 1432.1120905038943, 1442.3941944383384, 1462.6928345047447, 881.0396667632311, 896.6278994217326, 898.5327629632554, 919.5999740113073, 927.5779520318239, 7879.842403151905, 8015.47899386538, 8039.959800200962, 8151.103378628346, 8328.500289982621, 970.9174720148725, 1000.1448761308976, 1011.6610935336597, 1026.430331166195, 1052.3843551522446, 4799.760011999386, 4908.975455122773, 4957.975210123926, 5093.286939828427, 5110.591152707774, 16414.589635259214, 17375.13124343803, 17379.826201737822, 17388.565285867953, 17412.303507859797, 17013.319467221172, 18054.548636283937, 18120.456386308168, 18154.273829046953, 18196.454106376565, 10076.395416275047, 10233.48832558369, 10239.692809215736, 10296.279260451696, 10330.741731456623, 7505.474616776992, 8106.067802202586, 8130.959345203236, 8315.293200078062, 8418.663253469793, 13582.660433489242, 14161.291935402982, 14171.716565668423, 15532.844671553592, 15539.84460155384, 13241.867581324064, 13819.101758385672, 14009.929950350182, 14049.0, 14106.083104598169, 10885.401302928414, 11111.777764444827, 11118.277311974696, 11122.721931951766, 11123.833142502706, 12004.39978001114, 12560.811587826007, 12658.0, 12697.301648409426, 12710.110292279453, 9761.658341957997, 10146.949265253626, 10167.135793457343, 10427.322224055411, 10466.842997354894, 9905.257105716955, 9951.452670103214, 10192.643257485952, 10283.537240824331, 10452.477376131315, 8370.497770133812, 8712.91287087121, 8823.382363234768, 8887.73336799897, 8922.197002269826, 6617.636030018202, 6795.38841504267, 6870.690818913061, 6999.1950925644205, 7067.328603782633, 6846.486513511407, 6924.272951340238, 7035.0, 7206.89189662166, 7308.524945878501], "value": 5967.695665538273, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.26186202837636, 493.00613614849755, 508.1437777345176, 517.3171413733871, 518.7639623971094, 6253.218347706536, 6381.4575761060305, 6422.903656445157, 6432.42108210261, 6435.259945106314, 6078.696065196734, 6253.499720022399, 6266.968665156679, 6290.905636415458, 6298.834715577621, 4989.950100499003, 5013.924791128136, 5019.0, 5022.221555658879, 5027.421846487664, 5032.949670503303, 5036.82371117011, 5042.596592272609, 5047.394312682465, 5054.00366855092, 4818.156822556039, 5007.774650140753, 5010.148274793276, 5015.699058056528, 5025.84922452327, 4975.676581022222, 4984.87537811554, 4995.675281106753, 4999.375078115236, 5019.723915184663, 4458.799354029076, 4481.596656300916, 4482.977585112086, 4523.954760452386, 4530.62794403399, 6110.358412366682, 6128.3258841527395, 6132.325444201134, 6136.6011209271255, 6140.508759299245, 5682.886342273131, 5683.589846092353, 5690.146478028288, 5722.341930677942, 5733.770649174028, 6653.833654158685, 6658.001299805068, 6662.5003124765835, 6686.331366863324, 6687.164104486939, 4876.268559716035, 4891.4863939286215, 4893.975530122362, 4903.41159060915, 4905.337779399771, 7038.859222815515, 7039.436845052383, 7051.6474176291495, 7069.151701795818, 7135.072440582691, 5007.549320561094, 5050.191969284897, 5064.620153488503, 5078.21287700407, 5082.822101226513, 5094.5160209780015, 5105.5149760772665, 5112.207607820794, 5131.589472842164, 5150.536451719363, 5716.885662286731, 5740.56945729072, 5759.366469688331, 5769.682667453247, 5772.09372033768, 6748.527603067836, 6754.797356079325, 6759.966200169066, 6760.357766012221, 6810.523263371616, 1664.0514906503176, 1744.3633073927924, 1770.2564922732483, 1774.3523613881098, 1775.0947017021413, 1184.3604453594962, 1207.3902679146975, 1231.4396949388006, 1238.2694210415898, 1246.7818131826893, 5629.549636029108, 5787.1319302104175, 5842.211301474332, 5897.174395584621, 5905.911411328833, 6741.2921643226755, 6779.966100169468, 6820.079289295981, 6843.418309443654, 6856.725730970706, 5866.823995280063, 5889.882202355929, 5890.587658863838, 5899.318694172141, 5903.35063143054, 3620.185458271868, 3632.328019316435, 3642.85428582859, 3644.835982380799, 3649.50731651229, 6588.53880228389, 6638.933610663928, 6652.434543063797, 6664.000799760052, 6686.331366863372, 6969.930300697029, 7018.473614478832, 7055.7177712891935, 7059.788206353817, 7067.187273463514, 6624.171978502687, 6636.942547810194, 6637.1703537057865, 6657.500687448461, 6677.232118306457, 6745.5952642841585, 6828.692708828214, 6846.4522838173825, 6856.760013399507, 6863.862722745417, 6780.1524809398825, 6792.286809884891, 6796.966015169893, 6808.761693340709, 6837.418819400406, 6390.025326319906, 6628.635425051669, 6673.564149085646, 6674.866502670016, 6679.732810687518, 5369.19462080691, 5386.676799392049, 5495.835124946258, 5520.834374968757, 5574.9721251393485, 6839.179298484015, 6880.449564034965, 6897.896531552131, 6905.0, 6917.169939607279, 6634.170728658918, 6656.400923916871, 6657.3009833966735, 6706.597604143767, 6708.966455167693, 6675.429959465738, 6691.933080669131, 6701.865962680621, 6719.160104986877, 6734.427573656294, 6614.603123812587, 6615.702293396905, 6622.377517508241, 6666.633335166613, 6678.933210667831, 6682.131322927989, 6725.764598239038, 6758.391744742997, 6764.425023872829, 6765.830854228684, 6454.870902581828, 6494.7077381517, 6499.5775274607, 6507.893658078044, 6546.901796472961], "value": 5139.444828778278, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.520038377741, 872.4242000279814, 872.8690696395544, 873.0570983337996, 882.7484167012401, 17354.392596259135, 17765.20056597453, 18003.369882054132, 18055.548611284725, 18143.36498222561, 16856.66286674269, 16885.83114168858, 16972.4059657912, 17872.195751191197, 19154.521136971583, 1058.5077938758495, 1073.1629329123257, 1075.6289080267295, 1081.361996422111, 1082.3289560472517, 1078.6494389323461, 1080.8756992945832, 1082.5615625671576, 1083.0360978728938, 1083.5611577311201, 1131.9264247823864, 1139.0375133012592, 1139.6524060161648, 1147.1339138950123, 1147.741758104428, 1019.0, 1050.4852622215099, 1090.5310716391948, 1100.4882729530727, 1110.2062025651658, 795.9005124359455, 797.1908512859452, 797.2904115337354, 798.3134504326275, 801.9719309824128, 18052.54868628295, 18187.54531136732, 18286.0, 18321.08394580279, 18421.907890460596, 19300.420987370402, 19938.60122797536, 20172.29396971099, 20206.29277975264, 20250.189992400286, 15440.536783896501, 15818.604534886605, 15819.762703559456, 15902.681946361125, 15963.92018039914, 3499.947500787465, 3577.8568857245677, 3580.3555360035184, 3595.856165753393, 3611.20553478237, 94823.0, 95200.52399738027, 97819.51090244575, 98382.50808745911, 100145.0, 16304.918475407785, 16530.09084500364, 16582.668346633, 16674.49976500707, 16740.41408550695, 26905.596416053773, 27792.44415111727, 28286.009989650265, 28381.432371352457, 28500.572491412644, 8622.78443038929, 8650.913490865136, 8690.0, 8700.477971321741, 8711.60797764102, 4063.89840253996, 4114.7119701620595, 4162.167566486714, 4189.497260328719, 4302.806373713191, 4907.533784290486, 5040.193569028937, 5047.268146118792, 5047.4952504749235, 5057.393112826484, 1009.8030883977553, 1032.1330082730392, 1044.1698849414734, 1044.827603445423, 1050.3487837540774, 670.7216505150406, 670.872534218497, 674.1573033707865, 701.03607539633, 706.2231545300232, 11432.828507572392, 11533.0, 11534.884651153548, 11883.643490695293, 11941.52233910634, 672.8351553869236, 683.7435961514432, 688.5834070387443, 706.7385067524946, 717.6447658409121, 5147.3051138096625, 5234.424213336606, 5312.707801070978, 5407.405185429599, 5543.445655434505, 88895.0, 91342.54328728447, 91428.54285728528, 93269.06730932604, 95166.0, 75940.62029689817, 79181.60409197917, 82581.0, 86149.0, 88015.55992219997, 67969.3203067973, 72563.2743672567, 73055.0, 73166.26833731595, 73244.63377683077, 11541.480633371686, 12358.62924112278, 12368.319742414255, 12382.81425778596, 12404.0, 32740.67259327376, 33021.33957320888, 33450.49824252687, 33471.330573388885, 33619.327613448084, 41252.0, 41309.58690413057, 59624.70187649034, 61021.42378825817, 64263.0, 17628.471145865133, 18636.534086647942, 18718.0, 19036.238550457827, 19120.23519059222, 19633.901830490755, 20216.49458763484, 20493.692594610795, 20786.688199676715, 21008.894955525124, 19005.71491427602, 19070.809291906902, 19079.0, 19202.519937001685, 19472.221111155395, 18555.35056273024, 18640.0, 18867.90566047161, 19076.713849292548, 19351.0, 17827.732584011508, 18039.909800450914, 18513.166907489463, 18547.44357669272, 18734.812651873854, 11970.700732481757, 12526.624201273977, 12531.18547294423, 12881.806772898226, 13732.65668358299, 13781.86218137846, 14605.561833145022, 14646.26768661584, 14670.63323416923, 14741.484048058266], "value": 8769.317634504667, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 108.0, 107.0, 106.0, 107.0, 108.0, 110.0, 112.0, 108.0], "value": 107.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 119.0, 150.0, 176.0, 122.0, 147.0, 144.0, 127.0, 168.0, 121.0], "value": 142.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 162.0, 163.0, 162.0, 164.0, 164.0, 171.0, 177.0, 166.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 167.0, 78.0, 74.0, 74.0, 73.0, 97.0, 75.0], "value": 86.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 144.0, 82.0, 82.0, 82.0, 152.0, 83.0, 83.0, 150.0], "value": 102.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 114.0, 115.0, 114.0, 113.0, 113.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 151.0, 152.0, 151.0, 150.0, 150.0, 150.0, 150.0, 150.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 57.0, 54.0, 56.0, 57.0, 57.0, 54.0, 55.0, 59.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 53.0, 53.0, 54.0, 54.0, 53.0, 61.0, 53.0], "value": 54.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 77.0, 77.0, 77.0, 85.0, 75.0, 77.0, 75.0, 79.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 137.0, 133.0, 133.0, 127.0, 130.0, 131.0, 133.0, 131.0, 157.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 193.0, 179.0, 181.0, 183.0, 198.0, 183.0, 179.0, 179.0, 187.0], "value": 184.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 66.0, 68.0, 69.0, 69.0, 67.0, 66.0, 68.0, 66.0], "value": 67.8, "unit": "score"}]}]} 22:33:23 INFO - Return code: 0 22:33:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:33:23 INFO - # TBPL SUCCESS # 22:33:23 INFO - Running post-action listener: _resource_record_post_action 22:33:23 INFO - [mozharness: 2017-06-21 05:33:23.572873Z] Finished run-tests step (success) 22:33:23 INFO - Running post-run listener: _resource_record_post_run 22:33:23 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 426971136; Read time: 12; Write time: 276856 22:33:23 INFO - TinderboxPrint: CPU usage
13.2% 22:33:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 22:33:23 INFO - TinderboxPrint: I/O write bytes / time
426,971,136 / 276,856 22:33:23 INFO - TinderboxPrint: CPU idle
8,288.4 (86.7%) 22:33:23 INFO - TinderboxPrint: CPU user
1,211.1 (12.7%) 22:33:23 INFO - TinderboxPrint: Swap in / out
0 / 0 22:33:23 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 98942976; Read time: 0; Write time: 92300 22:33:23 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 22:33:23 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 323387392; Read time: 12; Write time: 184184 22:33:24 INFO - Running post-run listener: _upload_blobber_files 22:33:24 INFO - Blob upload gear active. 22:33:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:33:24 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 22:33:24 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'] 22:33:24 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 22:33:24 INFO - (blobuploader) - INFO - Open directory for files ... 22:33:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:33:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:33:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:25 INFO - (blobuploader) - INFO - Done attempting. 22:33:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:33:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:33:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:28 INFO - (blobuploader) - INFO - Done attempting. 22:33:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:33:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:33:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:30 INFO - (blobuploader) - INFO - Done attempting. 22:33:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:33:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:33:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:30 INFO - (blobuploader) - INFO - Done attempting. 22:33:31 INFO - (blobuploader) - INFO - Iteration through files over. 22:33:31 INFO - Return code: 0 22:33:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:33:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:33:31 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e91a3c7b3f4de00362919499f9b0e87eab31fed1e486fe86157021ada440a52d239371f139e878e2f126bea99692170923e4531d149ce18b8824a12a781e6dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/80514883870094a9cde72b4ae96e4ee999c779f615fbc71c2ae14fd5dce3a818ee606cb85c8aff5c597ec4523d4af251fb9bb0bd86f5812c4943615ca022db10", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3fde17f9e05bbc99dbe6ca6827a212c8919c0c445c9334880ed5093dfceecd0a1eff068a79cde9b18a630001cb97c404d57e861c99e8bf6c6fd4f9d9f682cbf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/395e56a10a89262c162f8db5aced8b088c50aefce176b4214ceb439c024553e14c1f7fadbe775431d2e244d71714eba115692364267ec10c7e6d9b24c2eed15e"} 22:33:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:33:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:33:31 INFO - Contents: 22:33:31 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e91a3c7b3f4de00362919499f9b0e87eab31fed1e486fe86157021ada440a52d239371f139e878e2f126bea99692170923e4531d149ce18b8824a12a781e6dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/80514883870094a9cde72b4ae96e4ee999c779f615fbc71c2ae14fd5dce3a818ee606cb85c8aff5c597ec4523d4af251fb9bb0bd86f5812c4943615ca022db10", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3fde17f9e05bbc99dbe6ca6827a212c8919c0c445c9334880ed5093dfceecd0a1eff068a79cde9b18a630001cb97c404d57e861c99e8bf6c6fd4f9d9f682cbf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/395e56a10a89262c162f8db5aced8b088c50aefce176b4214ceb439c024553e14c1f7fadbe775431d2e244d71714eba115692364267ec10c7e6d9b24c2eed15e"} 22:33:31 INFO - Running post-run listener: copy_logs_to_upload_dir 22:33:31 INFO - Copying logs to upload dir... 22:33:31 INFO - mkdir: /builds/slave/test/build/upload/logs 22:33:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.754778 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-06-20 22:33:30.779967) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-20 22:33:30.787583) ========= 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=9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e91a3c7b3f4de00362919499f9b0e87eab31fed1e486fe86157021ada440a52d239371f139e878e2f126bea99692170923e4531d149ce18b8824a12a781e6dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/80514883870094a9cde72b4ae96e4ee999c779f615fbc71c2ae14fd5dce3a818ee606cb85c8aff5c597ec4523d4af251fb9bb0bd86f5812c4943615ca022db10", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3fde17f9e05bbc99dbe6ca6827a212c8919c0c445c9334880ed5093dfceecd0a1eff068a79cde9b18a630001cb97c404d57e861c99e8bf6c6fd4f9d9f682cbf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/395e56a10a89262c162f8db5aced8b088c50aefce176b4214ceb439c024553e14c1f7fadbe775431d2e244d71714eba115692364267ec10c7e6d9b24c2eed15e"} build_url:https://queue.taskcluster.net/v1/task/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011414 build_url: 'https://queue.taskcluster.net/v1/task/bkPDzM7oQv-AtHhPukd0vg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e91a3c7b3f4de00362919499f9b0e87eab31fed1e486fe86157021ada440a52d239371f139e878e2f126bea99692170923e4531d149ce18b8824a12a781e6dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/80514883870094a9cde72b4ae96e4ee999c779f615fbc71c2ae14fd5dce3a818ee606cb85c8aff5c597ec4523d4af251fb9bb0bd86f5812c4943615ca022db10", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3fde17f9e05bbc99dbe6ca6827a212c8919c0c445c9334880ed5093dfceecd0a1eff068a79cde9b18a630001cb97c404d57e861c99e8bf6c6fd4f9d9f682cbf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/395e56a10a89262c162f8db5aced8b088c50aefce176b4214ceb439c024553e14c1f7fadbe775431d2e244d71714eba115692364267ec10c7e6d9b24c2eed15e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-20 22:33:30.812738) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-20 22:33:30.813062) ========= 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=9bfb7e13875ed353a705960e000001c0-1498018822.8743-1024886070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004402 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-20 22:33:30.893985) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-20 22:33:30.897337) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-20 22:33:30.897645) ========= ========= Total master_lag: 0.16 =========