builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-013 starttime: 1495986574.53 results: success (0) revision: 701e0ebc2b4b7ae57248e44fd06278e5309e1a05 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-28 08:49:34.529404) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-28 08:49:34.529830) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-28 08:49:34.530118) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-28 08:49:34.545821) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 08:49:34.546090) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-28 08:49:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2017-05-28 08:49:35 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.077071 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 08:49:34.635896) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 08:49:34.639218) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022386 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 08:49:34.688597) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 08:49:34.688899) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 701e0ebc2b4b7ae57248e44fd06278e5309e1a05 --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 701e0ebc2b4b7ae57248e44fd06278e5309e1a05 --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=9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-28 08:49:35,295 truncating revision to first 12 chars 2017-05-28 08:49:35,295 Setting DEBUG logging. 2017-05-28 08:49:35,296 attempt 1/10 2017-05-28 08:49:35,296 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/701e0ebc2b4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-28 08:49:35,603 unpacking tar archive at: mozilla-central-701e0ebc2b4b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.619471 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 08:49:35.323439) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-28 08:49:35.323740) ========= script_repo_revision: 701e0ebc2b4b7ae57248e44fd06278e5309e1a05 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-28 08:49:35.327137) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-28 08:49:35.327420) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-28 08:49:35.336446) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-05-28 08:49:35.336776) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:49:36 INFO - MultiFileLogger online at 20170528 08:49:36 in /builds/slave/test 08:49:36 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 08:49:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:49:36 INFO - {'append_to_log': False, 08:49:36 INFO - 'base_work_dir': '/builds/slave/test', 08:49:36 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:49:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:49:36 INFO - 'branch': 'Firefox-Non-PGO', 08:49:36 INFO - 'buildbot_json_path': 'buildprops.json', 08:49:36 INFO - 'config_files': ('talos/linux_config.py',), 08:49:36 INFO - 'default_actions': ('clobber', 08:49:36 INFO - 'read-buildbot-config', 08:49:36 INFO - 'download-and-extract', 08:49:36 INFO - 'populate-webroot', 08:49:36 INFO - 'create-virtualenv', 08:49:36 INFO - 'install', 08:49:36 INFO - 'setup-mitmproxy', 08:49:36 INFO - 'run-tests'), 08:49:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:49:36 INFO - 'download_minidump_stackwalk': True, 08:49:36 INFO - 'download_symbols': 'ondemand', 08:49:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:49:36 INFO - 'tooltool.py': '/tools/tooltool.py', 08:49:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:49:36 INFO - '/tools/misc-python/virtualenv.py')}, 08:49:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:49:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:49:36 INFO - 'gecko_profile': False, 08:49:36 INFO - 'gecko_profile_interval': 0, 08:49:36 INFO - 'installer_path': 'installer.exe', 08:49:36 INFO - 'log_level': 'info', 08:49:36 INFO - 'log_name': 'talos', 08:49:36 INFO - 'log_to_console': True, 08:49:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:49:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:49:36 INFO - 'opt_config_files': (), 08:49:36 INFO - 'pip_index': False, 08:49:36 INFO - 'suite': 'dromaeojs-e10s', 08:49:36 INFO - 'system_bits': '32', 08:49:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:49:36 INFO - 'title': 'talos-linux64-ix-013', 08:49:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:49:36 INFO - 'use_talos_json': True, 08:49:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:49:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:49:36 INFO - 'work_dir': 'build'} 08:49:36 INFO - [mozharness: 2017-05-28 15:49:36.041793Z] Running clobber step. 08:49:36 INFO - Running pre-action listener: _resource_record_pre_action 08:49:36 INFO - Running main action method: clobber 08:49:36 INFO - rmtree: /builds/slave/test/build 08:49:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:49:37 INFO - Running post-action listener: _resource_record_post_action 08:49:37 INFO - [mozharness: 2017-05-28 15:49:37.067813Z] Finished clobber step (success) 08:49:37 INFO - [mozharness: 2017-05-28 15:49:37.067914Z] Running read-buildbot-config step. 08:49:37 INFO - Running pre-action listener: _resource_record_pre_action 08:49:37 INFO - Running main action method: read_buildbot_config 08:49:37 INFO - Using buildbot properties: 08:49:37 INFO - { 08:49:37 INFO - "project": "", 08:49:37 INFO - "product": "firefox", 08:49:37 INFO - "who": "ffxbld@noreply.mozilla.org", 08:49:37 INFO - "installer_path": "public/build/target.tar.bz2", 08:49:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:49:37 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:49:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:49:37 INFO - "stage_platform": "linux64", 08:49:37 INFO - "basedir": "/builds/slave/test", 08:49:37 INFO - "buildnumber": 861, 08:49:37 INFO - "platform": "ubuntu64_hw", 08:49:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:49:37 INFO - "slavebuilddir": "test", 08:49:37 INFO - "taskId": "R0tP3wdQT8uL6hg9cEsHFg", 08:49:37 INFO - "branch": "mozilla-central", 08:49:37 INFO - "script_repo_revision": "production", 08:49:37 INFO - "revision": "701e0ebc2b4b7ae57248e44fd06278e5309e1a05", 08:49:37 INFO - "slavename": "talos-linux64-ix-013", 08:49:37 INFO - "repo_path": "mozilla-central" 08:49:37 INFO - } 08:49:37 INFO - Finding installer, test and symbols from parent task. 08:49:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R0tP3wdQT8uL6hg9cEsHFg'}, attempt #1 08:49:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R0tP3wdQT8uL6hg9cEsHFg'}, attempt #1 08:49:38 INFO - Task dependencies: VlwvVN6nRR2Yz4_i8i1nOA 08:49:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VlwvVN6nRR2Yz4_i8i1nOA'}, attempt #1 08:49:38 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/target.tar.bz2 08:49:38 INFO - Set test_url: https://queue.taskcluster.net/v1/task/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/test_packages.json 08:49:38 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/target.crashreporter-symbols.zip 08:49:38 INFO - Running post-action listener: _resource_record_post_action 08:49:38 INFO - [mozharness: 2017-05-28 15:49:38.456097Z] Finished read-buildbot-config step (success) 08:49:38 INFO - [mozharness: 2017-05-28 15:49:38.456316Z] Running download-and-extract step. 08:49:38 INFO - Running pre-action listener: _resource_record_pre_action 08:49:38 INFO - Running main action method: download_and_extract 08:49:38 INFO - mkdir: /builds/slave/test/build/tests 08:49:38 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')]} 08:49:38 INFO - trying https://queue.taskcluster.net/v1/task/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/target.test_packages.json 08:49:38 INFO - Downloading https://queue.taskcluster.net/v1/task/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:49:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:49:38 INFO - Downloaded 986 bytes. 08:49:38 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:49:38 INFO - Using the following test package requirements: 08:49:38 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:49:38 INFO - u'common': [u'target.common.tests.zip'], 08:49:38 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:49:38 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:49:38 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:49:38 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:49:38 INFO - u'mozbase': [u'target.common.tests.zip'], 08:49:38 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:49:38 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:49:38 INFO - u'web-platform': [u'target.common.tests.zip', 08:49:38 INFO - u'target.web-platform.tests.zip'], 08:49:38 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:49:38 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:49:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/target.common.tests.zip 08:49:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:49:38 INFO - Fetch https://queue.taskcluster.net/v1/task/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/target.common.tests.zip into memory 08:49:40 INFO - Content-Length response header: 63527031 08:49:40 INFO - Bytes received: 63527031 08:49:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:49:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/target.common.tests.zip 08:49:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:49:50 INFO - Fetch https://queue.taskcluster.net/v1/task/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/target.common.tests.zip into memory 08:49:52 INFO - Content-Length response header: 63527031 08:49:52 INFO - Bytes received: 63527031 08:50:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/target.talos.tests.zip 08:50:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:50:03 INFO - Fetch https://queue.taskcluster.net/v1/task/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/target.talos.tests.zip into memory 08:50:04 INFO - Content-Length response header: 14447425 08:50:04 INFO - Bytes received: 14447425 08:50: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')]} 08:50:04 INFO - trying https://queue.taskcluster.net/v1/task/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/target.tar.bz2 08:50:04 INFO - Downloading https://queue.taskcluster.net/v1/task/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:50:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:50:05 INFO - Downloaded 54047114 bytes. 08:50:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/target.tar.bz2 08:50:05 INFO - mkdir: /builds/slave/test/properties 08:50:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:50:05 INFO - Writing to file /builds/slave/test/properties/build_url 08:50:05 INFO - Contents: 08:50:05 INFO - build_url:https://queue.taskcluster.net/v1/task/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/target.tar.bz2 08:50:05 INFO - Running post-action listener: _resource_record_post_action 08:50:05 INFO - Running post-action listener: set_extra_try_arguments 08:50:05 INFO - [mozharness: 2017-05-28 15:50:05.883053Z] Finished download-and-extract step (success) 08:50:05 INFO - [mozharness: 2017-05-28 15:50:05.883149Z] Running populate-webroot step. 08:50:05 INFO - Running pre-action listener: _resource_record_pre_action 08:50:05 INFO - Running main action method: populate_webroot 08:50:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:50:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:50:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:50:05 INFO - '--tppagecycles', 08:50:05 INFO - '7'], 08:50:05 INFO - 'tests': ['tsvgm']}}, 08:50:05 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:50:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:50:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:50:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:50:05 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:50:05 INFO - 'talos_options': ['--disable-e10s'], 08:50:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:50:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:50:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:50:05 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:50:05 INFO - 'talos_options': ['--disable-e10s'], 08:50:05 INFO - 'tests': ['damp', 'tps']}, 08:50:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:50:05 INFO - 'tests': ['damp', 'tps']}, 08:50:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:50:05 INFO - 'tests': ['dromaeo_dom']}, 08:50:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:50:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:50:05 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:50:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:50:05 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:50:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:50:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:50:05 INFO - 'tests': ['a11yr', 08:50:05 INFO - 'ts_paint', 08:50:05 INFO - 'tpaint', 08:50:05 INFO - 'sessionrestore', 08:50:05 INFO - 'sessionrestore_no_auto_restore', 08:50:05 INFO - 'tabpaint']}, 08:50:05 INFO - 'other-e10s': {'tests': ['a11yr', 08:50:05 INFO - 'ts_paint', 08:50:05 INFO - 'tpaint', 08:50:05 INFO - 'sessionrestore', 08:50:05 INFO - 'sessionrestore_no_auto_restore', 08:50:05 INFO - 'tabpaint']}, 08:50:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:50:05 INFO - 'ts_paint', 08:50:05 INFO - 'tpaint', 08:50:05 INFO - 'sessionrestore', 08:50:05 INFO - 'sessionrestore_no_auto_restore', 08:50:05 INFO - 'tabpaint']}, 08:50:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:50:05 INFO - 'ts_paint', 08:50:05 INFO - 'tpaint', 08:50:05 INFO - 'sessionrestore', 08:50:05 INFO - 'sessionrestore_no_auto_restore', 08:50:05 INFO - 'tabpaint']}, 08:50:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:50:05 INFO - 'tests': ['a11yr', 08:50:05 INFO - 'ts_paint', 08:50:05 INFO - 'tpaint', 08:50:05 INFO - 'sessionrestore', 08:50:05 INFO - 'sessionrestore_no_auto_restore', 08:50:05 INFO - 'tabpaint']}, 08:50:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:50:05 INFO - 'tests': ['a11yr', 08:50:05 INFO - 'ts_paint', 08:50:05 INFO - 'tpaint', 08:50:05 INFO - 'sessionrestore', 08:50:05 INFO - 'sessionrestore_no_auto_restore', 08:50:05 INFO - 'tabpaint']}, 08:50:05 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:50:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:50:05 INFO - 'bloom_basic_ref']}, 08:50:05 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 08:50:05 INFO - 'talos_options': ['--mitmproxy', 08:50:05 INFO - 'mitmproxy-recording-1.mp', 08:50:05 INFO - '--firstNonBlankPaint'], 08:50:05 INFO - 'tests': ['Quantum_1']}, 08:50:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:50:05 INFO - 'tests': ['tsvgx', 08:50:05 INFO - 'tsvgr_opacity', 08:50:05 INFO - 'tart', 08:50:05 INFO - 'tscrollx', 08:50:05 INFO - 'cart', 08:50:05 INFO - 'tsvg_static']}, 08:50:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:50:05 INFO - 'tsvgr_opacity', 08:50:05 INFO - 'tart', 08:50:05 INFO - 'tscrollx', 08:50:05 INFO - 'cart', 08:50:05 INFO - 'tsvg_static']}, 08:50:05 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:50:05 INFO - 'talos_options': ['--disable-e10s'], 08:50:05 INFO - 'tests': ['tp5o']}, 08:50:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:50:05 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:50:05 INFO - 'talos_options': ['--disable-e10s', 08:50:05 INFO - '--xperf_path', 08:50:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:50:05 INFO - 'tests': ['tp5n']}, 08:50:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:50:05 INFO - 'talos_options': ['--xperf_path', 08:50:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:50:05 INFO - 'tests': ['tp5n']}}, 08:50:05 INFO - 'talos.zip': {'path': '', 08:50:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:50:05 INFO - Running post-action listener: _resource_record_post_action 08:50:05 INFO - [mozharness: 2017-05-28 15:50:05.897492Z] Finished populate-webroot step (success) 08:50:05 INFO - [mozharness: 2017-05-28 15:50:05.897587Z] Running create-virtualenv step. 08:50:05 INFO - Running pre-action listener: _resource_record_pre_action 08:50:05 INFO - Running main action method: create_virtualenv 08:50:05 INFO - Creating virtualenv /builds/slave/test/build/venv 08:50: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 08:50:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:50:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:50:05 INFO - Using real prefix '/usr' 08:50:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:50:06 INFO - Installing distribute.............................................................................................................................................................................................done. 08:50:08 INFO - Installing pip.................done. 08:50:08 INFO - Return code: 0 08:50:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:50:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:50:08 INFO - Reading from file tmpfile_stdout 08:50:08 INFO - Output received: 08:50: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) 08:50:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50: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')]} 08:50:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50: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 0xe1f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1199e40>, '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 0x119afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119b440>, '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': '9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760', '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 08:50: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 08:50: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 08:50:08 INFO - Using env: {'DISPLAY': ':0', 08:50:08 INFO - 'HOME': '/home/cltbld', 08:50:08 INFO - 'LANG': 'en_US.UTF-8', 08:50:08 INFO - 'LANGUAGE': 'en_US:en', 08:50:08 INFO - 'LOGNAME': 'cltbld', 08:50:08 INFO - 'MAIL': '/var/mail/cltbld', 08:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:08 INFO - 'MOZ_NO_REMOTE': '1', 08:50:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:08 INFO - 'NO_EM_RESTART': '1', 08:50:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:08 INFO - 'PWD': '/builds/slave/test', 08:50:08 INFO - 'SHELL': '/bin/bash', 08:50:08 INFO - 'SHLVL': '1', 08:50:08 INFO - 'TERM': 'linux', 08:50:08 INFO - 'TMOUT': '86400', 08:50:08 INFO - 'USER': 'cltbld', 08:50:08 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760', 08:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:08 INFO - '_': '/tools/buildbot/bin/python'} 08:50:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50: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 08:50:08 INFO - Cleaning up... 08:50:08 INFO - Return code: 0 08:50:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50: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')]} 08:50:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50: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 0xe1f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1199e40>, '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 0x119afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119b440>, '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': '9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760', '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 08:50: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 08:50: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 08:50:08 INFO - Using env: {'DISPLAY': ':0', 08:50:08 INFO - 'HOME': '/home/cltbld', 08:50:08 INFO - 'LANG': 'en_US.UTF-8', 08:50:08 INFO - 'LANGUAGE': 'en_US:en', 08:50:08 INFO - 'LOGNAME': 'cltbld', 08:50:08 INFO - 'MAIL': '/var/mail/cltbld', 08:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:08 INFO - 'MOZ_NO_REMOTE': '1', 08:50:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:08 INFO - 'NO_EM_RESTART': '1', 08:50:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:08 INFO - 'PWD': '/builds/slave/test', 08:50:08 INFO - 'SHELL': '/bin/bash', 08:50:08 INFO - 'SHLVL': '1', 08:50:08 INFO - 'TERM': 'linux', 08:50:08 INFO - 'TMOUT': '86400', 08:50:08 INFO - 'USER': 'cltbld', 08:50:08 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760', 08:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:08 INFO - '_': '/tools/buildbot/bin/python'} 08:50:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:09 INFO - Downloading/unpacking psutil>=3.1.1 08:50: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 08:50: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 08:50: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 08:50: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 08:50:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:50:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:50:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:50:10 INFO - Installing collected packages: psutil 08:50:10 INFO - Running setup.py install for psutil 08:50:10 INFO - building 'psutil._psutil_linux' extension 08:50: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 08:50: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 08:50:10 INFO - building 'psutil._psutil_posix' extension 08:50: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 08:50: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 08:50:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:50:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:50:10 INFO - Successfully installed psutil 08:50:10 INFO - Cleaning up... 08:50:10 INFO - Return code: 0 08:50:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50: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')]} 08:50:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50: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 0xe1f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1199e40>, '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 0x119afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119b440>, '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': '9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760', '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 08:50: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 08:50: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 08:50:10 INFO - Using env: {'DISPLAY': ':0', 08:50:10 INFO - 'HOME': '/home/cltbld', 08:50:10 INFO - 'LANG': 'en_US.UTF-8', 08:50:10 INFO - 'LANGUAGE': 'en_US:en', 08:50:10 INFO - 'LOGNAME': 'cltbld', 08:50:10 INFO - 'MAIL': '/var/mail/cltbld', 08:50:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:10 INFO - 'MOZ_NO_REMOTE': '1', 08:50:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:10 INFO - 'NO_EM_RESTART': '1', 08:50:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:10 INFO - 'PWD': '/builds/slave/test', 08:50:10 INFO - 'SHELL': '/bin/bash', 08:50:10 INFO - 'SHLVL': '1', 08:50:10 INFO - 'TERM': 'linux', 08:50:10 INFO - 'TMOUT': '86400', 08:50:10 INFO - 'USER': 'cltbld', 08:50:10 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760', 08:50:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:10 INFO - '_': '/tools/buildbot/bin/python'} 08:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:50: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 08:50: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 08:50: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 08:50: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 08:50:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:50:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:50:12 INFO - Installing collected packages: mozsystemmonitor 08:50:12 INFO - Running setup.py install for mozsystemmonitor 08:50:12 INFO - Successfully installed mozsystemmonitor 08:50:12 INFO - Cleaning up... 08:50:12 INFO - Return code: 0 08:50:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50: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')]} 08:50:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50: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 0xe1f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1199e40>, '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 0x119afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119b440>, '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': '9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760', '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 08:50: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 08:50: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 08:50:12 INFO - Using env: {'DISPLAY': ':0', 08:50:12 INFO - 'HOME': '/home/cltbld', 08:50:12 INFO - 'LANG': 'en_US.UTF-8', 08:50:12 INFO - 'LANGUAGE': 'en_US:en', 08:50:12 INFO - 'LOGNAME': 'cltbld', 08:50:12 INFO - 'MAIL': '/var/mail/cltbld', 08:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:12 INFO - 'MOZ_NO_REMOTE': '1', 08:50:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:12 INFO - 'NO_EM_RESTART': '1', 08:50:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:12 INFO - 'PWD': '/builds/slave/test', 08:50:12 INFO - 'SHELL': '/bin/bash', 08:50:12 INFO - 'SHLVL': '1', 08:50:12 INFO - 'TERM': 'linux', 08:50:12 INFO - 'TMOUT': '86400', 08:50:12 INFO - 'USER': 'cltbld', 08:50:12 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760', 08:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:12 INFO - '_': '/tools/buildbot/bin/python'} 08:50:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:12 INFO - Downloading/unpacking jsonschema==2.5.1 08:50: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 08:50: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 08:50: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 08:50: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 08:50:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:50:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:50: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 08:50: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 08:50: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 08:50: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 08:50:13 INFO - Downloading functools32-3.2.3-2.tar.gz 08:50:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:50:13 INFO - warning: no files found matching '*.txt' 08:50:13 INFO - no previously-included directories found matching 'build' 08:50:13 INFO - no previously-included directories found matching 'dist' 08:50:13 INFO - no previously-included directories found matching '.git*' 08:50:13 INFO - Installing collected packages: jsonschema, functools32 08:50:13 INFO - Running setup.py install for functools32 08:50:14 INFO - warning: no files found matching '*.txt' 08:50:14 INFO - no previously-included directories found matching 'build' 08:50:14 INFO - no previously-included directories found matching 'dist' 08:50:14 INFO - no previously-included directories found matching '.git*' 08:50:14 INFO - Successfully installed jsonschema functools32 08:50:14 INFO - Cleaning up... 08:50:14 INFO - Return code: 0 08:50:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50: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')]} 08:50:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50: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 0xe1f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1199e40>, '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 0x119afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119b440>, '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': '9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760', '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 08:50: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 08:50: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 08:50:14 INFO - Using env: {'DISPLAY': ':0', 08:50:14 INFO - 'HOME': '/home/cltbld', 08:50:14 INFO - 'LANG': 'en_US.UTF-8', 08:50:14 INFO - 'LANGUAGE': 'en_US:en', 08:50:14 INFO - 'LOGNAME': 'cltbld', 08:50:14 INFO - 'MAIL': '/var/mail/cltbld', 08:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:14 INFO - 'MOZ_NO_REMOTE': '1', 08:50:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:14 INFO - 'NO_EM_RESTART': '1', 08:50:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:14 INFO - 'PWD': '/builds/slave/test', 08:50:14 INFO - 'SHELL': '/bin/bash', 08:50:14 INFO - 'SHLVL': '1', 08:50:14 INFO - 'TERM': 'linux', 08:50:14 INFO - 'TMOUT': '86400', 08:50:14 INFO - 'USER': 'cltbld', 08:50:14 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760', 08:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:14 INFO - '_': '/tools/buildbot/bin/python'} 08:50:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:50:14 INFO - Cleaning up... 08:50:14 INFO - Return code: 0 08:50:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50: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')]} 08:50:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50: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 0xe1f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1199e40>, '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 0x119afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119b440>, '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': '9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760', '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 08:50: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 08:50: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 08:50:14 INFO - Using env: {'DISPLAY': ':0', 08:50:14 INFO - 'HOME': '/home/cltbld', 08:50:14 INFO - 'LANG': 'en_US.UTF-8', 08:50:14 INFO - 'LANGUAGE': 'en_US:en', 08:50:14 INFO - 'LOGNAME': 'cltbld', 08:50:14 INFO - 'MAIL': '/var/mail/cltbld', 08:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:14 INFO - 'MOZ_NO_REMOTE': '1', 08:50:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:14 INFO - 'NO_EM_RESTART': '1', 08:50:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:14 INFO - 'PWD': '/builds/slave/test', 08:50:14 INFO - 'SHELL': '/bin/bash', 08:50:14 INFO - 'SHLVL': '1', 08:50:14 INFO - 'TERM': 'linux', 08:50:14 INFO - 'TMOUT': '86400', 08:50:14 INFO - 'USER': 'cltbld', 08:50:14 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760', 08:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:14 INFO - '_': '/tools/buildbot/bin/python'} 08:50:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:14 INFO - Downloading/unpacking blobuploader==1.2.4 08:50: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 08:50: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 08:50: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 08:50: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 08:50:15 INFO - Downloading blobuploader-1.2.4.tar.gz 08:50:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:50:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:50: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 08:50: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 08:50: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 08:50: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 08:50:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:50:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:50: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 08:50: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 08:50: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 08:50: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 08:50:16 INFO - Downloading docopt-0.6.1.tar.gz 08:50:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:50:16 INFO - Installing collected packages: blobuploader, requests, docopt 08:50:16 INFO - Running setup.py install for blobuploader 08:50:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:50:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:50:16 INFO - Running setup.py install for requests 08:50:16 INFO - Running setup.py install for docopt 08:50:16 INFO - Successfully installed blobuploader requests docopt 08:50:16 INFO - Cleaning up... 08:50:16 INFO - Return code: 0 08:50:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1199e40>, '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 0x119afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119b440>, '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': '9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760', '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 08:50:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:50:16 INFO - Using env: {'DISPLAY': ':0', 08:50:16 INFO - 'HOME': '/home/cltbld', 08:50:16 INFO - 'LANG': 'en_US.UTF-8', 08:50:16 INFO - 'LANGUAGE': 'en_US:en', 08:50:16 INFO - 'LOGNAME': 'cltbld', 08:50:16 INFO - 'MAIL': '/var/mail/cltbld', 08:50:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:16 INFO - 'MOZ_NO_REMOTE': '1', 08:50:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:16 INFO - 'NO_EM_RESTART': '1', 08:50:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:16 INFO - 'PWD': '/builds/slave/test', 08:50:16 INFO - 'SHELL': '/bin/bash', 08:50:16 INFO - 'SHLVL': '1', 08:50:16 INFO - 'TERM': 'linux', 08:50:16 INFO - 'TMOUT': '86400', 08:50:16 INFO - 'USER': 'cltbld', 08:50:16 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760', 08:50:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:16 INFO - '_': '/tools/buildbot/bin/python'} 08:50:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:50:17 INFO - Running setup.py (path:/tmp/pip-aDCaWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:50:17 INFO - Running setup.py (path:/tmp/pip-aQoanC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:50:17 INFO - Running setup.py (path:/tmp/pip-cnr00Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:50:17 INFO - Running setup.py (path:/tmp/pip-eeo25N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:50:17 INFO - Running setup.py (path:/tmp/pip-1QDwzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:50:17 INFO - Running setup.py (path:/tmp/pip-uToFfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:50:17 INFO - Running setup.py (path:/tmp/pip-gdMOHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:50:17 INFO - Running setup.py (path:/tmp/pip-ntNwmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:50:17 INFO - Running setup.py (path:/tmp/pip-kqOwI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:50:17 INFO - Running setup.py (path:/tmp/pip-RkOMQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:50:17 INFO - Running setup.py (path:/tmp/pip-NtfYMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:50:17 INFO - Running setup.py (path:/tmp/pip-_n1wAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:50:17 INFO - Running setup.py (path:/tmp/pip-Dx4T8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:50:17 INFO - Running setup.py (path:/tmp/pip-QEKP8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:18 INFO - Running setup.py (path:/tmp/pip-d9Clmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:50:18 INFO - Running setup.py (path:/tmp/pip-oPB0KF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:50:18 INFO - Running setup.py (path:/tmp/pip-bIDoG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:50:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:50:18 INFO - Running setup.py install for manifestparser 08:50:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:50:18 INFO - Running setup.py install for mozcrash 08:50:18 INFO - Running setup.py install for mozdebug 08:50:18 INFO - Running setup.py install for mozdevice 08:50:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:50:18 INFO - Running setup.py install for mozfile 08:50:18 INFO - Running setup.py install for mozhttpd 08:50:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:50:18 INFO - Running setup.py install for mozinfo 08:50:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:50:18 INFO - Running setup.py install for mozInstall 08:50:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:50:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:50:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:50:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:50:19 INFO - Running setup.py install for mozleak 08:50:19 INFO - Running setup.py install for mozlog 08:50:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:50:19 INFO - Running setup.py install for moznetwork 08:50:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:50:19 INFO - Running setup.py install for mozprocess 08:50:19 INFO - Running setup.py install for mozprofile 08:50:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:50:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:50:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:50:19 INFO - Running setup.py install for mozrunner 08:50:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:50:19 INFO - Running setup.py install for mozscreenshot 08:50:19 INFO - Running setup.py install for moztest 08:50:19 INFO - Running setup.py install for mozversion 08:50:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:50:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:50:19 INFO - Cleaning up... 08:50:19 INFO - Return code: 0 08:50:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50: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')]} 08:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50: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 0xe1f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1199e40>, '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 0x119afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119b440>, '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': '9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760', '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 08:50: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 08:50: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 08:50:20 INFO - Using env: {'DISPLAY': ':0', 08:50:20 INFO - 'HOME': '/home/cltbld', 08:50:20 INFO - 'LANG': 'en_US.UTF-8', 08:50:20 INFO - 'LANGUAGE': 'en_US:en', 08:50:20 INFO - 'LOGNAME': 'cltbld', 08:50:20 INFO - 'MAIL': '/var/mail/cltbld', 08:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:20 INFO - 'MOZ_NO_REMOTE': '1', 08:50:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:20 INFO - 'NO_EM_RESTART': '1', 08:50:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:20 INFO - 'PWD': '/builds/slave/test', 08:50:20 INFO - 'SHELL': '/bin/bash', 08:50:20 INFO - 'SHLVL': '1', 08:50:20 INFO - 'TERM': 'linux', 08:50:20 INFO - 'TMOUT': '86400', 08:50:20 INFO - 'USER': 'cltbld', 08:50:20 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760', 08:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:20 INFO - '_': '/tools/buildbot/bin/python'} 08:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:50:20 INFO - Running setup.py (path:/tmp/pip-A8W7Bk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:50: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)) 08:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:50:20 INFO - Running setup.py (path:/tmp/pip-QrZPul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:50: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)) 08:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:50:20 INFO - Running setup.py (path:/tmp/pip-nguN0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:50: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)) 08:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:50:20 INFO - Running setup.py (path:/tmp/pip-76UuGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:50: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)) 08:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:50:20 INFO - Running setup.py (path:/tmp/pip-2iaA2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:50: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)) 08:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:50:20 INFO - Running setup.py (path:/tmp/pip-ZuIH6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:50: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)) 08:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:50:20 INFO - Running setup.py (path:/tmp/pip-Lsc1lS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:50:20 INFO - Running setup.py (path:/tmp/pip-KorcGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:50:20 INFO - Running setup.py (path:/tmp/pip-_ZVLkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:50:20 INFO - Running setup.py (path:/tmp/pip-v97vF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:50:20 INFO - Running setup.py (path:/tmp/pip-oOufob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:50: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)) 08:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:50:21 INFO - Running setup.py (path:/tmp/pip-aasjc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:50: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)) 08:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:50:21 INFO - Running setup.py (path:/tmp/pip-76MjGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:50: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)) 08:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:50:21 INFO - Running setup.py (path:/tmp/pip-49OrrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:50: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)) 08:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:21 INFO - Running setup.py (path:/tmp/pip-bx5NXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:50: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)) 08:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:50:21 INFO - Running setup.py (path:/tmp/pip-7Em3Cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:50: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)) 08:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:50:21 INFO - Running setup.py (path:/tmp/pip-_q8h5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:50: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)) 08:50: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)) 08:50: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)) 08:50: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)) 08:50: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)) 08:50: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)) 08:50:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:50: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 08:50: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 08:50: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 08:50: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 08:50:22 INFO - Downloading blessings-1.6.tar.gz 08:50:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:50:22 INFO - Installing collected packages: blessings 08:50:22 INFO - Running setup.py install for blessings 08:50:22 INFO - Successfully installed blessings 08:50:22 INFO - Cleaning up... 08:50:22 INFO - Return code: 0 08:50:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:50:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:22 INFO - Reading from file tmpfile_stdout 08:50:22 INFO - Current package versions: 08:50:22 INFO - argparse == 1.2.1 08:50:22 INFO - blessings == 1.6 08:50:22 INFO - blobuploader == 1.2.4 08:50:22 INFO - docopt == 0.6.1 08:50:22 INFO - functools32 == 3.2.3-2 08:50:22 INFO - jsonschema == 2.5.1 08:50:22 INFO - manifestparser == 1.1 08:50:22 INFO - mozInstall == 1.12 08:50:22 INFO - mozcrash == 1.0 08:50:22 INFO - mozdebug == 0.1 08:50:22 INFO - mozdevice == 0.51 08:50:22 INFO - mozfile == 1.2 08:50:22 INFO - mozhttpd == 0.7 08:50:22 INFO - mozinfo == 0.9 08:50:22 INFO - mozleak == 0.1 08:50:22 INFO - mozlog == 3.4 08:50:22 INFO - moznetwork == 0.27 08:50:22 INFO - mozprocess == 0.25 08:50:22 INFO - mozprofile == 0.28 08:50:22 INFO - mozrunner == 6.13 08:50:22 INFO - mozscreenshot == 0.1 08:50:22 INFO - mozsystemmonitor == 0.3 08:50:22 INFO - moztest == 0.8 08:50:22 INFO - mozversion == 1.4 08:50:22 INFO - psutil == 3.1.1 08:50:22 INFO - requests == 1.2.3 08:50:22 INFO - wsgiref == 0.1.2 08:50:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1199e40>, '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 0x119afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119b440>, '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': '9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760', '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 08:50:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:50:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:50:22 INFO - Using env: {'DISPLAY': ':0', 08:50:22 INFO - 'HOME': '/home/cltbld', 08:50:22 INFO - 'LANG': 'en_US.UTF-8', 08:50:22 INFO - 'LANGUAGE': 'en_US:en', 08:50:22 INFO - 'LOGNAME': 'cltbld', 08:50:22 INFO - 'MAIL': '/var/mail/cltbld', 08:50:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:23 INFO - 'MOZ_NO_REMOTE': '1', 08:50:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:23 INFO - 'NO_EM_RESTART': '1', 08:50:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:23 INFO - 'PWD': '/builds/slave/test', 08:50:23 INFO - 'SHELL': '/bin/bash', 08:50:23 INFO - 'SHLVL': '1', 08:50:23 INFO - 'TERM': 'linux', 08:50:23 INFO - 'TMOUT': '86400', 08:50:23 INFO - 'USER': 'cltbld', 08:50:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760', 08:50:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:23 INFO - '_': '/tools/buildbot/bin/python'} 08:50:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50: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)) 08:50: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)) 08:50: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)) 08:50: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)) 08:50: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)) 08:50: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)) 08:50: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)) 08:50: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)) 08:50: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)) 08:50:23 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:50: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 08:50: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 08:50: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 08:50: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 08:50:24 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:50:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:50: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)) 08:50: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)) 08:50: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)) 08:50: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)) 08:50:24 INFO - Installing collected packages: marionette-driver 08:50:24 INFO - Running setup.py install for marionette-driver 08:50:24 INFO - Successfully installed marionette-driver 08:50:24 INFO - Cleaning up... 08:50:24 INFO - Return code: 0 08:50:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50: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')]} 08:50:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50: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 0xe1f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1199e40>, '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 0x119afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119b440>, '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': '9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760', '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 08:50: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 08:50: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 08:50:24 INFO - Using env: {'DISPLAY': ':0', 08:50:24 INFO - 'HOME': '/home/cltbld', 08:50:24 INFO - 'LANG': 'en_US.UTF-8', 08:50:24 INFO - 'LANGUAGE': 'en_US:en', 08:50:24 INFO - 'LOGNAME': 'cltbld', 08:50:24 INFO - 'MAIL': '/var/mail/cltbld', 08:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:24 INFO - 'MOZ_NO_REMOTE': '1', 08:50:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:24 INFO - 'NO_EM_RESTART': '1', 08:50:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:24 INFO - 'PWD': '/builds/slave/test', 08:50:24 INFO - 'SHELL': '/bin/bash', 08:50:24 INFO - 'SHLVL': '1', 08:50:24 INFO - 'TERM': 'linux', 08:50:24 INFO - 'TMOUT': '86400', 08:50:24 INFO - 'USER': 'cltbld', 08:50:24 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760', 08:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:24 INFO - '_': '/tools/buildbot/bin/python'} 08:50:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:50:24 INFO - Cleaning up... 08:50:24 INFO - Return code: 0 08:50:24 INFO - Running post-action listener: _resource_record_post_action 08:50:24 INFO - Running post-action listener: _start_resource_monitoring 08:50:24 INFO - Starting resource monitoring. 08:50:24 INFO - [mozharness: 2017-05-28 15:50:24.776845Z] Finished create-virtualenv step (success) 08:50:24 INFO - [mozharness: 2017-05-28 15:50:24.777424Z] Running install step. 08:50:24 INFO - Running pre-action listener: _resource_record_pre_action 08:50:24 INFO - Running main action method: install 08:50:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:24 INFO - Reading from file tmpfile_stdout 08:50:24 INFO - Detecting whether we're running mozinstall >=1.0... 08:50:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:50:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:50:25 INFO - Reading from file tmpfile_stdout 08:50:25 INFO - Output received: 08:50:25 INFO - Usage: mozinstall [options] installer 08:50:25 INFO - Options: 08:50:25 INFO - -h, --help show this help message and exit 08:50:25 INFO - -d DEST, --destination=DEST 08:50:25 INFO - Directory to install application into. [default: 08:50:25 INFO - "/builds/slave/test"] 08:50:25 INFO - --app=APP Application being installed. [default: firefox] 08:50:25 INFO - mkdir: /builds/slave/test/build/application 08:50: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'] 08:50:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:50:40 INFO - Reading from file tmpfile_stdout 08:50:40 INFO - Output received: 08:50:40 INFO - /builds/slave/test/build/application/firefox/firefox 08:50:40 INFO - Running post-action listener: _resource_record_post_action 08:50:40 INFO - [mozharness: 2017-05-28 15:50:40.561682Z] Finished install step (success) 08:50:40 INFO - [mozharness: 2017-05-28 15:50:40.561925Z] Running setup-mitmproxy step. 08:50:40 INFO - Running pre-action listener: _resource_record_pre_action 08:50:40 INFO - Running main action method: setup_mitmproxy 08:50:40 INFO - Skipping: mitmproxy is not required 08:50:40 INFO - Running post-action listener: _resource_record_post_action 08:50:40 INFO - [mozharness: 2017-05-28 15:50:40.563010Z] Finished setup-mitmproxy step (success) 08:50:40 INFO - [mozharness: 2017-05-28 15:50:40.563232Z] Running run-tests step. 08:50:40 INFO - Running pre-action listener: _resource_record_pre_action 08:50:40 INFO - Running main action method: run_tests 08:50:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:50:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:50:40 INFO - Python 2.7.3 08:50:40 INFO - Return code: 0 08:50:40 INFO - grabbing minidump binary from tooltool 08:50:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:40 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1199e40>, '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 0x119afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119b440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:50:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:50:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:50:40 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:50:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:50:40 INFO - Return code: 0 08:50:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:50:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:50:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:50:40 INFO - ENV: RUST_BACKTRACE is now 1 08:50:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:50:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:50:40 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/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 08:50:40 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/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 08:50:40 INFO - Using env: {'DISPLAY': ':0', 08:50:40 INFO - 'HOME': '/home/cltbld', 08:50:40 INFO - 'LANG': 'en_US.UTF-8', 08:50:40 INFO - 'LANGUAGE': 'en_US:en', 08:50:40 INFO - 'LOGNAME': 'cltbld', 08:50:40 INFO - 'MAIL': '/var/mail/cltbld', 08:50:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:50:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:50:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:40 INFO - 'MOZ_NO_REMOTE': '1', 08:50:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:50:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:40 INFO - 'NO_EM_RESTART': '1', 08:50:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:40 INFO - 'PWD': '/builds/slave/test', 08:50:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:50:40 INFO - 'RUST_BACKTRACE': '1', 08:50:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:50:40 INFO - 'SHELL': '/bin/bash', 08:50:40 INFO - 'SHLVL': '1', 08:50:40 INFO - 'TERM': 'linux', 08:50:40 INFO - 'TMOUT': '86400', 08:50:40 INFO - 'USER': 'cltbld', 08:50:40 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760', 08:50:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:40 INFO - '_': '/tools/buildbot/bin/python'} 08:50:40 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/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 08:50:40 INFO - mozversion application_buildid: 20170528151506 08:50:40 INFO - mozversion application_changeset: 701e0ebc2b4b7ae57248e44fd06278e5309e1a05 08:50:40 INFO - mozversion application_display_name: Nightly 08:50:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:50:40 INFO - mozversion application_name: Firefox 08:50:40 INFO - mozversion application_remotingname: firefox 08:50:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:50:40 INFO - mozversion application_vendor: Mozilla 08:50:40 INFO - mozversion application_version: 55.0a1 08:50:40 INFO - mozversion platform_buildid: 20170528151506 08:50:40 INFO - mozversion platform_changeset: 701e0ebc2b4b7ae57248e44fd06278e5309e1a05 08:50:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:50:40 INFO - mozversion platform_version: 55.0a1 08:50:40 INFO - using testdate: 1495986640 08:50:40 INFO - actual date: 1495986640 08:50:40 INFO - starting webserver on 'localhost:59623' 08:50:40 INFO - SUITE-START | Running 2 tests 08:50:40 INFO - TEST-START | dromaeo_css 08:50:40 INFO - operating with platform_type : linux_ 08:50:40 INFO - Initialising browser for dromaeo_css test... 08:50:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59623/getInfo.html -profile /tmp/tmpwTyIEX/profile 08:50:40 INFO - TEST-INFO | started process 26204 (/builds/slave/test/build/application/firefox/firefox http://localhost:59623/getInfo.html) 08:51:15 INFO - TEST-INFO | 26204: killed by SIGTERM 08:51:16 INFO - Browser initialized. 08:51:16 INFO - Running cycle 1/1 for dromaeo_css test... 08:51:16 INFO - TEST-INFO | started process 26401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwTyIEX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:51:28 INFO - PID 26401 | RSS: Main: 183480320 08:51:28 INFO - PID 26401 | 08:54:33 INFO - PID 26401 | Cycle 1(1): loaded http://localhost:59623/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59623/tests/dromaeo/cssquery-ext.html) 08:54:35 INFO - PID 26401 | RSS: Main: 180449280 08:54:35 INFO - PID 26401 | 08:57:37 INFO - PID 26401 | Cycle 1(1): loaded http://localhost:59623/tests/dromaeo/cssquery-ext.html (next: http://localhost:59623/tests/dromaeo/cssquery-jquery.html) 08:57:37 INFO - PID 26401 | RSS: Main: 183517184 08:57:37 INFO - PID 26401 | 09:00:39 INFO - PID 26401 | Cycle 1(1): loaded http://localhost:59623/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59623/tests/dromaeo/cssquery-mootools.html) 09:00:40 INFO - PID 26401 | RSS: Main: 180547584 09:00:40 INFO - PID 26401 | 09:03:41 INFO - PID 26401 | Cycle 1(1): loaded http://localhost:59623/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59623/tests/dromaeo/cssquery-prototype.html) 09:03:42 INFO - PID 26401 | RSS: Main: 185446400 09:03:42 INFO - PID 26401 | 09:06:45 INFO - PID 26401 | Cycle 1(1): loaded http://localhost:59623/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59623/tests/dromaeo/cssquery-yui.html) 09:06:45 INFO - PID 26401 | RSS: Main: 183758848 09:06:45 INFO - PID 26401 | 09:09:47 INFO - PID 26401 | Cycle 1(1): loaded http://localhost:59623/tests/dromaeo/cssquery-yui.html (next: http://localhost:59623/tests/dromaeo/cssquery-dojo.html) 09:09:47 INFO - PID 26401 | RSS: Main: 181227520 09:09:47 INFO - PID 26401 | 09:09:47 INFO - PID 26401 | __start_tp_report 09:09:47 INFO - PID 26401 | _x_x_mozilla_page_load 09:09:47 INFO - PID 26401 | _x_x_mozilla_page_load_details 09:09:47 INFO - PID 26401 | |i|pagename|runs| 09:09:47 INFO - PID 26401 | |0;dojo.html;2711.593261010849;2718.836869787814;2729.4131761671238;2754.1049159023323;2757.5174344489724;5075.289459475676;5193.402758682752;5200.453952335002;5213.582913366931;5268.209768534722;5134.794608215667;5201.193814958678;5219.060569097561;5305.761240744167;5314.548263397606;4592.035672508777;4649.186392381328;4691.179043667362;4707.317438971364;4727.621790256771;4743.075100355415;4751.477337492873;4754.38193034905;4759.262314341266;4769.093872164295;4598.218302888517;4647.86056418308;4653.046125544289;4707.882302942419;4716.481187069419;4643.953560464386;4652.162610730067;4657.743824089674;4705.694129881546;4713.717176969393;4558.908821823545;4630.027694184226;4640.814367425299;4645.303204519315;4676.392069031038;5115.744212789383;5187.3775146982225;5191.532762051395;5197.298364720752;5251.264822924793;5649.943500564983;5736.82789516311;5749.626274292157;5757.510611598019;5764.769409223626;5746.827595172152;5752.769889204426;5761.740721667493;5773.509251713609;5776.9422305776825;5321.388040375367;5330.067238233293;5356.651817631841;5357.330333708286;5401.216823560561;5735.483806457355;5816.331121920949;5844.970775146097;5932.0508718604815;5934.8813023739285;5614.214010038598;5615.747291371898;5633.971830140823;5661.801836935688;5685.346185188756;5621.381648018714;5676.205331253628;5725.828225153252;5738.8278351649515;5752.223449834219;5525.392206857243;5591.888162236733;5623.072193088176;5704.515116215168;5714.542836573064;5573.916391254134;5652.0391533439415;5667.659940403589;5677.687727175045;5709.543236541067;4740.644451666139;4741.478437371887;4745.905081898342;4758.762061896891;4799.688020278671;4074.796260186979;4078.000889781963;4080.224757296104;4085.816138273785;4121.464209652786;4736.242201247784;4767.261074533453;4810.11012962603;4882.609391248691;4898.14282500561;5680.346760122557;5682.8634273145535;5694.60137790359;5722.055860783007;5735.770569177186;4772.689775164603;4779.044191161782;4784.2823576463115;4784.425868895755;4824.49342819006;4937.604991600663;5005.62457815658;5008.69947803133;5009.974950125226;5019.096562618691;5200.895982080261;5220.190870415092;5314.070037743457;5320.866978325573;5326.041312563776;5586.497215250647;5666.15007748841;5687.146927960839;5786.161006653927;5806.042003069446;5191.377034755854;5322.946770532245;5328.520433161034;5330.147176451904;5365.651232669864;5675.205471233948;5680.829575112753;5691.573132015033;5695.943040569541;5699.173619825019;5593.804216852391;5676.17695434168;5684.317881854204;5735.197072409949;5780.566457515787;5612.298462692163;5639.7180140993605;5646.632968857176;5678.063119585222;5687.118496633028;5590.636608620427;5612.522935550361;5615.438456154352;5628.380878103323;5632.380438151882;5330.333708286465;5460.26286451324;5501.669899805865;5560.443955604407;5563.833085007456;5556.694381808878;5558.499735023867;5642.069058605448;5656.2929633795775;5660.85847853807;5433.1035379161995;5442.673439593637;5444.6188766785945;5447.564194864322;5501.092319767194 09:09:47 INFO - PID 26401 | |1;ext.html;660.227533785471;723.3092396761092;736.3777607921306;1084.1976937066572;1099.598646494029;32615.347693046155;33476.83261583689;33500;33547.66452335476;33635.159121021985;34763.47854782174;35407.82296088523;35440.64559354405;35476.2904741905;35482.8225858871;6633.668316584176;6845.555038922479;6851.417629501499;6970.059042029337;6983.895241571355;6731.158605174353;6797.864042719143;6801.115854938876;6806.829829254259;6835.350641689031;6796.422304104132;6796.966015169917;6826.146731658543;6835.658217089151;6847.417969472601;6797.184337879461;6841.452683785285;6844.623545704984;6844.802159622096;6859;6742.056112144303;6783.3216678332265;6786.694598743068;6802.7619033334095;6816.352446517573;32544.674553254637;32601;32819;32844.507332390036;32942.50586241209;3025.4554180247546;3061.4336347775734;3063.9540406893916;3068.2942923127584;3076;24928.376790580198;24932.50134997308;24965.62551561728;25103;25181.24456266315;3040.0879736079087;3070.7696922730884;3084.1826915867314;3112.7821052526333;3140.937181256385;119562.40218798937;121570;140633.29683351621;140706.29646851702;141077;38517;39126.41310380347;39219.80390098031;39264.09198850144;39271.21457570833;40341.59658403437;40393.39409908854;40460;40568.1886362277;40665.59334406618;12386.442610082568;12531.87468125307;12533;12543.3101179436;12552.686182845318;10099.343542669703;10140.898591014144;10149;10168.694939151837;10192.388456692623;12156.392180390945;12343.876561234452;12352;12389.938050309871;12527.310997895022;5045.293658887758;5118.436971933159;5127.769250383742;5155.175171972466;5159.509846564571;862.7368652560904;897.6633762339122;908.9863652045225;917.1882883648019;939.3330735177964;20771.376858694264;21580.352589422342;21714.565708686056;21825.454363640718;21875.12499500002;970.8689326940914;977.4379731654327;984.4388698441819;1002.2783595811004;1007.7883644434751;11207.159463040305;11436.94281528587;11500.309981401142;11575.073994080622;11625.76748465026;166192;166503;166906;167639;168015;40979;41047.589524104376;41049.38425923613;41081.58918410837;41120.58879411227;1193.319797762656;1230.5877531027206;1237.616338934933;1238.1147479552164;1242.763874863773;19619.411417657495;19793.703094453307;20368.490787730425;21260.681089783357;21406.678899816827;29875.55186672158;29899.103026909226;29922.70077299199;29941.251468713457;29962.70037299599;145859;147093;147589;148896.2555187217;149445.25277373544;28375.43249135047;28703.138905832857;29798.851005744833;30630;30644;36335.81832090823;36578.45132322964;36602.633973659926;36650.26699466049;36650.63349366579;25637.871810640827;27311;27403.862980685768;27605.03382381607;27749.86125069362;27551.586726199523;28012.85993570019;29223;29341.050979451473;29541.704582954757;33645.83177084099;33686.49470257899;34106.65893341035;34253.31493370169;34321.82839085789;35512.46731298981;35757.82121089378;35758.28483430369;35953;36063;22532.662010069533;23417.648735269326;24939.875300624106;25000;25172.622410663487 09:09:47 INFO - PID 26401 | |2;jquery.html;408.5852859347761;409.43497972797536;418.3975075890717;433.1229260746987;438.5899184262714;12679.366031698424;16978.5755356116;17091.31634734612;17692.38076667315;17791.555211119714;18138.72791908119;18226;18527.536811579717;18738.90630546849;18921.432357029313;5383.43473935237;5505.807296744615;5546.77812887484;5551.583631227654;5558.722063896789;5302.628815982883;5474;5476.041692703761;5477.698726570037;5482.780688772445;5246.606504512158;5364.222187782769;5404.4595540445835;5415.296011518497;5431.565474762009;5427.9185812212845;5484.095124304485;5500.697461639608;5506.972465137689;5508.173773933902;4875.8781030474165;4917.114919314522;4954.702717836905;4966.056449274626;4966.6771659842;21921.46549741519;22189.334319970425;22243;22304.665430018562;22450.214242501435;1623.4642567952546;1637.5578593779733;1671.089256355277;1680.7142785726455;1683.0490772713379;14382.784258236135;14684.559463216014;14825.48110816127;14860.405583776635;14879;2026.574419371919;2032.6747720364672;2100.243912191625;2110.947226319339;2128.6062078515524;80417.59791201065;80868.19131808724;81656;81852.59073704593;82500;10718.785624287626;10891.183161262938;11056.170787190993;11179.888201118047;11197.49611267495;13932.37304321308;15462.536123916301;15600.219989000505;15632;15670.764938525932;6691.498137639696;7139.535930164523;7213.32301157227;7445.36714379273;7461.738839140713;6544.509161812883;6626.370494802986;6708.966455167693;6764.627945462948;6773.390394864387;6740.797776066725;6742.5280230383405;6755.2231493378895;6786.083878676414;6927.757528486479;2028.5334373094272;2045.273927755655;2066.782987786291;2066.8036536529307;2070.3685375960476;834.4534330013851;874.1870060843477;897.3852910756153;905.1898550797;911.444019148319;17081.145942702817;17209.311627535008;17295.221715022853;17507.82492175062;17942.641147177244;901.3555307954844;923.7782932096248;932.7807965128189;933.2394098809449;935.8409070458039;9526.190273826802;9538.61845526185;9792.755181120529;9804.65683701067;9934.15559677421;362264;364957;366257;380602;389821;75762.62118689482;76843.61578192073;78414;78931.60534197408;80307;1063.8616979792578;1065.9626913058005;1119.054399032816;1123.9100871930225;1124.820028795389;16864.662706745552;17557.297708091533;17844.55388615243;17999.460016199537;18017.819821801615;35839;37452.62547374491;38042.42936356012;38197.80901095477;38588.42117368298;46798.29802553033;47225;47615.28577071278;47696.523034770595;49515.75242123767;8039.035315762146;8341.20758527939;8356.707515236938;8427.62075706607;8657.783555411164;11723.179377443497;11873.881261187278;11944.880551194725;11948.522059117538;12000.399980001139;10222.897771022195;10258.53836577341;10283.84574231402;10660.093892019266;10861.239713219999;9975;10022.799544009225;10131.544080516247;10283.845742313722;10726.747383049335;10342.948285258526;10383.636572719919;10415.270931034755;10466.63366782159;10489.947550262199;8147.737100749393;8358.916410835815;8411.62147703367;8449.11284315138;8488.702895398632;10208.336458130198;10237.897621023993;10314.329568578018;10466.372017678963;10594 09:09:47 INFO - PID 26401 | |3;mootools.html;1249.5938819883538;1345.085341967463;1346.7845144776838;1349.1837438349799;1350.2910971739839;9998.650047248348;10438.582456701743;10581.418022008796;10600.734981625463;10737.302075365096;10158.54286557105;10365.118964887975;10388.948055259712;10393.584256629725;10408.583656653725;2101.905414256358;2133.8186254168413;2142.7107340509065;2154.5475450155486;2157.6979222908803;2139.657654775236;2160.9351719448364;2170.9891450542727;2173.48942484973;2185.442712108418;2106.8735875847497;2110.535682149932;2129.37183530858;2130.052126803573;2136.2629892686996;2060.7527096748413;2082.760482544504;2086.7600225974056;2087.4676957375923;2094.7591027031935;1875.9437216883516;1936.6417212815534;2032.4918770307422;2087.5929193807215;2110;10150.644727434505;10224.897751022469;10228.488575571266;10229.335093218917;10265.076143147078;5210.791568337262;5458.590605704549;5466;5487.807926722586;5491.588130890199;3246.2695893423793;3254.8209848458328;3350.8659653613827;3357.647447018077;3360.0927749507496;1140.2987162894842;1147.2428197389684;1158.223989926751;1167.97080072998;1177.9705507362298;14974.850251497455;15298.770518442232;15355.692886142326;15373.692526149527;15415.3833846646;4857.562819346205;4977.228529577921;5161.690298582022;5169.793208271627;5189;12783.488660453479;12826.102172847812;12832.165909215872;12842.422091005927;12850.293233872228;5553.416891226363;5628.409017053233;5638.407967163389;5643.830685079372;5650.576206784508;5033.471485494044;5099.209622508517;5111.463296353903;5114.974425127851;5168.664036837668;4173.207090652766;4184.349638895105;4210.200061988213;4259.850905218303;4291.9785401072795;1219.1039585904352;1240.4232032105115;1257.1964519122225;1270.7966725323904;1271.1229251816217;702.5749421599859;717.2433083097383;724.626817189148;726.5023458930649;733.6331834082958;5509.449055094458;5544.7782088716;5604.2154098425435;5610.915836262459;5621.943780562142;539.3258426966293;825.4881973176668;827.962741676626;829.7510746775943;839.4963022186639;3660.0666829958723;3848.114933565296;3905.3751399776465;3919.098607320332;3957.6796643903767;12932.224066556037;13647.317634118255;13891.583252502442;13892.93053534726;13920;13646.454141834414;13757.518486852912;13781.931090344484;13782.310884455737;13806.585802425943;7149.177844547944;7231.9999999998945;7310.780676579711;7337.046183996153;7424.591647459441;5478.369987451335;5548.334199896039;5618.606697531133;5766.4233576642;5774.451427114417;12006.939965300118;12298.385080745747;12394.690132746393;12429;12534.435950382436;12533.686657833627;12587.874121259036;12602.747945041232;12719.364031798557;12788.296643684687;7817.179196184319;7906.367490600623;7960.6417711201975;7972.242636949481;8020.639071241691;9660.565274562521;9703.563339649592;9714.174295184988;9781.559829807533;9800.264980126662;8138.511689298661;8161.265486106279;8182.83634327322;8201.384896132933;8220.671173153007;8067.112617611941;8171.346292296721;8198.83602327962;8223.917760822314;8292.87560686578;7019.333163349474;7158.3915367192285;7197.71209151628;7216.134063912364;7231.240719724564;5136.30659860929;5167.405748338989;5174.404943431554;5279.392869819866;5363.0614642438195;5171.663841850268;5193.76628051731;5252.343457067866;5288.2860813791185;5364.14173732201 09:09:47 INFO - PID 26401 | |4;prototype.html;342.39738061012616;354.831455058847;390.9237698648763;397.14019148543423;401.76898283487003;5464.590155738316;5471.343438787346;5487.972560137204;5504.669719816814;5536.335639723234;5304.814331498398;5378.2470454136455;5382.4886635769635;5388.7305634718205;5398.217258497515;4209.179210054033;4214.494260688722;4214.894627634319;4222.746635201883;4241.491021077475;4209.137126888996;4223.51429585597;4228.429162063128;4240.766757828318;4243.363495475673;4110.8972275693195;4196.328587426013;4202.327627579588;4212.1996820604145;4225.535191128974;4159.812808423628;4183.958160418402;4184.895377615553;4186.183694179636;4192.496900371975;3790.223004284115;3792.5348523459697;3793.4499497572974;3810.5427348718054;3841.5390153181515;5249.370075590915;5255.632105752599;5263.289455923439;5265.946280950432;5273.367195936474;4873.537013983666;4991.226359914219;5014.52362025607;5038.564009257344;5042.84871453857;5721.284839395075;5739.081746920514;5749.568782341341;5756.33802112754;5770.653760774367;4219.7046206765535;4288.721233119868;4297.001894119249;4301.225779359714;4303.784810759481;5828.795992140254;5836.824895253107;5969.492593129589;5988.8502787430225;6004.579679422486;4147.419361289422;4182.665386769051;4185.518665353523;4186.623203911602;4189.601987811153;4186.979065104655;4225.704200705921;4229.429027081304;4231.87304380869;4237.745735255895;4711.458182309078;4797.544233297831;4821.2045012572535;4849.127157111754;4850.563449289581;5691.459311365414;5724.284464441945;5733.254676891977;5738.856528586819;5752.28096487939;1450.3111022264552;1451.1148199598238;1464.9560513184622;1466.5307101727344;1468.8237411510688;956.5886668732512;957.5834511987308;1002.4236064262932;1006.2654262388497;1009.5406590001678;4943.8516844494725;4950.7721525313755;4957.529034741694;4970.254461830755;4977.576905963034;5900.321463031721;5945.554083443759;5948.494377977834;5948.553858460633;5991.5206783457215;4792.496787837227;4881.486739110887;4927.384076990376;4936.753162341868;4945;3094.9535756963664;3138.905832825019;3139.576157218792;3148.307372378073;3150.33842892995;5402.011913294909;5427.782888684487;5427.8330159016;5467.644603100785;5471.06991811393;5998.640081595118;6001.699915004232;6027.8794424111275;6042.909356359658;6062.151298818169;5421.647592906448;5436.3476382834315;5438.918416223839;5445.646033007842;5454.972725136428;5730.541556675373;5857.648541087378;5879.647221166743;5906.881862362815;5910.556708246984;5781.797637082682;5803.47768700819;5827.737751801094;5831.241938547962;5843.211166492469;5191.273221748883;5333.7866485340155;5353.598480113929;5436.293281873332;5441.183822426668;4111.8560850370095;4120.660785244748;4142.482189726285;4144.378343248537;4147.2534943710425;5857.4435428634215;5940.524758019262;5944.49471794885;5958.612690175125;5968.134620480093;5682.090865461506;5708.429157084424;5717.571182161271;5732.742026608729;5739.167820666064;5598.916016259678;5675.4892059713175;5688.431156884279;5711.428857114422;5744.454276843693;5494.560435165257;5630.324361076697;5634.577406694596;5641.323041234914;5661.433856614306;5749.367569567428;5757.769689212385;5767.68277744728;5809.448102430262;5835.2122463466885;5527.613067085426;5603.243562119224;5626.803061892814;5634.718264086861;5638.519051617439 09:09:47 INFO - PID 26401 | |5;yui.html;739.8483310921262;747.8504299140171;756.5914406220642;762.7330434347979;772.02339041113;13795.379207935643;14898.925505372472;14913.925430372847;16345.34618615257;16941.237644306006;15258.389664413438;15290.159041252728;15308.387664493435;15313.0812151271;15330.540083797503;883.9558022098886;906.1527471813843;909.3589019741099;910.0444533240104;910.3809409601469;887.9289656827439;888.9777755556098;891.589868660417;892.2193081054078;892.892852857658;926.5321012888481;931.1293940165932;931.7065124485765;933.0995589256366;942.0344147249056;928.6563971330584;929.5352323838081;930.6742640076021;931.2317338196016;937.503123344625;677.3429773120066;679.3342524326139;680.1328306409318;681.9113515242987;686.9347411995852;14313.928430357886;14350.282485875665;14453.855461445357;14515.346809393603;14582;15694.372225110981;16179;16193;16271.267792949227;16351.26419311122;12733.299668518228;12796.360181990864;13016.804747928789;13024.609261722164;13072.803907941388;3026.107298346993;3036.498977668682;3052.3895220955897;3056.098450956973;3069.2326918270433;85330;85495;86378;86988;87843.99999999936;12789.424475898606;12809.103362764517;13021.414036368385;13037.608871733863;13039.478420863248;22609.660855087186;23144.07423703033;23260.185893493646;23421.648675269884;23438.531229375316;5866.794662186803;5980.55145864062;6009.879802403927;6073.6659483727935;6091.086337049478;3078.6767389424235;3177.4757165067967;3185.6973587509615;3190.0748782853175;3192.3296107817155;3835.1754372809423;3966.920661586752;3968.444417781513;3973.980130099389;3984.2429938312207;703.4528219280555;720.8882623193414;729.1141263365037;730.7296300368897;735.7498450526847;592.1827877528982;610.5542953643776;622.0917460507709;630.1272737258929;638.2245571630491;9867.901320986699;10056.396616203052;10299.794004120025;10399.308245572864;10406.479676016168;566.8186180422225;570.3327107284405;574.615007944678;580.1529766540813;595.9880802384015;4691.108689349013;4785.59322457595;4934.432540257844;5032.32063671407;5060.645754797202;72873.27126728771;73440.63279683674;76347.23652763401;84834;86742.56628716942;65563.86622594502;65737;65915.67042164759;66331.66834165798;68512.31487685059;57527.71236143876;57993.42006579965;58497.415025850045;59961.400385995585;60022.492689875966;9453;10320.896791032294;10612.310199836986;11161.330320180816;11213.327200368005;26814.329641759112;27476;27944.580831287953;27999.160025199275;28986.565201522415;50022;50136.247956279956;50746.746266268434;51043.744781275855;51119;13289.269090200132;13491.932540337235;13615.79576306376;13759.10565813219;13767.518136865161;15293.694126117638;15856.44502442409;15971.840281597035;16223.107729074542;16304.673906521566;14187.935904806975;14402.927985360426;14434.133951962916;14562.271886405426;14673.339699713752;13281.601551953458;13598.320083995563;13708;13718.862811371759;13820.963427743161;14005;14471.782923255949;15339.539813805604;15478.303476343817;15662.686746265239;9781.41311521311;9984.151347135576;10323.63867264642;10353.63762268317;10702.411367374869;10697.358158510515;10732.570697172338;11223;11352.318860868045;11375.943120284346 09:09:47 INFO - PID 26401 | __end_tp_report 09:09:47 INFO - PID 26401 | __start_cc_report 09:09:47 INFO - PID 26401 | _x_x_mozilla_cycle_collect,375 09:09:47 INFO - PID 26401 | __end_cc_report 09:09:47 INFO - PID 26401 | __startTimestamp1495987787873__endTimestamp 09:09:47 INFO - PID 26401 | 09:09:47 INFO - PID 26401 | ------- Summary: start ------- 09:09:47 INFO - PID 26401 | Number of tests: 6 09:09:47 INFO - PID 26401 | 09:09:47 INFO - PID 26401 | [#0] dojo.html Cycles:165 Average:5203.83 Median:5356.65 stddev:627.07 (11.7%) stddev-sans-first:597.74 09:09:47 INFO - PID 26401 | Values: 2711.6 2718.8 2729.4 2754.1 2757.5 5075.3 5193.4 5200.5 5213.6 5268.2 5134.8 5201.2 5219.1 5305.8 5314.5 4592.0 4649.2 4691.2 4707.3 4727.6 4743.1 4751.5 4754.4 4759.3 4769.1 4598.2 4647.9 4653.0 4707.9 4716.5 4644.0 4652.2 4657.7 4705.7 4713.7 4558.9 4630.0 4640.8 4645.3 4676.4 5115.7 5187.4 5191.5 5197.3 5251.3 5649.9 5736.8 5749.6 5757.5 5764.8 5746.8 5752.8 5761.7 5773.5 5776.9 5321.4 5330.1 5356.7 5357.3 5401.2 5735.5 5816.3 5845.0 5932.1 5934.9 5614.2 5615.7 5634.0 5661.8 5685.3 5621.4 5676.2 5725.8 5738.8 5752.2 5525.4 5591.9 5623.1 5704.5 5714.5 5573.9 5652.0 5667.7 5677.7 5709.5 4740.6 4741.5 4745.9 4758.8 4799.7 4074.8 4078.0 4080.2 4085.8 4121.5 4736.2 4767.3 4810.1 4882.6 4898.1 5680.3 5682.9 5694.6 5722.1 5735.8 4772.7 4779.0 4784.3 4784.4 4824.5 4937.6 5005.6 5008.7 5010.0 5019.1 5200.9 5220.2 5314.1 5320.9 5326.0 5586.5 5666.2 5687.1 5786.2 5806.0 5191.4 5322.9 5328.5 5330.1 5365.7 5675.2 5680.8 5691.6 5695.9 5699.2 5593.8 5676.2 5684.3 5735.2 5780.6 5612.3 5639.7 5646.6 5678.1 5687.1 5590.6 5612.5 5615.4 5628.4 5632.4 5330.3 5460.3 5501.7 5560.4 5563.8 5556.7 5558.5 5642.1 5656.3 5660.9 5433.1 5442.7 5444.6 5447.6 5501.1 09:09:47 INFO - PID 26401 | 09:09:47 INFO - PID 26401 | [#1] ext.html Cycles:180 Average:29958.01 Median:3080.09 stddev:38646.40 (1254.7%) stddev-sans-first:38692.19 09:09:47 INFO - PID 26401 | Values: 660.2 723.3 736.4 1084.2 1099.6 32615.3 33476.8 33500.0 33547.7 33635.2 34763.5 35407.8 35440.6 35476.3 35482.8 6633.7 6845.6 6851.4 6970.1 6983.9 6731.2 6797.9 6801.1 6806.8 6835.4 6796.4 6797.0 6826.1 6835.7 6847.4 6797.2 6841.5 6844.6 6844.8 6859.0 6742.1 6783.3 6786.7 6802.8 6816.4 32544.7 32601.0 32819.0 32844.5 32942.5 3025.5 3061.4 3064.0 3068.3 3076.0 24928.4 24932.5 24965.6 25103.0 25181.2 3040.1 3070.8 3084.2 3112.8 3140.9 119562.4 121570.0 140633.3 140706.3 141077.0 38517.0 39126.4 39219.8 39264.1 39271.2 40341.6 40393.4 40460.0 40568.2 40665.6 12386.4 12531.9 12533.0 12543.3 12552.7 10099.3 10140.9 10149.0 10168.7 10192.4 12156.4 12343.9 12352.0 12389.9 12527.3 5045.3 5118.4 5127.8 5155.2 5159.5 862.7 897.7 909.0 917.2 939.3 20771.4 21580.4 21714.6 21825.5 21875.1 970.9 977.4 984.4 1002.3 1007.8 11207.2 11436.9 11500.3 11575.1 11625.8 166192.0 166503.0 166906.0 167639.0 168015.0 40979.0 41047.6 41049.4 41081.6 41120.6 1193.3 1230.6 1237.6 1238.1 1242.8 19619.4 19793.7 20368.5 21260.7 21406.7 29875.6 29899.1 29922.7 29941.3 29962.7 145859.0 147093.0 147589.0 148896.3 149445.3 28375.4 28703.1 29798.9 30630.0 30644.0 36335.8 36578.5 36602.6 36650.3 36650.6 25637.9 27311.0 27403.9 27605.0 27749.9 27551.6 28012.9 29223.0 29341.1 29541.7 33645.8 33686.5 34106.7 34253.3 34321.8 35512.5 35757.8 35758.3 35953.0 36063.0 22532.7 23417.6 24939.9 25000.0 25172.6 09:09:47 INFO - PID 26401 | 09:09:47 INFO - PID 26401 | [#2] jquery.html Cycles:180 Average:24646.69 Median:209399.90 stddev:61871.07 (29.5%) stddev-sans-first:62017.87 09:09:47 INFO - PID 26401 | Values: 408.6 409.4 418.4 433.1 438.6 12679.4 16978.6 17091.3 17692.4 17791.6 18138.7 18226.0 18527.5 18738.9 18921.4 5383.4 5505.8 5546.8 5551.6 5558.7 5302.6 5474.0 5476.0 5477.7 5482.8 5246.6 5364.2 5404.5 5415.3 5431.6 5427.9 5484.1 5500.7 5507.0 5508.2 4875.9 4917.1 4954.7 4966.1 4966.7 21921.5 22189.3 22243.0 22304.7 22450.2 1623.5 1637.6 1671.1 1680.7 1683.0 14382.8 14684.6 14825.5 14860.4 14879.0 2026.6 2032.7 2100.2 2110.9 2128.6 80417.6 80868.2 81656.0 81852.6 82500.0 10718.8 10891.2 11056.2 11179.9 11197.5 13932.4 15462.5 15600.2 15632.0 15670.8 6691.5 7139.5 7213.3 7445.4 7461.7 6544.5 6626.4 6709.0 6764.6 6773.4 6740.8 6742.5 6755.2 6786.1 6927.8 2028.5 2045.3 2066.8 2066.8 2070.4 834.5 874.2 897.4 905.2 911.4 17081.1 17209.3 17295.2 17507.8 17942.6 901.4 923.8 932.8 933.2 935.8 9526.2 9538.6 9792.8 9804.7 9934.2 362264.0 364957.0 366257.0 380602.0 389821.0 75762.6 76843.6 78414.0 78931.6 80307.0 1063.9 1066.0 1119.1 1123.9 1124.8 16864.7 17557.3 17844.6 17999.5 18017.8 35839.0 37452.6 38042.4 38197.8 38588.4 46798.3 47225.0 47615.3 47696.5 49515.8 8039.0 8341.2 8356.7 8427.6 8657.8 11723.2 11873.9 11944.9 11948.5 12000.4 10222.9 10258.5 10283.8 10660.1 10861.2 9975.0 10022.8 10131.5 10283.8 10726.7 10342.9 10383.6 10415.3 10466.6 10489.9 8147.7 8358.9 8411.6 8449.1 8488.7 10208.3 10237.9 10314.3 10466.4 10594.0 09:09:47 INFO - PID 26401 | 09:09:47 INFO - PID 26401 | [#3] mootools.html Cycles:180 Average:6391.43 Median:3876.75 stddev:4212.07 (108.6%) stddev-sans-first:4206.16 09:09:47 INFO - PID 26401 | Values: 1249.6 1345.1 1346.8 1349.2 1350.3 9998.7 10438.6 10581.4 10600.7 10737.3 10158.5 10365.1 10388.9 10393.6 10408.6 2101.9 2133.8 2142.7 2154.5 2157.7 2139.7 2160.9 2171.0 2173.5 2185.4 2106.9 2110.5 2129.4 2130.1 2136.3 2060.8 2082.8 2086.8 2087.5 2094.8 1875.9 1936.6 2032.5 2087.6 2110.0 10150.6 10224.9 10228.5 10229.3 10265.1 5210.8 5458.6 5466.0 5487.8 5491.6 3246.3 3254.8 3350.9 3357.6 3360.1 1140.3 1147.2 1158.2 1168.0 1178.0 14974.9 15298.8 15355.7 15373.7 15415.4 4857.6 4977.2 5161.7 5169.8 5189.0 12783.5 12826.1 12832.2 12842.4 12850.3 5553.4 5628.4 5638.4 5643.8 5650.6 5033.5 5099.2 5111.5 5115.0 5168.7 4173.2 4184.3 4210.2 4259.9 4292.0 1219.1 1240.4 1257.2 1270.8 1271.1 702.6 717.2 724.6 726.5 733.6 5509.4 5544.8 5604.2 5610.9 5621.9 539.3 825.5 828.0 829.8 839.5 3660.1 3848.1 3905.4 3919.1 3957.7 12932.2 13647.3 13891.6 13892.9 13920.0 13646.5 13757.5 13781.9 13782.3 13806.6 7149.2 7232.0 7310.8 7337.0 7424.6 5478.4 5548.3 5618.6 5766.4 5774.5 12006.9 12298.4 12394.7 12429.0 12534.4 12533.7 12587.9 12602.7 12719.4 12788.3 7817.2 7906.4 7960.6 7972.2 8020.6 9660.6 9703.6 9714.2 9781.6 9800.3 8138.5 8161.3 8182.8 8201.4 8220.7 8067.1 8171.3 8198.8 8223.9 8292.9 7019.3 7158.4 7197.7 7216.1 7231.2 5136.3 5167.4 5174.4 5279.4 5363.1 5171.7 5193.8 5252.3 5288.3 5364.1 09:09:47 INFO - PID 26401 | 09:09:47 INFO - PID 26401 | [#4] prototype.html Cycles:180 Average:4744.33 Median:5343.69 stddev:1370.08 (25.6%) stddev-sans-first:1333.49 09:09:47 INFO - PID 26401 | Values: 342.4 354.8 390.9 397.1 401.8 5464.6 5471.3 5488.0 5504.7 5536.3 5304.8 5378.2 5382.5 5388.7 5398.2 4209.2 4214.5 4214.9 4222.7 4241.5 4209.1 4223.5 4228.4 4240.8 4243.4 4110.9 4196.3 4202.3 4212.2 4225.5 4159.8 4184.0 4184.9 4186.2 4192.5 3790.2 3792.5 3793.4 3810.5 3841.5 5249.4 5255.6 5263.3 5265.9 5273.4 4873.5 4991.2 5014.5 5038.6 5042.8 5721.3 5739.1 5749.6 5756.3 5770.7 4219.7 4288.7 4297.0 4301.2 4303.8 5828.8 5836.8 5969.5 5988.9 6004.6 4147.4 4182.7 4185.5 4186.6 4189.6 4187.0 4225.7 4229.4 4231.9 4237.7 4711.5 4797.5 4821.2 4849.1 4850.6 5691.5 5724.3 5733.3 5738.9 5752.3 1450.3 1451.1 1465.0 1466.5 1468.8 956.6 957.6 1002.4 1006.3 1009.5 4943.9 4950.8 4957.5 4970.3 4977.6 5900.3 5945.6 5948.5 5948.6 5991.5 4792.5 4881.5 4927.4 4936.8 4945.0 3095.0 3138.9 3139.6 3148.3 3150.3 5402.0 5427.8 5427.8 5467.6 5471.1 5998.6 6001.7 6027.9 6042.9 6062.2 5421.6 5436.3 5438.9 5445.6 5455.0 5730.5 5857.6 5879.6 5906.9 5910.6 5781.8 5803.5 5827.7 5831.2 5843.2 5191.3 5333.8 5353.6 5436.3 5441.2 4111.9 4120.7 4142.5 4144.4 4147.3 5857.4 5940.5 5944.5 5958.6 5968.1 5682.1 5708.4 5717.6 5732.7 5739.2 5598.9 5675.5 5688.4 5711.4 5744.5 5494.6 5630.3 5634.6 5641.3 5661.4 5749.4 5757.8 5767.7 5809.4 5835.2 5527.6 5603.2 5626.8 5634.7 5638.5 09:09:47 INFO - PID 26401 | 09:09:47 INFO - PID 26401 | [#5] yui.html Cycles:180 Average:17276.53 Median:3513.75 stddev:22169.78 (630.9%) stddev-sans-first:22197.19 09:09:47 INFO - PID 26401 | Values: 739.8 747.9 756.6 762.7 772.0 13795.4 14898.9 14913.9 16345.3 16941.2 15258.4 15290.2 15308.4 15313.1 15330.5 884.0 906.2 909.4 910.0 910.4 887.9 889.0 891.6 892.2 892.9 926.5 931.1 931.7 933.1 942.0 928.7 929.5 930.7 931.2 937.5 677.3 679.3 680.1 681.9 686.9 14313.9 14350.3 14453.9 14515.3 14582.0 15694.4 16179.0 16193.0 16271.3 16351.3 12733.3 12796.4 13016.8 13024.6 13072.8 3026.1 3036.5 3052.4 3056.1 3069.2 85330.0 85495.0 86378.0 86988.0 87844.0 12789.4 12809.1 13021.4 13037.6 13039.5 22609.7 23144.1 23260.2 23421.6 23438.5 5866.8 5980.6 6009.9 6073.7 6091.1 3078.7 3177.5 3185.7 3190.1 3192.3 3835.2 3966.9 3968.4 3974.0 3984.2 703.5 720.9 729.1 730.7 735.7 592.2 610.6 622.1 630.1 638.2 9867.9 10056.4 10299.8 10399.3 10406.5 566.8 570.3 574.6 580.2 596.0 4691.1 4785.6 4934.4 5032.3 5060.6 72873.3 73440.6 76347.2 84834.0 86742.6 65563.9 65737.0 65915.7 66331.7 68512.3 57527.7 57993.4 58497.4 59961.4 60022.5 9453.0 10320.9 10612.3 11161.3 11213.3 26814.3 27476.0 27944.6 27999.2 28986.6 50022.0 50136.2 50746.7 51043.7 51119.0 13289.3 13491.9 13615.8 13759.1 13767.5 15293.7 15856.4 15971.8 16223.1 16304.7 14187.9 14402.9 14434.1 14562.3 14673.3 13281.6 13598.3 13708.0 13718.9 13821.0 14005.0 14471.8 15339.5 15478.3 15662.7 9781.4 9984.2 10323.6 10353.6 10702.4 10697.4 10732.6 11223.0 11352.3 11375.9 09:09:47 INFO - PID 26401 | -------- Summary: end -------- 09:09:47 INFO - PID 26401 | 09:09:48 INFO - TEST-INFO | 26401: exit 0 09:09:48 INFO - TEST-OK | dromaeo_css | took 1147958ms 09:09:48 INFO - TEST-START | kraken 09:09:48 INFO - operating with platform_type : linux_ 09:09:48 INFO - Initialising browser for kraken test... 09:09:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59623/getInfo.html -profile /tmp/tmpP7H15I/profile 09:09:48 INFO - TEST-INFO | started process 26800 (/builds/slave/test/build/application/firefox/firefox http://localhost:59623/getInfo.html) 09:10:23 INFO - TEST-INFO | 26800: killed by SIGTERM 09:10:23 INFO - Browser initialized. 09:10:23 INFO - Running cycle 1/1 for kraken test... 09:10:23 INFO - TEST-INFO | started process 26999 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP7H15I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:10:36 INFO - PID 26999 | RSS: Main: 183242752 09:10:36 INFO - PID 26999 | 09:10:38 INFO - PID 26999 | Cycle 1(1): loaded http://localhost:59623/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59623/tests/kraken/driver.html?testName=audio-beat-detection) 09:10:39 INFO - PID 26999 | RSS: Main: 186880000 09:10:39 INFO - PID 26999 | 09:10:42 INFO - PID 26999 | Cycle 1(1): loaded http://localhost:59623/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59623/tests/kraken/driver.html?testName=audio-dft) 09:10:43 INFO - PID 26999 | RSS: Main: 185225216 09:10:43 INFO - PID 26999 | 09:10:45 INFO - PID 26999 | Cycle 1(1): loaded http://localhost:59623/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59623/tests/kraken/driver.html?testName=audio-fft) 09:10:46 INFO - PID 26999 | RSS: Main: 181407744 09:10:46 INFO - PID 26999 | 09:10:48 INFO - PID 26999 | Cycle 1(1): loaded http://localhost:59623/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59623/tests/kraken/driver.html?testName=audio-oscillator) 09:10:49 INFO - PID 26999 | RSS: Main: 181862400 09:10:49 INFO - PID 26999 | 09:10:51 INFO - PID 26999 | Cycle 1(1): loaded http://localhost:59623/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59623/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:10:52 INFO - PID 26999 | RSS: Main: 182243328 09:10:52 INFO - PID 26999 | 09:10:55 INFO - PID 26999 | Cycle 1(1): loaded http://localhost:59623/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59623/tests/kraken/driver.html?testName=imaging-darkroom) 09:10:55 INFO - PID 26999 | RSS: Main: 183640064 09:10:55 INFO - PID 26999 | 09:10:59 INFO - PID 26999 | Cycle 1(1): loaded http://localhost:59623/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59623/tests/kraken/driver.html?testName=imaging-desaturate) 09:10:59 INFO - PID 26999 | RSS: Main: 183001088 09:10:59 INFO - PID 26999 | 09:11:02 INFO - PID 26999 | Cycle 1(1): loaded http://localhost:59623/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59623/tests/kraken/driver.html?testName=json-parse-financial) 09:11:03 INFO - PID 26999 | RSS: Main: 183435264 09:11:03 INFO - PID 26999 | 09:11:05 INFO - PID 26999 | Cycle 1(1): loaded http://localhost:59623/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59623/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:11:05 INFO - PID 26999 | RSS: Main: 183468032 09:11:05 INFO - PID 26999 | 09:11:07 INFO - PID 26999 | Cycle 1(1): loaded http://localhost:59623/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59623/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:11:08 INFO - PID 26999 | RSS: Main: 183037952 09:11:08 INFO - PID 26999 | 09:11:10 INFO - PID 26999 | Cycle 1(1): loaded http://localhost:59623/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59623/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:11:11 INFO - PID 26999 | RSS: Main: 182886400 09:11:11 INFO - PID 26999 | 09:11:13 INFO - PID 26999 | Cycle 1(1): loaded http://localhost:59623/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59623/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:11:14 INFO - PID 26999 | RSS: Main: 182910976 09:11:14 INFO - PID 26999 | 09:11:17 INFO - PID 26999 | Cycle 1(1): loaded http://localhost:59623/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59623/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:11:18 INFO - PID 26999 | RSS: Main: 182718464 09:11:18 INFO - PID 26999 | 09:11:20 INFO - PID 26999 | Cycle 1(1): loaded http://localhost:59623/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59623/tests/kraken/driver.html?testName=ai-astar) 09:11:20 INFO - PID 26999 | RSS: Main: 184430592 09:11:20 INFO - PID 26999 | 09:11:20 INFO - PID 26999 | __start_tp_report 09:11:20 INFO - PID 26999 | _x_x_mozilla_page_load 09:11:20 INFO - PID 26999 | _x_x_mozilla_page_load_details 09:11:20 INFO - PID 26999 | |i|pagename|runs| 09:11:20 INFO - PID 26999 | |0;ai-astar;104;113;109;109;109;113;111;110;110;111 09:11:20 INFO - PID 26999 | |1;audio-beat-detection;153;126;128;172;123;131;127;128;156;124 09:11:20 INFO - PID 26999 | |2;audio-dft;164;165;162;166;170;170;167;163;164;162 09:11:20 INFO - PID 26999 | |3;audio-fft;74;75;73;118;76;76;75;76;99;74 09:11:20 INFO - PID 26999 | |4;audio-oscillator;84;84;111;84;86;84;103;85;85;110 09:11:20 INFO - PID 26999 | |5;imaging-gaussian-blur;114;114;113;114;114;114;113;115;114;114 09:11:20 INFO - PID 26999 | |6;imaging-darkroom;150;150;151;152;150;151;151;150;150;150 09:11:20 INFO - PID 26999 | |7;imaging-desaturate;95;95;94;94;94;94;94;94;95;95 09:11:20 INFO - PID 26999 | |8;json-parse-financial;55;56;55;56;56;56;57;59;57;57 09:11:20 INFO - PID 26999 | |9;json-stringify-tinderbox;57;57;58;57;56;57;57;57;56;57 09:11:20 INFO - PID 26999 | |10;stanford-crypto-aes;89;90;86;86;87;87;88;88;130;85 09:11:20 INFO - PID 26999 | |11;stanford-crypto-ccm;139;133;138;136;133;134;135;133;142;145 09:11:20 INFO - PID 26999 | |12;stanford-crypto-pbkdf2;188;189;196;191;196;195;182;189;190;193 09:11:20 INFO - PID 26999 | |13;stanford-crypto-sha256-iterative;72;74;72;73;71;77;70;72;70;71 09:11:20 INFO - PID 26999 | __end_tp_report 09:11:20 INFO - PID 26999 | __start_cc_report 09:11:20 INFO - PID 26999 | _x_x_mozilla_cycle_collect,1040 09:11:20 INFO - PID 26999 | __end_cc_report 09:11:20 INFO - PID 26999 | __startTimestamp1495987880409__endTimestamp 09:11:20 INFO - PID 26999 | 09:11:20 INFO - PID 26999 | ------- Summary: start ------- 09:11:20 INFO - PID 26999 | Number of tests: 14 09:11:20 INFO - PID 26999 | 09:11:20 INFO - PID 26999 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.50 stddev:2.56 (2.3%) stddev-sans-first:1.59 09:11:20 INFO - PID 26999 | Values: 104.0 113.0 109.0 109.0 109.0 113.0 111.0 110.0 110.0 111.0 09:11:20 INFO - PID 26999 | 09:11:20 INFO - PID 26999 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:129.50 stddev:17.08 (13.2%) stddev-sans-first:17.08 09:11:20 INFO - PID 26999 | Values: 153.0 126.0 128.0 172.0 123.0 131.0 127.0 128.0 156.0 124.0 09:11:20 INFO - PID 26999 | 09:11:20 INFO - PID 26999 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.50 stddev:2.95 (1.8%) stddev-sans-first:3.09 09:11:20 INFO - PID 26999 | Values: 164.0 165.0 162.0 166.0 170.0 170.0 167.0 163.0 164.0 162.0 09:11:20 INFO - PID 26999 | 09:11:20 INFO - PID 26999 | [#3] audio-fft Cycles:10 Average:81.60 Median:75.50 stddev:14.90 (19.7%) stddev-sans-first:15.55 09:11:20 INFO - PID 26999 | Values: 74.0 75.0 73.0 118.0 76.0 76.0 75.0 76.0 99.0 74.0 09:11:20 INFO - PID 26999 | 09:11:20 INFO - PID 26999 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:84.00 stddev:11.52 (13.7%) stddev-sans-first:11.89 09:11:20 INFO - PID 26999 | Values: 84.0 84.0 111.0 84.0 86.0 84.0 103.0 85.0 85.0 110.0 09:11:20 INFO - PID 26999 | 09:11:20 INFO - PID 26999 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 09:11:20 INFO - PID 26999 | Values: 114.0 114.0 113.0 114.0 114.0 114.0 113.0 115.0 114.0 114.0 09:11:20 INFO - PID 26999 | 09:11:20 INFO - PID 26999 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 09:11:20 INFO - PID 26999 | Values: 150.0 150.0 151.0 152.0 150.0 151.0 151.0 150.0 150.0 150.0 09:11:20 INFO - PID 26999 | 09:11:20 INFO - PID 26999 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:11:20 INFO - PID 26999 | Values: 95.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 09:11:20 INFO - PID 26999 | 09:11:20 INFO - PID 26999 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.50 stddev:1.17 (2.1%) stddev-sans-first:1.13 09:11:20 INFO - PID 26999 | Values: 55.0 56.0 55.0 56.0 56.0 56.0 57.0 59.0 57.0 57.0 09:11:20 INFO - PID 26999 | 09:11:20 INFO - PID 26999 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:57.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 09:11:20 INFO - PID 26999 | Values: 57.0 57.0 58.0 57.0 56.0 57.0 57.0 57.0 56.0 57.0 09:11:20 INFO - PID 26999 | 09:11:20 INFO - PID 26999 | [#10] stanford-crypto-aes Cycles:10 Average:91.60 Median:87.50 stddev:13.57 (15.5%) stddev-sans-first:14.37 09:11:20 INFO - PID 26999 | Values: 89.0 90.0 86.0 86.0 87.0 87.0 88.0 88.0 130.0 85.0 09:11:20 INFO - PID 26999 | 09:11:20 INFO - PID 26999 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:137.00 stddev:4.16 (3.0%) stddev-sans-first:4.33 09:11:20 INFO - PID 26999 | Values: 139.0 133.0 138.0 136.0 133.0 134.0 135.0 133.0 142.0 145.0 09:11:20 INFO - PID 26999 | 09:11:20 INFO - PID 26999 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.90 Median:192.00 stddev:4.33 (2.3%) stddev-sans-first:4.47 09:11:20 INFO - PID 26999 | Values: 188.0 189.0 196.0 191.0 196.0 195.0 182.0 189.0 190.0 193.0 09:11:20 INFO - PID 26999 | 09:11:20 INFO - PID 26999 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:72.00 stddev:2.10 (2.9%) stddev-sans-first:2.22 09:11:20 INFO - PID 26999 | Values: 72.0 74.0 72.0 73.0 71.0 77.0 70.0 72.0 70.0 71.0 09:11:20 INFO - PID 26999 | -------- Summary: end -------- 09:11:20 INFO - PID 26999 | 09:11:21 INFO - TEST-INFO | 26999: exit 0 09:11:21 INFO - TEST-OK | kraken | took 92808ms 09:11:21 INFO - SUITE-END | took 1240s 09:11:22 INFO - Completed test suite (00:20:41) 09:11:22 INFO - javascript benchmark 09:11:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6784.386649311162, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2711.593261010849, 2718.836869787814, 2729.4131761671238, 2754.1049159023323, 2757.5174344489724, 5075.289459475676, 5193.402758682752, 5200.453952335002, 5213.582913366931, 5268.209768534722, 5134.794608215667, 5201.193814958678, 5219.060569097561, 5305.761240744167, 5314.548263397606, 4592.035672508777, 4649.186392381328, 4691.179043667362, 4707.317438971364, 4727.621790256771, 4743.075100355415, 4751.477337492873, 4754.38193034905, 4759.262314341266, 4769.093872164295, 4598.218302888517, 4647.86056418308, 4653.046125544289, 4707.882302942419, 4716.481187069419, 4643.953560464386, 4652.162610730067, 4657.743824089674, 4705.694129881546, 4713.717176969393, 4558.908821823545, 4630.027694184226, 4640.814367425299, 4645.303204519315, 4676.392069031038, 5115.744212789383, 5187.3775146982225, 5191.532762051395, 5197.298364720752, 5251.264822924793, 5649.943500564983, 5736.82789516311, 5749.626274292157, 5757.510611598019, 5764.769409223626, 5746.827595172152, 5752.769889204426, 5761.740721667493, 5773.509251713609, 5776.9422305776825, 5321.388040375367, 5330.067238233293, 5356.651817631841, 5357.330333708286, 5401.216823560561, 5735.483806457355, 5816.331121920949, 5844.970775146097, 5932.0508718604815, 5934.8813023739285, 5614.214010038598, 5615.747291371898, 5633.971830140823, 5661.801836935688, 5685.346185188756, 5621.381648018714, 5676.205331253628, 5725.828225153252, 5738.8278351649515, 5752.223449834219, 5525.392206857243, 5591.888162236733, 5623.072193088176, 5704.515116215168, 5714.542836573064, 5573.916391254134, 5652.0391533439415, 5667.659940403589, 5677.687727175045, 5709.543236541067, 4740.644451666139, 4741.478437371887, 4745.905081898342, 4758.762061896891, 4799.688020278671, 4074.796260186979, 4078.000889781963, 4080.224757296104, 4085.816138273785, 4121.464209652786, 4736.242201247784, 4767.261074533453, 4810.11012962603, 4882.609391248691, 4898.14282500561, 5680.346760122557, 5682.8634273145535, 5694.60137790359, 5722.055860783007, 5735.770569177186, 4772.689775164603, 4779.044191161782, 4784.2823576463115, 4784.425868895755, 4824.49342819006, 4937.604991600663, 5005.62457815658, 5008.69947803133, 5009.974950125226, 5019.096562618691, 5200.895982080261, 5220.190870415092, 5314.070037743457, 5320.866978325573, 5326.041312563776, 5586.497215250647, 5666.15007748841, 5687.146927960839, 5786.161006653927, 5806.042003069446, 5191.377034755854, 5322.946770532245, 5328.520433161034, 5330.147176451904, 5365.651232669864, 5675.205471233948, 5680.829575112753, 5691.573132015033, 5695.943040569541, 5699.173619825019, 5593.804216852391, 5676.17695434168, 5684.317881854204, 5735.197072409949, 5780.566457515787, 5612.298462692163, 5639.7180140993605, 5646.632968857176, 5678.063119585222, 5687.118496633028, 5590.636608620427, 5612.522935550361, 5615.438456154352, 5628.380878103323, 5632.380438151882, 5330.333708286465, 5460.26286451324, 5501.669899805865, 5560.443955604407, 5563.833085007456, 5556.694381808878, 5558.499735023867, 5642.069058605448, 5656.2929633795775, 5660.85847853807, 5433.1035379161995, 5442.673439593637, 5444.6188766785945, 5447.564194864322, 5501.092319767194], "value": 5157.412316010586, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.227533785471, 723.3092396761092, 736.3777607921306, 1084.1976937066572, 1099.598646494029, 32615.347693046155, 33476.83261583689, 33500.0, 33547.66452335476, 33635.159121021985, 34763.47854782174, 35407.82296088523, 35440.64559354405, 35476.2904741905, 35482.8225858871, 6633.668316584176, 6845.555038922479, 6851.417629501499, 6970.059042029337, 6983.895241571355, 6731.158605174353, 6797.864042719143, 6801.115854938876, 6806.829829254259, 6835.350641689031, 6796.422304104132, 6796.966015169917, 6826.146731658543, 6835.658217089151, 6847.417969472601, 6797.184337879461, 6841.452683785285, 6844.623545704984, 6844.802159622096, 6859.0, 6742.056112144303, 6783.3216678332265, 6786.694598743068, 6802.7619033334095, 6816.352446517573, 32544.674553254637, 32601.0, 32819.0, 32844.507332390036, 32942.50586241209, 3025.4554180247546, 3061.4336347775734, 3063.9540406893916, 3068.2942923127584, 3076.0, 24928.376790580198, 24932.50134997308, 24965.62551561728, 25103.0, 25181.24456266315, 3040.0879736079087, 3070.7696922730884, 3084.1826915867314, 3112.7821052526333, 3140.937181256385, 119562.40218798937, 121570.0, 140633.29683351621, 140706.29646851702, 141077.0, 38517.0, 39126.41310380347, 39219.80390098031, 39264.09198850144, 39271.21457570833, 40341.59658403437, 40393.39409908854, 40460.0, 40568.1886362277, 40665.59334406618, 12386.442610082568, 12531.87468125307, 12533.0, 12543.3101179436, 12552.686182845318, 10099.343542669703, 10140.898591014144, 10149.0, 10168.694939151837, 10192.388456692623, 12156.392180390945, 12343.876561234452, 12352.0, 12389.938050309871, 12527.310997895022, 5045.293658887758, 5118.436971933159, 5127.769250383742, 5155.175171972466, 5159.509846564571, 862.7368652560904, 897.6633762339122, 908.9863652045225, 917.1882883648019, 939.3330735177964, 20771.376858694264, 21580.352589422342, 21714.565708686056, 21825.454363640718, 21875.12499500002, 970.8689326940914, 977.4379731654327, 984.4388698441819, 1002.2783595811004, 1007.7883644434751, 11207.159463040305, 11436.94281528587, 11500.309981401142, 11575.073994080622, 11625.76748465026, 166192.0, 166503.0, 166906.0, 167639.0, 168015.0, 40979.0, 41047.589524104376, 41049.38425923613, 41081.58918410837, 41120.58879411227, 1193.319797762656, 1230.5877531027206, 1237.616338934933, 1238.1147479552164, 1242.763874863773, 19619.411417657495, 19793.703094453307, 20368.490787730425, 21260.681089783357, 21406.678899816827, 29875.55186672158, 29899.103026909226, 29922.70077299199, 29941.251468713457, 29962.70037299599, 145859.0, 147093.0, 147589.0, 148896.2555187217, 149445.25277373544, 28375.43249135047, 28703.138905832857, 29798.851005744833, 30630.0, 30644.0, 36335.81832090823, 36578.45132322964, 36602.633973659926, 36650.26699466049, 36650.63349366579, 25637.871810640827, 27311.0, 27403.862980685768, 27605.03382381607, 27749.86125069362, 27551.586726199523, 28012.85993570019, 29223.0, 29341.050979451473, 29541.704582954757, 33645.83177084099, 33686.49470257899, 34106.65893341035, 34253.31493370169, 34321.82839085789, 35512.46731298981, 35757.82121089378, 35758.28483430369, 35953.0, 36063.0, 22532.662010069533, 23417.648735269326, 24939.875300624106, 25000.0, 25172.622410663487], "value": 14599.65654531196, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.5852859347761, 409.43497972797536, 418.3975075890717, 433.1229260746987, 438.5899184262714, 12679.366031698424, 16978.5755356116, 17091.31634734612, 17692.38076667315, 17791.555211119714, 18138.72791908119, 18226.0, 18527.536811579717, 18738.90630546849, 18921.432357029313, 5383.43473935237, 5505.807296744615, 5546.77812887484, 5551.583631227654, 5558.722063896789, 5302.628815982883, 5474.0, 5476.041692703761, 5477.698726570037, 5482.780688772445, 5246.606504512158, 5364.222187782769, 5404.4595540445835, 5415.296011518497, 5431.565474762009, 5427.9185812212845, 5484.095124304485, 5500.697461639608, 5506.972465137689, 5508.173773933902, 4875.8781030474165, 4917.114919314522, 4954.702717836905, 4966.056449274626, 4966.6771659842, 21921.46549741519, 22189.334319970425, 22243.0, 22304.665430018562, 22450.214242501435, 1623.4642567952546, 1637.5578593779733, 1671.089256355277, 1680.7142785726455, 1683.0490772713379, 14382.784258236135, 14684.559463216014, 14825.48110816127, 14860.405583776635, 14879.0, 2026.574419371919, 2032.6747720364672, 2100.243912191625, 2110.947226319339, 2128.6062078515524, 80417.59791201065, 80868.19131808724, 81656.0, 81852.59073704593, 82500.0, 10718.785624287626, 10891.183161262938, 11056.170787190993, 11179.888201118047, 11197.49611267495, 13932.37304321308, 15462.536123916301, 15600.219989000505, 15632.0, 15670.764938525932, 6691.498137639696, 7139.535930164523, 7213.32301157227, 7445.36714379273, 7461.738839140713, 6544.509161812883, 6626.370494802986, 6708.966455167693, 6764.627945462948, 6773.390394864387, 6740.797776066725, 6742.5280230383405, 6755.2231493378895, 6786.083878676414, 6927.757528486479, 2028.5334373094272, 2045.273927755655, 2066.782987786291, 2066.8036536529307, 2070.3685375960476, 834.4534330013851, 874.1870060843477, 897.3852910756153, 905.1898550797, 911.444019148319, 17081.145942702817, 17209.311627535008, 17295.221715022853, 17507.82492175062, 17942.641147177244, 901.3555307954844, 923.7782932096248, 932.7807965128189, 933.2394098809449, 935.8409070458039, 9526.190273826802, 9538.61845526185, 9792.755181120529, 9804.65683701067, 9934.15559677421, 362264.0, 364957.0, 366257.0, 380602.0, 389821.0, 75762.62118689482, 76843.61578192073, 78414.0, 78931.60534197408, 80307.0, 1063.8616979792578, 1065.9626913058005, 1119.054399032816, 1123.9100871930225, 1124.820028795389, 16864.662706745552, 17557.297708091533, 17844.55388615243, 17999.460016199537, 18017.819821801615, 35839.0, 37452.62547374491, 38042.42936356012, 38197.80901095477, 38588.42117368298, 46798.29802553033, 47225.0, 47615.28577071278, 47696.523034770595, 49515.75242123767, 8039.035315762146, 8341.20758527939, 8356.707515236938, 8427.62075706607, 8657.783555411164, 11723.179377443497, 11873.881261187278, 11944.880551194725, 11948.522059117538, 12000.399980001139, 10222.897771022195, 10258.53836577341, 10283.84574231402, 10660.093892019266, 10861.239713219999, 9975.0, 10022.799544009225, 10131.544080516247, 10283.845742313722, 10726.747383049335, 10342.948285258526, 10383.636572719919, 10415.270931034755, 10466.63366782159, 10489.947550262199, 8147.737100749393, 8358.916410835815, 8411.62147703367, 8449.11284315138, 8488.702895398632, 10208.336458130198, 10237.897621023993, 10314.329568578018, 10466.372017678963, 10594.0], "value": 8741.701609537053, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1249.5938819883538, 1345.085341967463, 1346.7845144776838, 1349.1837438349799, 1350.2910971739839, 9998.650047248348, 10438.582456701743, 10581.418022008796, 10600.734981625463, 10737.302075365096, 10158.54286557105, 10365.118964887975, 10388.948055259712, 10393.584256629725, 10408.583656653725, 2101.905414256358, 2133.8186254168413, 2142.7107340509065, 2154.5475450155486, 2157.6979222908803, 2139.657654775236, 2160.9351719448364, 2170.9891450542727, 2173.48942484973, 2185.442712108418, 2106.8735875847497, 2110.535682149932, 2129.37183530858, 2130.052126803573, 2136.2629892686996, 2060.7527096748413, 2082.760482544504, 2086.7600225974056, 2087.4676957375923, 2094.7591027031935, 1875.9437216883516, 1936.6417212815534, 2032.4918770307422, 2087.5929193807215, 2110.0, 10150.644727434505, 10224.897751022469, 10228.488575571266, 10229.335093218917, 10265.076143147078, 5210.791568337262, 5458.590605704549, 5466.0, 5487.807926722586, 5491.588130890199, 3246.2695893423793, 3254.8209848458328, 3350.8659653613827, 3357.647447018077, 3360.0927749507496, 1140.2987162894842, 1147.2428197389684, 1158.223989926751, 1167.97080072998, 1177.9705507362298, 14974.850251497455, 15298.770518442232, 15355.692886142326, 15373.692526149527, 15415.3833846646, 4857.562819346205, 4977.228529577921, 5161.690298582022, 5169.793208271627, 5189.0, 12783.488660453479, 12826.102172847812, 12832.165909215872, 12842.422091005927, 12850.293233872228, 5553.416891226363, 5628.409017053233, 5638.407967163389, 5643.830685079372, 5650.576206784508, 5033.471485494044, 5099.209622508517, 5111.463296353903, 5114.974425127851, 5168.664036837668, 4173.207090652766, 4184.349638895105, 4210.200061988213, 4259.850905218303, 4291.9785401072795, 1219.1039585904352, 1240.4232032105115, 1257.1964519122225, 1270.7966725323904, 1271.1229251816217, 702.5749421599859, 717.2433083097383, 724.626817189148, 726.5023458930649, 733.6331834082958, 5509.449055094458, 5544.7782088716, 5604.2154098425435, 5610.915836262459, 5621.943780562142, 539.3258426966293, 825.4881973176668, 827.962741676626, 829.7510746775943, 839.4963022186639, 3660.0666829958723, 3848.114933565296, 3905.3751399776465, 3919.098607320332, 3957.6796643903767, 12932.224066556037, 13647.317634118255, 13891.583252502442, 13892.93053534726, 13920.0, 13646.454141834414, 13757.518486852912, 13781.931090344484, 13782.310884455737, 13806.585802425943, 7149.177844547944, 7231.9999999998945, 7310.780676579711, 7337.046183996153, 7424.591647459441, 5478.369987451335, 5548.334199896039, 5618.606697531133, 5766.4233576642, 5774.451427114417, 12006.939965300118, 12298.385080745747, 12394.690132746393, 12429.0, 12534.435950382436, 12533.686657833627, 12587.874121259036, 12602.747945041232, 12719.364031798557, 12788.296643684687, 7817.179196184319, 7906.367490600623, 7960.6417711201975, 7972.242636949481, 8020.639071241691, 9660.565274562521, 9703.563339649592, 9714.174295184988, 9781.559829807533, 9800.264980126662, 8138.511689298661, 8161.265486106279, 8182.83634327322, 8201.384896132933, 8220.671173153007, 8067.112617611941, 8171.346292296721, 8198.83602327962, 8223.917760822314, 8292.87560686578, 7019.333163349474, 7158.3915367192285, 7197.71209151628, 7216.134063912364, 7231.240719724564, 5136.30659860929, 5167.405748338989, 5174.404943431554, 5279.392869819866, 5363.0614642438195, 5171.663841850268, 5193.76628051731, 5252.343457067866, 5288.2860813791185, 5364.14173732201], "value": 4776.200376988149, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.39738061012616, 354.831455058847, 390.9237698648763, 397.14019148543423, 401.76898283487003, 5464.590155738316, 5471.343438787346, 5487.972560137204, 5504.669719816814, 5536.335639723234, 5304.814331498398, 5378.2470454136455, 5382.4886635769635, 5388.7305634718205, 5398.217258497515, 4209.179210054033, 4214.494260688722, 4214.894627634319, 4222.746635201883, 4241.491021077475, 4209.137126888996, 4223.51429585597, 4228.429162063128, 4240.766757828318, 4243.363495475673, 4110.8972275693195, 4196.328587426013, 4202.327627579588, 4212.1996820604145, 4225.535191128974, 4159.812808423628, 4183.958160418402, 4184.895377615553, 4186.183694179636, 4192.496900371975, 3790.223004284115, 3792.5348523459697, 3793.4499497572974, 3810.5427348718054, 3841.5390153181515, 5249.370075590915, 5255.632105752599, 5263.289455923439, 5265.946280950432, 5273.367195936474, 4873.537013983666, 4991.226359914219, 5014.52362025607, 5038.564009257344, 5042.84871453857, 5721.284839395075, 5739.081746920514, 5749.568782341341, 5756.33802112754, 5770.653760774367, 4219.7046206765535, 4288.721233119868, 4297.001894119249, 4301.225779359714, 4303.784810759481, 5828.795992140254, 5836.824895253107, 5969.492593129589, 5988.8502787430225, 6004.579679422486, 4147.419361289422, 4182.665386769051, 4185.518665353523, 4186.623203911602, 4189.601987811153, 4186.979065104655, 4225.704200705921, 4229.429027081304, 4231.87304380869, 4237.745735255895, 4711.458182309078, 4797.544233297831, 4821.2045012572535, 4849.127157111754, 4850.563449289581, 5691.459311365414, 5724.284464441945, 5733.254676891977, 5738.856528586819, 5752.28096487939, 1450.3111022264552, 1451.1148199598238, 1464.9560513184622, 1466.5307101727344, 1468.8237411510688, 956.5886668732512, 957.5834511987308, 1002.4236064262932, 1006.2654262388497, 1009.5406590001678, 4943.8516844494725, 4950.7721525313755, 4957.529034741694, 4970.254461830755, 4977.576905963034, 5900.321463031721, 5945.554083443759, 5948.494377977834, 5948.553858460633, 5991.5206783457215, 4792.496787837227, 4881.486739110887, 4927.384076990376, 4936.753162341868, 4945.0, 3094.9535756963664, 3138.905832825019, 3139.576157218792, 3148.307372378073, 3150.33842892995, 5402.011913294909, 5427.782888684487, 5427.8330159016, 5467.644603100785, 5471.06991811393, 5998.640081595118, 6001.699915004232, 6027.8794424111275, 6042.909356359658, 6062.151298818169, 5421.647592906448, 5436.3476382834315, 5438.918416223839, 5445.646033007842, 5454.972725136428, 5730.541556675373, 5857.648541087378, 5879.647221166743, 5906.881862362815, 5910.556708246984, 5781.797637082682, 5803.47768700819, 5827.737751801094, 5831.241938547962, 5843.211166492469, 5191.273221748883, 5333.7866485340155, 5353.598480113929, 5436.293281873332, 5441.183822426668, 4111.8560850370095, 4120.660785244748, 4142.482189726285, 4144.378343248537, 4147.2534943710425, 5857.4435428634215, 5940.524758019262, 5944.49471794885, 5958.612690175125, 5968.134620480093, 5682.090865461506, 5708.429157084424, 5717.571182161271, 5732.742026608729, 5739.167820666064, 5598.916016259678, 5675.4892059713175, 5688.431156884279, 5711.428857114422, 5744.454276843693, 5494.560435165257, 5630.324361076697, 5634.577406694596, 5641.323041234914, 5661.433856614306, 5749.367569567428, 5757.769689212385, 5767.68277744728, 5809.448102430262, 5835.2122463466885, 5527.613067085426, 5603.243562119224, 5626.803061892814, 5634.718264086861, 5638.519051617439], "value": 4320.92264317704, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.8483310921262, 747.8504299140171, 756.5914406220642, 762.7330434347979, 772.02339041113, 13795.379207935643, 14898.925505372472, 14913.925430372847, 16345.34618615257, 16941.237644306006, 15258.389664413438, 15290.159041252728, 15308.387664493435, 15313.0812151271, 15330.540083797503, 883.9558022098886, 906.1527471813843, 909.3589019741099, 910.0444533240104, 910.3809409601469, 887.9289656827439, 888.9777755556098, 891.589868660417, 892.2193081054078, 892.892852857658, 926.5321012888481, 931.1293940165932, 931.7065124485765, 933.0995589256366, 942.0344147249056, 928.6563971330584, 929.5352323838081, 930.6742640076021, 931.2317338196016, 937.503123344625, 677.3429773120066, 679.3342524326139, 680.1328306409318, 681.9113515242987, 686.9347411995852, 14313.928430357886, 14350.282485875665, 14453.855461445357, 14515.346809393603, 14582.0, 15694.372225110981, 16179.0, 16193.0, 16271.267792949227, 16351.26419311122, 12733.299668518228, 12796.360181990864, 13016.804747928789, 13024.609261722164, 13072.803907941388, 3026.107298346993, 3036.498977668682, 3052.3895220955897, 3056.098450956973, 3069.2326918270433, 85330.0, 85495.0, 86378.0, 86988.0, 87843.99999999936, 12789.424475898606, 12809.103362764517, 13021.414036368385, 13037.608871733863, 13039.478420863248, 22609.660855087186, 23144.07423703033, 23260.185893493646, 23421.648675269884, 23438.531229375316, 5866.794662186803, 5980.55145864062, 6009.879802403927, 6073.6659483727935, 6091.086337049478, 3078.6767389424235, 3177.4757165067967, 3185.6973587509615, 3190.0748782853175, 3192.3296107817155, 3835.1754372809423, 3966.920661586752, 3968.444417781513, 3973.980130099389, 3984.2429938312207, 703.4528219280555, 720.8882623193414, 729.1141263365037, 730.7296300368897, 735.7498450526847, 592.1827877528982, 610.5542953643776, 622.0917460507709, 630.1272737258929, 638.2245571630491, 9867.901320986699, 10056.396616203052, 10299.794004120025, 10399.308245572864, 10406.479676016168, 566.8186180422225, 570.3327107284405, 574.615007944678, 580.1529766540813, 595.9880802384015, 4691.108689349013, 4785.59322457595, 4934.432540257844, 5032.32063671407, 5060.645754797202, 72873.27126728771, 73440.63279683674, 76347.23652763401, 84834.0, 86742.56628716942, 65563.86622594502, 65737.0, 65915.67042164759, 66331.66834165798, 68512.31487685059, 57527.71236143876, 57993.42006579965, 58497.415025850045, 59961.400385995585, 60022.492689875966, 9453.0, 10320.896791032294, 10612.310199836986, 11161.330320180816, 11213.327200368005, 26814.329641759112, 27476.0, 27944.580831287953, 27999.160025199275, 28986.565201522415, 50022.0, 50136.247956279956, 50746.746266268434, 51043.744781275855, 51119.0, 13289.269090200132, 13491.932540337235, 13615.79576306376, 13759.10565813219, 13767.518136865161, 15293.694126117638, 15856.44502442409, 15971.840281597035, 16223.107729074542, 16304.673906521566, 14187.935904806975, 14402.927985360426, 14434.133951962916, 14562.271886405426, 14673.339699713752, 13281.601551953458, 13598.320083995563, 13708.0, 13718.862811371759, 13820.963427743161, 14005.0, 14471.782923255949, 15339.539813805604, 15478.303476343817, 15662.686746265239, 9781.41311521311, 9984.151347135576, 10323.63867264642, 10353.63762268317, 10702.411367374869, 10697.358158510515, 10732.570697172338, 11223.0, 11352.318860868045, 11375.943120284346], "value": 7177.985210876107, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 109.0, 109.0, 109.0, 113.0, 111.0, 110.0, 110.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 128.0, 172.0, 123.0, 131.0, 127.0, 128.0, 156.0, 124.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 162.0, 166.0, 170.0, 170.0, 167.0, 163.0, 164.0, 162.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 73.0, 118.0, 76.0, 76.0, 75.0, 76.0, 99.0, 74.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 111.0, 84.0, 86.0, 84.0, 103.0, 85.0, 85.0, 110.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 115.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 152.0, 150.0, 151.0, 151.0, 150.0, 150.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 56.0, 56.0, 56.0, 57.0, 59.0, 57.0, 57.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 57.0, 56.0, 57.0, 57.0, 57.0, 56.0, 57.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 86.0, 86.0, 87.0, 87.0, 88.0, 88.0, 130.0, 85.0], "value": 91.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 133.0, 138.0, 136.0, 133.0, 134.0, 135.0, 133.0, 142.0, 145.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 189.0, 196.0, 191.0, 196.0, 195.0, 182.0, 189.0, 190.0, 193.0], "value": 190.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 72.0, 73.0, 71.0, 77.0, 70.0, 72.0, 70.0, 71.0], "value": 72.2, "unit": "score"}]}]} 09:11:22 INFO - Return code: 0 09:11:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:11:22 INFO - # TBPL SUCCESS # 09:11:22 INFO - Running post-action listener: _resource_record_post_action 09:11:22 INFO - [mozharness: 2017-05-28 16:11:22.196619Z] Finished run-tests step (success) 09:11:22 INFO - Running post-run listener: _resource_record_post_run 09:11:22 INFO - Total resource usage - Wall time: 1257s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403030016; Read time: 28; Write time: 224416 09:11:22 INFO - TinderboxPrint: CPU usage
12.7% 09:11:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 28 09:11:22 INFO - TinderboxPrint: I/O write bytes / time
403,030,016 / 224,416 09:11:22 INFO - TinderboxPrint: CPU idle
8,762.7 (87.3%) 09:11:22 INFO - TinderboxPrint: CPU user
1,219.0 (12.1%) 09:11:22 INFO - TinderboxPrint: Swap in / out
0 / 0 09:11:22 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 30879744; Read time: 0; Write time: 6784 09:11:22 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:11:22 INFO - run-tests - Wall time: 1242s; CPU: 13.0%; Read bytes: 4096; Write bytes: 305352704; Read time: 28; Write time: 162876 09:11:22 INFO - Running post-run listener: _upload_blobber_files 09:11:22 INFO - Blob upload gear active. 09:11:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:11:22 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 09:11:22 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'] 09:11:22 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 09:11:23 INFO - (blobuploader) - INFO - Open directory for files ... 09:11:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:11:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:11:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:23 INFO - (blobuploader) - INFO - Done attempting. 09:11:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:11:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:11:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:24 INFO - (blobuploader) - INFO - Done attempting. 09:11:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:11:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:11:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:31 INFO - (blobuploader) - INFO - Done attempting. 09:11:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:11:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:11:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:32 INFO - (blobuploader) - INFO - Done attempting. 09:11:32 INFO - (blobuploader) - INFO - Iteration through files over. 09:11:32 INFO - Return code: 0 09:11:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:11:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:11:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a480c59a0358c78fe47ce420bdf5def1505eaec015e9e2aa0f9638418e8a2f656a037dce9b25a1c4a2cae59e357b6bdfc6cbbb3cb1855b3260aa458cd69d7f7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/257fb0a7b393aff41889b2e30fc8b8f8eec4d6da9031b255f50d27e40897829d920e1dea6c04ba4be261603d1447ac00e35d91c9c2ed20e364256068058f014e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d48c6827d7dfe328e2e7e7d8a8d5a82851decc6bd5d469d5034e8c7adb6f80bdb4139330751cc908c16c82ec1710c554a52a700b7cea2ca295fd9d3f5d025a7e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/84f305b9bce955f65bcf146d7f00b6ce02fd669510644947c532b4406066a8a5cadadeff170f986fa32aba1a42e595b86afce4fa05018bda59cced012aa71959"} 09:11:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:11:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:11:32 INFO - Contents: 09:11:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a480c59a0358c78fe47ce420bdf5def1505eaec015e9e2aa0f9638418e8a2f656a037dce9b25a1c4a2cae59e357b6bdfc6cbbb3cb1855b3260aa458cd69d7f7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/257fb0a7b393aff41889b2e30fc8b8f8eec4d6da9031b255f50d27e40897829d920e1dea6c04ba4be261603d1447ac00e35d91c9c2ed20e364256068058f014e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d48c6827d7dfe328e2e7e7d8a8d5a82851decc6bd5d469d5034e8c7adb6f80bdb4139330751cc908c16c82ec1710c554a52a700b7cea2ca295fd9d3f5d025a7e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/84f305b9bce955f65bcf146d7f00b6ce02fd669510644947c532b4406066a8a5cadadeff170f986fa32aba1a42e595b86afce4fa05018bda59cced012aa71959"} 09:11:32 INFO - Running post-run listener: copy_logs_to_upload_dir 09:11:32 INFO - Copying logs to upload dir... 09:11:32 INFO - mkdir: /builds/slave/test/build/upload/logs 09:11:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1316.597466 ========= master_lag: -0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-05-28 09:11:31.831355) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-28 09:11:31.834552) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a480c59a0358c78fe47ce420bdf5def1505eaec015e9e2aa0f9638418e8a2f656a037dce9b25a1c4a2cae59e357b6bdfc6cbbb3cb1855b3260aa458cd69d7f7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/257fb0a7b393aff41889b2e30fc8b8f8eec4d6da9031b255f50d27e40897829d920e1dea6c04ba4be261603d1447ac00e35d91c9c2ed20e364256068058f014e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d48c6827d7dfe328e2e7e7d8a8d5a82851decc6bd5d469d5034e8c7adb6f80bdb4139330751cc908c16c82ec1710c554a52a700b7cea2ca295fd9d3f5d025a7e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/84f305b9bce955f65bcf146d7f00b6ce02fd669510644947c532b4406066a8a5cadadeff170f986fa32aba1a42e595b86afce4fa05018bda59cced012aa71959"} build_url:https://queue.taskcluster.net/v1/task/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011281 build_url: 'https://queue.taskcluster.net/v1/task/VlwvVN6nRR2Yz4_i8i1nOA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a480c59a0358c78fe47ce420bdf5def1505eaec015e9e2aa0f9638418e8a2f656a037dce9b25a1c4a2cae59e357b6bdfc6cbbb3cb1855b3260aa458cd69d7f7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/257fb0a7b393aff41889b2e30fc8b8f8eec4d6da9031b255f50d27e40897829d920e1dea6c04ba4be261603d1447ac00e35d91c9c2ed20e364256068058f014e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d48c6827d7dfe328e2e7e7d8a8d5a82851decc6bd5d469d5034e8c7adb6f80bdb4139330751cc908c16c82ec1710c554a52a700b7cea2ca295fd9d3f5d025a7e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/84f305b9bce955f65bcf146d7f00b6ce02fd669510644947c532b4406066a8a5cadadeff170f986fa32aba1a42e595b86afce4fa05018bda59cced012aa71959"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-28 09:11:31.866513) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 09:11:31.866923) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1495981462.997927-1118511760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 09:11:31.951503) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-28 09:11:31.951963) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-28 09:11:31.952370) ========= ========= Total master_lag: 0.05 =========