builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-063 starttime: 1466587765.41 results: success (0) buildid: 20160621234002 builduid: 857be21ca7ae409584522603bb514c23 revision: 0bcc9439bf8c9106740ce9e7cb3bb0131487ae67 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 02:29:25.408062) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 02:29:25.408641) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 02:29:25.409087) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 02:29:25.424925) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:29:25.425255) ========= 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=33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 02:29:26-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.4M=0s 2016-06-22 02:29:26 (41.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118460 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:29:25.557791) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:29:25.558142) ========= 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=33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020031 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:29:25.612026) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:29:25.612413) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0bcc9439bf8c9106740ce9e7cb3bb0131487ae67 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0bcc9439bf8c9106740ce9e7cb3bb0131487ae67 --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=33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 02:29:26,266 truncating revision to first 12 chars 2016-06-22 02:29:26,266 Setting DEBUG logging. 2016-06-22 02:29:26,266 attempt 1/10 2016-06-22 02:29:26,266 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0bcc9439bf8c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 02:29:26,623 unpacking tar archive at: mozilla-beta-0bcc9439bf8c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.673368 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:29:26.300098) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 02:29:26.300528) ========= script_repo_revision: 0bcc9439bf8c9106740ce9e7cb3bb0131487ae67 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 02:29:26.301061) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 02:29:26.301376) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 02:29:26.311828) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-22 02:29:26.312210) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:29:27 INFO - MultiFileLogger online at 20160622 02:29:27 in /builds/slave/test 02:29:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 02:29:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:29:27 INFO - {'append_to_log': False, 02:29:27 INFO - 'base_work_dir': '/builds/slave/test', 02:29:27 INFO - 'blob_upload_branch': 'Mozilla-Beta', 02:29:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:29:27 INFO - 'branch': 'Mozilla-Beta', 02:29:27 INFO - 'buildbot_json_path': 'buildprops.json', 02:29:27 INFO - 'config_files': ('talos/linux_config.py',), 02:29:27 INFO - 'default_actions': ('clobber', 02:29:27 INFO - 'read-buildbot-config', 02:29:27 INFO - 'download-and-extract', 02:29:27 INFO - 'populate-webroot', 02:29:27 INFO - 'create-virtualenv', 02:29:27 INFO - 'install', 02:29:27 INFO - 'run-tests'), 02:29:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:29:27 INFO - 'download_minidump_stackwalk': True, 02:29:27 INFO - 'download_symbols': 'ondemand', 02:29:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:29:27 INFO - 'tooltool.py': '/tools/tooltool.py', 02:29:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:29:27 INFO - '/tools/misc-python/virtualenv.py')}, 02:29:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:29:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:29:27 INFO - 'installer_path': 'installer.exe', 02:29:27 INFO - 'log_level': 'info', 02:29:27 INFO - 'log_name': 'talos', 02:29:27 INFO - 'log_to_console': True, 02:29:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:29:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:29:27 INFO - 'opt_config_files': (), 02:29:27 INFO - 'pip_index': False, 02:29:27 INFO - 'sps_profile': False, 02:29:27 INFO - 'sps_profile_interval': 0, 02:29:27 INFO - 'suite': 'dromaeojs', 02:29:27 INFO - 'system_bits': '32', 02:29:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:29:27 INFO - 'title': 'talos-linux64-ix-063', 02:29:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:29:27 INFO - 'use_talos_json': True, 02:29:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:29:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:29:27 INFO - 'work_dir': 'build'} 02:29:27 INFO - ##### 02:29:27 INFO - ##### Running clobber step. 02:29:27 INFO - ##### 02:29:27 INFO - Running pre-action listener: _resource_record_pre_action 02:29:27 INFO - Running main action method: clobber 02:29:27 INFO - rmtree: /builds/slave/test/build 02:29:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:29:27 INFO - Running post-action listener: _resource_record_post_action 02:29:27 INFO - ##### 02:29:27 INFO - ##### Running read-buildbot-config step. 02:29:27 INFO - ##### 02:29:27 INFO - Running pre-action listener: _resource_record_pre_action 02:29:27 INFO - Running main action method: read_buildbot_config 02:29:27 INFO - Using buildbot properties: 02:29:27 INFO - { 02:29:27 INFO - "project": "", 02:29:27 INFO - "product": "firefox", 02:29:27 INFO - "script_repo_revision": "production", 02:29:27 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 02:29:27 INFO - "repository": "", 02:29:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 02:29:27 INFO - "buildid": "20160621234002", 02:29:27 INFO - "pgo_build": "True", 02:29:27 INFO - "basedir": "/builds/slave/test", 02:29:27 INFO - "buildnumber": 56, 02:29:27 INFO - "slavename": "talos-linux64-ix-063", 02:29:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:29:27 INFO - "platform": "ubuntu64_hw", 02:29:27 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 02:29:27 INFO - "branch": "mozilla-beta", 02:29:27 INFO - "repo_path": "releases/mozilla-beta", 02:29:27 INFO - "revision": "0bcc9439bf8c9106740ce9e7cb3bb0131487ae67", 02:29:27 INFO - "stage_platform": "linux64-pgo", 02:29:27 INFO - "builduid": "857be21ca7ae409584522603bb514c23", 02:29:27 INFO - "slavebuilddir": "test" 02:29:27 INFO - } 02:29:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 02:29:27 INFO - Running post-action listener: _resource_record_post_action 02:29:27 INFO - ##### 02:29:27 INFO - ##### Running download-and-extract step. 02:29:27 INFO - ##### 02:29:27 INFO - Running pre-action listener: _resource_record_pre_action 02:29:27 INFO - Running main action method: download_and_extract 02:29:27 INFO - mkdir: /builds/slave/test/build/tests 02:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:27 INFO - https://queue.taskcluster.net/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:29:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 02:29:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 02:29:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 02:29:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:29:28 INFO - Downloaded 1327 bytes. 02:29:28 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 02:29:28 INFO - Using the following test package requirements: 02:29:28 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 02:29:28 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:29:28 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 02:29:28 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:29:28 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 02:29:28 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:29:28 INFO - u'jsshell-linux-x86_64.zip'], 02:29:28 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:29:28 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 02:29:28 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 02:29:28 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:29:28 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 02:29:28 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:29:28 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 02:29:28 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:29:28 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 02:29:28 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:29:28 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 02:29:28 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:29:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:28 INFO - https://queue.taskcluster.net/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:29:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:29:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:29:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:29:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:29:29 INFO - Downloaded 24186972 bytes. 02:29:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:29:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:29:30 INFO - Return code: 0 02:29:30 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:30 INFO - https://queue.taskcluster.net/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:29:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:29:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:29:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:29:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:29:33 INFO - Downloaded 24186972 bytes. 02:29:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:29:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:29:34 INFO - Return code: 0 02:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:34 INFO - https://queue.taskcluster.net/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:29:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 02:29:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 02:29:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 02:29:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:29:36 INFO - Downloaded 10840145 bytes. 02:29:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:29:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:29:36 INFO - Return code: 0 02:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:36 INFO - https://queue.taskcluster.net/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:29:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 02:29:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 02:29:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 02:29:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:29:38 INFO - Downloaded 56003536 bytes. 02:29:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 02:29:38 INFO - mkdir: /builds/slave/test/properties 02:29:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:29:38 INFO - Writing to file /builds/slave/test/properties/build_url 02:29:38 INFO - Contents: 02:29:38 INFO - build_url:https://queue.taskcluster.net/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 02:29:39 INFO - Running post-action listener: _resource_record_post_action 02:29:39 INFO - Running post-action listener: set_extra_try_arguments 02:29:39 INFO - ##### 02:29:39 INFO - ##### Running populate-webroot step. 02:29:39 INFO - ##### 02:29:39 INFO - Running pre-action listener: _resource_record_pre_action 02:29:39 INFO - Running main action method: populate_webroot 02:29:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:29:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:29:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:29:39 INFO - '--tppagecycles', 02:29:39 INFO - '7'], 02:29:39 INFO - 'tests': ['tsvgm']}}, 02:29:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:29:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:29:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:29:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:29:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:29:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:29:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:39 INFO - 'talos_options': ['--disable-e10s'], 02:29:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:29:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:29:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:39 INFO - 'talos_options': ['--disable-e10s'], 02:29:39 INFO - 'tests': ['damp', 'tps']}, 02:29:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:39 INFO - 'tests': ['damp', 'tps']}, 02:29:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:29:39 INFO - 'tests': ['dromaeo_dom']}, 02:29:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:29:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:29:39 INFO - 'tests': ['a11yr', 02:29:39 INFO - 'ts_paint', 02:29:39 INFO - 'tpaint', 02:29:39 INFO - 'sessionrestore', 02:29:39 INFO - 'sessionrestore_no_auto_restore', 02:29:39 INFO - 'tabpaint']}, 02:29:39 INFO - 'other-e10s': {'tests': ['a11yr', 02:29:39 INFO - 'ts_paint', 02:29:39 INFO - 'tpaint', 02:29:39 INFO - 'sessionrestore', 02:29:39 INFO - 'sessionrestore_no_auto_restore', 02:29:39 INFO - 'tabpaint']}, 02:29:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:29:39 INFO - 'ts_paint', 02:29:39 INFO - 'tpaint', 02:29:39 INFO - 'sessionrestore', 02:29:39 INFO - 'sessionrestore_no_auto_restore', 02:29:39 INFO - 'tabpaint']}, 02:29:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:29:39 INFO - 'ts_paint', 02:29:39 INFO - 'tpaint', 02:29:39 INFO - 'sessionrestore', 02:29:39 INFO - 'sessionrestore_no_auto_restore', 02:29:39 INFO - 'tabpaint']}, 02:29:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:29:39 INFO - 'tests': ['a11yr', 02:29:39 INFO - 'ts_paint', 02:29:39 INFO - 'tpaint', 02:29:39 INFO - 'sessionrestore', 02:29:39 INFO - 'sessionrestore_no_auto_restore', 02:29:39 INFO - 'tabpaint']}, 02:29:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:29:39 INFO - 'tests': ['a11yr', 02:29:39 INFO - 'ts_paint', 02:29:39 INFO - 'tpaint', 02:29:39 INFO - 'sessionrestore', 02:29:39 INFO - 'sessionrestore_no_auto_restore', 02:29:39 INFO - 'tabpaint']}, 02:29:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:29:39 INFO - 'tests': ['tsvgx', 02:29:39 INFO - 'tsvgr_opacity', 02:29:39 INFO - 'tart', 02:29:39 INFO - 'tscrollx', 02:29:39 INFO - 'cart']}, 02:29:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:29:39 INFO - 'tsvgr_opacity', 02:29:39 INFO - 'tart', 02:29:39 INFO - 'tscrollx', 02:29:39 INFO - 'cart']}, 02:29:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:39 INFO - 'talos_options': ['--disable-e10s'], 02:29:39 INFO - 'tests': ['tp5o']}, 02:29:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:39 INFO - 'tests': ['tp5o']}, 02:29:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:39 INFO - 'talos_options': ['--disable-e10s', 02:29:39 INFO - '--xperf_path', 02:29:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:29:39 INFO - 'tests': ['tp5n']}, 02:29:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:39 INFO - 'talos_options': ['--xperf_path', 02:29:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:29:39 INFO - 'tests': ['tp5n']}}, 02:29:39 INFO - 'talos.zip': {'path': '', 02:29:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:29:39 INFO - Running post-action listener: _resource_record_post_action 02:29:39 INFO - ##### 02:29:39 INFO - ##### Running create-virtualenv step. 02:29:39 INFO - ##### 02:29:39 INFO - Running pre-action listener: _resource_record_pre_action 02:29:39 INFO - Running main action method: create_virtualenv 02:29:39 INFO - Creating virtualenv /builds/slave/test/build/venv 02:29:39 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 02:29:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:29:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:29:39 INFO - Using real prefix '/usr' 02:29:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:29:40 INFO - Installing distribute.............................................................................................................................................................................................done. 02:29:42 INFO - Installing pip.................done. 02:29:42 INFO - Return code: 0 02:29:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:42 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7ffe92fd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2500410>, '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 0x2501310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25017a0>, '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': '33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137', '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 02:29:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 02:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:29:42 INFO - Using env: {'DISPLAY': ':0', 02:29:42 INFO - 'HOME': '/home/cltbld', 02:29:42 INFO - 'LANG': 'en_US.UTF-8', 02:29:42 INFO - 'LANGUAGE': 'en_US:en', 02:29:42 INFO - 'LOGNAME': 'cltbld', 02:29:42 INFO - 'MAIL': '/var/mail/cltbld', 02:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:42 INFO - 'MOZ_NO_REMOTE': '1', 02:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:42 INFO - 'NO_EM_RESTART': '1', 02:29:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:42 INFO - 'PWD': '/builds/slave/test', 02:29:42 INFO - 'SHELL': '/bin/bash', 02:29:42 INFO - 'SHLVL': '1', 02:29:42 INFO - 'TERM': 'linux', 02:29:42 INFO - 'TMOUT': '86400', 02:29:42 INFO - 'USER': 'cltbld', 02:29:42 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137', 02:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:42 INFO - '_': '/tools/buildbot/bin/python'} 02:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:42 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 02:29:42 INFO - Cleaning up... 02:29:42 INFO - Return code: 0 02:29:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:42 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe92fd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2500410>, '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 0x2501310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25017a0>, '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': '33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137', '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 02:29:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:29:42 INFO - Using env: {'DISPLAY': ':0', 02:29:42 INFO - 'HOME': '/home/cltbld', 02:29:42 INFO - 'LANG': 'en_US.UTF-8', 02:29:42 INFO - 'LANGUAGE': 'en_US:en', 02:29:42 INFO - 'LOGNAME': 'cltbld', 02:29:42 INFO - 'MAIL': '/var/mail/cltbld', 02:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:42 INFO - 'MOZ_NO_REMOTE': '1', 02:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:42 INFO - 'NO_EM_RESTART': '1', 02:29:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:42 INFO - 'PWD': '/builds/slave/test', 02:29:42 INFO - 'SHELL': '/bin/bash', 02:29:42 INFO - 'SHLVL': '1', 02:29:42 INFO - 'TERM': 'linux', 02:29:42 INFO - 'TMOUT': '86400', 02:29:42 INFO - 'USER': 'cltbld', 02:29:42 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137', 02:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:42 INFO - '_': '/tools/buildbot/bin/python'} 02:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:42 INFO - Downloading/unpacking psutil>=0.7.1 02:29:42 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 02:29:42 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 02:29:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:42 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 02:29:42 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 02:29:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:29:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:29:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:29:44 INFO - Installing collected packages: psutil 02:29:44 INFO - Running setup.py install for psutil 02:29:44 INFO - building 'psutil._psutil_linux' extension 02:29:44 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 02:29:45 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 02:29:45 INFO - building 'psutil._psutil_posix' extension 02:29:45 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 02:29:45 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 02:29:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:29:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:29:45 INFO - Successfully installed psutil 02:29:45 INFO - Cleaning up... 02:29:45 INFO - Return code: 0 02:29:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:45 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe92fd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2500410>, '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 0x2501310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25017a0>, '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': '33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137', '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 02:29:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:29:45 INFO - Using env: {'DISPLAY': ':0', 02:29:45 INFO - 'HOME': '/home/cltbld', 02:29:45 INFO - 'LANG': 'en_US.UTF-8', 02:29:45 INFO - 'LANGUAGE': 'en_US:en', 02:29:45 INFO - 'LOGNAME': 'cltbld', 02:29:45 INFO - 'MAIL': '/var/mail/cltbld', 02:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:45 INFO - 'MOZ_NO_REMOTE': '1', 02:29:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:45 INFO - 'NO_EM_RESTART': '1', 02:29:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:45 INFO - 'PWD': '/builds/slave/test', 02:29:45 INFO - 'SHELL': '/bin/bash', 02:29:45 INFO - 'SHLVL': '1', 02:29:45 INFO - 'TERM': 'linux', 02:29:45 INFO - 'TMOUT': '86400', 02:29:45 INFO - 'USER': 'cltbld', 02:29:45 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137', 02:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:45 INFO - '_': '/tools/buildbot/bin/python'} 02:29:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:29:45 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 02:29:45 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 02:29:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:45 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 02:29:45 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 02:29:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:29:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:29:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:29:47 INFO - Installing collected packages: mozsystemmonitor 02:29:47 INFO - Running setup.py install for mozsystemmonitor 02:29:47 INFO - Successfully installed mozsystemmonitor 02:29:47 INFO - Cleaning up... 02:29:47 INFO - Return code: 0 02:29:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:29:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:47 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7ffe92fd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2500410>, '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 0x2501310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25017a0>, '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': '33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137', '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 02:29:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 02:29:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:29:47 INFO - Using env: {'DISPLAY': ':0', 02:29:47 INFO - 'HOME': '/home/cltbld', 02:29:47 INFO - 'LANG': 'en_US.UTF-8', 02:29:47 INFO - 'LANGUAGE': 'en_US:en', 02:29:47 INFO - 'LOGNAME': 'cltbld', 02:29:47 INFO - 'MAIL': '/var/mail/cltbld', 02:29:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:47 INFO - 'MOZ_NO_REMOTE': '1', 02:29:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:47 INFO - 'NO_EM_RESTART': '1', 02:29:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:47 INFO - 'PWD': '/builds/slave/test', 02:29:47 INFO - 'SHELL': '/bin/bash', 02:29:47 INFO - 'SHLVL': '1', 02:29:47 INFO - 'TERM': 'linux', 02:29:47 INFO - 'TMOUT': '86400', 02:29:47 INFO - 'USER': 'cltbld', 02:29:47 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137', 02:29:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:47 INFO - '_': '/tools/buildbot/bin/python'} 02:29:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:47 INFO - Downloading/unpacking blobuploader==1.2.4 02:29:47 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 02:29:47 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 02:29:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:47 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 02:29:47 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 02:29:49 INFO - Downloading blobuploader-1.2.4.tar.gz 02:29:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:29:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:29:49 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 02:29:49 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 02:29:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:49 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 02:29:49 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 02:29:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:29:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:29:50 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 02:29:50 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 02:29:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:50 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 02:29:50 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 02:29:50 INFO - Downloading docopt-0.6.1.tar.gz 02:29:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:29:50 INFO - Installing collected packages: blobuploader, requests, docopt 02:29:50 INFO - Running setup.py install for blobuploader 02:29:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:29:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:29:50 INFO - Running setup.py install for requests 02:29:51 INFO - Running setup.py install for docopt 02:29:51 INFO - Successfully installed blobuploader requests docopt 02:29:51 INFO - Cleaning up... 02:29:51 INFO - Return code: 0 02:29:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:29:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:51 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7ffe92fd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2500410>, '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 0x2501310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25017a0>, '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': '33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137', '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 02:29:51 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 02:29:51 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:29:51 INFO - Using env: {'DISPLAY': ':0', 02:29:51 INFO - 'HOME': '/home/cltbld', 02:29:51 INFO - 'LANG': 'en_US.UTF-8', 02:29:51 INFO - 'LANGUAGE': 'en_US:en', 02:29:51 INFO - 'LOGNAME': 'cltbld', 02:29:51 INFO - 'MAIL': '/var/mail/cltbld', 02:29:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:51 INFO - 'MOZ_NO_REMOTE': '1', 02:29:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:51 INFO - 'NO_EM_RESTART': '1', 02:29:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:51 INFO - 'PWD': '/builds/slave/test', 02:29:51 INFO - 'SHELL': '/bin/bash', 02:29:51 INFO - 'SHLVL': '1', 02:29:51 INFO - 'TERM': 'linux', 02:29:51 INFO - 'TMOUT': '86400', 02:29:51 INFO - 'USER': 'cltbld', 02:29:51 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137', 02:29:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:51 INFO - '_': '/tools/buildbot/bin/python'} 02:29:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:29:51 INFO - Running setup.py (path:/tmp/pip-wl5ia1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:29:51 INFO - Running setup.py (path:/tmp/pip-7xNOrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:29:51 INFO - Running setup.py (path:/tmp/pip-CbbY88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:29:51 INFO - Running setup.py (path:/tmp/pip-_IHVrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:29:51 INFO - Running setup.py (path:/tmp/pip-bQiKE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:29:51 INFO - Running setup.py (path:/tmp/pip-X_ckCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:29:51 INFO - Running setup.py (path:/tmp/pip-HiWUYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:29:51 INFO - Running setup.py (path:/tmp/pip-pvTPZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:29:51 INFO - Running setup.py (path:/tmp/pip-HzRf9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:29:52 INFO - Running setup.py (path:/tmp/pip-vWdBA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:29:52 INFO - Running setup.py (path:/tmp/pip-pf4p4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:29:52 INFO - Running setup.py (path:/tmp/pip-QNX28_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:29:52 INFO - Running setup.py (path:/tmp/pip-5Y349Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:29:52 INFO - Running setup.py (path:/tmp/pip-JlC1MC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:52 INFO - Running setup.py (path:/tmp/pip-CmhYOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:29:52 INFO - Running setup.py (path:/tmp/pip-VL9oZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:29:52 INFO - Running setup.py (path:/tmp/pip-U9P_uL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:29:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:29:52 INFO - Running setup.py install for manifestparser 02:29:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:29:52 INFO - Running setup.py install for mozcrash 02:29:52 INFO - Running setup.py install for mozdebug 02:29:52 INFO - Running setup.py install for mozdevice 02:29:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:29:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:29:52 INFO - Running setup.py install for mozfile 02:29:53 INFO - Running setup.py install for mozhttpd 02:29:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:29:53 INFO - Running setup.py install for mozinfo 02:29:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:29:53 INFO - Running setup.py install for mozInstall 02:29:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:29:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:29:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:29:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:29:53 INFO - Running setup.py install for mozleak 02:29:53 INFO - Running setup.py install for mozlog 02:29:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:29:53 INFO - Running setup.py install for moznetwork 02:29:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:29:53 INFO - Running setup.py install for mozprocess 02:29:53 INFO - Running setup.py install for mozprofile 02:29:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:29:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:29:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:29:53 INFO - Running setup.py install for mozrunner 02:29:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:29:54 INFO - Running setup.py install for mozscreenshot 02:29:54 INFO - Running setup.py install for moztest 02:29:54 INFO - Running setup.py install for mozversion 02:29:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:29:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:29:54 INFO - Cleaning up... 02:29:54 INFO - Return code: 0 02:29:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:54 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7ffe92fd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2500410>, '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 0x2501310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25017a0>, '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': '33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137', '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 02:29:54 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 02:29:54 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:29:54 INFO - Using env: {'DISPLAY': ':0', 02:29:54 INFO - 'HOME': '/home/cltbld', 02:29:54 INFO - 'LANG': 'en_US.UTF-8', 02:29:54 INFO - 'LANGUAGE': 'en_US:en', 02:29:54 INFO - 'LOGNAME': 'cltbld', 02:29:54 INFO - 'MAIL': '/var/mail/cltbld', 02:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:54 INFO - 'MOZ_NO_REMOTE': '1', 02:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:54 INFO - 'NO_EM_RESTART': '1', 02:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:54 INFO - 'PWD': '/builds/slave/test', 02:29:54 INFO - 'SHELL': '/bin/bash', 02:29:54 INFO - 'SHLVL': '1', 02:29:54 INFO - 'TERM': 'linux', 02:29:54 INFO - 'TMOUT': '86400', 02:29:54 INFO - 'USER': 'cltbld', 02:29:54 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137', 02:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:54 INFO - '_': '/tools/buildbot/bin/python'} 02:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:29:54 INFO - Running setup.py (path:/tmp/pip-8rQA48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:29:54 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)) 02:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:29:54 INFO - Running setup.py (path:/tmp/pip-bRsUav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 02:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:29:54 INFO - Running setup.py (path:/tmp/pip-JfIUAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:29:54 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)) 02:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:29:54 INFO - Running setup.py (path:/tmp/pip-6_iWPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 02:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:29:54 INFO - Running setup.py (path:/tmp/pip-ShZJ3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:29:54 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)) 02:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:29:54 INFO - Running setup.py (path:/tmp/pip-FSJ6vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:29:55 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)) 02:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:29:55 INFO - Running setup.py (path:/tmp/pip-Kz882w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:29:55 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)) 02:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:29:55 INFO - Running setup.py (path:/tmp/pip-aymOIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:29:55 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)) 02:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:29:55 INFO - Running setup.py (path:/tmp/pip-9utRaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:29:55 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)) 02:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:29:55 INFO - Running setup.py (path:/tmp/pip-kpohMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:29:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 02:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:29:55 INFO - Running setup.py (path:/tmp/pip-mfuuhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:29:55 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)) 02:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:29:55 INFO - Running setup.py (path:/tmp/pip-LLNcLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:29:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 02:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:29:55 INFO - Running setup.py (path:/tmp/pip-j5XRoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:29:55 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)) 02:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:29:55 INFO - Running setup.py (path:/tmp/pip-n5wTnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:29:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 02:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:55 INFO - Running setup.py (path:/tmp/pip-qRkOw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:55 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)) 02:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:29:55 INFO - Running setup.py (path:/tmp/pip-Gzl8Ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:29:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 02:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:29:55 INFO - Running setup.py (path:/tmp/pip-T4NzbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:29:55 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)) 02:29:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:29:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:29:55 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)) 02:29:55 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:29:55 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:29:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:29:55 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 02:29:55 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 02:29:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:55 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 02:29:55 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 02:29:57 INFO - Downloading blessings-1.6.tar.gz 02:29:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:29:57 INFO - Installing collected packages: blessings 02:29:57 INFO - Running setup.py install for blessings 02:29:57 INFO - Successfully installed blessings 02:29:57 INFO - Cleaning up... 02:29:57 INFO - Return code: 0 02:29:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:29:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:29:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:29:58 INFO - Reading from file tmpfile_stdout 02:29:58 INFO - Current package versions: 02:29:58 INFO - argparse == 1.2.1 02:29:58 INFO - blessings == 1.6 02:29:58 INFO - blobuploader == 1.2.4 02:29:58 INFO - docopt == 0.6.1 02:29:58 INFO - manifestparser == 1.1 02:29:58 INFO - mozInstall == 1.12 02:29:58 INFO - mozcrash == 0.17 02:29:58 INFO - mozdebug == 0.1 02:29:58 INFO - mozdevice == 0.48 02:29:58 INFO - mozfile == 1.2 02:29:58 INFO - mozhttpd == 0.7 02:29:58 INFO - mozinfo == 0.9 02:29:58 INFO - mozleak == 0.1 02:29:58 INFO - mozlog == 3.1 02:29:58 INFO - moznetwork == 0.27 02:29:58 INFO - mozprocess == 0.22 02:29:58 INFO - mozprofile == 0.28 02:29:58 INFO - mozrunner == 6.11 02:29:58 INFO - mozscreenshot == 0.1 02:29:58 INFO - mozsystemmonitor == 0.0 02:29:58 INFO - moztest == 0.7 02:29:58 INFO - mozversion == 1.4 02:29:58 INFO - psutil == 3.1.1 02:29:58 INFO - requests == 1.2.3 02:29:58 INFO - wsgiref == 0.1.2 02:29:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:58 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7ffe92fd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2500410>, '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 0x2501310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25017a0>, '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': '33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137', '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 02:29:58 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 02:29:58 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:29:58 INFO - Using env: {'DISPLAY': ':0', 02:29:58 INFO - 'HOME': '/home/cltbld', 02:29:58 INFO - 'LANG': 'en_US.UTF-8', 02:29:58 INFO - 'LANGUAGE': 'en_US:en', 02:29:58 INFO - 'LOGNAME': 'cltbld', 02:29:58 INFO - 'MAIL': '/var/mail/cltbld', 02:29:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:58 INFO - 'MOZ_NO_REMOTE': '1', 02:29:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:58 INFO - 'NO_EM_RESTART': '1', 02:29:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:58 INFO - 'PWD': '/builds/slave/test', 02:29:58 INFO - 'SHELL': '/bin/bash', 02:29:58 INFO - 'SHLVL': '1', 02:29:58 INFO - 'TERM': 'linux', 02:29:58 INFO - 'TMOUT': '86400', 02:29:58 INFO - 'USER': 'cltbld', 02:29:58 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137', 02:29:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:58 INFO - '_': '/tools/buildbot/bin/python'} 02:29:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:58 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)) 02:29:58 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)) 02:29:58 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)) 02:29:58 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)) 02:29:58 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)) 02:29:58 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)) 02:29:58 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)) 02:29:58 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)) 02:29:58 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)) 02:29:58 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)) 02:29:58 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)) 02:29:58 INFO - Cleaning up... 02:29:58 INFO - Return code: 0 02:29:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:58 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7ffe92fd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2500410>, '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 0x2501310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25017a0>, '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': '33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137', '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 02:29:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:29:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:29:58 INFO - Using env: {'DISPLAY': ':0', 02:29:58 INFO - 'HOME': '/home/cltbld', 02:29:58 INFO - 'LANG': 'en_US.UTF-8', 02:29:58 INFO - 'LANGUAGE': 'en_US:en', 02:29:58 INFO - 'LOGNAME': 'cltbld', 02:29:58 INFO - 'MAIL': '/var/mail/cltbld', 02:29:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:58 INFO - 'MOZ_NO_REMOTE': '1', 02:29:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:58 INFO - 'NO_EM_RESTART': '1', 02:29:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:58 INFO - 'PWD': '/builds/slave/test', 02:29:58 INFO - 'SHELL': '/bin/bash', 02:29:58 INFO - 'SHLVL': '1', 02:29:58 INFO - 'TERM': 'linux', 02:29:58 INFO - 'TMOUT': '86400', 02:29:58 INFO - 'USER': 'cltbld', 02:29:58 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137', 02:29:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:58 INFO - '_': '/tools/buildbot/bin/python'} 02:29:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:58 INFO - Downloading/unpacking jsonschema 02:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:30:00 INFO - Downloading/unpacking functools32 (from jsonschema) 02:30:00 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 02:30:00 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 02:30:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:00 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 02:30:00 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 02:30:00 INFO - Downloading functools32-3.2.3-2.tar.gz 02:30:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:30:00 INFO - warning: no files found matching '*.txt' 02:30:00 INFO - no previously-included directories found matching 'build' 02:30:00 INFO - no previously-included directories found matching 'dist' 02:30:00 INFO - no previously-included directories found matching '.git*' 02:30:00 INFO - Installing collected packages: jsonschema, functools32 02:30:00 INFO - Running setup.py install for functools32 02:30:00 INFO - warning: no files found matching '*.txt' 02:30:00 INFO - no previously-included directories found matching 'build' 02:30:00 INFO - no previously-included directories found matching 'dist' 02:30:00 INFO - no previously-included directories found matching '.git*' 02:30:00 INFO - Successfully installed jsonschema functools32 02:30:00 INFO - Cleaning up... 02:30:01 INFO - Return code: 0 02:30:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:01 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe92fd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2500410>, '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 0x2501310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25017a0>, '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': '33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137', '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 02:30:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:30:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:30:01 INFO - Using env: {'DISPLAY': ':0', 02:30:01 INFO - 'HOME': '/home/cltbld', 02:30:01 INFO - 'LANG': 'en_US.UTF-8', 02:30:01 INFO - 'LANGUAGE': 'en_US:en', 02:30:01 INFO - 'LOGNAME': 'cltbld', 02:30:01 INFO - 'MAIL': '/var/mail/cltbld', 02:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:01 INFO - 'MOZ_NO_REMOTE': '1', 02:30:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:01 INFO - 'NO_EM_RESTART': '1', 02:30:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:01 INFO - 'PWD': '/builds/slave/test', 02:30:01 INFO - 'SHELL': '/bin/bash', 02:30:01 INFO - 'SHLVL': '1', 02:30:01 INFO - 'TERM': 'linux', 02:30:01 INFO - 'TMOUT': '86400', 02:30:01 INFO - 'USER': 'cltbld', 02:30:01 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137', 02:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:01 INFO - '_': '/tools/buildbot/bin/python'} 02:30:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:01 INFO - Downloading/unpacking flake8 02:30:01 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 02:30:01 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 02:30:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:01 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 02:30:01 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 02:30:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:30:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:30:03 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 02:30:03 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 02:30:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:03 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 02:30:03 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 02:30:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:30:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:30:03 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 02:30:03 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 02:30:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:03 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 02:30:03 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 02:30:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:30:03 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 02:30:03 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 02:30:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:03 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 02:30:03 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 02:30:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:30:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:30:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:30:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:30:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:30:03 INFO - no previously-included directories found matching 'docs/_build' 02:30:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:30:03 INFO - Running setup.py install for pep8 02:30:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:30:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:30:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:30:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:30:04 INFO - no previously-included directories found matching 'docs/_build' 02:30:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:30:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:30:04 INFO - Cleaning up... 02:30:04 INFO - Return code: 0 02:30:04 INFO - Running post-action listener: _resource_record_post_action 02:30:04 INFO - Running post-action listener: _start_resource_monitoring 02:30:04 INFO - Starting resource monitoring. 02:30:04 INFO - ##### 02:30:04 INFO - ##### Running install step. 02:30:04 INFO - ##### 02:30:04 INFO - Running pre-action listener: _resource_record_pre_action 02:30:04 INFO - Running main action method: install 02:30:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:30:04 INFO - Reading from file tmpfile_stdout 02:30:04 INFO - Detecting whether we're running mozinstall >=1.0... 02:30:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:30:04 INFO - Reading from file tmpfile_stdout 02:30:04 INFO - Output received: 02:30:04 INFO - Usage: mozinstall [options] installer 02:30:04 INFO - Options: 02:30:04 INFO - -h, --help show this help message and exit 02:30:04 INFO - -d DEST, --destination=DEST 02:30:04 INFO - Directory to install application into. [default: 02:30:04 INFO - "/builds/slave/test"] 02:30:04 INFO - --app=APP Application being installed. [default: firefox] 02:30:04 INFO - mkdir: /builds/slave/test/build/application 02:30:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:30:26 INFO - Reading from file tmpfile_stdout 02:30:26 INFO - Output received: 02:30:26 INFO - /builds/slave/test/build/application/firefox/firefox 02:30:26 INFO - Running post-action listener: _resource_record_post_action 02:30:26 INFO - ##### 02:30:26 INFO - ##### Running run-tests step. 02:30:26 INFO - ##### 02:30:26 INFO - Running pre-action listener: _resource_record_pre_action 02:30:26 INFO - Running main action method: run_tests 02:30:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:30:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:30:26 INFO - Python 2.7.3 02:30:26 INFO - Return code: 0 02:30:26 INFO - grabbing minidump binary from tooltool 02:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:26 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2500410>, '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 0x2501310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25017a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:30:26 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 02:30:26 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 02:30:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:30:26 INFO - Return code: 0 02:30:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:30:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:30:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:30:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:30:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:30:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:30:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:30:30 INFO - Return code: 0 02:30:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:30:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:30:30 INFO - Using env: {'DISPLAY': ':0', 02:30:30 INFO - 'HOME': '/home/cltbld', 02:30:30 INFO - 'LANG': 'en_US.UTF-8', 02:30:30 INFO - 'LANGUAGE': 'en_US:en', 02:30:30 INFO - 'LOGNAME': 'cltbld', 02:30:30 INFO - 'MAIL': '/var/mail/cltbld', 02:30:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:30:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:30:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:30 INFO - 'MOZ_NO_REMOTE': '1', 02:30:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:30:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:30 INFO - 'NO_EM_RESTART': '1', 02:30:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:30 INFO - 'PWD': '/builds/slave/test', 02:30:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:30:30 INFO - 'SHELL': '/bin/bash', 02:30:30 INFO - 'SHLVL': '1', 02:30:30 INFO - 'TERM': 'linux', 02:30:30 INFO - 'TMOUT': '86400', 02:30:30 INFO - 'USER': 'cltbld', 02:30:30 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137', 02:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:30 INFO - '_': '/tools/buildbot/bin/python'} 02:30:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:30:30 INFO - mozversion application_buildid: 20160621234002 02:30:30 INFO - mozversion application_changeset: 0bcc9439bf8c9106740ce9e7cb3bb0131487ae67 02:30:30 INFO - mozversion application_display_name: Firefox 02:30:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:30:30 INFO - mozversion application_name: Firefox 02:30:30 INFO - mozversion application_remotingname: firefox 02:30:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 02:30:30 INFO - mozversion application_vendor: Mozilla 02:30:30 INFO - mozversion application_version: 48.0 02:30:30 INFO - mozversion platform_buildid: 20160621234002 02:30:30 INFO - mozversion platform_changeset: 0bcc9439bf8c9106740ce9e7cb3bb0131487ae67 02:30:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 02:30:30 INFO - mozversion platform_version: 48.0 02:30:30 INFO - using testdate: 1466587830 02:30:30 INFO - actual date: 1466587830 02:30:30 INFO - starting webserver on 'localhost:35479' 02:30:30 INFO - SUITE-START | Running 2 tests 02:30:30 INFO - TEST-START | dromaeo_css 02:30:30 INFO - operating with platform_type : linux_ 02:30:30 INFO - Initialising browser for dromaeo_css test... 02:30:30 INFO - TEST-INFO | started process 31998 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQk6P4g/profile http://localhost:35479/getInfo.html) 02:30:36 INFO - PROCESS | 31998 | __metrics Screen width/height:1600/1200 02:30:36 INFO - PROCESS | 31998 | colorDepth:24 02:30:36 INFO - PROCESS | 31998 | Browser inner width/height: 1024/697 02:30:36 INFO - PROCESS | 31998 | __metrics 02:30:38 ERROR - PROCESS | 31998 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:30:39 INFO - TEST-INFO | 31998: exit 0 02:30:39 INFO - Browser initialized. 02:30:39 INFO - Running cycle 1/1 for dromaeo_css test... 02:30:39 INFO - TEST-INFO | started process 32096 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQk6P4g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:30:57 INFO - PROCESS | 32096 | RSS: Main: 141041664 02:30:57 INFO - PROCESS | 32096 | 02:31:42 INFO - PROCESS | 32096 | 1466587902957 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:33:56 INFO - PROCESS | 32096 | Cycle 1(1): loaded http://localhost:35479/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35479/tests/dromaeo/cssquery-ext.html) 02:33:57 INFO - PROCESS | 32096 | RSS: Main: 268840960 02:33:57 INFO - PROCESS | 32096 | 02:36:59 INFO - PROCESS | 32096 | Cycle 1(1): loaded http://localhost:35479/tests/dromaeo/cssquery-ext.html (next: http://localhost:35479/tests/dromaeo/cssquery-jquery.html) 02:37:00 INFO - PROCESS | 32096 | RSS: Main: 224886784 02:37:00 INFO - PROCESS | 32096 | 02:40:02 INFO - PROCESS | 32096 | Cycle 1(1): loaded http://localhost:35479/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35479/tests/dromaeo/cssquery-mootools.html) 02:40:02 INFO - PROCESS | 32096 | RSS: Main: 224260096 02:40:02 INFO - PROCESS | 32096 | 02:43:04 INFO - PROCESS | 32096 | Cycle 1(1): loaded http://localhost:35479/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35479/tests/dromaeo/cssquery-prototype.html) 02:43:05 INFO - PROCESS | 32096 | RSS: Main: 216453120 02:43:05 INFO - PROCESS | 32096 | 02:46:07 INFO - PROCESS | 32096 | Cycle 1(1): loaded http://localhost:35479/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35479/tests/dromaeo/cssquery-yui.html) 02:46:08 INFO - PROCESS | 32096 | RSS: Main: 213135360 02:46:08 INFO - PROCESS | 32096 | 02:49:10 INFO - PROCESS | 32096 | Cycle 1(1): loaded http://localhost:35479/tests/dromaeo/cssquery-yui.html (next: http://localhost:35479/tests/dromaeo/cssquery-dojo.html) 02:49:10 INFO - PROCESS | 32096 | RSS: Main: 250781696 02:49:10 INFO - PROCESS | 32096 | 02:49:10 INFO - PROCESS | 32096 | __start_tp_report 02:49:10 INFO - PROCESS | 32096 | _x_x_mozilla_page_load 02:49:10 INFO - PROCESS | 32096 | _x_x_mozilla_page_load_details 02:49:10 INFO - PROCESS | 32096 | |i|pagename|runs| 02:49:10 INFO - PROCESS | 32096 | |0;dojo.html;3274.3287626036663;3290.901272961812;3371;3372.8313584320776;3409.4203985322492;5470.398256191816;5523;5548.472895074971;5554.305711786027;5583.441655834425;5571.331440227158;5579.637323573965;5582.162675598652;5585.329760428734;5588.30146231721;5009.924851127236;5038.949610503884;5053.924191137117;5081.720505372203;5121.257417674435;5064.265681476202;5097.898042039157;5105.030044291572;5117.130087885032;5133.127368347353;5163.8192663256605;5166.560842328407;5173.198154286091;5181.222816577506;5186.844394668128;4931.605471562302;5079.492050794928;5150.639455238135;5168.095583272912;5177.611679124081;5024.271480635324;5035.420926593415;5045.117104506697;5048.9495105048845;5050.040492306487;5505.174223866412;5520.254765606672;5525.668459892419;5531.2809334786625;5558.777648894039;5841.153032810261;5971.641701497924;6065.638985579314;6076.939230607726;6114;5945.286565612111;5980.671063091529;6000.36996115406;6004.039353703431;6010.489108425745;5570.582206334541;5575.135853942646;5582;5584.497395234448;5631.774729010794;6112.969435152885;6170.475509581735;6196.690165491707;6227.09707092469;6228.688565571703;5923.200367950358;5934.792282270186;5936.5547583931375;5940.168376427304;5963;5919.6152250103605;6029.246344206974;6029.457348838538;6032.758689652364;6041.607295525777;5971.223740913653;5982;5984.042553191555;5994.790182343597;6022.819315420545;5936.821895343147;5937.970310148422;5989.490893274034;5994.880102397928;5995.100734889801;4481.551844815557;4562.429696287964;4572.9314060289125;4574.313852922089;4647.9767601161775;4054.7972601369815;4060.1879624075304;4064.6748260139116;4089.7137200396282;4092.6521245693853;5699.031164702011;5699.686517241592;5702.600817942704;5707.571932105108;5758.452946970031;5879.206307148565;5932.940670593325;5951.672658003851;5967.37342579023;5970.9701451492465;5697.515711164515;5731.885362292731;5735.139729040678;5739.110437882135;5747.942520574825;5168.767405466763;5174.913268213717;5179.98990196908;5182.144946083929;5193.091209038479;6152.077188421594;6156.630602163885;6228.159198508325;6228.5951413158;6235.532335074979;6047.939520604914;6053.667048312385;6060.909086363797;6065.722821145455;6102.206713127265;6111.663858487826;6275.466585340298;6298.212723409574;6301.653409062362;6315.684215789101;5967.76128954837;6005.789797357072;6008.639481631116;6032.034874420072;6060.2424696912885;6053.243344581927;6073.48375388097;6097.512199024156;6103.450689437972;6107.9083813741945;5727.198192253005;5762.971185144047;5950.672713000827;5956.285245770535;5958.97020514912;5845.970770146122;5860.970695146497;5862.882742345044;5864.970675146597;5900.350961394157;5735.025045742317;5735.684537350486;5735.9139612905;5739.311282645942;5740.167675686918;5778.422157784188;5865.912011319919;5867.090600956859;5893.734781934909;5944.048952167633;5695.572832037531;5753;5795.7391917362975;5796.04365279741;5830.591858569859 02:49:10 INFO - PROCESS | 32096 | |1;ext.html;658.6311665467339;680.6460640466958;685.0854109763466;747.4842358772445;754.837709892373;32668.836655816718;33214.16964575887;39658.20683586327;40542.18915621693;40578.59421405785;42861.35707964383;43366.13267734643;43426.34860477087;43465.130697386034;43470.34794478078;8815.603297851612;8990.056044115372;9000.459972401644;9001.23489503393;9005.77485562863;8848.203661670448;8941.284697224239;8967.64129434825;8970.730878073635;8974.551272436385;8966.148215919477;9196.310276729238;9197.908020919805;9212.585433655468;9216.216621587173;9077.546122693871;9092.136247056585;9102.590383432795;9106.134917182857;9111.589978450953;9018.143276388733;9123.452592844451;9124.635014599407;9126.452412855184;9133.178013978708;43201.78399107984;43726.78136609328;43748.3437748434;43815;44067;3995.5604883462797;4032.576579459144;4275.636570891478;4525.456945166601;4603.884902877421;32768.344633107445;32953.835230823934;33469.665303347145;34028.82985585056;34842;4286.507051689034;4318.589733975267;4330.39374487572;4341.413909122291;4344.109457561192;323375.9999999977;323679;324958;326010;327759;62367.37632623706;62512.12463626098;62875.685621571596;62905.68547157326;62965.37034629687;65052.34947650557;65224;69446;70512;70627.64686176536;19334.516637083903;19540.120694568777;19551.80448195528;19553.511162220773;19576.804231957783;14913.92543037278;14945.40218391274;15019.924900375428;15025.774613380809;15034.248287585577;19723.30968416127;20008.39974800758;20051.59896802085;20078.598428031357;20089.397318080482;7380.125434147116;7446.441516886255;7792.259735325135;7813;7890.289873911375;1154.7575009247985;1187.554666999875;1192.9105317101253;1249.419020155632;1297.0790738575529;34833;34917.825410872785;34948.825255873555;35445.82277088598;35493.46759798605;1167.9532818687157;1221.5052903574067;1233.0628722171034;1245.9813102803466;1255.4413286087786;18101.909490452465;18161.437211665874;18214.721310500307;18342.541436464195;18359.724604130948;506841;508568;511354;511367;514304;43671;43695.78152109219;43759.34360984588;43907.780461098126;43987.34018989718;1523.7866698662197;1534.815822101355;1544.8146222453377;1555.129127688498;1573.2055312067562;33186.50220246746;34371.4844277341;34550.82724586361;34848.65151348454;34907.4763878537;57367.71316143392;57965;58023.4197658018;58043.548911277554;58067.41932580789;420374;428134;429277;430046;431899;30956.380872382877;31383.21541961469;31587.36825263528;31732.841335793175;31756.364872702878;52064;52100.47899520956;52148.739256303474;52780;53231.46768532265;43461.565384345755;43589;44437.77781111074;45145.77427112844;45273.094538108395;43246.351304729826;44037.779811102024;44388.55611443844;44432.55567444284;44488.55511444844;40213.396799047456;44912.77543612261;45181;46224.30663539982;46244;33408.498872516444;35747.64252357443;37316.440253396766;37488.20860101891;38150.80924595359;29544;29755.702442975293;29858;29861.850690746407;29942.401151977276 02:49:10 INFO - PROCESS | 32096 | |2;jquery.html;397.3523157253676;399.9820008099635;408.3509247220397;421.1534815021806;428.5478819845062;16013.359465621375;19065.618687626258;19397.32109376174;19563.315283965065;19737.309194178208;18630.906845465754;19423.708644370312;19712.112954917025;20463;20509.897450512726;5207.817726379568;5377.4084850666395;5398.163284690879;5402.324709411324;5402.810901618444;4016.6385025347713;5754.827355179351;5990.9101363479585;6008.579399442041;6012.308584512772;5867.618604790675;5977.790777322794;5978.40215978403;5985.371535988724;6007.4593286604195;5721.399253078429;5818;5850.76596936122;5854.73653685583;5873.970630146843;5739.16782066598;5744.368119506851;5748.051571490699;5748.080307150877;5749.655020698771;13996.230207338593;14162.71674566503;14352.856471435256;14355.78466323006;14361.138331700131;2289.713785776778;2462.7906627936645;2513.522430738154;2642.4186678930605;2964.1418411498526;9988.500574971222;10116.645917392856;10254.282200245985;10315.277930544866;10632.521536530874;2010.1657812008;2096.6645336746046;2114.7779483154354;2120.9893950530304;2122.7240458740266;79345.80981285285;79525.60237198777;80179;82885.58557207236;83058.58470707668;11642.476088576035;11652.53389864413;11687.941560292315;11843.526258949718;11890.762184756257;16346.100964446832;16346.346146154021;16432.424865129662;16674.49976500707;16693.33226670944;9065.41074830134;9178.724638260863;9180.6786762463;9288.90711092894;9326.440413575207;8909.242714369351;8980.506072166094;9097.317701172306;9157.542122893828;9182.35723499362;4829.1307564638;4964.503549645006;5131.435542090367;5181.145111056709;5181.559567436735;2031.3804289691786;2101.432613194429;2149.3444499427824;2155.4180371299663;2187.9453013674784;486.1371066357244;502.6305665335975;988.3921388346115;1045.8849526552074;1089.2593036734938;11056.668299951014;11246.43767811606;11297.26567773092;11331.490082946288;11470.827937580943;506.94423613402495;510.8365323096648;519.3378442485861;521.7599904044182;531.9308489896289;6222.502199824004;6231.875362492725;6233.438990490787;6256.843578910563;6300.1494798202575;558096;560510;566889;581015;591998;97235;100150.49924750329;101131;101380;102267;521.7599904044106;522.3496746550493;527.7967982326832;528.4926470588279;529.3330403691376;11141.610043648434;11313.7737245253;11411.087113031104;11443.25618834773;11637.941810290895;39539;39608.22742408004;40003.59996400115;40032.1993560133;40404.59595404008;60289.39710602838;60331.69834150801;60456.395436046834;60570;60997.39002609917;8490.448120872123;8503.617337219715;8584.399092063495;8588.355873309401;8689.522076285864;12332.876671233173;12698.111132220656;12810;12991.740165196832;13252.602421927357;11524.884751152382;11705.707357315794;11766.764664706829;11769.52921883115;11966.401679915794;11496.195266331277;11914.169411905337;11948.940255298668;12119.394030298274;12214.08394370408;12066.577669781516;12231.26612403223;12234.204776689487;12309.50761969547;12491.93754031224;8749.781255468664;8926.776830579287;8947.06055864125;9043.773905652411;9139.086091390807;9106.544672766202;12145.089118315986;12177.147599667938;12201.69495762613;12337 02:49:10 INFO - PROCESS | 32096 | |3;mootools.html;1437.7555815511362;1583.9862488007673;1589.7217986852302;1812.9184186711598;1917.3481016454402;8472.788180295496;8654.09132041136;8672.653093876253;8695.69565065223;8698.260647844942;8534.70128545501;8666.91333086669;8743.213110820025;8745.169208925157;8745.562721863913;2417.903283868643;2449.7917676997477;2455.5211733711935;2466.7656572625574;2470.407102295454;2434.294054724128;2544.3893465568317;2544.796416286702;2552.4767422678306;2556.7059788124325;2384.6899903012586;2395.185636883459;2397.3886658901956;2401.0515846240723;2401.6157414813547;2453.325335532725;2453.4479742058074;2457.7050753909466;2478.0459523083564;2495.126705653025;2477.36827109086;2497.8751062446986;2518.7607177318127;2520.332111990324;2525.936851578707;8478.872816907751;8649.567521623894;8875.911240887574;8947.060558641379;8950.641974321019;5534.501894829485;5620.775168993236;5629.831105066854;5632.155176723483;5666.603337766358;3405.7956522608724;3444.500547420635;3466.2374277658873;3603;3654.7076233901225;1129.4522156753967;1152.2049785647876;1161.8373427720126;1164.3654208456412;1166.6558365282262;12124.696882577919;12342.13605047647;12667.30329831868;12815.74368512634;12846.229226246454;4804.55010352482;4857.514248575185;4935.777889994959;4949.82675606352;4953.108440480676;10906;10931;10942.234043617029;11003.724906877233;11022.50398732059;5598.300212473441;5605.299337582802;5638.464345887134;5647.576431767634;5648.802291919763;4593.770311484413;5002.59979201663;5119.820806271762;5133.974330128325;5136.743162841843;4205.201011807747;4244.808983595745;4254.893627659271;4287.2711639021445;4328.458942632171;1378.63466181462;1383.5641772841523;1425.3300948554163;1428.1859340176209;1438.8992770506175;1050.0759331787979;1074.5164675895878;1081.1512962324537;1087.896649818266;1088.5210507376728;6203;6355.841103972345;6415.711292991827;6424.3254458282145;6454.19322584677;438.49353996134516;445.4698908299114;447.6061066261669;448.96857219994286;453.67562193031483;4158.480189976253;4237.427947227085;4272.9359059614135;4304.418903448057;4346.587074227943;11036.392998385005;11511.942440287745;11543.018843398406;11584;11597.304161750322;11362.034227090624;11369.886301137049;11372.829407558893;11378.544858205745;11398.544058237578;8206.097329293772;8532.445391049561;8548.658053677907;8641.222289993932;8651.870221946676;6012.6392416455155;6072.72472780721;6098.847528811815;6185.257769067741;6201.131841542278;9851.261155413229;10035.598576057168;10068.144207742424;10305.381677099398;10306.896931030893;10204.336718113298;10291.742706432398;10354.534045968101;10528.473166440152;10538.8419173714;7028.402585780266;7197.820054498679;7526.435517336331;8164.428490005643;8301.460405073893;8282.1303763104;8298.58507074656;8334.124916883882;8346.624401901807;8354.958225208835;7203.747868824566;7313.049303590499;7364.410847132323;7365.8158546036775;7434;7339.6330183489545;7356.816079598053;7384.187739348775;7401.666924988281;7452;6468.288488266381;6494.447971922439;6506.902396464152;6582.539222254396;6636.668166591748;4789.44921334051;5120.3087583177285;5137.460566640599;5150.278960945396;5150.716710580954;5314.760835762323;5318.468153184651;5385.219143224289;5427.778749781268;5546.944530554642 02:49:10 INFO - PROCESS | 32096 | |4;prototype.html;348.78201124297317;351.29039340532125;354.1217779905833;356.7271037656195;361.126074898745;6162.784302549411;6191.783287584935;6228.719707613162;6288.842778930529;6314.084457753623;6225.12848201251;6226.906596401058;6230.595011324261;6237.688115594214;6254.21822272216;4571.817127314904;4591.357209990604;4689.038747056845;4727.196376615983;4762.190427627294;4717.599004084657;4747.596454301389;4757.381540399743;4759.571638552529;4767.261074533453;4502.369668246448;4633.9073218535605;4710.929336059962;4712.740799256039;4732.739699316537;4586;4652.74409907455;4686.343911852344;4688.132695451318;4706.576408123286;4075.735077219971;4076;4082.755034697928;4085.836566537335;4088.550259471456;6022.096685497167;6024.728887200043;6027.367126451703;6027.939720602782;6032.185654936615;5439.238506609038;5446.891062178774;5449.04641687707;5454.836354909319;5459.454054594548;6455.9354406455805;6525.902111468332;6533.869322613568;6534.738610455576;6587.176602924635;4579.084183163381;4583.977080114578;4597.103564804865;4601.631869450436;4602.516735742733;6770.593764374154;6802.4217941475035;6822.079019332376;6824.044633751329;6828.078209441712;4679.555442232982;4691.7184968901975;4697.859064228079;4702.835400760957;4706.85879423611;4762.119007983534;4773.594244489257;4774.928376074362;4777.211760059551;4778.761061946958;5462.535684466785;5465.9726701366235;5489.533389661844;5491.36849262332;5499.120140777456;6309.905351419732;6566.146400967939;6583.63789991555;6584.308647591934;6591.967040164768;1605.1091644137382;1610.5973506623345;1617.6036870966689;1630.4537979776671;1632.0289427790447;1000.694788089625;1023.7133602591286;1036.8807587127576;1052.7631282961272;1053.068034789217;6158.507319414436;6284.12022316876;6337.795818794414;6339.809805705744;6351.96824015877;6717.596944183365;6723.899141512881;6724.596524208563;6733.562318449285;6736.191657001191;6324.778632747832;6337.873242535124;6386.489080873519;6389.872202555923;6390.0734393512685;3589.353916295092;3629.94555081674;3631.8365673544754;3632.0919770057485;3633.9636603633626;6828.829279267959;7002.404795592432;7024.121984751906;7039.225685174627;7040.612766297801;6785.864282714417;6844.178698556205;6860.3139686032;6861.4853885958755;6865.210500792473;6968.930310696929;6986.685599148051;6996.650167491707;6998.545094568837;7002.334778196063;6681.69932353055;6682.46540276767;6699.799006029827;6700.229473610597;6706.932930670826;6570.77002304917;6571.667058194273;6741.52809303344;6765.458763298826;6765.830854228684;7129.037579926851;7130.358267755927;7133.8929916050265;7138.214796372498;7150.141982962078;4597.7011494252765;4632.050429661978;4641.721496710208;4643.048175124024;4646.233371493666;6793.66031698423;6796.864062718619;6807.795766127024;6819.215790184192;6823.761168359084;6415.326390729093;6600.207975043026;6614.834629134118;6645.9366501359555;6660.467162627075;6573.934260657332;6609.438197753245;6613.041109039259;6619.4042536170045;6624.8343791405605;6445.613263204223;6475.838104047248;6513.088167656627;6529.314421985813;6532.281449040697;6672.599644021374;6677.866442671217;6679.6994135265;6683.699233534406;6688.264290927897;6383.680815959091;6492.870142597216;6493.350664933658;6497.9025314619375;6500.122483464672 02:49:10 INFO - PROCESS | 32096 | |5;yui.html;827.4084029918607;888.3515034025162;917.9489484540204;924.5038247617911;948.4688574398333;15064.322105505238;15355.53933381999;15453.30460129294;15532.301046452909;15545.378184872605;13233.13984591001;13304.201747895133;13330.133541319807;13375.933120334385;13379.933100334509;747.7495039161887;834.2158371131147;857.9184977427135;888.1251966812684;902.9322800789935;896.0143841774062;902.8510295801185;905.7011186308503;907.3557773980482;907.4600612635471;923.1184219070805;936.241644268145;936.3866667332908;938.2025278513244;938.6433155400938;778.0935210479785;916.4867674102491;938.8450905600567;939.3800091939321;939.8966113727485;687.1685260834396;687.4569090418613;688.5317983771033;689.2108535726616;689.2487188964053;14715.705685886329;14816.851831481763;14826.629334266621;14829.703405931821;14858.702825943421;14896.255187240704;15354.539363819104;15405.922970385076;15437.536873893801;15564.844351556452;12543.811842822364;12576.308303043328;12596.81104783429;12764.234145951272;12798.552050678274;4093.2427500912127;4119.237940980928;4131.483564554431;4149.771762553089;4187.706860519765;51889.96220075615;51914.74042629763;51941.7402912983;51972.74013629946;52158.739206304104;10266.845997310047;11030.338179709242;11210.831837522444;11309.547618095348;11505.252158609663;19188.232470701296;19282.517937051685;19306.13122409495;19321;19332.613347732968;8577.142285771497;8644.78388040304;8790.42862213954;8812.8678069829;8907.688230912017;5038.2190760432195;5068.290439338495;5159.690418574897;5177.430482646906;5182.300389447451;3679.2457546202963;3748.194138260287;3750.9497340744633;3752.3058234226755;3754.530683664542;671.4359937652396;681.2438193605094;683.5795985468901;686.4508393285452;686.5228666077029;799.0371602219312;808.789714674189;810.5906517208772;814.8248126652799;815.963281652327;9339.859902101474;10113.595456181818;10240.334378265388;10283.742906427398;10347.068763811292;779.8518281526492;788.333857890082;792.8691765858568;801.5951944268107;838.6435764799936;4520.276755719069;4617;4735.621150307967;4784;4789.640776941744;58962;62199;62732.37267627265;62823.68588157121;62988;55569.444305556426;56622.71688641531;57062;57255.42744572584;57631;51489;51657.7417112912;51919.221211681855;52886.20670689943;52926;10386.636467723594;10400.687979360631;10439.426076107298;10450.947745261225;10477.31897426665;38707.41938870976;39021;39240.41139382969;39315.410268845415;39752;45103.77448112739;45390;48178.27732583944;49907.25139122989;51028.48971510386;12105.636830895088;12308.384580771104;12496.562620308245;12526.060545458944;12722.809157862825;14202.928985355007;14331.211783352015;14353;14440.494582689555;14789.482368117064;13286.734265314833;13833.10084844482;14067.507637232648;14228.786568201278;14412.85587144157;13730.176189428666;13824;13955.860441395862;14241.857581424054;14318.498852540111;13865.86134138686;13903.652408689864;13919.860801391857;14007.859921400655;14145.151290922578;10012.799744004933;10052.246081543768;10106.292559520763;10279.7430064246;10563.20775941792;10719.785604288027;11065.834012489659;11222.438878056228;11326.490307935997;11389.601363952223 02:49:10 INFO - PROCESS | 32096 | __end_tp_report 02:49:10 INFO - PROCESS | 32096 | __start_cc_report 02:49:10 INFO - PROCESS | 32096 | _x_x_mozilla_cycle_collect,1030 02:49:10 INFO - PROCESS | 32096 | __end_cc_report 02:49:10 INFO - PROCESS | 32096 | __startTimestamp1466588950762__endTimestamp 02:49:10 INFO - PROCESS | 32096 | 02:49:10 INFO - PROCESS | 32096 | ------- Summary: start ------- 02:49:10 INFO - PROCESS | 32096 | Number of tests: 6 02:49:10 INFO - PROCESS | 32096 | 02:49:10 INFO - PROCESS | 32096 | [#0] dojo.html Cycles:165 Average:5579.18 Median:5758.45 stddev:631.46 (11.0%) stddev-sans-first:606.96 02:49:10 INFO - PROCESS | 32096 | Values: 3274.3 3290.9 3371.0 3372.8 3409.4 5470.4 5523.0 5548.5 5554.3 5583.4 5571.3 5579.6 5582.2 5585.3 5588.3 5009.9 5038.9 5053.9 5081.7 5121.3 5064.3 5097.9 5105.0 5117.1 5133.1 5163.8 5166.6 5173.2 5181.2 5186.8 4931.6 5079.5 5150.6 5168.1 5177.6 5024.3 5035.4 5045.1 5048.9 5050.0 5505.2 5520.3 5525.7 5531.3 5558.8 5841.2 5971.6 6065.6 6076.9 6114.0 5945.3 5980.7 6000.4 6004.0 6010.5 5570.6 5575.1 5582.0 5584.5 5631.8 6113.0 6170.5 6196.7 6227.1 6228.7 5923.2 5934.8 5936.6 5940.2 5963.0 5919.6 6029.2 6029.5 6032.8 6041.6 5971.2 5982.0 5984.0 5994.8 6022.8 5936.8 5938.0 5989.5 5994.9 5995.1 4481.6 4562.4 4572.9 4574.3 4648.0 4054.8 4060.2 4064.7 4089.7 4092.7 5699.0 5699.7 5702.6 5707.6 5758.5 5879.2 5932.9 5951.7 5967.4 5971.0 5697.5 5731.9 5735.1 5739.1 5747.9 5168.8 5174.9 5180.0 5182.1 5193.1 6152.1 6156.6 6228.2 6228.6 6235.5 6047.9 6053.7 6060.9 6065.7 6102.2 6111.7 6275.5 6298.2 6301.7 6315.7 5967.8 6005.8 6008.6 6032.0 6060.2 6053.2 6073.5 6097.5 6103.5 6107.9 5727.2 5763.0 5950.7 5956.3 5959.0 5846.0 5861.0 5862.9 5865.0 5900.4 5735.0 5735.7 5735.9 5739.3 5740.2 5778.4 5865.9 5867.1 5893.7 5944.0 5695.6 5753.0 5795.7 5796.0 5830.6 02:49:10 INFO - PROCESS | 32096 | 02:49:10 INFO - PROCESS | 32096 | [#1] ext.html Cycles:180 Average:59606.55 Median:23853.77 stddev:113094.73 (474.1%) stddev-sans-first:113325.39 02:49:10 INFO - PROCESS | 32096 | Values: 658.6 680.6 685.1 747.5 754.8 32668.8 33214.2 39658.2 40542.2 40578.6 42861.4 43366.1 43426.3 43465.1 43470.3 8815.6 8990.1 9000.5 9001.2 9005.8 8848.2 8941.3 8967.6 8970.7 8974.6 8966.1 9196.3 9197.9 9212.6 9216.2 9077.5 9092.1 9102.6 9106.1 9111.6 9018.1 9123.5 9124.6 9126.5 9133.2 43201.8 43726.8 43748.3 43815.0 44067.0 3995.6 4032.6 4275.6 4525.5 4603.9 32768.3 32953.8 33469.7 34028.8 34842.0 4286.5 4318.6 4330.4 4341.4 4344.1 323376.0 323679.0 324958.0 326010.0 327759.0 62367.4 62512.1 62875.7 62905.7 62965.4 65052.3 65224.0 69446.0 70512.0 70627.6 19334.5 19540.1 19551.8 19553.5 19576.8 14913.9 14945.4 15019.9 15025.8 15034.2 19723.3 20008.4 20051.6 20078.6 20089.4 7380.1 7446.4 7792.3 7813.0 7890.3 1154.8 1187.6 1192.9 1249.4 1297.1 34833.0 34917.8 34948.8 35445.8 35493.5 1168.0 1221.5 1233.1 1246.0 1255.4 18101.9 18161.4 18214.7 18342.5 18359.7 506841.0 508568.0 511354.0 511367.0 514304.0 43671.0 43695.8 43759.3 43907.8 43987.3 1523.8 1534.8 1544.8 1555.1 1573.2 33186.5 34371.5 34550.8 34848.7 34907.5 57367.7 57965.0 58023.4 58043.5 58067.4 420374.0 428134.0 429277.0 430046.0 431899.0 30956.4 31383.2 31587.4 31732.8 31756.4 52064.0 52100.5 52148.7 52780.0 53231.5 43461.6 43589.0 44437.8 45145.8 45273.1 43246.4 44037.8 44388.6 44432.6 44488.6 40213.4 44912.8 45181.0 46224.3 46244.0 33408.5 35747.6 37316.4 37488.2 38150.8 29544.0 29755.7 29858.0 29861.9 29942.4 02:49:10 INFO - PROCESS | 32096 | 02:49:10 INFO - PROCESS | 32096 | [#2] jquery.html Cycles:180 Average:30902.64 Median:22210.62 stddev:94182.30 (424.0%) stddev-sans-first:94418.65 02:49:10 INFO - PROCESS | 32096 | Values: 397.4 400.0 408.4 421.2 428.5 16013.4 19065.6 19397.3 19563.3 19737.3 18630.9 19423.7 19712.1 20463.0 20509.9 5207.8 5377.4 5398.2 5402.3 5402.8 4016.6 5754.8 5990.9 6008.6 6012.3 5867.6 5977.8 5978.4 5985.4 6007.5 5721.4 5818.0 5850.8 5854.7 5874.0 5739.2 5744.4 5748.1 5748.1 5749.7 13996.2 14162.7 14352.9 14355.8 14361.1 2289.7 2462.8 2513.5 2642.4 2964.1 9988.5 10116.6 10254.3 10315.3 10632.5 2010.2 2096.7 2114.8 2121.0 2122.7 79345.8 79525.6 80179.0 82885.6 83058.6 11642.5 11652.5 11687.9 11843.5 11890.8 16346.1 16346.3 16432.4 16674.5 16693.3 9065.4 9178.7 9180.7 9288.9 9326.4 8909.2 8980.5 9097.3 9157.5 9182.4 4829.1 4964.5 5131.4 5181.1 5181.6 2031.4 2101.4 2149.3 2155.4 2187.9 486.1 502.6 988.4 1045.9 1089.3 11056.7 11246.4 11297.3 11331.5 11470.8 506.9 510.8 519.3 521.8 531.9 6222.5 6231.9 6233.4 6256.8 6300.1 558096.0 560510.0 566889.0 581015.0 591998.0 97235.0 100150.5 101131.0 101380.0 102267.0 521.8 522.3 527.8 528.5 529.3 11141.6 11313.8 11411.1 11443.3 11637.9 39539.0 39608.2 40003.6 40032.2 40404.6 60289.4 60331.7 60456.4 60570.0 60997.4 8490.4 8503.6 8584.4 8588.4 8689.5 12332.9 12698.1 12810.0 12991.7 13252.6 11524.9 11705.7 11766.8 11769.5 11966.4 11496.2 11914.2 11948.9 12119.4 12214.1 12066.6 12231.3 12234.2 12309.5 12491.9 8749.8 8926.8 8947.1 9043.8 9139.1 9106.5 12145.1 12177.1 12201.7 12337.0 02:49:10 INFO - PROCESS | 32096 | 02:49:10 INFO - PROCESS | 32096 | [#3] mootools.html Cycles:180 Average:5915.11 Median:446.54 stddev:3342.39 (748.5%) stddev-sans-first:3334.82 02:49:10 INFO - PROCESS | 32096 | Values: 1437.8 1584.0 1589.7 1812.9 1917.3 8472.8 8654.1 8672.7 8695.7 8698.3 8534.7 8666.9 8743.2 8745.2 8745.6 2417.9 2449.8 2455.5 2466.8 2470.4 2434.3 2544.4 2544.8 2552.5 2556.7 2384.7 2395.2 2397.4 2401.1 2401.6 2453.3 2453.4 2457.7 2478.0 2495.1 2477.4 2497.9 2518.8 2520.3 2525.9 8478.9 8649.6 8875.9 8947.1 8950.6 5534.5 5620.8 5629.8 5632.2 5666.6 3405.8 3444.5 3466.2 3603.0 3654.7 1129.5 1152.2 1161.8 1164.4 1166.7 12124.7 12342.1 12667.3 12815.7 12846.2 4804.6 4857.5 4935.8 4949.8 4953.1 10906.0 10931.0 10942.2 11003.7 11022.5 5598.3 5605.3 5638.5 5647.6 5648.8 4593.8 5002.6 5119.8 5134.0 5136.7 4205.2 4244.8 4254.9 4287.3 4328.5 1378.6 1383.6 1425.3 1428.2 1438.9 1050.1 1074.5 1081.2 1087.9 1088.5 6203.0 6355.8 6415.7 6424.3 6454.2 438.5 445.5 447.6 449.0 453.7 4158.5 4237.4 4272.9 4304.4 4346.6 11036.4 11511.9 11543.0 11584.0 11597.3 11362.0 11369.9 11372.8 11378.5 11398.5 8206.1 8532.4 8548.7 8641.2 8651.9 6012.6 6072.7 6098.8 6185.3 6201.1 9851.3 10035.6 10068.1 10305.4 10306.9 10204.3 10291.7 10354.5 10528.5 10538.8 7028.4 7197.8 7526.4 8164.4 8301.5 8282.1 8298.6 8334.1 8346.6 8355.0 7203.7 7313.0 7364.4 7365.8 7434.0 7339.6 7356.8 7384.2 7401.7 7452.0 6468.3 6494.4 6506.9 6582.5 6636.7 4789.4 5120.3 5137.5 5150.3 5150.7 5314.8 5318.5 5385.2 5427.8 5546.9 02:49:10 INFO - PROCESS | 32096 | 02:49:10 INFO - PROCESS | 32096 | [#4] prototype.html Cycles:180 Average:5495.02 Median:6299.37 stddev:1669.47 (26.5%) stddev-sans-first:1628.86 02:49:10 INFO - PROCESS | 32096 | Values: 348.8 351.3 354.1 356.7 361.1 6162.8 6191.8 6228.7 6288.8 6314.1 6225.1 6226.9 6230.6 6237.7 6254.2 4571.8 4591.4 4689.0 4727.2 4762.2 4717.6 4747.6 4757.4 4759.6 4767.3 4502.4 4633.9 4710.9 4712.7 4732.7 4586.0 4652.7 4686.3 4688.1 4706.6 4075.7 4076.0 4082.8 4085.8 4088.6 6022.1 6024.7 6027.4 6027.9 6032.2 5439.2 5446.9 5449.0 5454.8 5459.5 6455.9 6525.9 6533.9 6534.7 6587.2 4579.1 4584.0 4597.1 4601.6 4602.5 6770.6 6802.4 6822.1 6824.0 6828.1 4679.6 4691.7 4697.9 4702.8 4706.9 4762.1 4773.6 4774.9 4777.2 4778.8 5462.5 5466.0 5489.5 5491.4 5499.1 6309.9 6566.1 6583.6 6584.3 6592.0 1605.1 1610.6 1617.6 1630.5 1632.0 1000.7 1023.7 1036.9 1052.8 1053.1 6158.5 6284.1 6337.8 6339.8 6352.0 6717.6 6723.9 6724.6 6733.6 6736.2 6324.8 6337.9 6386.5 6389.9 6390.1 3589.4 3629.9 3631.8 3632.1 3634.0 6828.8 7002.4 7024.1 7039.2 7040.6 6785.9 6844.2 6860.3 6861.5 6865.2 6968.9 6986.7 6996.7 6998.5 7002.3 6681.7 6682.5 6699.8 6700.2 6706.9 6570.8 6571.7 6741.5 6765.5 6765.8 7129.0 7130.4 7133.9 7138.2 7150.1 4597.7 4632.1 4641.7 4643.0 4646.2 6793.7 6796.9 6807.8 6819.2 6823.8 6415.3 6600.2 6614.8 6645.9 6660.5 6573.9 6609.4 6613.0 6619.4 6624.8 6445.6 6475.8 6513.1 6529.3 6532.3 6672.6 6677.9 6679.7 6683.7 6688.3 6383.7 6492.9 6493.4 6497.9 6500.1 02:49:10 INFO - PROCESS | 32096 | 02:49:10 INFO - PROCESS | 32096 | [#5] yui.html Cycles:180 Average:15457.29 Median:4125.36 stddev:17372.78 (421.1%) stddev-sans-first:17386.77 02:49:10 INFO - PROCESS | 32096 | Values: 827.4 888.4 917.9 924.5 948.5 15064.3 15355.5 15453.3 15532.3 15545.4 13233.1 13304.2 13330.1 13375.9 13379.9 747.7 834.2 857.9 888.1 902.9 896.0 902.9 905.7 907.4 907.5 923.1 936.2 936.4 938.2 938.6 778.1 916.5 938.8 939.4 939.9 687.2 687.5 688.5 689.2 689.2 14715.7 14816.9 14826.6 14829.7 14858.7 14896.3 15354.5 15405.9 15437.5 15564.8 12543.8 12576.3 12596.8 12764.2 12798.6 4093.2 4119.2 4131.5 4149.8 4187.7 51890.0 51914.7 51941.7 51972.7 52158.7 10266.8 11030.3 11210.8 11309.5 11505.3 19188.2 19282.5 19306.1 19321.0 19332.6 8577.1 8644.8 8790.4 8812.9 8907.7 5038.2 5068.3 5159.7 5177.4 5182.3 3679.2 3748.2 3750.9 3752.3 3754.5 671.4 681.2 683.6 686.5 686.5 799.0 808.8 810.6 814.8 816.0 9339.9 10113.6 10240.3 10283.7 10347.1 779.9 788.3 792.9 801.6 838.6 4520.3 4617.0 4735.6 4784.0 4789.6 58962.0 62199.0 62732.4 62823.7 62988.0 55569.4 56622.7 57062.0 57255.4 57631.0 51489.0 51657.7 51919.2 52886.2 52926.0 10386.6 10400.7 10439.4 10450.9 10477.3 38707.4 39021.0 39240.4 39315.4 39752.0 45103.8 45390.0 48178.3 49907.3 51028.5 12105.6 12308.4 12496.6 12526.1 12722.8 14202.9 14331.2 14353.0 14440.5 14789.5 13286.7 13833.1 14067.5 14228.8 14412.9 13730.2 13824.0 13955.9 14241.9 14318.5 13865.9 13903.7 13919.9 14007.9 14145.2 10012.8 10052.2 10106.3 10279.7 10563.2 10719.8 11065.8 11222.4 11326.5 11389.6 02:49:10 INFO - PROCESS | 32096 | -------- Summary: end -------- 02:49:10 INFO - PROCESS | 32096 | 02:49:11 INFO - TEST-INFO | 32096: exit 0 02:49:11 INFO - TEST-OK | dromaeo_css | took 1121037ms 02:49:11 INFO - TEST-START | kraken 02:49:11 INFO - operating with platform_type : linux_ 02:49:11 INFO - Initialising browser for kraken test... 02:49:11 INFO - TEST-INFO | started process 32289 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI0icK3/profile http://localhost:35479/getInfo.html) 02:49:17 INFO - PROCESS | 32289 | __metrics Screen width/height:1600/1200 02:49:17 INFO - PROCESS | 32289 | colorDepth:24 02:49:17 INFO - PROCESS | 32289 | Browser inner width/height: 1024/697 02:49:17 INFO - PROCESS | 32289 | __metrics 02:49:19 ERROR - PROCESS | 32289 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:49:20 INFO - TEST-INFO | 32289: exit 0 02:49:20 INFO - Browser initialized. 02:49:20 INFO - Running cycle 1/1 for kraken test... 02:49:20 INFO - TEST-INFO | started process 32379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI0icK3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:49:32 INFO - PROCESS | 32379 | RSS: Main: 141078528 02:49:32 INFO - PROCESS | 32379 | 02:49:34 INFO - PROCESS | 32379 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35479/tests/kraken/driver.html?testName=audio-beat-detection) 02:49:35 INFO - PROCESS | 32379 | RSS: Main: 198066176 02:49:35 INFO - PROCESS | 32379 | 02:49:38 INFO - PROCESS | 32379 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35479/tests/kraken/driver.html?testName=audio-dft) 02:49:38 INFO - PROCESS | 32379 | RSS: Main: 184619008 02:49:38 INFO - PROCESS | 32379 | 02:49:41 INFO - PROCESS | 32379 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35479/tests/kraken/driver.html?testName=audio-fft) 02:49:42 INFO - PROCESS | 32379 | RSS: Main: 274219008 02:49:42 INFO - PROCESS | 32379 | 02:49:44 INFO - PROCESS | 32379 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35479/tests/kraken/driver.html?testName=audio-oscillator) 02:49:44 INFO - PROCESS | 32379 | RSS: Main: 180789248 02:49:44 INFO - PROCESS | 32379 | 02:49:47 INFO - PROCESS | 32379 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35479/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:49:47 INFO - PROCESS | 32379 | RSS: Main: 179093504 02:49:47 INFO - PROCESS | 32379 | 02:49:50 INFO - PROCESS | 32379 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35479/tests/kraken/driver.html?testName=imaging-darkroom) 02:49:51 INFO - PROCESS | 32379 | RSS: Main: 213118976 02:49:51 INFO - PROCESS | 32379 | 02:49:54 INFO - PROCESS | 32379 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35479/tests/kraken/driver.html?testName=imaging-desaturate) 02:49:55 INFO - PROCESS | 32379 | RSS: Main: 213356544 02:49:55 INFO - PROCESS | 32379 | 02:49:57 INFO - PROCESS | 32379 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35479/tests/kraken/driver.html?testName=json-parse-financial) 02:49:58 INFO - PROCESS | 32379 | RSS: Main: 212914176 02:49:58 INFO - PROCESS | 32379 | 02:50:00 INFO - PROCESS | 32379 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35479/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:50:00 INFO - PROCESS | 32379 | RSS: Main: 195063808 02:50:00 INFO - PROCESS | 32379 | 02:50:02 INFO - PROCESS | 32379 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35479/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:50:02 INFO - PROCESS | 32379 | RSS: Main: 198762496 02:50:02 INFO - PROCESS | 32379 | 02:50:04 INFO - PROCESS | 32379 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35479/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:50:05 INFO - PROCESS | 32379 | RSS: Main: 210292736 02:50:05 INFO - PROCESS | 32379 | 02:50:07 INFO - PROCESS | 32379 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35479/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:50:08 INFO - PROCESS | 32379 | RSS: Main: 215699456 02:50:08 INFO - PROCESS | 32379 | 02:50:11 INFO - PROCESS | 32379 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35479/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:50:11 INFO - PROCESS | 32379 | RSS: Main: 213671936 02:50:11 INFO - PROCESS | 32379 | 02:50:13 INFO - PROCESS | 32379 | Cycle 1(1): loaded http://localhost:35479/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35479/tests/kraken/driver.html?testName=ai-astar) 02:50:13 INFO - PROCESS | 32379 | RSS: Main: 274751488 02:50:13 INFO - PROCESS | 32379 | 02:50:13 INFO - PROCESS | 32379 | __start_tp_report 02:50:13 INFO - PROCESS | 32379 | _x_x_mozilla_page_load 02:50:13 INFO - PROCESS | 32379 | _x_x_mozilla_page_load_details 02:50:13 INFO - PROCESS | 32379 | |i|pagename|runs| 02:50:13 INFO - PROCESS | 32379 | |0;ai-astar;109;111;111;110;112;110;105;112;109;109 02:50:13 INFO - PROCESS | 32379 | |1;audio-beat-detection;160;125;157;180;129;153;158;127;184;129 02:50:13 INFO - PROCESS | 32379 | |2;audio-dft;161;162;163;161;162;160;162;164;160;161 02:50:13 INFO - PROCESS | 32379 | |3;audio-fft;77;77;77;174;78;76;76;73;162;74 02:50:13 INFO - PROCESS | 32379 | |4;audio-oscillator;92;93;160;92;92;93;151;92;92;143 02:50:13 INFO - PROCESS | 32379 | |5;imaging-gaussian-blur;116;116;116;116;117;117;117;116;116;117 02:50:13 INFO - PROCESS | 32379 | |6;imaging-darkroom;144;145;145;145;145;145;145;145;145;145 02:50:13 INFO - PROCESS | 32379 | |7;imaging-desaturate;102;95;95;95;95;95;95;95;94;95 02:50:13 INFO - PROCESS | 32379 | |8;json-parse-financial;53;55;54;53;55;54;58;76;53;52 02:50:13 INFO - PROCESS | 32379 | |9;json-stringify-tinderbox;60;59;58;58;58;58;58;59;58;58 02:50:13 INFO - PROCESS | 32379 | |10;stanford-crypto-aes;73;72;72;72;74;73;74;73;72;72 02:50:13 INFO - PROCESS | 32379 | |11;stanford-crypto-ccm;114;114;117;118;112;112;112;112;132;131 02:50:13 INFO - PROCESS | 32379 | |12;stanford-crypto-pbkdf2;167;158;159;160;158;162;156;161;157;160 02:50:13 INFO - PROCESS | 32379 | |13;stanford-crypto-sha256-iterative;70;66;67;67;67;65;65;66;70;66 02:50:13 INFO - PROCESS | 32379 | __end_tp_report 02:50:13 INFO - PROCESS | 32379 | __start_cc_report 02:50:13 INFO - PROCESS | 32379 | _x_x_mozilla_cycle_collect,1582 02:50:13 INFO - PROCESS | 32379 | __end_cc_report 02:50:13 INFO - PROCESS | 32379 | __startTimestamp1466589013775__endTimestamp 02:50:13 INFO - PROCESS | 32379 | 02:50:13 INFO - PROCESS | 32379 | ------- Summary: start ------- 02:50:13 INFO - PROCESS | 32379 | Number of tests: 14 02:50:13 INFO - PROCESS | 32379 | 02:50:13 INFO - PROCESS | 32379 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.50 stddev:2.04 (1.8%) stddev-sans-first:2.15 02:50:13 INFO - PROCESS | 32379 | Values: 109.0 111.0 111.0 110.0 112.0 110.0 105.0 112.0 109.0 109.0 02:50:13 INFO - PROCESS | 32379 | 02:50:13 INFO - PROCESS | 32379 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:157.50 stddev:21.89 (13.9%) stddev-sans-first:22.93 02:50:13 INFO - PROCESS | 32379 | Values: 160.0 125.0 157.0 180.0 129.0 153.0 158.0 127.0 184.0 129.0 02:50:13 INFO - PROCESS | 32379 | 02:50:13 INFO - PROCESS | 32379 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 02:50:13 INFO - PROCESS | 32379 | Values: 161.0 162.0 163.0 161.0 162.0 160.0 162.0 164.0 160.0 161.0 02:50:13 INFO - PROCESS | 32379 | 02:50:13 INFO - PROCESS | 32379 | [#3] audio-fft Cycles:10 Average:94.40 Median:76.50 stddev:38.92 (50.9%) stddev-sans-first:40.77 02:50:13 INFO - PROCESS | 32379 | Values: 77.0 77.0 77.0 174.0 78.0 76.0 76.0 73.0 162.0 74.0 02:50:13 INFO - PROCESS | 32379 | 02:50:13 INFO - PROCESS | 32379 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:92.00 stddev:28.81 (31.3%) stddev-sans-first:29.81 02:50:13 INFO - PROCESS | 32379 | Values: 92.0 93.0 160.0 92.0 92.0 93.0 151.0 92.0 92.0 143.0 02:50:13 INFO - PROCESS | 32379 | 02:50:13 INFO - PROCESS | 32379 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:50:13 INFO - PROCESS | 32379 | Values: 116.0 116.0 116.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 02:50:13 INFO - PROCESS | 32379 | 02:50:13 INFO - PROCESS | 32379 | [#6] imaging-darkroom Cycles:10 Average:144.90 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.00 02:50:13 INFO - PROCESS | 32379 | Values: 144.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 02:50:13 INFO - PROCESS | 32379 | 02:50:13 INFO - PROCESS | 32379 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.00 stddev:2.27 (2.4%) stddev-sans-first:0.33 02:50:13 INFO - PROCESS | 32379 | Values: 102.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 02:50:13 INFO - PROCESS | 32379 | 02:50:13 INFO - PROCESS | 32379 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:54.50 stddev:7.12 (13.1%) stddev-sans-first:7.45 02:50:13 INFO - PROCESS | 32379 | Values: 53.0 55.0 54.0 53.0 55.0 54.0 58.0 76.0 53.0 52.0 02:50:13 INFO - PROCESS | 32379 | 02:50:13 INFO - PROCESS | 32379 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.00 stddev:0.70 (1.2%) stddev-sans-first:0.44 02:50:13 INFO - PROCESS | 32379 | Values: 60.0 59.0 58.0 58.0 58.0 58.0 58.0 59.0 58.0 58.0 02:50:13 INFO - PROCESS | 32379 | 02:50:13 INFO - PROCESS | 32379 | [#10] stanford-crypto-aes Cycles:10 Average:72.70 Median:73.00 stddev:0.82 (1.1%) stddev-sans-first:0.87 02:50:13 INFO - PROCESS | 32379 | Values: 73.0 72.0 72.0 72.0 74.0 73.0 74.0 73.0 72.0 72.0 02:50:13 INFO - PROCESS | 32379 | 02:50:13 INFO - PROCESS | 32379 | [#11] stanford-crypto-ccm Cycles:10 Average:117.40 Median:115.50 stddev:7.73 (6.7%) stddev-sans-first:8.11 02:50:13 INFO - PROCESS | 32379 | Values: 114.0 114.0 117.0 118.0 112.0 112.0 112.0 112.0 132.0 131.0 02:50:13 INFO - PROCESS | 32379 | 02:50:13 INFO - PROCESS | 32379 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.80 Median:160.00 stddev:3.12 (1.9%) stddev-sans-first:1.94 02:50:13 INFO - PROCESS | 32379 | Values: 167.0 158.0 159.0 160.0 158.0 162.0 156.0 161.0 157.0 160.0 02:50:13 INFO - PROCESS | 32379 | 02:50:13 INFO - PROCESS | 32379 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.79 (2.7%) stddev-sans-first:1.51 02:50:13 INFO - PROCESS | 32379 | Values: 70.0 66.0 67.0 67.0 67.0 65.0 65.0 66.0 70.0 66.0 02:50:13 INFO - PROCESS | 32379 | -------- Summary: end -------- 02:50:13 INFO - PROCESS | 32379 | 02:50:14 INFO - TEST-INFO | 32379: exit 0 02:50:14 INFO - TEST-OK | kraken | took 63199ms 02:50:14 INFO - SUITE-END | took 1184s 02:50:14 INFO - Completed test suite (00:19:44) 02:50:14 INFO - javascript benchmark 02:50:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3274.3287626036663, 3290.901272961812, 3371.0, 3372.8313584320776, 3409.4203985322492, 5470.398256191816, 5523.0, 5548.472895074971, 5554.305711786027, 5583.441655834425, 5571.331440227158, 5579.637323573965, 5582.162675598652, 5585.329760428734, 5588.30146231721, 5009.924851127236, 5038.949610503884, 5053.924191137117, 5081.720505372203, 5121.257417674435, 5064.265681476202, 5097.898042039157, 5105.030044291572, 5117.130087885032, 5133.127368347353, 5163.8192663256605, 5166.560842328407, 5173.198154286091, 5181.222816577506, 5186.844394668128, 4931.605471562302, 5079.492050794928, 5150.639455238135, 5168.095583272912, 5177.611679124081, 5024.271480635324, 5035.420926593415, 5045.117104506697, 5048.9495105048845, 5050.040492306487, 5505.174223866412, 5520.254765606672, 5525.668459892419, 5531.2809334786625, 5558.777648894039, 5841.153032810261, 5971.641701497924, 6065.638985579314, 6076.939230607726, 6114.0, 5945.286565612111, 5980.671063091529, 6000.36996115406, 6004.039353703431, 6010.489108425745, 5570.582206334541, 5575.135853942646, 5582.0, 5584.497395234448, 5631.774729010794, 6112.969435152885, 6170.475509581735, 6196.690165491707, 6227.09707092469, 6228.688565571703, 5923.200367950358, 5934.792282270186, 5936.5547583931375, 5940.168376427304, 5963.0, 5919.6152250103605, 6029.246344206974, 6029.457348838538, 6032.758689652364, 6041.607295525777, 5971.223740913653, 5982.0, 5984.042553191555, 5994.790182343597, 6022.819315420545, 5936.821895343147, 5937.970310148422, 5989.490893274034, 5994.880102397928, 5995.100734889801, 4481.551844815557, 4562.429696287964, 4572.9314060289125, 4574.313852922089, 4647.9767601161775, 4054.7972601369815, 4060.1879624075304, 4064.6748260139116, 4089.7137200396282, 4092.6521245693853, 5699.031164702011, 5699.686517241592, 5702.600817942704, 5707.571932105108, 5758.452946970031, 5879.206307148565, 5932.940670593325, 5951.672658003851, 5967.37342579023, 5970.9701451492465, 5697.515711164515, 5731.885362292731, 5735.139729040678, 5739.110437882135, 5747.942520574825, 5168.767405466763, 5174.913268213717, 5179.98990196908, 5182.144946083929, 5193.091209038479, 6152.077188421594, 6156.630602163885, 6228.159198508325, 6228.5951413158, 6235.532335074979, 6047.939520604914, 6053.667048312385, 6060.909086363797, 6065.722821145455, 6102.206713127265, 6111.663858487826, 6275.466585340298, 6298.212723409574, 6301.653409062362, 6315.684215789101, 5967.76128954837, 6005.789797357072, 6008.639481631116, 6032.034874420072, 6060.2424696912885, 6053.243344581927, 6073.48375388097, 6097.512199024156, 6103.450689437972, 6107.9083813741945, 5727.198192253005, 5762.971185144047, 5950.672713000827, 5956.285245770535, 5958.97020514912, 5845.970770146122, 5860.970695146497, 5862.882742345044, 5864.970675146597, 5900.350961394157, 5735.025045742317, 5735.684537350486, 5735.9139612905, 5739.311282645942, 5740.167675686918, 5778.422157784188, 5865.912011319919, 5867.090600956859, 5893.734781934909, 5944.048952167633, 5695.572832037531, 5753.0, 5795.7391917362975, 5796.04365279741, 5830.591858569859], "value": 5537.244390637499, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.6311665467339, 680.6460640466958, 685.0854109763466, 747.4842358772445, 754.837709892373, 32668.836655816718, 33214.16964575887, 39658.20683586327, 40542.18915621693, 40578.59421405785, 42861.35707964383, 43366.13267734643, 43426.34860477087, 43465.130697386034, 43470.34794478078, 8815.603297851612, 8990.056044115372, 9000.459972401644, 9001.23489503393, 9005.77485562863, 8848.203661670448, 8941.284697224239, 8967.64129434825, 8970.730878073635, 8974.551272436385, 8966.148215919477, 9196.310276729238, 9197.908020919805, 9212.585433655468, 9216.216621587173, 9077.546122693871, 9092.136247056585, 9102.590383432795, 9106.134917182857, 9111.589978450953, 9018.143276388733, 9123.452592844451, 9124.635014599407, 9126.452412855184, 9133.178013978708, 43201.78399107984, 43726.78136609328, 43748.3437748434, 43815.0, 44067.0, 3995.5604883462797, 4032.576579459144, 4275.636570891478, 4525.456945166601, 4603.884902877421, 32768.344633107445, 32953.835230823934, 33469.665303347145, 34028.82985585056, 34842.0, 4286.507051689034, 4318.589733975267, 4330.39374487572, 4341.413909122291, 4344.109457561192, 323375.9999999977, 323679.0, 324958.0, 326010.0, 327759.0, 62367.37632623706, 62512.12463626098, 62875.685621571596, 62905.68547157326, 62965.37034629687, 65052.34947650557, 65224.0, 69446.0, 70512.0, 70627.64686176536, 19334.516637083903, 19540.120694568777, 19551.80448195528, 19553.511162220773, 19576.804231957783, 14913.92543037278, 14945.40218391274, 15019.924900375428, 15025.774613380809, 15034.248287585577, 19723.30968416127, 20008.39974800758, 20051.59896802085, 20078.598428031357, 20089.397318080482, 7380.125434147116, 7446.441516886255, 7792.259735325135, 7813.0, 7890.289873911375, 1154.7575009247985, 1187.554666999875, 1192.9105317101253, 1249.419020155632, 1297.0790738575529, 34833.0, 34917.825410872785, 34948.825255873555, 35445.82277088598, 35493.46759798605, 1167.9532818687157, 1221.5052903574067, 1233.0628722171034, 1245.9813102803466, 1255.4413286087786, 18101.909490452465, 18161.437211665874, 18214.721310500307, 18342.541436464195, 18359.724604130948, 506841.0, 508568.0, 511354.0, 511367.0, 514304.0, 43671.0, 43695.78152109219, 43759.34360984588, 43907.780461098126, 43987.34018989718, 1523.7866698662197, 1534.815822101355, 1544.8146222453377, 1555.129127688498, 1573.2055312067562, 33186.50220246746, 34371.4844277341, 34550.82724586361, 34848.65151348454, 34907.4763878537, 57367.71316143392, 57965.0, 58023.4197658018, 58043.548911277554, 58067.41932580789, 420374.0, 428134.0, 429277.0, 430046.0, 431899.0, 30956.380872382877, 31383.21541961469, 31587.36825263528, 31732.841335793175, 31756.364872702878, 52064.0, 52100.47899520956, 52148.739256303474, 52780.0, 53231.46768532265, 43461.565384345755, 43589.0, 44437.77781111074, 45145.77427112844, 45273.094538108395, 43246.351304729826, 44037.779811102024, 44388.55611443844, 44432.55567444284, 44488.55511444844, 40213.396799047456, 44912.77543612261, 45181.0, 46224.30663539982, 46244.0, 33408.498872516444, 35747.64252357443, 37316.440253396766, 37488.20860101891, 38150.80924595359, 29544.0, 29755.702442975293, 29858.0, 29861.850690746407, 29942.401151977276], "value": 21155.30420974605, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.3523157253676, 399.9820008099635, 408.3509247220397, 421.1534815021806, 428.5478819845062, 16013.359465621375, 19065.618687626258, 19397.32109376174, 19563.315283965065, 19737.309194178208, 18630.906845465754, 19423.708644370312, 19712.112954917025, 20463.0, 20509.897450512726, 5207.817726379568, 5377.4084850666395, 5398.163284690879, 5402.324709411324, 5402.810901618444, 4016.6385025347713, 5754.827355179351, 5990.9101363479585, 6008.579399442041, 6012.308584512772, 5867.618604790675, 5977.790777322794, 5978.40215978403, 5985.371535988724, 6007.4593286604195, 5721.399253078429, 5818.0, 5850.76596936122, 5854.73653685583, 5873.970630146843, 5739.16782066598, 5744.368119506851, 5748.051571490699, 5748.080307150877, 5749.655020698771, 13996.230207338593, 14162.71674566503, 14352.856471435256, 14355.78466323006, 14361.138331700131, 2289.713785776778, 2462.7906627936645, 2513.522430738154, 2642.4186678930605, 2964.1418411498526, 9988.500574971222, 10116.645917392856, 10254.282200245985, 10315.277930544866, 10632.521536530874, 2010.1657812008, 2096.6645336746046, 2114.7779483154354, 2120.9893950530304, 2122.7240458740266, 79345.80981285285, 79525.60237198777, 80179.0, 82885.58557207236, 83058.58470707668, 11642.476088576035, 11652.53389864413, 11687.941560292315, 11843.526258949718, 11890.762184756257, 16346.100964446832, 16346.346146154021, 16432.424865129662, 16674.49976500707, 16693.33226670944, 9065.41074830134, 9178.724638260863, 9180.6786762463, 9288.90711092894, 9326.440413575207, 8909.242714369351, 8980.506072166094, 9097.317701172306, 9157.542122893828, 9182.35723499362, 4829.1307564638, 4964.503549645006, 5131.435542090367, 5181.145111056709, 5181.559567436735, 2031.3804289691786, 2101.432613194429, 2149.3444499427824, 2155.4180371299663, 2187.9453013674784, 486.1371066357244, 502.6305665335975, 988.3921388346115, 1045.8849526552074, 1089.2593036734938, 11056.668299951014, 11246.43767811606, 11297.26567773092, 11331.490082946288, 11470.827937580943, 506.94423613402495, 510.8365323096648, 519.3378442485861, 521.7599904044182, 531.9308489896289, 6222.502199824004, 6231.875362492725, 6233.438990490787, 6256.843578910563, 6300.1494798202575, 558096.0, 560510.0, 566889.0, 581015.0, 591998.0, 97235.0, 100150.49924750329, 101131.0, 101380.0, 102267.0, 521.7599904044106, 522.3496746550493, 527.7967982326832, 528.4926470588279, 529.3330403691376, 11141.610043648434, 11313.7737245253, 11411.087113031104, 11443.25618834773, 11637.941810290895, 39539.0, 39608.22742408004, 40003.59996400115, 40032.1993560133, 40404.59595404008, 60289.39710602838, 60331.69834150801, 60456.395436046834, 60570.0, 60997.39002609917, 8490.448120872123, 8503.617337219715, 8584.399092063495, 8588.355873309401, 8689.522076285864, 12332.876671233173, 12698.111132220656, 12810.0, 12991.740165196832, 13252.602421927357, 11524.884751152382, 11705.707357315794, 11766.764664706829, 11769.52921883115, 11966.401679915794, 11496.195266331277, 11914.169411905337, 11948.940255298668, 12119.394030298274, 12214.08394370408, 12066.577669781516, 12231.26612403223, 12234.204776689487, 12309.50761969547, 12491.93754031224, 8749.781255468664, 8926.776830579287, 8947.06055864125, 9043.773905652411, 9139.086091390807, 9106.544672766202, 12145.089118315986, 12177.147599667938, 12201.69495762613, 12337.0], "value": 8629.200783304263, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.7555815511362, 1583.9862488007673, 1589.7217986852302, 1812.9184186711598, 1917.3481016454402, 8472.788180295496, 8654.09132041136, 8672.653093876253, 8695.69565065223, 8698.260647844942, 8534.70128545501, 8666.91333086669, 8743.213110820025, 8745.169208925157, 8745.562721863913, 2417.903283868643, 2449.7917676997477, 2455.5211733711935, 2466.7656572625574, 2470.407102295454, 2434.294054724128, 2544.3893465568317, 2544.796416286702, 2552.4767422678306, 2556.7059788124325, 2384.6899903012586, 2395.185636883459, 2397.3886658901956, 2401.0515846240723, 2401.6157414813547, 2453.325335532725, 2453.4479742058074, 2457.7050753909466, 2478.0459523083564, 2495.126705653025, 2477.36827109086, 2497.8751062446986, 2518.7607177318127, 2520.332111990324, 2525.936851578707, 8478.872816907751, 8649.567521623894, 8875.911240887574, 8947.060558641379, 8950.641974321019, 5534.501894829485, 5620.775168993236, 5629.831105066854, 5632.155176723483, 5666.603337766358, 3405.7956522608724, 3444.500547420635, 3466.2374277658873, 3603.0, 3654.7076233901225, 1129.4522156753967, 1152.2049785647876, 1161.8373427720126, 1164.3654208456412, 1166.6558365282262, 12124.696882577919, 12342.13605047647, 12667.30329831868, 12815.74368512634, 12846.229226246454, 4804.55010352482, 4857.514248575185, 4935.777889994959, 4949.82675606352, 4953.108440480676, 10906.0, 10931.0, 10942.234043617029, 11003.724906877233, 11022.50398732059, 5598.300212473441, 5605.299337582802, 5638.464345887134, 5647.576431767634, 5648.802291919763, 4593.770311484413, 5002.59979201663, 5119.820806271762, 5133.974330128325, 5136.743162841843, 4205.201011807747, 4244.808983595745, 4254.893627659271, 4287.2711639021445, 4328.458942632171, 1378.63466181462, 1383.5641772841523, 1425.3300948554163, 1428.1859340176209, 1438.8992770506175, 1050.0759331787979, 1074.5164675895878, 1081.1512962324537, 1087.896649818266, 1088.5210507376728, 6203.0, 6355.841103972345, 6415.711292991827, 6424.3254458282145, 6454.19322584677, 438.49353996134516, 445.4698908299114, 447.6061066261669, 448.96857219994286, 453.67562193031483, 4158.480189976253, 4237.427947227085, 4272.9359059614135, 4304.418903448057, 4346.587074227943, 11036.392998385005, 11511.942440287745, 11543.018843398406, 11584.0, 11597.304161750322, 11362.034227090624, 11369.886301137049, 11372.829407558893, 11378.544858205745, 11398.544058237578, 8206.097329293772, 8532.445391049561, 8548.658053677907, 8641.222289993932, 8651.870221946676, 6012.6392416455155, 6072.72472780721, 6098.847528811815, 6185.257769067741, 6201.131841542278, 9851.261155413229, 10035.598576057168, 10068.144207742424, 10305.381677099398, 10306.896931030893, 10204.336718113298, 10291.742706432398, 10354.534045968101, 10528.473166440152, 10538.8419173714, 7028.402585780266, 7197.820054498679, 7526.435517336331, 8164.428490005643, 8301.460405073893, 8282.1303763104, 8298.58507074656, 8334.124916883882, 8346.624401901807, 8354.958225208835, 7203.747868824566, 7313.049303590499, 7364.410847132323, 7365.8158546036775, 7434.0, 7339.6330183489545, 7356.816079598053, 7384.187739348775, 7401.666924988281, 7452.0, 6468.288488266381, 6494.447971922439, 6506.902396464152, 6582.539222254396, 6636.668166591748, 4789.44921334051, 5120.3087583177285, 5137.460566640599, 5150.278960945396, 5150.716710580954, 5314.760835762323, 5318.468153184651, 5385.219143224289, 5427.778749781268, 5546.944530554642], "value": 4695.443118391933, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.78201124297317, 351.29039340532125, 354.1217779905833, 356.7271037656195, 361.126074898745, 6162.784302549411, 6191.783287584935, 6228.719707613162, 6288.842778930529, 6314.084457753623, 6225.12848201251, 6226.906596401058, 6230.595011324261, 6237.688115594214, 6254.21822272216, 4571.817127314904, 4591.357209990604, 4689.038747056845, 4727.196376615983, 4762.190427627294, 4717.599004084657, 4747.596454301389, 4757.381540399743, 4759.571638552529, 4767.261074533453, 4502.369668246448, 4633.9073218535605, 4710.929336059962, 4712.740799256039, 4732.739699316537, 4586.0, 4652.74409907455, 4686.343911852344, 4688.132695451318, 4706.576408123286, 4075.735077219971, 4076.0, 4082.755034697928, 4085.836566537335, 4088.550259471456, 6022.096685497167, 6024.728887200043, 6027.367126451703, 6027.939720602782, 6032.185654936615, 5439.238506609038, 5446.891062178774, 5449.04641687707, 5454.836354909319, 5459.454054594548, 6455.9354406455805, 6525.902111468332, 6533.869322613568, 6534.738610455576, 6587.176602924635, 4579.084183163381, 4583.977080114578, 4597.103564804865, 4601.631869450436, 4602.516735742733, 6770.593764374154, 6802.4217941475035, 6822.079019332376, 6824.044633751329, 6828.078209441712, 4679.555442232982, 4691.7184968901975, 4697.859064228079, 4702.835400760957, 4706.85879423611, 4762.119007983534, 4773.594244489257, 4774.928376074362, 4777.211760059551, 4778.761061946958, 5462.535684466785, 5465.9726701366235, 5489.533389661844, 5491.36849262332, 5499.120140777456, 6309.905351419732, 6566.146400967939, 6583.63789991555, 6584.308647591934, 6591.967040164768, 1605.1091644137382, 1610.5973506623345, 1617.6036870966689, 1630.4537979776671, 1632.0289427790447, 1000.694788089625, 1023.7133602591286, 1036.8807587127576, 1052.7631282961272, 1053.068034789217, 6158.507319414436, 6284.12022316876, 6337.795818794414, 6339.809805705744, 6351.96824015877, 6717.596944183365, 6723.899141512881, 6724.596524208563, 6733.562318449285, 6736.191657001191, 6324.778632747832, 6337.873242535124, 6386.489080873519, 6389.872202555923, 6390.0734393512685, 3589.353916295092, 3629.94555081674, 3631.8365673544754, 3632.0919770057485, 3633.9636603633626, 6828.829279267959, 7002.404795592432, 7024.121984751906, 7039.225685174627, 7040.612766297801, 6785.864282714417, 6844.178698556205, 6860.3139686032, 6861.4853885958755, 6865.210500792473, 6968.930310696929, 6986.685599148051, 6996.650167491707, 6998.545094568837, 7002.334778196063, 6681.69932353055, 6682.46540276767, 6699.799006029827, 6700.229473610597, 6706.932930670826, 6570.77002304917, 6571.667058194273, 6741.52809303344, 6765.458763298826, 6765.830854228684, 7129.037579926851, 7130.358267755927, 7133.8929916050265, 7138.214796372498, 7150.141982962078, 4597.7011494252765, 4632.050429661978, 4641.721496710208, 4643.048175124024, 4646.233371493666, 6793.66031698423, 6796.864062718619, 6807.795766127024, 6819.215790184192, 6823.761168359084, 6415.326390729093, 6600.207975043026, 6614.834629134118, 6645.9366501359555, 6660.467162627075, 6573.934260657332, 6609.438197753245, 6613.041109039259, 6619.4042536170045, 6624.8343791405605, 6445.613263204223, 6475.838104047248, 6513.088167656627, 6529.314421985813, 6532.281449040697, 6672.599644021374, 6677.866442671217, 6679.6994135265, 6683.699233534406, 6688.264290927897, 6383.680815959091, 6492.870142597216, 6493.350664933658, 6497.9025314619375, 6500.122483464672], "value": 4945.909586773475, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.4084029918607, 888.3515034025162, 917.9489484540204, 924.5038247617911, 948.4688574398333, 15064.322105505238, 15355.53933381999, 15453.30460129294, 15532.301046452909, 15545.378184872605, 13233.13984591001, 13304.201747895133, 13330.133541319807, 13375.933120334385, 13379.933100334509, 747.7495039161887, 834.2158371131147, 857.9184977427135, 888.1251966812684, 902.9322800789935, 896.0143841774062, 902.8510295801185, 905.7011186308503, 907.3557773980482, 907.4600612635471, 923.1184219070805, 936.241644268145, 936.3866667332908, 938.2025278513244, 938.6433155400938, 778.0935210479785, 916.4867674102491, 938.8450905600567, 939.3800091939321, 939.8966113727485, 687.1685260834396, 687.4569090418613, 688.5317983771033, 689.2108535726616, 689.2487188964053, 14715.705685886329, 14816.851831481763, 14826.629334266621, 14829.703405931821, 14858.702825943421, 14896.255187240704, 15354.539363819104, 15405.922970385076, 15437.536873893801, 15564.844351556452, 12543.811842822364, 12576.308303043328, 12596.81104783429, 12764.234145951272, 12798.552050678274, 4093.2427500912127, 4119.237940980928, 4131.483564554431, 4149.771762553089, 4187.706860519765, 51889.96220075615, 51914.74042629763, 51941.7402912983, 51972.74013629946, 52158.739206304104, 10266.845997310047, 11030.338179709242, 11210.831837522444, 11309.547618095348, 11505.252158609663, 19188.232470701296, 19282.517937051685, 19306.13122409495, 19321.0, 19332.613347732968, 8577.142285771497, 8644.78388040304, 8790.42862213954, 8812.8678069829, 8907.688230912017, 5038.2190760432195, 5068.290439338495, 5159.690418574897, 5177.430482646906, 5182.300389447451, 3679.2457546202963, 3748.194138260287, 3750.9497340744633, 3752.3058234226755, 3754.530683664542, 671.4359937652396, 681.2438193605094, 683.5795985468901, 686.4508393285452, 686.5228666077029, 799.0371602219312, 808.789714674189, 810.5906517208772, 814.8248126652799, 815.963281652327, 9339.859902101474, 10113.595456181818, 10240.334378265388, 10283.742906427398, 10347.068763811292, 779.8518281526492, 788.333857890082, 792.8691765858568, 801.5951944268107, 838.6435764799936, 4520.276755719069, 4617.0, 4735.621150307967, 4784.0, 4789.640776941744, 58962.0, 62199.0, 62732.37267627265, 62823.68588157121, 62988.0, 55569.444305556426, 56622.71688641531, 57062.0, 57255.42744572584, 57631.0, 51489.0, 51657.7417112912, 51919.221211681855, 52886.20670689943, 52926.0, 10386.636467723594, 10400.687979360631, 10439.426076107298, 10450.947745261225, 10477.31897426665, 38707.41938870976, 39021.0, 39240.41139382969, 39315.410268845415, 39752.0, 45103.77448112739, 45390.0, 48178.27732583944, 49907.25139122989, 51028.48971510386, 12105.636830895088, 12308.384580771104, 12496.562620308245, 12526.060545458944, 12722.809157862825, 14202.928985355007, 14331.211783352015, 14353.0, 14440.494582689555, 14789.482368117064, 13286.734265314833, 13833.10084844482, 14067.507637232648, 14228.786568201278, 14412.85587144157, 13730.176189428666, 13824.0, 13955.860441395862, 14241.857581424054, 14318.498852540111, 13865.86134138686, 13903.652408689864, 13919.860801391857, 14007.859921400655, 14145.151290922578, 10012.799744004933, 10052.246081543768, 10106.292559520763, 10279.7430064246, 10563.20775941792, 10719.785604288027, 11065.834012489659, 11222.438878056228, 11326.490307935997, 11389.601363952223], "value": 7209.040419802656, "unit": "score"}], "name": "dromaeo_css", "value": 7437.389681442054, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 111.0, 110.0, 112.0, 110.0, 105.0, 112.0, 109.0, 109.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 125.0, 157.0, 180.0, 129.0, 153.0, 158.0, 127.0, 184.0, 129.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 161.0, 162.0, 160.0, 162.0, 164.0, 160.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 174.0, 78.0, 76.0, 76.0, 73.0, 162.0, 74.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 160.0, 92.0, 92.0, 93.0, 151.0, 92.0, 92.0, 143.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 144.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 54.0, 53.0, 55.0, 54.0, 58.0, 76.0, 53.0, 52.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 58.0, 58.0, 58.0, 58.0, 58.0, 59.0, 58.0, 58.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 72.0, 74.0, 73.0, 74.0, 73.0, 72.0, 72.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 117.0, 118.0, 112.0, 112.0, 112.0, 112.0, 132.0, 131.0], "value": 117.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 158.0, 159.0, 160.0, 158.0, 162.0, 156.0, 161.0, 157.0, 160.0], "value": 159.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 67.0, 67.0, 67.0, 65.0, 65.0, 66.0, 70.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1514.4000000000003, "alertThreshold": 2.0}]} 02:50:15 INFO - Return code: 0 02:50:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:50:15 ERROR - # TBPL SUCCESS # 02:50:15 INFO - Running post-action listener: _resource_record_post_action 02:50:15 INFO - Running post-run listener: _resource_record_post_run 02:50:16 INFO - Total resource usage - Wall time: 1210s; CPU: 13.0%; Read bytes: 4096; Write bytes: 464510976; Read time: 12; Write time: 3014324 02:50:16 INFO - install - Wall time: 22s; CPU: 22.0%; Read bytes: 0; Write bytes: 231178240; Read time: 0; Write time: 2056876 02:50:16 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 227409920; Read time: 12; Write time: 908676 02:50:16 INFO - Running post-run listener: _upload_blobber_files 02:50:16 INFO - Blob upload gear active. 02:50:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:50:16 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 02:50:16 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:50:16 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:50:16 INFO - (blobuploader) - INFO - Open directory for files ... 02:50:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:50:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:50:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:50:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:50:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:50:17 INFO - (blobuploader) - INFO - Done attempting. 02:50:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:50:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:50:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:50:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:50:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:50:17 INFO - (blobuploader) - INFO - Done attempting. 02:50:17 INFO - (blobuploader) - INFO - Iteration through files over. 02:50:17 INFO - Return code: 0 02:50:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:50:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:50:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a5f302f6d07e74d31cd184676b0a2e7238ab84cf321e55fec0307e376063b587e320e467e1e6f39e5eec7534ee512c8b7aae00cc17bc10e379407c95e1015045", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/621a6fc24f5b04ee3d45db513dc61e86ad634a8ad505f45b15f68b53f17727c3c3d022884f19abe3956830c866157e5836efd57caca7b235e65494ca4629c9f4"} 02:50:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:50:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:50:17 INFO - Contents: 02:50:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a5f302f6d07e74d31cd184676b0a2e7238ab84cf321e55fec0307e376063b587e320e467e1e6f39e5eec7534ee512c8b7aae00cc17bc10e379407c95e1015045", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/621a6fc24f5b04ee3d45db513dc61e86ad634a8ad505f45b15f68b53f17727c3c3d022884f19abe3956830c866157e5836efd57caca7b235e65494ca4629c9f4"} 02:50:17 INFO - Running post-run listener: copy_logs_to_upload_dir 02:50:17 INFO - Copying logs to upload dir... 02:50:17 INFO - mkdir: /builds/slave/test/build/upload/logs 02:50:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.056750 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-22 02:50:17.372693) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 02:50:17.375996) ========= 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=33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a5f302f6d07e74d31cd184676b0a2e7238ab84cf321e55fec0307e376063b587e320e467e1e6f39e5eec7534ee512c8b7aae00cc17bc10e379407c95e1015045", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/621a6fc24f5b04ee3d45db513dc61e86ad634a8ad505f45b15f68b53f17727c3c3d022884f19abe3956830c866157e5836efd57caca7b235e65494ca4629c9f4"} build_url:https://queue.taskcluster.net/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011485 build_url: 'https://queue.taskcluster.net/v1/task/ScWTHGaVQg2D2R7MzY2nGg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a5f302f6d07e74d31cd184676b0a2e7238ab84cf321e55fec0307e376063b587e320e467e1e6f39e5eec7534ee512c8b7aae00cc17bc10e379407c95e1015045", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/621a6fc24f5b04ee3d45db513dc61e86ad634a8ad505f45b15f68b53f17727c3c3d022884f19abe3956830c866157e5836efd57caca7b235e65494ca4629c9f4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 02:50:17.402675) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:50:17.403054) ========= 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=33d5923976266a1c518c4bf7000001ab-1466587482.868679-468597137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:50:17.486581) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 02:50:17.486974) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 02:50:17.487340) ========= ========= Total master_lag: 0.16 =========