builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-031 starttime: 1460755875.89 results: success (0) buildid: 20160415134642 builduid: 7907857672884246901353948a758700 revision: 6a623b9d45990722da19fc864c7ef820821bd4b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:15.892863) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:15.900794) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:15.901207) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:15.932703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:15.933148) ========= 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=db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 14:31:16-- 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% 223M=0s 2016-04-15 14:31:16 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142429 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:16.094573) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:16.094900) ========= 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=db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014901 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:16.145205) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:16.145537) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6a623b9d45990722da19fc864c7ef820821bd4b0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6a623b9d45990722da19fc864c7ef820821bd4b0 --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=db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 14:31:16,343 truncating revision to first 12 chars 2016-04-15 14:31:16,343 Setting DEBUG logging. 2016-04-15 14:31:16,343 attempt 1/10 2016-04-15 14:31:16,343 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6a623b9d4599?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 14:31:16,682 unpacking tar archive at: fx-team-6a623b9d4599/testing/mozharness/ program finished with exit code 0 elapsedTime=0.613096 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:16.771775) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:16.772099) ========= script_repo_revision: 6a623b9d45990722da19fc864c7ef820821bd4b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:16.772485) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:16.772801) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:16.782189) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-15 14:31:16.782559) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:31:17 INFO - MultiFileLogger online at 20160415 14:31:17 in /builds/slave/test 14:31:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 14:31:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:31:17 INFO - {'append_to_log': False, 14:31:17 INFO - 'base_work_dir': '/builds/slave/test', 14:31:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:31:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:31:17 INFO - 'branch': 'Fx-Team-Non-PGO', 14:31:17 INFO - 'buildbot_json_path': 'buildprops.json', 14:31:17 INFO - 'config_files': ('talos/linux_config.py',), 14:31:17 INFO - 'default_actions': ('clobber', 14:31:17 INFO - 'read-buildbot-config', 14:31:17 INFO - 'download-and-extract', 14:31:17 INFO - 'populate-webroot', 14:31:17 INFO - 'create-virtualenv', 14:31:17 INFO - 'install', 14:31:17 INFO - 'run-tests'), 14:31:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:31:17 INFO - 'download_minidump_stackwalk': True, 14:31:17 INFO - 'download_symbols': 'ondemand', 14:31:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:31:17 INFO - 'tooltool.py': '/tools/tooltool.py', 14:31:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:31:17 INFO - '/tools/misc-python/virtualenv.py')}, 14:31:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:31:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:31:17 INFO - 'installer_path': 'installer.exe', 14:31:17 INFO - 'log_level': 'info', 14:31:17 INFO - 'log_name': 'talos', 14:31:17 INFO - 'log_to_console': True, 14:31:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:31:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:31:17 INFO - 'opt_config_files': (), 14:31:17 INFO - 'pip_index': False, 14:31:17 INFO - 'sps_profile': False, 14:31:17 INFO - 'sps_profile_interval': 0, 14:31:17 INFO - 'suite': 'dromaeojs', 14:31:17 INFO - 'system_bits': '32', 14:31:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:31:17 INFO - 'title': 'talos-linux64-ix-031', 14:31:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:31:17 INFO - 'use_talos_json': True, 14:31:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:31:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:31:17 INFO - 'work_dir': 'build'} 14:31:17 INFO - ##### 14:31:17 INFO - ##### Running clobber step. 14:31:17 INFO - ##### 14:31:17 INFO - Running pre-action listener: _resource_record_pre_action 14:31:17 INFO - Running main action method: clobber 14:31:17 INFO - rmtree: /builds/slave/test/build 14:31:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:31:18 INFO - Running post-action listener: _resource_record_post_action 14:31:18 INFO - ##### 14:31:18 INFO - ##### Running read-buildbot-config step. 14:31:18 INFO - ##### 14:31:18 INFO - Running pre-action listener: _resource_record_pre_action 14:31:18 INFO - Running main action method: read_buildbot_config 14:31:18 INFO - Using buildbot properties: 14:31:18 INFO - { 14:31:18 INFO - "project": "", 14:31:18 INFO - "product": "firefox", 14:31:18 INFO - "script_repo_revision": "production", 14:31:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:31:18 INFO - "repository": "", 14:31:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:31:18 INFO - "buildid": "20160415134642", 14:31:18 INFO - "pgo_build": "False", 14:31:18 INFO - "basedir": "/builds/slave/test", 14:31:18 INFO - "buildnumber": 1567, 14:31:18 INFO - "slavename": "talos-linux64-ix-031", 14:31:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:31:18 INFO - "platform": "ubuntu64_hw", 14:31:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:31:18 INFO - "branch": "fx-team", 14:31:18 INFO - "repo_path": "integration/fx-team", 14:31:18 INFO - "revision": "6a623b9d45990722da19fc864c7ef820821bd4b0", 14:31:18 INFO - "stage_platform": "linux64", 14:31:18 INFO - "builduid": "7907857672884246901353948a758700", 14:31:18 INFO - "slavebuilddir": "test" 14:31:18 INFO - } 14:31:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 14:31:18 INFO - Running post-action listener: _resource_record_post_action 14:31:18 INFO - ##### 14:31:18 INFO - ##### Running download-and-extract step. 14:31:18 INFO - ##### 14:31:18 INFO - Running pre-action listener: _resource_record_pre_action 14:31:18 INFO - Running main action method: download_and_extract 14:31:18 INFO - mkdir: /builds/slave/test/build/tests 14:31:18 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')]} 14:31:18 INFO - https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:31:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:31:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:31:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:31:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:31:23 INFO - Downloaded 1361 bytes. 14:31:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:31:23 INFO - Using the following test package requirements: 14:31:23 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:31:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:31:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:31:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:23 INFO - u'jsshell-linux-x86_64.zip'], 14:31:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:31:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:31:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:31:23 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:31:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:31:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:31:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:31:23 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')]} 14:31:23 INFO - https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:31:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:31:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:31:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:31:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:31:30 INFO - Downloaded 22205647 bytes. 14:31:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:31:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:31:32 INFO - Return code: 0 14:31:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:31:32 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')]} 14:31:32 INFO - https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:31:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:31:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:31:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:31:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:31:34 INFO - Downloaded 22205647 bytes. 14:31:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:31:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:31:35 INFO - Return code: 0 14:31:35 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')]} 14:31:35 INFO - https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:31:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:31:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:31:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:31:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:31:36 INFO - Downloaded 10841076 bytes. 14:31:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:31:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:31:36 INFO - Return code: 0 14:31: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')]} 14:31:36 INFO - https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:31:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:31:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:31:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:31:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:31:38 INFO - Downloaded 54453664 bytes. 14:31:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:31:38 INFO - mkdir: /builds/slave/test/properties 14:31:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:31:38 INFO - Writing to file /builds/slave/test/properties/build_url 14:31:38 INFO - Contents: 14:31:38 INFO - build_url:https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:31:39 INFO - Running post-action listener: _resource_record_post_action 14:31:39 INFO - Running post-action listener: set_extra_try_arguments 14:31:39 INFO - ##### 14:31:39 INFO - ##### Running populate-webroot step. 14:31:39 INFO - ##### 14:31:39 INFO - Running pre-action listener: _resource_record_pre_action 14:31:39 INFO - Running main action method: populate_webroot 14:31:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:31:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:31:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:31:39 INFO - '--tppagecycles', 14:31:39 INFO - '7'], 14:31:39 INFO - 'tests': ['tsvgm']}}, 14:31:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:31:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:31:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:31:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:31:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:31:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:31:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:39 INFO - 'talos_options': ['--disable-e10s'], 14:31:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:31:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:31:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:39 INFO - 'talos_options': ['--disable-e10s'], 14:31:39 INFO - 'tests': ['damp', 'tps']}, 14:31:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:39 INFO - 'tests': ['damp', 'tps']}, 14:31:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:31:39 INFO - 'tests': ['dromaeo_dom']}, 14:31:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:31:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:31:39 INFO - 'tests': ['a11yr', 14:31:39 INFO - 'ts_paint', 14:31:39 INFO - 'tpaint', 14:31:39 INFO - 'sessionrestore', 14:31:39 INFO - 'sessionrestore_no_auto_restore', 14:31:39 INFO - 'tabpaint']}, 14:31:39 INFO - 'other-e10s': {'tests': ['a11yr', 14:31:39 INFO - 'ts_paint', 14:31:39 INFO - 'tpaint', 14:31:39 INFO - 'sessionrestore', 14:31:39 INFO - 'sessionrestore_no_auto_restore', 14:31:39 INFO - 'tabpaint']}, 14:31:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:31:39 INFO - 'ts_paint', 14:31:39 INFO - 'tpaint', 14:31:39 INFO - 'sessionrestore', 14:31:39 INFO - 'sessionrestore_no_auto_restore', 14:31:39 INFO - 'tabpaint']}, 14:31:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:31:39 INFO - 'ts_paint', 14:31:39 INFO - 'tpaint', 14:31:39 INFO - 'sessionrestore', 14:31:39 INFO - 'sessionrestore_no_auto_restore', 14:31:39 INFO - 'tabpaint']}, 14:31:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:31:39 INFO - 'tests': ['a11yr', 14:31:39 INFO - 'ts_paint', 14:31:39 INFO - 'tpaint', 14:31:39 INFO - 'sessionrestore', 14:31:39 INFO - 'sessionrestore_no_auto_restore', 14:31:39 INFO - 'tabpaint']}, 14:31:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:31:39 INFO - 'tests': ['a11yr', 14:31:39 INFO - 'ts_paint', 14:31:39 INFO - 'tpaint', 14:31:39 INFO - 'sessionrestore', 14:31:39 INFO - 'sessionrestore_no_auto_restore', 14:31:39 INFO - 'tabpaint']}, 14:31:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:31:39 INFO - 'tests': ['tsvgx', 14:31:39 INFO - 'tsvgr_opacity', 14:31:39 INFO - 'tart', 14:31:39 INFO - 'tscrollx', 14:31:39 INFO - 'cart']}, 14:31:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:31:39 INFO - 'tsvgr_opacity', 14:31:39 INFO - 'tart', 14:31:39 INFO - 'tscrollx', 14:31:39 INFO - 'cart']}, 14:31:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:39 INFO - 'talos_options': ['--disable-e10s'], 14:31:39 INFO - 'tests': ['tp5o']}, 14:31:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:39 INFO - 'tests': ['tp5o']}, 14:31:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:39 INFO - 'talos_options': ['--disable-e10s', 14:31:39 INFO - '--xperf_path', 14:31:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:31:39 INFO - 'tests': ['tp5n']}, 14:31:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:39 INFO - 'talos_options': ['--xperf_path', 14:31:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:31:39 INFO - 'tests': ['tp5n']}}, 14:31:39 INFO - 'talos.zip': {'path': '', 14:31:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:31:39 INFO - Running post-action listener: _resource_record_post_action 14:31:39 INFO - ##### 14:31:39 INFO - ##### Running create-virtualenv step. 14:31:39 INFO - ##### 14:31:39 INFO - Running pre-action listener: _resource_record_pre_action 14:31:39 INFO - Running main action method: create_virtualenv 14:31:39 INFO - Creating virtualenv /builds/slave/test/build/venv 14:31: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 14:31:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:31:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:31:39 INFO - Using real prefix '/usr' 14:31:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:31:40 INFO - Installing distribute.............................................................................................................................................................................................done. 14:31:42 INFO - Installing pip.................done. 14:31:42 INFO - Return code: 0 14:31:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:31: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')]} 14:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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')]} 14:31:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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 0x7f2a2f890f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55410>, '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 0x1c56310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c567a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171', '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 14:31: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 14:31: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 14:31:42 INFO - Using env: {'DISPLAY': ':0', 14:31:42 INFO - 'HOME': '/home/cltbld', 14:31:42 INFO - 'LANG': 'en_US.UTF-8', 14:31:42 INFO - 'LANGUAGE': 'en_US:en', 14:31:42 INFO - 'LOGNAME': 'cltbld', 14:31:42 INFO - 'MAIL': '/var/mail/cltbld', 14:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:42 INFO - 'MOZ_NO_REMOTE': '1', 14:31:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:42 INFO - 'NO_EM_RESTART': '1', 14:31:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:42 INFO - 'PWD': '/builds/slave/test', 14:31:42 INFO - 'SHELL': '/bin/bash', 14:31:42 INFO - 'SHLVL': '1', 14:31:42 INFO - 'TERM': 'linux', 14:31:42 INFO - 'TMOUT': '86400', 14:31:42 INFO - 'USER': 'cltbld', 14:31:42 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171', 14:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:42 INFO - '_': '/tools/buildbot/bin/python'} 14:31:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31: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 14:31:42 INFO - Cleaning up... 14:31:42 INFO - Return code: 0 14:31:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:31: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')]} 14:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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')]} 14:31:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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 0x7f2a2f890f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55410>, '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 0x1c56310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c567a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171', '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 14:31: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 14:31: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 14:31:42 INFO - Using env: {'DISPLAY': ':0', 14:31:42 INFO - 'HOME': '/home/cltbld', 14:31:42 INFO - 'LANG': 'en_US.UTF-8', 14:31:42 INFO - 'LANGUAGE': 'en_US:en', 14:31:42 INFO - 'LOGNAME': 'cltbld', 14:31:42 INFO - 'MAIL': '/var/mail/cltbld', 14:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:42 INFO - 'MOZ_NO_REMOTE': '1', 14:31:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:42 INFO - 'NO_EM_RESTART': '1', 14:31:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:42 INFO - 'PWD': '/builds/slave/test', 14:31:42 INFO - 'SHELL': '/bin/bash', 14:31:42 INFO - 'SHLVL': '1', 14:31:42 INFO - 'TERM': 'linux', 14:31:42 INFO - 'TMOUT': '86400', 14:31:42 INFO - 'USER': 'cltbld', 14:31:42 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171', 14:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:42 INFO - '_': '/tools/buildbot/bin/python'} 14:31:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:42 INFO - Downloading/unpacking psutil>=0.7.1 14:31: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 14:31: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 14:31: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 14:31: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 14:31: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 14:31: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 14:31:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:31:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:31:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:31:44 INFO - Installing collected packages: psutil 14:31:44 INFO - Running setup.py install for psutil 14:31:44 INFO - building 'psutil._psutil_linux' extension 14:31: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 14:31:44 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 14:31:44 INFO - building 'psutil._psutil_posix' extension 14:31:44 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 14:31:44 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 14:31:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:31:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:31:45 INFO - Successfully installed psutil 14:31:45 INFO - Cleaning up... 14:31:45 INFO - Return code: 0 14:31:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:31: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')]} 14:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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')]} 14:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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 0x7f2a2f890f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55410>, '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 0x1c56310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c567a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171', '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 14:31: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 14:31: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 14:31:45 INFO - Using env: {'DISPLAY': ':0', 14:31:45 INFO - 'HOME': '/home/cltbld', 14:31:45 INFO - 'LANG': 'en_US.UTF-8', 14:31:45 INFO - 'LANGUAGE': 'en_US:en', 14:31:45 INFO - 'LOGNAME': 'cltbld', 14:31:45 INFO - 'MAIL': '/var/mail/cltbld', 14:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:45 INFO - 'MOZ_NO_REMOTE': '1', 14:31:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:45 INFO - 'NO_EM_RESTART': '1', 14:31:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:45 INFO - 'PWD': '/builds/slave/test', 14:31:45 INFO - 'SHELL': '/bin/bash', 14:31:45 INFO - 'SHLVL': '1', 14:31:45 INFO - 'TERM': 'linux', 14:31:45 INFO - 'TMOUT': '86400', 14:31:45 INFO - 'USER': 'cltbld', 14:31:45 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171', 14:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:45 INFO - '_': '/tools/buildbot/bin/python'} 14:31:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:31: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 14:31: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 14:31: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 14:31: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 14:31: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 14:31: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 14:31:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:31: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) 14:31:47 INFO - Installing collected packages: mozsystemmonitor 14:31:47 INFO - Running setup.py install for mozsystemmonitor 14:31:47 INFO - Successfully installed mozsystemmonitor 14:31:47 INFO - Cleaning up... 14:31:47 INFO - Return code: 0 14:31:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:31: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')]} 14:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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')]} 14:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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 0x7f2a2f890f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55410>, '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 0x1c56310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c567a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171', '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 14:31: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 14:31: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 14:31:47 INFO - Using env: {'DISPLAY': ':0', 14:31:47 INFO - 'HOME': '/home/cltbld', 14:31:47 INFO - 'LANG': 'en_US.UTF-8', 14:31:47 INFO - 'LANGUAGE': 'en_US:en', 14:31:47 INFO - 'LOGNAME': 'cltbld', 14:31:47 INFO - 'MAIL': '/var/mail/cltbld', 14:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:47 INFO - 'MOZ_NO_REMOTE': '1', 14:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:47 INFO - 'NO_EM_RESTART': '1', 14:31:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:47 INFO - 'PWD': '/builds/slave/test', 14:31:47 INFO - 'SHELL': '/bin/bash', 14:31:47 INFO - 'SHLVL': '1', 14:31:47 INFO - 'TERM': 'linux', 14:31:47 INFO - 'TMOUT': '86400', 14:31:47 INFO - 'USER': 'cltbld', 14:31:47 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171', 14:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:47 INFO - '_': '/tools/buildbot/bin/python'} 14:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:47 INFO - Downloading/unpacking blobuploader==1.2.4 14:31: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 14:31: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 14:31: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 14:31: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 14:31: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 14:31: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 14:31:49 INFO - Downloading blobuploader-1.2.4.tar.gz 14:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:31:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:31: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 14:31: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 14:31: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 14:31: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 14:31: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 14:31: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 14:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:31:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:31: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 14:31: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 14:31: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 14:31: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 14:31: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 14:31: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 14:31:50 INFO - Downloading docopt-0.6.1.tar.gz 14:31:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:31:50 INFO - Installing collected packages: blobuploader, requests, docopt 14:31:50 INFO - Running setup.py install for blobuploader 14:31:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:31:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:31:50 INFO - Running setup.py install for requests 14:31:50 INFO - Running setup.py install for docopt 14:31:50 INFO - Successfully installed blobuploader requests docopt 14:31:50 INFO - Cleaning up... 14:31:50 INFO - Return code: 0 14:31:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31:50 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')]} 14:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:50 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')]} 14:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:50 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 0x7f2a2f890f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55410>, '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 0x1c56310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c567a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171', '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 14:31:50 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 14:31:50 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 14:31:50 INFO - Using env: {'DISPLAY': ':0', 14:31:50 INFO - 'HOME': '/home/cltbld', 14:31:50 INFO - 'LANG': 'en_US.UTF-8', 14:31:50 INFO - 'LANGUAGE': 'en_US:en', 14:31:50 INFO - 'LOGNAME': 'cltbld', 14:31:50 INFO - 'MAIL': '/var/mail/cltbld', 14:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:50 INFO - 'MOZ_NO_REMOTE': '1', 14:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:50 INFO - 'NO_EM_RESTART': '1', 14:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:50 INFO - 'PWD': '/builds/slave/test', 14:31:50 INFO - 'SHELL': '/bin/bash', 14:31:50 INFO - 'SHLVL': '1', 14:31:50 INFO - 'TERM': 'linux', 14:31:50 INFO - 'TMOUT': '86400', 14:31:50 INFO - 'USER': 'cltbld', 14:31:50 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171', 14:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:50 INFO - '_': '/tools/buildbot/bin/python'} 14:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:31:51 INFO - Running setup.py (path:/tmp/pip-DhQYex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:31:51 INFO - Running setup.py (path:/tmp/pip-EjQ0ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:31:51 INFO - Running setup.py (path:/tmp/pip-4yYKXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:31:51 INFO - Running setup.py (path:/tmp/pip-MA4uba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:31:51 INFO - Running setup.py (path:/tmp/pip-_gwyye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:31:51 INFO - Running setup.py (path:/tmp/pip-BIsQwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:31:51 INFO - Running setup.py (path:/tmp/pip-HAPOUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:31:51 INFO - Running setup.py (path:/tmp/pip-OuWSVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:31:51 INFO - Running setup.py (path:/tmp/pip-t9i36p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:31:51 INFO - Running setup.py (path:/tmp/pip-XYnceC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:31:51 INFO - Running setup.py (path:/tmp/pip-lwfGgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:31:51 INFO - Running setup.py (path:/tmp/pip-v7LLRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:31:51 INFO - Running setup.py (path:/tmp/pip-af8fPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:31:51 INFO - Running setup.py (path:/tmp/pip-I7bjEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:52 INFO - Running setup.py (path:/tmp/pip-6uykGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:31:52 INFO - Running setup.py (path:/tmp/pip-qnDYnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:31:52 INFO - Running setup.py (path:/tmp/pip-zLM1nG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:31:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:31:52 INFO - Running setup.py install for manifestparser 14:31:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:31:52 INFO - Running setup.py install for mozcrash 14:31:52 INFO - Running setup.py install for mozdebug 14:31:52 INFO - Running setup.py install for mozdevice 14:31:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:31:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:31:52 INFO - Running setup.py install for mozfile 14:31:52 INFO - Running setup.py install for mozhttpd 14:31:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:31:52 INFO - Running setup.py install for mozinfo 14:31:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:31:52 INFO - Running setup.py install for mozInstall 14:31:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:31:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:31:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:31:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:31:53 INFO - Running setup.py install for mozleak 14:31:53 INFO - Running setup.py install for mozlog 14:31:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:31:53 INFO - Running setup.py install for moznetwork 14:31:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:31:53 INFO - Running setup.py install for mozprocess 14:31:53 INFO - Running setup.py install for mozprofile 14:31:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:31:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:31:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:31:53 INFO - Running setup.py install for mozrunner 14:31:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:31:53 INFO - Running setup.py install for mozscreenshot 14:31:53 INFO - Running setup.py install for moztest 14:31:53 INFO - Running setup.py install for mozversion 14:31:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:31:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:31:54 INFO - Cleaning up... 14:31:54 INFO - Return code: 0 14:31:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31: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')]} 14:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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')]} 14:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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 0x7f2a2f890f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55410>, '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 0x1c56310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c567a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171', '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 14:31: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 14:31: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 14:31:54 INFO - Using env: {'DISPLAY': ':0', 14:31:54 INFO - 'HOME': '/home/cltbld', 14:31:54 INFO - 'LANG': 'en_US.UTF-8', 14:31:54 INFO - 'LANGUAGE': 'en_US:en', 14:31:54 INFO - 'LOGNAME': 'cltbld', 14:31:54 INFO - 'MAIL': '/var/mail/cltbld', 14:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:54 INFO - 'MOZ_NO_REMOTE': '1', 14:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:54 INFO - 'NO_EM_RESTART': '1', 14:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:54 INFO - 'PWD': '/builds/slave/test', 14:31:54 INFO - 'SHELL': '/bin/bash', 14:31:54 INFO - 'SHLVL': '1', 14:31:54 INFO - 'TERM': 'linux', 14:31:54 INFO - 'TMOUT': '86400', 14:31:54 INFO - 'USER': 'cltbld', 14:31:54 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171', 14:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:54 INFO - '_': '/tools/buildbot/bin/python'} 14:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:31:54 INFO - Running setup.py (path:/tmp/pip-vuEU8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:31: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)) 14:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:31:54 INFO - Running setup.py (path:/tmp/pip-sbKil1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:31: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)) 14:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:31:54 INFO - Running setup.py (path:/tmp/pip-OzjkRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:31: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)) 14:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:31:54 INFO - Running setup.py (path:/tmp/pip-T1gfmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:31: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)) 14:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:31:54 INFO - Running setup.py (path:/tmp/pip-NOnczf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:31: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)) 14:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:31:54 INFO - Running setup.py (path:/tmp/pip-BF67h5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:31:54 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)) 14:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:31:54 INFO - Running setup.py (path:/tmp/pip-2zOpyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:31:54 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)) 14:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:31:54 INFO - Running setup.py (path:/tmp/pip-S69Otx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:31:54 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)) 14:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:31:54 INFO - Running setup.py (path:/tmp/pip-VIrtAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:31:54 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)) 14:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:31:54 INFO - Running setup.py (path:/tmp/pip-J6vH2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:31:54 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)) 14:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:31:54 INFO - Running setup.py (path:/tmp/pip-ibM9vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:31: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)) 14:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:31:55 INFO - Running setup.py (path:/tmp/pip-cVNqpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:31: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)) 14:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:31:55 INFO - Running setup.py (path:/tmp/pip-fP_8U8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:31: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)) 14:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:31:55 INFO - Running setup.py (path:/tmp/pip-5_IUvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:31: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)) 14:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:55 INFO - Running setup.py (path:/tmp/pip-rlFfe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:31: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)) 14:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:31:55 INFO - Running setup.py (path:/tmp/pip-Jv8Tk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:31: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)) 14:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:31:55 INFO - Running setup.py (path:/tmp/pip-YLZIr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:31: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)) 14:31: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)) 14:31: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)) 14:31: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)) 14:31: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)) 14:31: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)) 14:31:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:31: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 14:31: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 14:31: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 14:31: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 14:31: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 14:31: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 14:31:57 INFO - Downloading blessings-1.6.tar.gz 14:31:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:31:57 INFO - Installing collected packages: blessings 14:31:57 INFO - Running setup.py install for blessings 14:31:57 INFO - Successfully installed blessings 14:31:57 INFO - Cleaning up... 14:31:57 INFO - Return code: 0 14:31:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:31:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:31:57 INFO - Reading from file tmpfile_stdout 14:31:57 INFO - Current package versions: 14:31:57 INFO - argparse == 1.2.1 14:31:57 INFO - blessings == 1.6 14:31:57 INFO - blobuploader == 1.2.4 14:31:57 INFO - docopt == 0.6.1 14:31:57 INFO - manifestparser == 1.1 14:31:57 INFO - mozInstall == 1.12 14:31:57 INFO - mozcrash == 0.17 14:31:57 INFO - mozdebug == 0.1 14:31:57 INFO - mozdevice == 0.48 14:31:57 INFO - mozfile == 1.2 14:31:57 INFO - mozhttpd == 0.7 14:31:57 INFO - mozinfo == 0.9 14:31:57 INFO - mozleak == 0.1 14:31:57 INFO - mozlog == 3.1 14:31:57 INFO - moznetwork == 0.27 14:31:57 INFO - mozprocess == 0.22 14:31:57 INFO - mozprofile == 0.28 14:31:57 INFO - mozrunner == 6.11 14:31:57 INFO - mozscreenshot == 0.1 14:31:57 INFO - mozsystemmonitor == 0.0 14:31:57 INFO - moztest == 0.7 14:31:57 INFO - mozversion == 1.4 14:31:57 INFO - psutil == 3.1.1 14:31:57 INFO - requests == 1.2.3 14:31:57 INFO - wsgiref == 0.1.2 14:31:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31:57 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')]} 14:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:57 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')]} 14:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:57 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 0x7f2a2f890f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55410>, '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 0x1c56310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c567a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171', '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 14:31:57 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 14:31:57 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 14:31:57 INFO - Using env: {'DISPLAY': ':0', 14:31:57 INFO - 'HOME': '/home/cltbld', 14:31:57 INFO - 'LANG': 'en_US.UTF-8', 14:31:57 INFO - 'LANGUAGE': 'en_US:en', 14:31:57 INFO - 'LOGNAME': 'cltbld', 14:31:57 INFO - 'MAIL': '/var/mail/cltbld', 14:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:57 INFO - 'MOZ_NO_REMOTE': '1', 14:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:57 INFO - 'NO_EM_RESTART': '1', 14:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:57 INFO - 'PWD': '/builds/slave/test', 14:31:57 INFO - 'SHELL': '/bin/bash', 14:31:57 INFO - 'SHLVL': '1', 14:31:57 INFO - 'TERM': 'linux', 14:31:57 INFO - 'TMOUT': '86400', 14:31:57 INFO - 'USER': 'cltbld', 14:31:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171', 14:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:57 INFO - '_': '/tools/buildbot/bin/python'} 14:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:57 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)) 14:31:57 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)) 14:31:57 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)) 14:31:57 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)) 14:31:57 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)) 14:31:57 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)) 14:31:57 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)) 14:31:57 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)) 14:31:57 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)) 14:31:57 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)) 14:31:57 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)) 14:31:57 INFO - Cleaning up... 14:31:58 INFO - Return code: 0 14:31:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:31: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')]} 14:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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')]} 14:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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 0x7f2a2f890f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55410>, '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 0x1c56310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c567a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171', '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 14:31: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 14:31: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 14:31:58 INFO - Using env: {'DISPLAY': ':0', 14:31:58 INFO - 'HOME': '/home/cltbld', 14:31:58 INFO - 'LANG': 'en_US.UTF-8', 14:31:58 INFO - 'LANGUAGE': 'en_US:en', 14:31:58 INFO - 'LOGNAME': 'cltbld', 14:31:58 INFO - 'MAIL': '/var/mail/cltbld', 14:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:58 INFO - 'MOZ_NO_REMOTE': '1', 14:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:58 INFO - 'NO_EM_RESTART': '1', 14:31:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:58 INFO - 'PWD': '/builds/slave/test', 14:31:58 INFO - 'SHELL': '/bin/bash', 14:31:58 INFO - 'SHLVL': '1', 14:31:58 INFO - 'TERM': 'linux', 14:31:58 INFO - 'TMOUT': '86400', 14:31:58 INFO - 'USER': 'cltbld', 14:31:58 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171', 14:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:58 INFO - '_': '/tools/buildbot/bin/python'} 14:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:58 INFO - Downloading/unpacking jsonschema 14:31: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 14:31: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 14:31: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 14:31: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 14:31: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 14:31: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 14:32:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:32:00 INFO - Downloading/unpacking functools32 (from jsonschema) 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32:00 INFO - Downloading functools32-3.2.3-2.tar.gz 14:32:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:32:00 INFO - warning: no files found matching '*.txt' 14:32:00 INFO - no previously-included directories found matching 'build' 14:32:00 INFO - no previously-included directories found matching 'dist' 14:32:00 INFO - no previously-included directories found matching '.git*' 14:32:00 INFO - Installing collected packages: jsonschema, functools32 14:32:00 INFO - Running setup.py install for functools32 14:32:00 INFO - warning: no files found matching '*.txt' 14:32:00 INFO - no previously-included directories found matching 'build' 14:32:00 INFO - no previously-included directories found matching 'dist' 14:32:00 INFO - no previously-included directories found matching '.git*' 14:32:00 INFO - Successfully installed jsonschema functools32 14:32:00 INFO - Cleaning up... 14:32:00 INFO - Return code: 0 14:32:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:32:00 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')]} 14:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:00 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')]} 14:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:00 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 0x7f2a2f890f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55410>, '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 0x1c56310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c567a0>, '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': 'db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171', '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 14:32:00 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 14:32:00 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 14:32:00 INFO - Using env: {'DISPLAY': ':0', 14:32:00 INFO - 'HOME': '/home/cltbld', 14:32:00 INFO - 'LANG': 'en_US.UTF-8', 14:32:00 INFO - 'LANGUAGE': 'en_US:en', 14:32:00 INFO - 'LOGNAME': 'cltbld', 14:32:00 INFO - 'MAIL': '/var/mail/cltbld', 14:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:00 INFO - 'MOZ_NO_REMOTE': '1', 14:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:00 INFO - 'NO_EM_RESTART': '1', 14:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:00 INFO - 'PWD': '/builds/slave/test', 14:32:00 INFO - 'SHELL': '/bin/bash', 14:32:00 INFO - 'SHLVL': '1', 14:32:00 INFO - 'TERM': 'linux', 14:32:00 INFO - 'TMOUT': '86400', 14:32:00 INFO - 'USER': 'cltbld', 14:32:00 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171', 14:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:00 INFO - '_': '/tools/buildbot/bin/python'} 14:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:00 INFO - Downloading/unpacking flake8 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:32:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:32:02 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 14:32:02 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 14:32:02 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 14:32:02 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 14:32:02 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 14:32:02 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 14:32:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:32:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:32:02 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 14:32:02 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 14:32:02 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 14:32:02 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 14:32:02 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 14:32:02 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 14:32:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:32:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:32:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:32:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:32:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:32:03 INFO - no previously-included directories found matching 'docs/_build' 14:32:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:32:03 INFO - Running setup.py install for pep8 14:32:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:32:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:32:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:32:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:32:03 INFO - no previously-included directories found matching 'docs/_build' 14:32:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:32:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:32:03 INFO - Cleaning up... 14:32:03 INFO - Return code: 0 14:32:03 INFO - Running post-action listener: _resource_record_post_action 14:32:03 INFO - Running post-action listener: _start_resource_monitoring 14:32:03 INFO - Starting resource monitoring. 14:32:03 INFO - ##### 14:32:03 INFO - ##### Running install step. 14:32:03 INFO - ##### 14:32:03 INFO - Running pre-action listener: _resource_record_pre_action 14:32:03 INFO - Running main action method: install 14:32:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:32:03 INFO - Reading from file tmpfile_stdout 14:32:03 INFO - Detecting whether we're running mozinstall >=1.0... 14:32:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:32:03 INFO - Reading from file tmpfile_stdout 14:32:03 INFO - Output received: 14:32:03 INFO - Usage: mozinstall [options] installer 14:32:03 INFO - Options: 14:32:03 INFO - -h, --help show this help message and exit 14:32:03 INFO - -d DEST, --destination=DEST 14:32:03 INFO - Directory to install application into. [default: 14:32:03 INFO - "/builds/slave/test"] 14:32:03 INFO - --app=APP Application being installed. [default: firefox] 14:32:03 INFO - mkdir: /builds/slave/test/build/application 14:32:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:32:19 INFO - Reading from file tmpfile_stdout 14:32:19 INFO - Output received: 14:32:19 INFO - /builds/slave/test/build/application/firefox/firefox 14:32:19 INFO - Running post-action listener: _resource_record_post_action 14:32:19 INFO - ##### 14:32:19 INFO - ##### Running run-tests step. 14:32:19 INFO - ##### 14:32:19 INFO - Running pre-action listener: _resource_record_pre_action 14:32:19 INFO - Running main action method: run_tests 14:32:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:32:19 INFO - Python 2.7.3 14:32:19 INFO - Return code: 0 14:32:19 INFO - grabbing minidump binary from tooltool 14:32:19 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')]} 14:32:19 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 0x1c55410>, '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 0x1c56310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c567a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:32:19 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 14:32:19 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 14:32:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:32:19 INFO - Return code: 0 14:32:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:32:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:32:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:32:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:32:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:32:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:32:20 INFO - Return code: 0 14:32:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 14:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 14:32:20 INFO - Using env: {'DISPLAY': ':0', 14:32:20 INFO - 'HOME': '/home/cltbld', 14:32:20 INFO - 'LANG': 'en_US.UTF-8', 14:32:20 INFO - 'LANGUAGE': 'en_US:en', 14:32:20 INFO - 'LOGNAME': 'cltbld', 14:32:20 INFO - 'MAIL': '/var/mail/cltbld', 14:32:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:32:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:20 INFO - 'MOZ_NO_REMOTE': '1', 14:32:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:32:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:20 INFO - 'NO_EM_RESTART': '1', 14:32:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:20 INFO - 'PWD': '/builds/slave/test', 14:32:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:32:20 INFO - 'SHELL': '/bin/bash', 14:32:20 INFO - 'SHLVL': '1', 14:32:20 INFO - 'TERM': 'linux', 14:32:20 INFO - 'TMOUT': '86400', 14:32:20 INFO - 'USER': 'cltbld', 14:32:20 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171', 14:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:20 INFO - '_': '/tools/buildbot/bin/python'} 14:32:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 14:32:20 INFO - mozversion application_buildid: 20160415134642 14:32:20 INFO - mozversion application_changeset: 6a623b9d45990722da19fc864c7ef820821bd4b0 14:32:20 INFO - mozversion application_display_name: Nightly 14:32:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:32:20 INFO - mozversion application_name: Firefox 14:32:20 INFO - mozversion application_remotingname: firefox 14:32:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:32:20 INFO - mozversion application_vendor: Mozilla 14:32:20 INFO - mozversion application_version: 48.0a1 14:32:20 INFO - mozversion platform_buildid: 20160415134642 14:32:20 INFO - mozversion platform_changeset: 6a623b9d45990722da19fc864c7ef820821bd4b0 14:32:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:32:20 INFO - mozversion platform_version: 48.0a1 14:32:20 INFO - using testdate: 1460755940 14:32:20 INFO - actual date: 1460755940 14:32:20 INFO - starting webserver on 'localhost:49089' 14:32:20 INFO - SUITE-START | Running 2 tests 14:32:20 INFO - TEST-START | dromaeo_css 14:32:20 INFO - operating with platform_type : linux_ 14:32:20 INFO - Initialising browser for dromaeo_css test... 14:32:20 INFO - TEST-INFO | started process 23256 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2dY37m/profile http://localhost:49089/getInfo.html) 14:32:25 INFO - PROCESS | 23256 | __metrics Screen width/height:1600/1200 14:32:25 INFO - PROCESS | 23256 | colorDepth:24 14:32:25 INFO - PROCESS | 23256 | Browser inner width/height: 1024/697 14:32:25 INFO - PROCESS | 23256 | __metrics 14:32:26 ERROR - PROCESS | 23256 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:32:27 INFO - TEST-INFO | 23256: exit 0 14:32:27 INFO - Browser initialized. 14:32:27 INFO - Running cycle 1/1 for dromaeo_css test... 14:32:27 INFO - TEST-INFO | started process 23334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2dY37m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:32:39 INFO - PROCESS | 23334 | RSS: Main: 154980352 14:32:39 INFO - PROCESS | 23334 | 14:33:30 INFO - PROCESS | 23334 | 1460756010672 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] 14:35:41 INFO - PROCESS | 23334 | Cycle 1(1): loaded http://localhost:49089/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49089/tests/dromaeo/cssquery-ext.html) 14:35:42 INFO - PROCESS | 23334 | RSS: Main: 229212160 14:35:42 INFO - PROCESS | 23334 | 14:38:45 INFO - PROCESS | 23334 | Cycle 1(1): loaded http://localhost:49089/tests/dromaeo/cssquery-ext.html (next: http://localhost:49089/tests/dromaeo/cssquery-jquery.html) 14:38:45 INFO - PROCESS | 23334 | RSS: Main: 235212800 14:38:45 INFO - PROCESS | 23334 | 14:41:47 INFO - PROCESS | 23334 | Cycle 1(1): loaded http://localhost:49089/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49089/tests/dromaeo/cssquery-mootools.html) 14:41:48 INFO - PROCESS | 23334 | RSS: Main: 241901568 14:41:48 INFO - PROCESS | 23334 | 14:44:50 INFO - PROCESS | 23334 | Cycle 1(1): loaded http://localhost:49089/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49089/tests/dromaeo/cssquery-prototype.html) 14:44:51 INFO - PROCESS | 23334 | RSS: Main: 234491904 14:44:51 INFO - PROCESS | 23334 | 14:47:54 INFO - PROCESS | 23334 | Cycle 1(1): loaded http://localhost:49089/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49089/tests/dromaeo/cssquery-yui.html) 14:47:54 INFO - PROCESS | 23334 | RSS: Main: 213864448 14:47:54 INFO - PROCESS | 23334 | 14:50:57 INFO - PROCESS | 23334 | Cycle 1(1): loaded http://localhost:49089/tests/dromaeo/cssquery-yui.html (next: http://localhost:49089/tests/dromaeo/cssquery-dojo.html) 14:50:57 INFO - PROCESS | 23334 | RSS: Main: 266153984 14:50:57 INFO - PROCESS | 23334 | 14:50:57 INFO - PROCESS | 23334 | __start_tp_report 14:50:57 INFO - PROCESS | 23334 | _x_x_mozilla_page_load 14:50:57 INFO - PROCESS | 23334 | _x_x_mozilla_page_load_details 14:50:57 INFO - PROCESS | 23334 | |i|pagename|runs| 14:50:57 INFO - PROCESS | 23334 | |0;dojo.html;2562.577174766164;2588.7670109690125;2602.726713695063;2618.9214323570286;2626.2909014566076;4363.52001279859;4423.380726698257;4439.6226320762735;4455.821767129315;4474.015716542363;4513.7517436540975;4546.954530454703;4561.6806823522365;4583.541645835415;4585.1975904216715;4153.54311025787;4174.624283814456;4176.498820141587;4202.621764041236;4395.120975804836;4263.893402664943;4336.6530677545725;4344.131173765244;4348.152110338485;4377.233984052794;4036.8183431745642;4113.691473139496;4161.146964872194;4197.874063778091;4214.747115173069;4140.420341152241;4167.083241686824;4171.645410140141;4178.22702799983;4206.348016057516;4151.252774500589;4167.52073511547;4168.874933751992;4191.685623578213;4202.70581059326;4260.786960651955;4411.073674528353;4455.443069616298;4503;4538.205813982539;4862.343583616202;4905.607551395879;4910.263460480921;4944.950550494485;4955.380577427822;4886.9511304886855;4920.237363208708;4929.211326187793;4933.950660493385;4938.654294199408;4355.542668019844;4471.418715566988;4512.909741805145;4560.361549383089;4562.110388474282;4994.275830004629;5003.224500202475;5016.072026675077;5044.722540260247;5073.086844368049;4642.976785116053;4856.1016212000895;4860.052289803454;4863.416390033148;4894.926576101361;4864.6594738368685;4890.144224760653;4902.044101400193;4936.062148191832;4942.975285123552;4824.951750482521;4846.61227101831;4868.318435419044;4876.268559716071;4920.72935988524;4603.079384123122;4835.0571638530855;4839.395075615548;4873.853784386474;4889.168841296988;4140.648044916215;4173.10278290169;4191.832326706897;4203.831846726097;4205.789710514462;3620.8913732588067;3630.546181727284;3636.3636363636256;3659.304732100892;3660.9816950915074;4049.6962727795535;4128.3601041838565;4204.096119334357;4209.831606735696;4239.894002649897;4800.5199480051715;4843.95156048435;4862.927056094161;4885.5847252983895;4894.363732714795;4209.894752631148;4243.6605071594195;4244.808983595745;4253.425787518708;4286.271333873249;4176.791160441966;4427.845025424159;4432.31299148626;4439.400680908101;4444.046053942102;4617.191991401559;4623.214053610827;4628.83799067031;4675.462321833033;4677.46209185948;4902.1911384621135;4907.043126590281;4911.631627628014;4914.311996320589;4962.702237865739;4444.577765112309;4564.041551274269;4640.767961601974;4648.860534183845;4693.483716791082;4750.691205071659;4766.833160839354;4780.402449693788;4799.352087468147;4822.638302127284;4829.830955916526;4830.637702172421;4837.733924634179;4844.685095468783;4882.2920676501;4565.703229290086;4659.510751371057;4704;4770.236762118045;4808.374911261513;4711.034237981137;4713.175194340908;4729.8108075677965;4733.810647574059;4776.641751868554;4649;4658.068386322817;4672.976635116803;4674.649401294984;4718.787654555485;4610.815567377267;4704.741239231875;4771.76141192932;4806.855794326176;4814.350062741625;4641.118187544355;4666.580007799314;4671.322658214608;4678.625709943129;4740.525947405232 14:50:57 INFO - PROCESS | 23334 | |1;ext.html;578.3291381996885;601.9849503762406;620.7548018532678;621.9720112594932;628.9779857704975;26866.597001044975;27449.999999999975;27488.450230995393;34388.31223375537;35574.64425355745;38136.42795358065;38738.61261387392;38777.22445551087;38812.805935970355;38831.029224269405;7580.924190758091;7727.8068048298965;7763.999999999972;7764.37884969204;7768.689252429925;7576.280253375948;7636.160022397532;7644.847103057936;7646.082470103595;7691.9230807691765;7851;7904.683812647487;7911.485753426037;7911.960440197791;7917.683292668286;7817.257360550767;7872.488288261302;7875.921240787576;7881.487703299267;7882.132965373804;7695.42284328672;7804.141544430108;7806.375489960847;7807.063152421689;7810.0237470316215;37572.81213593942;38085.619143808486;38134.23731525382;38164.23671526582;38173.61826381728;3179.666135055809;3239.1416274687226;3581.4806853006166;3621.27574485104;3840.884773456773;28647.14058578246;28681.426371472455;29168.124956251348;29779.5533067002;30181;3474.322507111114;3499.772514786531;3520.052310374889;3655.634436556323;3683.4843121962945;231416;233276;233281;233611.8319408409;234382;32768.18079547983;50848.99999999926;51282;51531.74234128805;51615.48384516182;32134.35731285361;32271.35457290841;32378.352432951207;32419;32452.67547324544;12909.677258068436;13195.67010824737;13213.471461141447;13220.405081771343;13247.138935969131;11063.889361106447;11140.220184587;11148.888511114947;11189.216754827246;11208.55165793359;8260.297874680598;8280.751577452686;8292.212239837207;8309.00291964968;8364.832703345899;3124.218945263684;3164.177313898357;3180.634227063871;3222;3232.9838350808095;893.4282059481936;938.1041105743998;965.9613615455303;993.8062077894741;1003.6236411345745;27628.447431051267;28943;29116.854415727787;29325;29491;943.8914524829595;1005.0100650858898;1046.612753281291;1053.694428615693;1076.1283360478037;14607.488737894335;15188.848111518744;15280.770788438182;15579.532614021597;15591.76612350793;378495;382381;384234;385942;386524;47749.522504774504;48442.757786210845;48484.27273590899;48634;51198;1154.543955137716;1241.4599649152467;1245.4582256718356;1262.3498898067503;1307.0523870194033;25236.873815630803;25683.35791605225;26050.739492604833;26240.343991399604;26676.333091672863;35665.82167089252;36254.274914502086;36431;36449.27101458009;36579.63420365869;232832;237574;238097;238294;238545.80727096254;22663.320100397013;25311;25683;26024.959001639723;26087.347816304744;36900;36969.81515092407;37578.812105939294;37676.81161594284;38122.42816357702;31899.202519936258;32202.67797321997;33595.49606755949;37096.258074838894;40982;34463.13842153966;34852.825735871156;35196.47205291872;35423.291534169686;35519.46720799139;34552.65447345595;35413.82293088518;35676.64323356837;35680.464793027604;35805.82097089498;30925.845370773;32098;32238.19404514906;33065.338693225516;37105.25789484249;24968;25277.62083568785;25851.61222581625;26938.461230775665;28178.85910570434 14:50:57 INFO - PROCESS | 23334 | |2;jquery.html;368.2469350178884;369.09019267505596;379.27747640744377;384.84221469197615;388.91443882345874;16004;16799.83200167998;17182.82817171828;17191.914040429798;17201.311947522085;15470.5358839235;15717.292721827516;16985.49043528696;16993.745093823603;17027.659446811056;5072.213806859933;5206.947930520684;5232.4767523247565;5243.3970093439175;5243.606729495284;3705.481232627434;5167.9224811627855;5515.862103447405;6009;6028.4574388305045;5960.105984102376;5962.8807423851495;5991.970040149793;6006.9399306007035;6009.609375390607;5795.4784069433745;5891.823245302648;5942.8811423771285;5951.196588460546;5983.132445795357;3373.443381841993;4956.90086198274;5175.171972484384;5309.840704778863;5314.707691077027;20929.790702092938;21263.68104478434;21473.570528589342;21574.24490142853;21640.783592164033;1946.1047917957756;2132.5201829588373;2157.6871353653787;2199.2522542335682;2230.0410823345956;13281.136726112773;13563.864361356358;13966.301684915714;14098.71802563943;14171.291435428187;1940.8738432002017;1945.5816999345068;1987.8111579399933;2010.1356416740796;2028.3306508852042;74191.25808741951;77025.61487192528;77786.22213777903;78410.21589784086;78930.60534697348;16187.577161650743;16796.832031679773;16872.240749166318;16942.322307107825;17026.914865425842;29681.85159074191;29684.703152968625;30107;30116.24709382283;30145.246368840515;7961.890099123737;8213.466124701876;8325.209105135002;8326.66693332272;8488.448250863674;6806.59894676415;6888.448924086061;7117.822054448577;7311.195768465464;7316.817079573053;8304.875426868603;8412.359589879914;8443.746687599381;8492.575371231414;8757.358599941914;2681.839089654627;3100.767442441781;3171.8255495947483;3215.903522894317;3399.2043565720387;885.1635204731467;897.3763234552055;924.861270809384;925.0194793518891;952.8427809411509;16380.426685066204;16677.749833752503;17229.483115506555;17332.740008899877;17450;888.7733627924838;889.4307643108416;906.3972458315278;941.5904081724472;942.2038377570941;9066.95466522663;9388.248940084777;9388.62445502186;9592.904070959341;9624.230061595055;398878;406112;410062;413440;415307;76933.61533192298;78529.21470785333;78975.892169705;83471;84012.15987840165;902.7878448564582;913.8857642794518;926.0554234680588;930.093159169804;939.7415710679618;14149.221792801494;14656.780148297998;15288.388464461297;15420.46028389001;15665.686686265983;31983.200419989687;32632.510512342807;33083.17292067718;33244;34629.653703462645;41024;41894.37158442565;44577.55422445734;44881.32678009767;46144.538554614024;7440.813979650552;7519.248075192437;7535.849283014419;7552.169261381134;7656.081270247383;7125.002331785128;10854.240203186017;11808.94095529517;12087.395630218278;12091.274523528617;10522.263441559018;10696.251262411557;10740.785184296426;10821.080208182393;10854.991826512121;10563.52464139131;10659.94670026645;10661.147108231167;10810.51352689115;10947.945260273966;10150.746231344276;10394.58421663125;10799.082078023455;10834.837477438003;10891.67324980252;7826.178251283761;7917.129115797373;8056.234657707509;8127.2279133482225;8155.918440815516;9727.464989425649;10228.846567301645;10390.480475976323;10404.895951040393;10556.049955504042 14:50:57 INFO - PROCESS | 23334 | |3;mootools.html;1248.4132457744856;1430.0918916488033;1449.4781878523734;1594.1789978161248;1778.8043315235323;6541.345865413462;7832.1776213497615;8039.758807235778;8056.194380561941;8063.556504392271;7747.1090824555195;7914.960425197866;7953.284204421601;7963.163867793871;7973.720919767809;1932.7970563090885;2193.8573992690503;2196.593630178418;2224.8998795054263;2267.5804976079394;2296.2881506732965;2323.024329781496;2323.465602911331;2323.8605683659034;2324.976750232501;2194.9122035118576;2233.553289342138;2236.2508559632543;2237.552489502098;2238.742544607375;1827.8903265804029;2193.9122435102577;2259.559385919746;2262.6379779235244;2266.172846910882;2167.1656412281227;2195.2865318771305;2200.9119635214574;2201.8458707890454;2202.933911982643;8021.598920053974;8130.105688374274;8160.877586836202;8186.631601577943;8192.139825318374;4607.792649330788;4800.495947925452;4800.831970881002;4831.154547954129;4835.661503694742;2911.796174267802;2935.427591619635;2991.3568582754597;2993.4462124507036;2997.4454725875567;935.6818681648205;966.7341481092685;980.632262901412;983.8475036369302;1001.0740065439439;11390.25963312382;11397.202195846294;11426.828597571042;11429.428528573539;11436.19946603738;4312.611864932172;4414.668899832525;4455.732656040648;4458.420405347349;4485.708428952173;8579.571021449028;8603.354748393895;8677.479351238946;8679;8683.348748843862;4020.1557672888434;4675.368825208621;4676.95323046772;4687.086018226481;4706.882327941828;4289.7640629765665;4367.388565600819;4375.868723938287;4398.604125628709;4415.403920470695;3505.211327451354;3571.982140089283;3623.7463377563845;3650.5619325681087;3690.538682664667;1074.248026381536;1076.7684947736275;1084.9620263290747;1100.1254003067581;1106.3583121789343;832.4173078844833;839.7438781171801;846.9745907622781;876.6055275126218;908.3006085314403;5249.973750131225;5291.920621190685;5327.147656374961;5377.220303056035;5464.043792336325;407.8083300848596;408.46083170215627;414.94813148356457;417.4531363913223;425.32585851425216;3510.3856825055514;3537.7523573349617;3543.539339885798;3574.195805943642;3600.117971097098;9804.068613481708;10235.078842904175;10261.486925653688;10270.435126068138;10280.742981425374;9243.352965292364;10131.797364052678;10220.897791021995;10222.795544089226;10224.539895704711;7435.25647435263;7509.549427034286;7519.1728909818785;7519.661615227218;7588.8482230356185;5371.704556249288;5690.430956904442;5697.4302569742695;5864.912026319694;5881.676507792113;9302.441853488812;9348.252139828934;9475.47884866339;9508.762280943032;9688.951555242178;9461.148496635336;9681.37071090377;9684.46735429558;9769.902300977183;9804.411735295906;6228.190335256388;6890;6900.689468974008;7153.856922861618;7249.963750181215;7737.419693522896;7738.883916741366;7757.650905709143;7795.337396321376;7818.100918394457;6888.586684798928;7037;7105.431565474853;7106.786796396116;7183.138023437221;6844.178698556205;6902.033715279765;6906.585604863724;6907.378335949788;7055.541389809646;6349.015902535114;6368.23581170244;6368.554201205871;6548.410643042149;6550.115734375799;4650.162970665313;4677.555632214934;4713.835015774432;4775.498572649822;4797.712137271775;4768.189407800613;4807.543283388072;4823.493533178966;4863.076015557032;4909.631777616764 14:50:57 INFO - PROCESS | 23334 | |4;prototype.html;314.16745624096154;315.48260852202384;320.1563879178365;322.1832654221549;324.2396580019853;5075.467075957026;5105.08108540463;5114.6675466094675;5134.229865520174;5144.8971020579565;5009.323741294924;5015.814957501985;5033.144365457872;5054.317667114948;5073.74631268436;3740.700743940485;3813.694904407641;3951.940720889189;3984.183242435294;3987.6012398760035;3976.582458841823;3976.840926362942;3990.7805070721097;3993.4608827808165;4000.7599544027307;3747.7376583639157;3944.7830369329677;3948.466956960817;3948.9802550987206;3961.623645753649;3866.574676785551;3962.0689138052535;3964.5638979712207;3978.8607398741196;3982.6216509431847;3515.1739341254784;3522.806245656488;3523.154442933703;3526.188976535386;3531.3290474809705;4840.975795121002;4860.586850117745;4871.488493708181;4872.3909511311085;4881.243407271843;4197.041086034338;4422.292433210703;4462.4645042594775;4492.707973981681;4523.36672865799;5228.947710522884;5250.7112108834;5262.105841787002;5267.947320526784;5276.393214780311;3710.461983012448;3710.647488488616;3714.294284086015;3723.1622884850963;3752;5307.52232299095;5539.972300138474;5544.667319960815;5593.580481463907;5629.5097039835155;3808.6000969898314;3823.7323387362617;3840.8847734568008;3841.750286231386;3850.114473671071;3892;3903.2388684206876;3904.1455308728696;3908.355121404993;3910.1788624389196;4183.748975061506;4449.377087207794;4478.283474644041;4492.707973981681;4494.348319493721;5344.839654810284;5351.5718742501285;5354.9196762048605;5357.624966252403;5361.533694500496;1325.4168166006925;1351.445907178072;1352.749741297863;1358.280111540885;1361.2309045389322;841.9705310314109;891.6166048599035;903.5301643145527;903.9864402033975;915.8305713443034;4627.190241707688;4627.8611641650805;4627.930581041287;4646.4888862225125;4662.836800712027;5422.376426710979;5435.537979271806;5443.537299329522;5447.073997420369;5455.672659640434;4459.643228541709;4637.281221410687;4646.883827904262;4653.046125544255;4653.7207767534055;2899.5215789394933;2902.4630443367623;2905.535114381689;2922.240217543454;2930.6190195274903;5118.718470484159;5130.307408499804;5141.922871156861;5147.408048074444;5149.562287205629;5336.17289320156;5515.338159420815;5518.19986102021;5673.347565030074;5712.6286791358425;5213.40045894727;5233.162693968947;5241.895162096736;5256.2904007959205;5267.341582302212;5516.806911758069;5522.861928451821;5530.419305972815;5549.250851135045;5550.111982082847;5226.764795584284;5406.83779486616;5429.348478182485;5429.886873191065;5451.209574611738;5196.792128314825;5215.243789650555;5225.712585807817;5230.372355317386;5235.397929238186;3814.8474061037246;3857.8263978121613;3861.864834730771;3870.845166193321;3871.941920871133;5349.839504814861;5475.698836564027;5490.3411590609385;5497.752601133038;5503.3395992481155;5273.26174335601;5280.920786188133;5293.761780719954;5310.256564081109;5347.117725575236;5160.509751573594;5315.495027972336;5345.599080069088;5352.705601191972;5355.544778693855;4988.251762235694;5288.894222115459;5316.867078322918;5326.307580014573;5327.813526526553;5198.792048318025;5351.491608297206;5364.570834333322;5368.382635996911;5398.217258497574;5229.47705229474;5233.058049551118;5235.240890070994;5236.240745092016;5247.344081989751 14:50:57 INFO - PROCESS | 23334 | |5;yui.html;656.2322083162699;681.3833480699965;688.359825362413;703.7853454696316;711.484173973869;12226.266424014555;12299.446524906378;12404.937975310133;12450.750984980295;12454.875451245485;12261.509539618404;12289.508419663225;12316.568920087799;12380.257184568933;12407.193532420386;775.0583041604464;791.0191362710256;791.6279348706099;791.7545560876147;791.9643616037292;641.1856941684082;779.9610019499003;805.2591615713528;808.6280311056921;808.8867558541809;855.995720021399;861.5132450165668;861.5950503263456;862.3790870573208;863.4085651328828;670.0786418674322;859.3039637893295;859.3125499600295;859.5014891363026;861.4960248254779;603.294145849353;621.4003486635419;621.7046902721216;621.7979156774021;621.828997025817;12782.872171278354;12867.806982895265;12919.483220671162;12931.612051638465;12947.158434701714;11784.234024788448;12579.308138052404;12613.180143290749;12882.935585322108;13090.73559596642;9706.90293097074;9751.561179746928;9793.118619324223;9815.116639502408;9967.80064398708;3031.9545206821917;3068.55505951638;3075.5232938894505;3084.737797287211;3095.396397702449;46013;46190.30714539284;46215;46297;46373.76813115913;9655.855162172573;9722.416655000723;10095;10248.692539223835;10538.20963427746;17769.555761105818;17775.46673599794;17950.820491795177;18019.459416217534;18990.905045474683;6943.409810166192;7001.649917504206;7013;7099.396551293198;7237.023001894677;3821.5987321331418;3879.592642772525;3879.631435013669;4009.278329900646;4046.393041043867;2835.2344866885824;2912.28648981001;2933.8826446941885;2938.8383638899636;2941.6470023596876;514.4444000479473;514.5471984653556;523.1707743227028;526.5708447615182;530.8115618955293;564.3622706341807;624.0670198053939;635.8713283920985;636.7612145445459;654.1398061549048;7234.204237533867;7643.273888980538;7661.42539309554;7908.4068694846965;7929.246721561558;622.2968046107869;635.4598591197538;645.8094862015716;647.8024202618246;652.2629428745487;3892.2993861104706;3925.803709814498;3958.88123356294;3975.3847987722497;4073.368627862686;50047;50278.74860625673;50625.49374506281;50802.23796643053;51071.74464127656;45869;46064.53935460669;46131.30803037957;46182.538174617825;46363;41349.379759303636;41909.371359429635;42086.78956605258;42512.362314565304;42576.57423425726;7555.886661700189;7629.198934112061;7652.373012120201;7807.9219207809465;7855.764327070197;28582;28584.57123143196;28880;29300.267493312836;29302.560461592668;34753.30493390169;35738.8213058933;36785.26429471449;37072.44391334078;38002;10500.212484063879;10954.726131846768;10970.177236707119;11019.944900275448;11077.723056923642;11248.94375528117;11311.377874216669;11543.653690389301;11887;11939;11027.22809403334;11107.666769996913;11520.423978801195;11529.365884876077;11559.30644161353;11178.441077945907;11219.831702524305;11225.158113141384;11724.179307448738;11745.412729363668;11405.087592992375;11408.372539510407;11712.765744685228;11724.179307448398;11976.101792365782;9542.904570954479;9627.614895404386;9642.566084526074;9726.659566915125;9749.805003900025;9828.705138845846;9854.359466634645;9884.406935583887;9920.355176913477;9979.151772099453 14:50:57 INFO - PROCESS | 23334 | __end_tp_report 14:50:57 INFO - PROCESS | 23334 | __start_cc_report 14:50:57 INFO - PROCESS | 23334 | _x_x_mozilla_cycle_collect,1032 14:50:57 INFO - PROCESS | 23334 | __end_cc_report 14:50:57 INFO - PROCESS | 23334 | __startTimestamp1460757057772__endTimestamp 14:50:57 INFO - PROCESS | 23334 | 14:50:57 INFO - PROCESS | 23334 | ------- Summary: start ------- 14:50:57 INFO - PROCESS | 23334 | Number of tests: 6 14:50:57 INFO - PROCESS | 23334 | 14:50:57 INFO - PROCESS | 23334 | [#0] dojo.html Cycles:165 Average:4504.12 Median:4628.84 stddev:464.23 (10.0%) stddev-sans-first:439.96 14:50:57 INFO - PROCESS | 23334 | Values: 2562.6 2588.8 2602.7 2618.9 2626.3 4363.5 4423.4 4439.6 4455.8 4474.0 4513.8 4547.0 4561.7 4583.5 4585.2 4153.5 4174.6 4176.5 4202.6 4395.1 4263.9 4336.7 4344.1 4348.2 4377.2 4036.8 4113.7 4161.1 4197.9 4214.7 4140.4 4167.1 4171.6 4178.2 4206.3 4151.3 4167.5 4168.9 4191.7 4202.7 4260.8 4411.1 4455.4 4503.0 4538.2 4862.3 4905.6 4910.3 4945.0 4955.4 4887.0 4920.2 4929.2 4934.0 4938.7 4355.5 4471.4 4512.9 4560.4 4562.1 4994.3 5003.2 5016.1 5044.7 5073.1 4643.0 4856.1 4860.1 4863.4 4894.9 4864.7 4890.1 4902.0 4936.1 4943.0 4825.0 4846.6 4868.3 4876.3 4920.7 4603.1 4835.1 4839.4 4873.9 4889.2 4140.6 4173.1 4191.8 4203.8 4205.8 3620.9 3630.5 3636.4 3659.3 3661.0 4049.7 4128.4 4204.1 4209.8 4239.9 4800.5 4844.0 4862.9 4885.6 4894.4 4209.9 4243.7 4244.8 4253.4 4286.3 4176.8 4427.8 4432.3 4439.4 4444.0 4617.2 4623.2 4628.8 4675.5 4677.5 4902.2 4907.0 4911.6 4914.3 4962.7 4444.6 4564.0 4640.8 4648.9 4693.5 4750.7 4766.8 4780.4 4799.4 4822.6 4829.8 4830.6 4837.7 4844.7 4882.3 4565.7 4659.5 4704.0 4770.2 4808.4 4711.0 4713.2 4729.8 4733.8 4776.6 4649.0 4658.1 4673.0 4674.6 4718.8 4610.8 4704.7 4771.8 4806.9 4814.4 4641.1 4666.6 4671.3 4678.6 4740.5 14:50:57 INFO - PROCESS | 23334 | 14:50:57 INFO - PROCESS | 23334 | [#1] ext.html Cycles:180 Average:42737.73 Median:19466.94 stddev:77269.62 (396.9%) stddev-sans-first:77421.55 14:50:57 INFO - PROCESS | 23334 | Values: 578.3 602.0 620.8 622.0 629.0 26866.6 27450.0 27488.5 34388.3 35574.6 38136.4 38738.6 38777.2 38812.8 38831.0 7580.9 7727.8 7764.0 7764.4 7768.7 7576.3 7636.2 7644.8 7646.1 7691.9 7851.0 7904.7 7911.5 7912.0 7917.7 7817.3 7872.5 7875.9 7881.5 7882.1 7695.4 7804.1 7806.4 7807.1 7810.0 37572.8 38085.6 38134.2 38164.2 38173.6 3179.7 3239.1 3581.5 3621.3 3840.9 28647.1 28681.4 29168.1 29779.6 30181.0 3474.3 3499.8 3520.1 3655.6 3683.5 231416.0 233276.0 233281.0 233611.8 234382.0 32768.2 50849.0 51282.0 51531.7 51615.5 32134.4 32271.4 32378.4 32419.0 32452.7 12909.7 13195.7 13213.5 13220.4 13247.1 11063.9 11140.2 11148.9 11189.2 11208.6 8260.3 8280.8 8292.2 8309.0 8364.8 3124.2 3164.2 3180.6 3222.0 3233.0 893.4 938.1 966.0 993.8 1003.6 27628.4 28943.0 29116.9 29325.0 29491.0 943.9 1005.0 1046.6 1053.7 1076.1 14607.5 15188.8 15280.8 15579.5 15591.8 378495.0 382381.0 384234.0 385942.0 386524.0 47749.5 48442.8 48484.3 48634.0 51198.0 1154.5 1241.5 1245.5 1262.3 1307.1 25236.9 25683.4 26050.7 26240.3 26676.3 35665.8 36254.3 36431.0 36449.3 36579.6 232832.0 237574.0 238097.0 238294.0 238545.8 22663.3 25311.0 25683.0 26025.0 26087.3 36900.0 36969.8 37578.8 37676.8 38122.4 31899.2 32202.7 33595.5 37096.3 40982.0 34463.1 34852.8 35196.5 35423.3 35519.5 34552.7 35413.8 35676.6 35680.5 35805.8 30925.8 32098.0 32238.2 33065.3 37105.3 24968.0 25277.6 25851.6 26938.5 28178.9 14:50:57 INFO - PROCESS | 23334 | 14:50:57 INFO - PROCESS | 23334 | [#2] jquery.html Cycles:180 Average:25833.36 Median:402495.00 stddev:67390.63 (16.7%) stddev-sans-first:67552.55 14:50:57 INFO - PROCESS | 23334 | Values: 368.2 369.1 379.3 384.8 388.9 16004.0 16799.8 17182.8 17191.9 17201.3 15470.5 15717.3 16985.5 16993.7 17027.7 5072.2 5206.9 5232.5 5243.4 5243.6 3705.5 5167.9 5515.9 6009.0 6028.5 5960.1 5962.9 5992.0 6006.9 6009.6 5795.5 5891.8 5942.9 5951.2 5983.1 3373.4 4956.9 5175.2 5309.8 5314.7 20929.8 21263.7 21473.6 21574.2 21640.8 1946.1 2132.5 2157.7 2199.3 2230.0 13281.1 13563.9 13966.3 14098.7 14171.3 1940.9 1945.6 1987.8 2010.1 2028.3 74191.3 77025.6 77786.2 78410.2 78930.6 16187.6 16796.8 16872.2 16942.3 17026.9 29681.9 29684.7 30107.0 30116.2 30145.2 7961.9 8213.5 8325.2 8326.7 8488.4 6806.6 6888.4 7117.8 7311.2 7316.8 8304.9 8412.4 8443.7 8492.6 8757.4 2681.8 3100.8 3171.8 3215.9 3399.2 885.2 897.4 924.9 925.0 952.8 16380.4 16677.7 17229.5 17332.7 17450.0 888.8 889.4 906.4 941.6 942.2 9067.0 9388.2 9388.6 9592.9 9624.2 398878.0 406112.0 410062.0 413440.0 415307.0 76933.6 78529.2 78975.9 83471.0 84012.2 902.8 913.9 926.1 930.1 939.7 14149.2 14656.8 15288.4 15420.5 15665.7 31983.2 32632.5 33083.2 33244.0 34629.7 41024.0 41894.4 44577.6 44881.3 46144.5 7440.8 7519.2 7535.8 7552.2 7656.1 7125.0 10854.2 11808.9 12087.4 12091.3 10522.3 10696.3 10740.8 10821.1 10855.0 10563.5 10659.9 10661.1 10810.5 10947.9 10150.7 10394.6 10799.1 10834.8 10891.7 7826.2 7917.1 8056.2 8127.2 8155.9 9727.5 10228.8 10390.5 10404.9 10556.0 14:50:57 INFO - PROCESS | 23334 | 14:50:57 INFO - PROCESS | 23334 | [#3] mootools.html Cycles:180 Average:5291.31 Median:4799.10 stddev:3035.32 (63.2%) stddev-sans-first:3028.63 14:50:57 INFO - PROCESS | 23334 | Values: 1248.4 1430.1 1449.5 1594.2 1778.8 6541.3 7832.2 8039.8 8056.2 8063.6 7747.1 7915.0 7953.3 7963.2 7973.7 1932.8 2193.9 2196.6 2224.9 2267.6 2296.3 2323.0 2323.5 2323.9 2325.0 2194.9 2233.6 2236.3 2237.6 2238.7 1827.9 2193.9 2259.6 2262.6 2266.2 2167.2 2195.3 2200.9 2201.8 2202.9 8021.6 8130.1 8160.9 8186.6 8192.1 4607.8 4800.5 4800.8 4831.2 4835.7 2911.8 2935.4 2991.4 2993.4 2997.4 935.7 966.7 980.6 983.8 1001.1 11390.3 11397.2 11426.8 11429.4 11436.2 4312.6 4414.7 4455.7 4458.4 4485.7 8579.6 8603.4 8677.5 8679.0 8683.3 4020.2 4675.4 4677.0 4687.1 4706.9 4289.8 4367.4 4375.9 4398.6 4415.4 3505.2 3572.0 3623.7 3650.6 3690.5 1074.2 1076.8 1085.0 1100.1 1106.4 832.4 839.7 847.0 876.6 908.3 5250.0 5291.9 5327.1 5377.2 5464.0 407.8 408.5 414.9 417.5 425.3 3510.4 3537.8 3543.5 3574.2 3600.1 9804.1 10235.1 10261.5 10270.4 10280.7 9243.4 10131.8 10220.9 10222.8 10224.5 7435.3 7509.5 7519.2 7519.7 7588.8 5371.7 5690.4 5697.4 5864.9 5881.7 9302.4 9348.3 9475.5 9508.8 9689.0 9461.1 9681.4 9684.5 9769.9 9804.4 6228.2 6890.0 6900.7 7153.9 7250.0 7737.4 7738.9 7757.7 7795.3 7818.1 6888.6 7037.0 7105.4 7106.8 7183.1 6844.2 6902.0 6906.6 6907.4 7055.5 6349.0 6368.2 6368.6 6548.4 6550.1 4650.2 4677.6 4713.8 4775.5 4797.7 4768.2 4807.5 4823.5 4863.1 4909.6 14:50:57 INFO - PROCESS | 23334 | 14:50:57 INFO - PROCESS | 23334 | [#4] prototype.html Cycles:180 Average:4408.41 Median:5074.61 stddev:1287.71 (25.4%) stddev-sans-first:1254.12 14:50:57 INFO - PROCESS | 23334 | Values: 314.2 315.5 320.2 322.2 324.2 5075.5 5105.1 5114.7 5134.2 5144.9 5009.3 5015.8 5033.1 5054.3 5073.7 3740.7 3813.7 3951.9 3984.2 3987.6 3976.6 3976.8 3990.8 3993.5 4000.8 3747.7 3944.8 3948.5 3949.0 3961.6 3866.6 3962.1 3964.6 3978.9 3982.6 3515.2 3522.8 3523.2 3526.2 3531.3 4841.0 4860.6 4871.5 4872.4 4881.2 4197.0 4422.3 4462.5 4492.7 4523.4 5228.9 5250.7 5262.1 5267.9 5276.4 3710.5 3710.6 3714.3 3723.2 3752.0 5307.5 5540.0 5544.7 5593.6 5629.5 3808.6 3823.7 3840.9 3841.8 3850.1 3892.0 3903.2 3904.1 3908.4 3910.2 4183.7 4449.4 4478.3 4492.7 4494.3 5344.8 5351.6 5354.9 5357.6 5361.5 1325.4 1351.4 1352.7 1358.3 1361.2 842.0 891.6 903.5 904.0 915.8 4627.2 4627.9 4627.9 4646.5 4662.8 5422.4 5435.5 5443.5 5447.1 5455.7 4459.6 4637.3 4646.9 4653.0 4653.7 2899.5 2902.5 2905.5 2922.2 2930.6 5118.7 5130.3 5141.9 5147.4 5149.6 5336.2 5515.3 5518.2 5673.3 5712.6 5213.4 5233.2 5241.9 5256.3 5267.3 5516.8 5522.9 5530.4 5549.3 5550.1 5226.8 5406.8 5429.3 5429.9 5451.2 5196.8 5215.2 5225.7 5230.4 5235.4 3814.8 3857.8 3861.9 3870.8 3871.9 5349.8 5475.7 5490.3 5497.8 5503.3 5273.3 5280.9 5293.8 5310.3 5347.1 5160.5 5315.5 5345.6 5352.7 5355.5 4988.3 5288.9 5316.9 5326.3 5327.8 5198.8 5351.5 5364.6 5368.4 5398.2 5229.5 5233.1 5235.2 5236.2 5247.3 14:50:57 INFO - PROCESS | 23334 | 14:50:57 INFO - PROCESS | 23334 | [#5] yui.html Cycles:180 Average:12711.87 Median:46097.92 stddev:14141.29 (30.7%) stddev-sans-first:14151.98 14:50:57 INFO - PROCESS | 23334 | Values: 656.2 681.4 688.4 703.8 711.5 12226.3 12299.4 12404.9 12450.8 12454.9 12261.5 12289.5 12316.6 12380.3 12407.2 775.1 791.0 791.6 791.8 792.0 641.2 780.0 805.3 808.6 808.9 856.0 861.5 861.6 862.4 863.4 670.1 859.3 859.3 859.5 861.5 603.3 621.4 621.7 621.8 621.8 12782.9 12867.8 12919.5 12931.6 12947.2 11784.2 12579.3 12613.2 12882.9 13090.7 9706.9 9751.6 9793.1 9815.1 9967.8 3032.0 3068.6 3075.5 3084.7 3095.4 46013.0 46190.3 46215.0 46297.0 46373.8 9655.9 9722.4 10095.0 10248.7 10538.2 17769.6 17775.5 17950.8 18019.5 18990.9 6943.4 7001.6 7013.0 7099.4 7237.0 3821.6 3879.6 3879.6 4009.3 4046.4 2835.2 2912.3 2933.9 2938.8 2941.6 514.4 514.5 523.2 526.6 530.8 564.4 624.1 635.9 636.8 654.1 7234.2 7643.3 7661.4 7908.4 7929.2 622.3 635.5 645.8 647.8 652.3 3892.3 3925.8 3958.9 3975.4 4073.4 50047.0 50278.7 50625.5 50802.2 51071.7 45869.0 46064.5 46131.3 46182.5 46363.0 41349.4 41909.4 42086.8 42512.4 42576.6 7555.9 7629.2 7652.4 7807.9 7855.8 28582.0 28584.6 28880.0 29300.3 29302.6 34753.3 35738.8 36785.3 37072.4 38002.0 10500.2 10954.7 10970.2 11019.9 11077.7 11248.9 11311.4 11543.7 11887.0 11939.0 11027.2 11107.7 11520.4 11529.4 11559.3 11178.4 11219.8 11225.2 11724.2 11745.4 11405.1 11408.4 11712.8 11724.2 11976.1 9542.9 9627.6 9642.6 9726.7 9749.8 9828.7 9854.4 9884.4 9920.4 9979.2 14:50:57 INFO - PROCESS | 23334 | -------- Summary: end -------- 14:50:57 INFO - PROCESS | 23334 | 14:50:58 INFO - TEST-INFO | 23334: exit 0 14:50:58 INFO - TEST-OK | dromaeo_css | took 1117623ms 14:50:58 INFO - TEST-START | kraken 14:50:58 INFO - operating with platform_type : linux_ 14:50:58 INFO - Initialising browser for kraken test... 14:50:58 INFO - TEST-INFO | started process 23507 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLCtmM3/profile http://localhost:49089/getInfo.html) 14:51:02 INFO - PROCESS | 23507 | __metrics Screen width/height:1600/1200 14:51:02 INFO - PROCESS | 23507 | colorDepth:24 14:51:02 INFO - PROCESS | 23507 | Browser inner width/height: 1024/697 14:51:02 INFO - PROCESS | 23507 | __metrics 14:51:03 ERROR - PROCESS | 23507 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:51:04 INFO - TEST-INFO | 23507: exit 0 14:51:04 INFO - Browser initialized. 14:51:04 INFO - Running cycle 1/1 for kraken test... 14:51:04 INFO - TEST-INFO | started process 23585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLCtmM3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:51:16 INFO - PROCESS | 23585 | RSS: Main: 154931200 14:51:16 INFO - PROCESS | 23585 | 14:51:19 INFO - PROCESS | 23585 | Cycle 1(1): loaded http://localhost:49089/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49089/tests/kraken/driver.html?testName=audio-beat-detection) 14:51:20 INFO - PROCESS | 23585 | RSS: Main: 209969152 14:51:20 INFO - PROCESS | 23585 | 14:51:22 INFO - PROCESS | 23585 | Cycle 1(1): loaded http://localhost:49089/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49089/tests/kraken/driver.html?testName=audio-dft) 14:51:23 INFO - PROCESS | 23585 | RSS: Main: 195100672 14:51:23 INFO - PROCESS | 23585 | 14:51:26 INFO - PROCESS | 23585 | Cycle 1(1): loaded http://localhost:49089/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49089/tests/kraken/driver.html?testName=audio-fft) 14:51:27 INFO - PROCESS | 23585 | RSS: Main: 265433088 14:51:27 INFO - PROCESS | 23585 | 14:51:29 INFO - PROCESS | 23585 | Cycle 1(1): loaded http://localhost:49089/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49089/tests/kraken/driver.html?testName=audio-oscillator) 14:51:30 INFO - PROCESS | 23585 | RSS: Main: 173445120 14:51:30 INFO - PROCESS | 23585 | 14:51:32 INFO - PROCESS | 23585 | Cycle 1(1): loaded http://localhost:49089/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49089/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:51:32 INFO - PROCESS | 23585 | RSS: Main: 178319360 14:51:32 INFO - PROCESS | 23585 | 14:51:36 INFO - PROCESS | 23585 | Cycle 1(1): loaded http://localhost:49089/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49089/tests/kraken/driver.html?testName=imaging-darkroom) 14:51:36 INFO - PROCESS | 23585 | RSS: Main: 214376448 14:51:36 INFO - PROCESS | 23585 | 14:51:40 INFO - PROCESS | 23585 | Cycle 1(1): loaded http://localhost:49089/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49089/tests/kraken/driver.html?testName=imaging-desaturate) 14:51:40 INFO - PROCESS | 23585 | RSS: Main: 214802432 14:51:40 INFO - PROCESS | 23585 | 14:51:43 INFO - PROCESS | 23585 | Cycle 1(1): loaded http://localhost:49089/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49089/tests/kraken/driver.html?testName=json-parse-financial) 14:51:44 INFO - PROCESS | 23585 | RSS: Main: 215461888 14:51:44 INFO - PROCESS | 23585 | 14:51:45 INFO - PROCESS | 23585 | Cycle 1(1): loaded http://localhost:49089/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49089/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:51:46 INFO - PROCESS | 23585 | RSS: Main: 200081408 14:51:46 INFO - PROCESS | 23585 | 14:51:48 INFO - PROCESS | 23585 | Cycle 1(1): loaded http://localhost:49089/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49089/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:51:48 INFO - PROCESS | 23585 | RSS: Main: 203698176 14:51:48 INFO - PROCESS | 23585 | 14:51:50 INFO - PROCESS | 23585 | Cycle 1(1): loaded http://localhost:49089/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49089/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:51:51 INFO - PROCESS | 23585 | RSS: Main: 217444352 14:51:51 INFO - PROCESS | 23585 | 14:51:54 INFO - PROCESS | 23585 | Cycle 1(1): loaded http://localhost:49089/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49089/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:51:55 INFO - PROCESS | 23585 | RSS: Main: 224903168 14:51:55 INFO - PROCESS | 23585 | 14:51:58 INFO - PROCESS | 23585 | Cycle 1(1): loaded http://localhost:49089/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49089/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:51:58 INFO - PROCESS | 23585 | RSS: Main: 217681920 14:51:58 INFO - PROCESS | 23585 | 14:52:00 INFO - PROCESS | 23585 | Cycle 1(1): loaded http://localhost:49089/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49089/tests/kraken/driver.html?testName=ai-astar) 14:52:00 INFO - PROCESS | 23585 | RSS: Main: 281075712 14:52:00 INFO - PROCESS | 23585 | 14:52:00 INFO - PROCESS | 23585 | __start_tp_report 14:52:00 INFO - PROCESS | 23585 | _x_x_mozilla_page_load 14:52:00 INFO - PROCESS | 23585 | _x_x_mozilla_page_load_details 14:52:00 INFO - PROCESS | 23585 | |i|pagename|runs| 14:52:00 INFO - PROCESS | 23585 | |0;ai-astar;111;114;107;113;115;114;103;115;113;113 14:52:00 INFO - PROCESS | 23585 | |1;audio-beat-detection;165;131;157;196;133;162;153;132;193;128 14:52:00 INFO - PROCESS | 23585 | |2;audio-dft;161;162;162;161;162;165;163;163;161;161 14:52:00 INFO - PROCESS | 23585 | |3;audio-fft;76;73;124;103;75;74;76;126;100;73 14:52:00 INFO - PROCESS | 23585 | |4;audio-oscillator;95;95;154;94;94;94;137;93;92;143 14:52:00 INFO - PROCESS | 23585 | |5;imaging-gaussian-blur;117;117;117;116;116;117;116;117;118;117 14:52:00 INFO - PROCESS | 23585 | |6;imaging-darkroom;146;145;147;145;147;146;145;145;145;146 14:52:00 INFO - PROCESS | 23585 | |7;imaging-desaturate;95;95;94;94;95;94;94;95;95;94 14:52:00 INFO - PROCESS | 23585 | |8;json-parse-financial;63;63;63;65;64;63;64;85;63;64 14:52:00 INFO - PROCESS | 23585 | |9;json-stringify-tinderbox;65;64;64;64;65;65;66;66;64;65 14:52:00 INFO - PROCESS | 23585 | |10;stanford-crypto-aes;79;77;77;77;81;81;78;78;80;79 14:52:00 INFO - PROCESS | 23585 | |11;stanford-crypto-ccm;135;132;132;134;141;133;132;134;166;139 14:52:00 INFO - PROCESS | 23585 | |12;stanford-crypto-pbkdf2;172;173;170;171;181;183;182;174;172;172 14:52:00 INFO - PROCESS | 23585 | |13;stanford-crypto-sha256-iterative;72;75;71;72;71;73;72;71;72;71 14:52:00 INFO - PROCESS | 23585 | __end_tp_report 14:52:00 INFO - PROCESS | 23585 | __start_cc_report 14:52:00 INFO - PROCESS | 23585 | _x_x_mozilla_cycle_collect,1899 14:52:00 INFO - PROCESS | 23585 | __end_cc_report 14:52:00 INFO - PROCESS | 23585 | __startTimestamp1460757120710__endTimestamp 14:52:00 INFO - PROCESS | 23585 | 14:52:00 INFO - PROCESS | 23585 | ------- Summary: start ------- 14:52:00 INFO - PROCESS | 23585 | Number of tests: 14 14:52:00 INFO - PROCESS | 23585 | 14:52:00 INFO - PROCESS | 23585 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.50 stddev:3.88 (3.4%) stddev-sans-first:4.11 14:52:00 INFO - PROCESS | 23585 | Values: 111.0 114.0 107.0 113.0 115.0 114.0 103.0 115.0 113.0 113.0 14:52:00 INFO - PROCESS | 23585 | 14:52:00 INFO - PROCESS | 23585 | [#1] audio-beat-detection Cycles:10 Average:155.00 Median:159.50 stddev:24.94 (15.6%) stddev-sans-first:26.19 14:52:00 INFO - PROCESS | 23585 | Values: 165.0 131.0 157.0 196.0 133.0 162.0 153.0 132.0 193.0 128.0 14:52:00 INFO - PROCESS | 23585 | 14:52:00 INFO - PROCESS | 23585 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.29 (0.8%) stddev-sans-first:1.30 14:52:00 INFO - PROCESS | 23585 | Values: 161.0 162.0 162.0 161.0 162.0 165.0 163.0 163.0 161.0 161.0 14:52:00 INFO - PROCESS | 23585 | 14:52:00 INFO - PROCESS | 23585 | [#3] audio-fft Cycles:10 Average:90.00 Median:73.50 stddev:21.53 (29.3%) stddev-sans-first:22.23 14:52:00 INFO - PROCESS | 23585 | Values: 76.0 73.0 124.0 103.0 75.0 74.0 76.0 126.0 100.0 73.0 14:52:00 INFO - PROCESS | 23585 | 14:52:00 INFO - PROCESS | 23585 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:94.00 stddev:24.89 (26.5%) stddev-sans-first:25.87 14:52:00 INFO - PROCESS | 23585 | Values: 95.0 95.0 154.0 94.0 94.0 94.0 137.0 93.0 92.0 143.0 14:52:00 INFO - PROCESS | 23585 | 14:52:00 INFO - PROCESS | 23585 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 14:52:00 INFO - PROCESS | 23585 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 116.0 117.0 118.0 117.0 14:52:00 INFO - PROCESS | 23585 | 14:52:00 INFO - PROCESS | 23585 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 14:52:00 INFO - PROCESS | 23585 | Values: 146.0 145.0 147.0 145.0 147.0 146.0 145.0 145.0 145.0 146.0 14:52:00 INFO - PROCESS | 23585 | 14:52:00 INFO - PROCESS | 23585 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 14:52:00 INFO - PROCESS | 23585 | Values: 95.0 95.0 94.0 94.0 95.0 94.0 94.0 95.0 95.0 94.0 14:52:00 INFO - PROCESS | 23585 | 14:52:00 INFO - PROCESS | 23585 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:64.00 stddev:6.82 (10.6%) stddev-sans-first:7.16 14:52:00 INFO - PROCESS | 23585 | Values: 63.0 63.0 63.0 65.0 64.0 63.0 64.0 85.0 63.0 64.0 14:52:00 INFO - PROCESS | 23585 | 14:52:00 INFO - PROCESS | 23585 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 14:52:00 INFO - PROCESS | 23585 | Values: 65.0 64.0 64.0 64.0 65.0 65.0 66.0 66.0 64.0 65.0 14:52:00 INFO - PROCESS | 23585 | 14:52:00 INFO - PROCESS | 23585 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:79.00 stddev:1.57 (2.0%) stddev-sans-first:1.66 14:52:00 INFO - PROCESS | 23585 | Values: 79.0 77.0 77.0 77.0 81.0 81.0 78.0 78.0 80.0 79.0 14:52:00 INFO - PROCESS | 23585 | 14:52:00 INFO - PROCESS | 23585 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:134.50 stddev:10.37 (7.7%) stddev-sans-first:10.95 14:52:00 INFO - PROCESS | 23585 | Values: 135.0 132.0 132.0 134.0 141.0 133.0 132.0 134.0 166.0 139.0 14:52:00 INFO - PROCESS | 23585 | 14:52:00 INFO - PROCESS | 23585 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:173.50 stddev:4.97 (2.9%) stddev-sans-first:5.15 14:52:00 INFO - PROCESS | 23585 | Values: 172.0 173.0 170.0 171.0 181.0 183.0 182.0 174.0 172.0 172.0 14:52:00 INFO - PROCESS | 23585 | 14:52:00 INFO - PROCESS | 23585 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.00 stddev:1.25 (1.7%) stddev-sans-first:1.32 14:52:00 INFO - PROCESS | 23585 | Values: 72.0 75.0 71.0 72.0 71.0 73.0 72.0 71.0 72.0 71.0 14:52:00 INFO - PROCESS | 23585 | -------- Summary: end -------- 14:52:00 INFO - PROCESS | 23585 | 14:52:01 INFO - TEST-INFO | 23585: exit 0 14:52:01 INFO - TEST-OK | kraken | took 63188ms 14:52:01 INFO - SUITE-END | took 1180s 14:52:01 INFO - Completed test suite (00:19:40) 14:52:01 INFO - javascript benchmark 14:52:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2562.577174766164, 2588.7670109690125, 2602.726713695063, 2618.9214323570286, 2626.2909014566076, 4363.52001279859, 4423.380726698257, 4439.6226320762735, 4455.821767129315, 4474.015716542363, 4513.7517436540975, 4546.954530454703, 4561.6806823522365, 4583.541645835415, 4585.1975904216715, 4153.54311025787, 4174.624283814456, 4176.498820141587, 4202.621764041236, 4395.120975804836, 4263.893402664943, 4336.6530677545725, 4344.131173765244, 4348.152110338485, 4377.233984052794, 4036.8183431745642, 4113.691473139496, 4161.146964872194, 4197.874063778091, 4214.747115173069, 4140.420341152241, 4167.083241686824, 4171.645410140141, 4178.22702799983, 4206.348016057516, 4151.252774500589, 4167.52073511547, 4168.874933751992, 4191.685623578213, 4202.70581059326, 4260.786960651955, 4411.073674528353, 4455.443069616298, 4503.0, 4538.205813982539, 4862.343583616202, 4905.607551395879, 4910.263460480921, 4944.950550494485, 4955.380577427822, 4886.9511304886855, 4920.237363208708, 4929.211326187793, 4933.950660493385, 4938.654294199408, 4355.542668019844, 4471.418715566988, 4512.909741805145, 4560.361549383089, 4562.110388474282, 4994.275830004629, 5003.224500202475, 5016.072026675077, 5044.722540260247, 5073.086844368049, 4642.976785116053, 4856.1016212000895, 4860.052289803454, 4863.416390033148, 4894.926576101361, 4864.6594738368685, 4890.144224760653, 4902.044101400193, 4936.062148191832, 4942.975285123552, 4824.951750482521, 4846.61227101831, 4868.318435419044, 4876.268559716071, 4920.72935988524, 4603.079384123122, 4835.0571638530855, 4839.395075615548, 4873.853784386474, 4889.168841296988, 4140.648044916215, 4173.10278290169, 4191.832326706897, 4203.831846726097, 4205.789710514462, 3620.8913732588067, 3630.546181727284, 3636.3636363636256, 3659.304732100892, 3660.9816950915074, 4049.6962727795535, 4128.3601041838565, 4204.096119334357, 4209.831606735696, 4239.894002649897, 4800.5199480051715, 4843.95156048435, 4862.927056094161, 4885.5847252983895, 4894.363732714795, 4209.894752631148, 4243.6605071594195, 4244.808983595745, 4253.425787518708, 4286.271333873249, 4176.791160441966, 4427.845025424159, 4432.31299148626, 4439.400680908101, 4444.046053942102, 4617.191991401559, 4623.214053610827, 4628.83799067031, 4675.462321833033, 4677.46209185948, 4902.1911384621135, 4907.043126590281, 4911.631627628014, 4914.311996320589, 4962.702237865739, 4444.577765112309, 4564.041551274269, 4640.767961601974, 4648.860534183845, 4693.483716791082, 4750.691205071659, 4766.833160839354, 4780.402449693788, 4799.352087468147, 4822.638302127284, 4829.830955916526, 4830.637702172421, 4837.733924634179, 4844.685095468783, 4882.2920676501, 4565.703229290086, 4659.510751371057, 4704.0, 4770.236762118045, 4808.374911261513, 4711.034237981137, 4713.175194340908, 4729.8108075677965, 4733.810647574059, 4776.641751868554, 4649.0, 4658.068386322817, 4672.976635116803, 4674.649401294984, 4718.787654555485, 4610.815567377267, 4704.741239231875, 4771.76141192932, 4806.855794326176, 4814.350062741625, 4641.118187544355, 4666.580007799314, 4671.322658214608, 4678.625709943129, 4740.525947405232], "value": 4475.494204180749, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.3291381996885, 601.9849503762406, 620.7548018532678, 621.9720112594932, 628.9779857704975, 26866.597001044975, 27449.999999999975, 27488.450230995393, 34388.31223375537, 35574.64425355745, 38136.42795358065, 38738.61261387392, 38777.22445551087, 38812.805935970355, 38831.029224269405, 7580.924190758091, 7727.8068048298965, 7763.999999999972, 7764.37884969204, 7768.689252429925, 7576.280253375948, 7636.160022397532, 7644.847103057936, 7646.082470103595, 7691.9230807691765, 7851.0, 7904.683812647487, 7911.485753426037, 7911.960440197791, 7917.683292668286, 7817.257360550767, 7872.488288261302, 7875.921240787576, 7881.487703299267, 7882.132965373804, 7695.42284328672, 7804.141544430108, 7806.375489960847, 7807.063152421689, 7810.0237470316215, 37572.81213593942, 38085.619143808486, 38134.23731525382, 38164.23671526582, 38173.61826381728, 3179.666135055809, 3239.1416274687226, 3581.4806853006166, 3621.27574485104, 3840.884773456773, 28647.14058578246, 28681.426371472455, 29168.124956251348, 29779.5533067002, 30181.0, 3474.322507111114, 3499.772514786531, 3520.052310374889, 3655.634436556323, 3683.4843121962945, 231416.0, 233276.0, 233281.0, 233611.8319408409, 234382.0, 32768.18079547983, 50848.99999999926, 51282.0, 51531.74234128805, 51615.48384516182, 32134.35731285361, 32271.35457290841, 32378.352432951207, 32419.0, 32452.67547324544, 12909.677258068436, 13195.67010824737, 13213.471461141447, 13220.405081771343, 13247.138935969131, 11063.889361106447, 11140.220184587, 11148.888511114947, 11189.216754827246, 11208.55165793359, 8260.297874680598, 8280.751577452686, 8292.212239837207, 8309.00291964968, 8364.832703345899, 3124.218945263684, 3164.177313898357, 3180.634227063871, 3222.0, 3232.9838350808095, 893.4282059481936, 938.1041105743998, 965.9613615455303, 993.8062077894741, 1003.6236411345745, 27628.447431051267, 28943.0, 29116.854415727787, 29325.0, 29491.0, 943.8914524829595, 1005.0100650858898, 1046.612753281291, 1053.694428615693, 1076.1283360478037, 14607.488737894335, 15188.848111518744, 15280.770788438182, 15579.532614021597, 15591.76612350793, 378495.0, 382381.0, 384234.0, 385942.0, 386524.0, 47749.522504774504, 48442.757786210845, 48484.27273590899, 48634.0, 51198.0, 1154.543955137716, 1241.4599649152467, 1245.4582256718356, 1262.3498898067503, 1307.0523870194033, 25236.873815630803, 25683.35791605225, 26050.739492604833, 26240.343991399604, 26676.333091672863, 35665.82167089252, 36254.274914502086, 36431.0, 36449.27101458009, 36579.63420365869, 232832.0, 237574.0, 238097.0, 238294.0, 238545.80727096254, 22663.320100397013, 25311.0, 25683.0, 26024.959001639723, 26087.347816304744, 36900.0, 36969.81515092407, 37578.812105939294, 37676.81161594284, 38122.42816357702, 31899.202519936258, 32202.67797321997, 33595.49606755949, 37096.258074838894, 40982.0, 34463.13842153966, 34852.825735871156, 35196.47205291872, 35423.291534169686, 35519.46720799139, 34552.65447345595, 35413.82293088518, 35676.64323356837, 35680.464793027604, 35805.82097089498, 30925.845370773, 32098.0, 32238.19404514906, 33065.338693225516, 37105.25789484249, 24968.0, 25277.62083568785, 25851.61222581625, 26938.461230775665, 28178.85910570434], "value": 16160.791365843565, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.2469350178884, 369.09019267505596, 379.27747640744377, 384.84221469197615, 388.91443882345874, 16004.0, 16799.83200167998, 17182.82817171828, 17191.914040429798, 17201.311947522085, 15470.5358839235, 15717.292721827516, 16985.49043528696, 16993.745093823603, 17027.659446811056, 5072.213806859933, 5206.947930520684, 5232.4767523247565, 5243.3970093439175, 5243.606729495284, 3705.481232627434, 5167.9224811627855, 5515.862103447405, 6009.0, 6028.4574388305045, 5960.105984102376, 5962.8807423851495, 5991.970040149793, 6006.9399306007035, 6009.609375390607, 5795.4784069433745, 5891.823245302648, 5942.8811423771285, 5951.196588460546, 5983.132445795357, 3373.443381841993, 4956.90086198274, 5175.171972484384, 5309.840704778863, 5314.707691077027, 20929.790702092938, 21263.68104478434, 21473.570528589342, 21574.24490142853, 21640.783592164033, 1946.1047917957756, 2132.5201829588373, 2157.6871353653787, 2199.2522542335682, 2230.0410823345956, 13281.136726112773, 13563.864361356358, 13966.301684915714, 14098.71802563943, 14171.291435428187, 1940.8738432002017, 1945.5816999345068, 1987.8111579399933, 2010.1356416740796, 2028.3306508852042, 74191.25808741951, 77025.61487192528, 77786.22213777903, 78410.21589784086, 78930.60534697348, 16187.577161650743, 16796.832031679773, 16872.240749166318, 16942.322307107825, 17026.914865425842, 29681.85159074191, 29684.703152968625, 30107.0, 30116.24709382283, 30145.246368840515, 7961.890099123737, 8213.466124701876, 8325.209105135002, 8326.66693332272, 8488.448250863674, 6806.59894676415, 6888.448924086061, 7117.822054448577, 7311.195768465464, 7316.817079573053, 8304.875426868603, 8412.359589879914, 8443.746687599381, 8492.575371231414, 8757.358599941914, 2681.839089654627, 3100.767442441781, 3171.8255495947483, 3215.903522894317, 3399.2043565720387, 885.1635204731467, 897.3763234552055, 924.861270809384, 925.0194793518891, 952.8427809411509, 16380.426685066204, 16677.749833752503, 17229.483115506555, 17332.740008899877, 17450.0, 888.7733627924838, 889.4307643108416, 906.3972458315278, 941.5904081724472, 942.2038377570941, 9066.95466522663, 9388.248940084777, 9388.62445502186, 9592.904070959341, 9624.230061595055, 398878.0, 406112.0, 410062.0, 413440.0, 415307.0, 76933.61533192298, 78529.21470785333, 78975.892169705, 83471.0, 84012.15987840165, 902.7878448564582, 913.8857642794518, 926.0554234680588, 930.093159169804, 939.7415710679618, 14149.221792801494, 14656.780148297998, 15288.388464461297, 15420.46028389001, 15665.686686265983, 31983.200419989687, 32632.510512342807, 33083.17292067718, 33244.0, 34629.653703462645, 41024.0, 41894.37158442565, 44577.55422445734, 44881.32678009767, 46144.538554614024, 7440.813979650552, 7519.248075192437, 7535.849283014419, 7552.169261381134, 7656.081270247383, 7125.002331785128, 10854.240203186017, 11808.94095529517, 12087.395630218278, 12091.274523528617, 10522.263441559018, 10696.251262411557, 10740.785184296426, 10821.080208182393, 10854.991826512121, 10563.52464139131, 10659.94670026645, 10661.147108231167, 10810.51352689115, 10947.945260273966, 10150.746231344276, 10394.58421663125, 10799.082078023455, 10834.837477438003, 10891.67324980252, 7826.178251283761, 7917.129115797373, 8056.234657707509, 8127.2279133482225, 8155.918440815516, 9727.464989425649, 10228.846567301645, 10390.480475976323, 10404.895951040393, 10556.049955504042], "value": 9044.227110377722, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1248.4132457744856, 1430.0918916488033, 1449.4781878523734, 1594.1789978161248, 1778.8043315235323, 6541.345865413462, 7832.1776213497615, 8039.758807235778, 8056.194380561941, 8063.556504392271, 7747.1090824555195, 7914.960425197866, 7953.284204421601, 7963.163867793871, 7973.720919767809, 1932.7970563090885, 2193.8573992690503, 2196.593630178418, 2224.8998795054263, 2267.5804976079394, 2296.2881506732965, 2323.024329781496, 2323.465602911331, 2323.8605683659034, 2324.976750232501, 2194.9122035118576, 2233.553289342138, 2236.2508559632543, 2237.552489502098, 2238.742544607375, 1827.8903265804029, 2193.9122435102577, 2259.559385919746, 2262.6379779235244, 2266.172846910882, 2167.1656412281227, 2195.2865318771305, 2200.9119635214574, 2201.8458707890454, 2202.933911982643, 8021.598920053974, 8130.105688374274, 8160.877586836202, 8186.631601577943, 8192.139825318374, 4607.792649330788, 4800.495947925452, 4800.831970881002, 4831.154547954129, 4835.661503694742, 2911.796174267802, 2935.427591619635, 2991.3568582754597, 2993.4462124507036, 2997.4454725875567, 935.6818681648205, 966.7341481092685, 980.632262901412, 983.8475036369302, 1001.0740065439439, 11390.25963312382, 11397.202195846294, 11426.828597571042, 11429.428528573539, 11436.19946603738, 4312.611864932172, 4414.668899832525, 4455.732656040648, 4458.420405347349, 4485.708428952173, 8579.571021449028, 8603.354748393895, 8677.479351238946, 8679.0, 8683.348748843862, 4020.1557672888434, 4675.368825208621, 4676.95323046772, 4687.086018226481, 4706.882327941828, 4289.7640629765665, 4367.388565600819, 4375.868723938287, 4398.604125628709, 4415.403920470695, 3505.211327451354, 3571.982140089283, 3623.7463377563845, 3650.5619325681087, 3690.538682664667, 1074.248026381536, 1076.7684947736275, 1084.9620263290747, 1100.1254003067581, 1106.3583121789343, 832.4173078844833, 839.7438781171801, 846.9745907622781, 876.6055275126218, 908.3006085314403, 5249.973750131225, 5291.920621190685, 5327.147656374961, 5377.220303056035, 5464.043792336325, 407.8083300848596, 408.46083170215627, 414.94813148356457, 417.4531363913223, 425.32585851425216, 3510.3856825055514, 3537.7523573349617, 3543.539339885798, 3574.195805943642, 3600.117971097098, 9804.068613481708, 10235.078842904175, 10261.486925653688, 10270.435126068138, 10280.742981425374, 9243.352965292364, 10131.797364052678, 10220.897791021995, 10222.795544089226, 10224.539895704711, 7435.25647435263, 7509.549427034286, 7519.1728909818785, 7519.661615227218, 7588.8482230356185, 5371.704556249288, 5690.430956904442, 5697.4302569742695, 5864.912026319694, 5881.676507792113, 9302.441853488812, 9348.252139828934, 9475.47884866339, 9508.762280943032, 9688.951555242178, 9461.148496635336, 9681.37071090377, 9684.46735429558, 9769.902300977183, 9804.411735295906, 6228.190335256388, 6890.0, 6900.689468974008, 7153.856922861618, 7249.963750181215, 7737.419693522896, 7738.883916741366, 7757.650905709143, 7795.337396321376, 7818.100918394457, 6888.586684798928, 7037.0, 7105.431565474853, 7106.786796396116, 7183.138023437221, 6844.178698556205, 6902.033715279765, 6906.585604863724, 6907.378335949788, 7055.541389809646, 6349.015902535114, 6368.23581170244, 6368.554201205871, 6548.410643042149, 6550.115734375799, 4650.162970665313, 4677.555632214934, 4713.835015774432, 4775.498572649822, 4797.712137271775, 4768.189407800613, 4807.543283388072, 4823.493533178966, 4863.076015557032, 4909.631777616764], "value": 4160.154183721754, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.16745624096154, 315.48260852202384, 320.1563879178365, 322.1832654221549, 324.2396580019853, 5075.467075957026, 5105.08108540463, 5114.6675466094675, 5134.229865520174, 5144.8971020579565, 5009.323741294924, 5015.814957501985, 5033.144365457872, 5054.317667114948, 5073.74631268436, 3740.700743940485, 3813.694904407641, 3951.940720889189, 3984.183242435294, 3987.6012398760035, 3976.582458841823, 3976.840926362942, 3990.7805070721097, 3993.4608827808165, 4000.7599544027307, 3747.7376583639157, 3944.7830369329677, 3948.466956960817, 3948.9802550987206, 3961.623645753649, 3866.574676785551, 3962.0689138052535, 3964.5638979712207, 3978.8607398741196, 3982.6216509431847, 3515.1739341254784, 3522.806245656488, 3523.154442933703, 3526.188976535386, 3531.3290474809705, 4840.975795121002, 4860.586850117745, 4871.488493708181, 4872.3909511311085, 4881.243407271843, 4197.041086034338, 4422.292433210703, 4462.4645042594775, 4492.707973981681, 4523.36672865799, 5228.947710522884, 5250.7112108834, 5262.105841787002, 5267.947320526784, 5276.393214780311, 3710.461983012448, 3710.647488488616, 3714.294284086015, 3723.1622884850963, 3752.0, 5307.52232299095, 5539.972300138474, 5544.667319960815, 5593.580481463907, 5629.5097039835155, 3808.6000969898314, 3823.7323387362617, 3840.8847734568008, 3841.750286231386, 3850.114473671071, 3892.0, 3903.2388684206876, 3904.1455308728696, 3908.355121404993, 3910.1788624389196, 4183.748975061506, 4449.377087207794, 4478.283474644041, 4492.707973981681, 4494.348319493721, 5344.839654810284, 5351.5718742501285, 5354.9196762048605, 5357.624966252403, 5361.533694500496, 1325.4168166006925, 1351.445907178072, 1352.749741297863, 1358.280111540885, 1361.2309045389322, 841.9705310314109, 891.6166048599035, 903.5301643145527, 903.9864402033975, 915.8305713443034, 4627.190241707688, 4627.8611641650805, 4627.930581041287, 4646.4888862225125, 4662.836800712027, 5422.376426710979, 5435.537979271806, 5443.537299329522, 5447.073997420369, 5455.672659640434, 4459.643228541709, 4637.281221410687, 4646.883827904262, 4653.046125544255, 4653.7207767534055, 2899.5215789394933, 2902.4630443367623, 2905.535114381689, 2922.240217543454, 2930.6190195274903, 5118.718470484159, 5130.307408499804, 5141.922871156861, 5147.408048074444, 5149.562287205629, 5336.17289320156, 5515.338159420815, 5518.19986102021, 5673.347565030074, 5712.6286791358425, 5213.40045894727, 5233.162693968947, 5241.895162096736, 5256.2904007959205, 5267.341582302212, 5516.806911758069, 5522.861928451821, 5530.419305972815, 5549.250851135045, 5550.111982082847, 5226.764795584284, 5406.83779486616, 5429.348478182485, 5429.886873191065, 5451.209574611738, 5196.792128314825, 5215.243789650555, 5225.712585807817, 5230.372355317386, 5235.397929238186, 3814.8474061037246, 3857.8263978121613, 3861.864834730771, 3870.845166193321, 3871.941920871133, 5349.839504814861, 5475.698836564027, 5490.3411590609385, 5497.752601133038, 5503.3395992481155, 5273.26174335601, 5280.920786188133, 5293.761780719954, 5310.256564081109, 5347.117725575236, 5160.509751573594, 5315.495027972336, 5345.599080069088, 5352.705601191972, 5355.544778693855, 4988.251762235694, 5288.894222115459, 5316.867078322918, 5326.307580014573, 5327.813526526553, 5198.792048318025, 5351.491608297206, 5364.570834333322, 5368.382635996911, 5398.217258497574, 5229.47705229474, 5233.058049551118, 5235.240890070994, 5236.240745092016, 5247.344081989751], "value": 4000.296940407361, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.2322083162699, 681.3833480699965, 688.359825362413, 703.7853454696316, 711.484173973869, 12226.266424014555, 12299.446524906378, 12404.937975310133, 12450.750984980295, 12454.875451245485, 12261.509539618404, 12289.508419663225, 12316.568920087799, 12380.257184568933, 12407.193532420386, 775.0583041604464, 791.0191362710256, 791.6279348706099, 791.7545560876147, 791.9643616037292, 641.1856941684082, 779.9610019499003, 805.2591615713528, 808.6280311056921, 808.8867558541809, 855.995720021399, 861.5132450165668, 861.5950503263456, 862.3790870573208, 863.4085651328828, 670.0786418674322, 859.3039637893295, 859.3125499600295, 859.5014891363026, 861.4960248254779, 603.294145849353, 621.4003486635419, 621.7046902721216, 621.7979156774021, 621.828997025817, 12782.872171278354, 12867.806982895265, 12919.483220671162, 12931.612051638465, 12947.158434701714, 11784.234024788448, 12579.308138052404, 12613.180143290749, 12882.935585322108, 13090.73559596642, 9706.90293097074, 9751.561179746928, 9793.118619324223, 9815.116639502408, 9967.80064398708, 3031.9545206821917, 3068.55505951638, 3075.5232938894505, 3084.737797287211, 3095.396397702449, 46013.0, 46190.30714539284, 46215.0, 46297.0, 46373.76813115913, 9655.855162172573, 9722.416655000723, 10095.0, 10248.692539223835, 10538.20963427746, 17769.555761105818, 17775.46673599794, 17950.820491795177, 18019.459416217534, 18990.905045474683, 6943.409810166192, 7001.649917504206, 7013.0, 7099.396551293198, 7237.023001894677, 3821.5987321331418, 3879.592642772525, 3879.631435013669, 4009.278329900646, 4046.393041043867, 2835.2344866885824, 2912.28648981001, 2933.8826446941885, 2938.8383638899636, 2941.6470023596876, 514.4444000479473, 514.5471984653556, 523.1707743227028, 526.5708447615182, 530.8115618955293, 564.3622706341807, 624.0670198053939, 635.8713283920985, 636.7612145445459, 654.1398061549048, 7234.204237533867, 7643.273888980538, 7661.42539309554, 7908.4068694846965, 7929.246721561558, 622.2968046107869, 635.4598591197538, 645.8094862015716, 647.8024202618246, 652.2629428745487, 3892.2993861104706, 3925.803709814498, 3958.88123356294, 3975.3847987722497, 4073.368627862686, 50047.0, 50278.74860625673, 50625.49374506281, 50802.23796643053, 51071.74464127656, 45869.0, 46064.53935460669, 46131.30803037957, 46182.538174617825, 46363.0, 41349.379759303636, 41909.371359429635, 42086.78956605258, 42512.362314565304, 42576.57423425726, 7555.886661700189, 7629.198934112061, 7652.373012120201, 7807.9219207809465, 7855.764327070197, 28582.0, 28584.57123143196, 28880.0, 29300.267493312836, 29302.560461592668, 34753.30493390169, 35738.8213058933, 36785.26429471449, 37072.44391334078, 38002.0, 10500.212484063879, 10954.726131846768, 10970.177236707119, 11019.944900275448, 11077.723056923642, 11248.94375528117, 11311.377874216669, 11543.653690389301, 11887.0, 11939.0, 11027.22809403334, 11107.666769996913, 11520.423978801195, 11529.365884876077, 11559.30644161353, 11178.441077945907, 11219.831702524305, 11225.158113141384, 11724.179307448738, 11745.412729363668, 11405.087592992375, 11408.372539510407, 11712.765744685228, 11724.179307448398, 11976.101792365782, 9542.904570954479, 9627.614895404386, 9642.566084526074, 9726.659566915125, 9749.805003900025, 9828.705138845846, 9854.359466634645, 9884.406935583887, 9920.355176913477, 9979.151772099453], "value": 5969.574816722031, "unit": "score"}], "name": "dromaeo_css", "value": 6340.806043879233, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 107.0, 113.0, 115.0, 114.0, 103.0, 115.0, 113.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 131.0, 157.0, 196.0, 133.0, 162.0, 153.0, 132.0, 193.0, 128.0], "value": 155.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 161.0, 162.0, 165.0, 163.0, 163.0, 161.0, 161.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 124.0, 103.0, 75.0, 74.0, 76.0, 126.0, 100.0, 73.0], "value": 90.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 154.0, 94.0, 94.0, 94.0, 137.0, 93.0, 92.0, 143.0], "value": 109.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 118.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 147.0, 145.0, 147.0, 146.0, 145.0, 145.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 65.0, 64.0, 63.0, 64.0, 85.0, 63.0, 64.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 65.0, 65.0, 66.0, 66.0, 64.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 77.0, 77.0, 81.0, 81.0, 78.0, 78.0, 80.0, 79.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 132.0, 134.0, 141.0, 133.0, 132.0, 134.0, 166.0, 139.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 170.0, 171.0, 181.0, 183.0, 182.0, 174.0, 172.0, 172.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 71.0, 72.0, 71.0, 73.0, 72.0, 71.0, 72.0, 71.0], "value": 72.0, "unit": "score"}], "name": "kraken", "value": 1579.0, "alertThreshold": 2.0}]} 14:52:01 INFO - Return code: 0 14:52:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:52:02 ERROR - # TBPL SUCCESS # 14:52:02 INFO - Running post-action listener: _resource_record_post_action 14:52:02 INFO - Running post-run listener: _resource_record_post_run 14:52:03 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 517115904; Read time: 12; Write time: 405928 14:52:03 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233873408; Read time: 0; Write time: 252028 14:52:03 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283242496; Read time: 12; Write time: 153900 14:52:03 INFO - Running post-run listener: _upload_blobber_files 14:52:03 INFO - Blob upload gear active. 14:52:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:52:03 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 14:52:03 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:52:03 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:52:03 INFO - (blobuploader) - INFO - Open directory for files ... 14:52:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:52:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:52:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:04 INFO - (blobuploader) - INFO - Done attempting. 14:52:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:52:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:52:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:05 INFO - (blobuploader) - INFO - Done attempting. 14:52:05 INFO - (blobuploader) - INFO - Iteration through files over. 14:52:05 INFO - Return code: 0 14:52:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:52:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:52:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d7c7c6d327799304cd8af4b869a6068aa9fd409b5536a9d01a551e880fd9eda0340c3c82ed293997a5a5fab473488c1a4f16bb88f554645f2fe8cd21b65481bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/26f3faf96e060e960c2bd8031922f1a5cac3e8d2c402920146f32c217367604c9bbb66ec65fdc9802935f55ecd2d494ad7435dabe338a2f59757b21f5ae42c87"} 14:52:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:52:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:52:05 INFO - Contents: 14:52:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d7c7c6d327799304cd8af4b869a6068aa9fd409b5536a9d01a551e880fd9eda0340c3c82ed293997a5a5fab473488c1a4f16bb88f554645f2fe8cd21b65481bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/26f3faf96e060e960c2bd8031922f1a5cac3e8d2c402920146f32c217367604c9bbb66ec65fdc9802935f55ecd2d494ad7435dabe338a2f59757b21f5ae42c87"} 14:52:05 INFO - Running post-run listener: copy_logs_to_upload_dir 14:52:05 INFO - Copying logs to upload dir... 14:52:05 INFO - mkdir: /builds/slave/test/build/upload/logs 14:52:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.234079 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-15 14:52:05.039089) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 14:52:05.042455) ========= 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=db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d7c7c6d327799304cd8af4b869a6068aa9fd409b5536a9d01a551e880fd9eda0340c3c82ed293997a5a5fab473488c1a4f16bb88f554645f2fe8cd21b65481bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/26f3faf96e060e960c2bd8031922f1a5cac3e8d2c402920146f32c217367604c9bbb66ec65fdc9802935f55ecd2d494ad7435dabe338a2f59757b21f5ae42c87"} build_url:https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011245 build_url: 'https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d7c7c6d327799304cd8af4b869a6068aa9fd409b5536a9d01a551e880fd9eda0340c3c82ed293997a5a5fab473488c1a4f16bb88f554645f2fe8cd21b65481bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/26f3faf96e060e960c2bd8031922f1a5cac3e8d2c402920146f32c217367604c9bbb66ec65fdc9802935f55ecd2d494ad7435dabe338a2f59757b21f5ae42c87"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 14:52:05.066857) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 14:52:05.067199) ========= 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=db0483c52d987ecb441a263b000001ad-1460752512.540546-693409171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 14:52:05.148728) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 14:52:05.149049) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 14:52:05.149353) ========= ========= Total master_lag: 0.18 =========