builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1462020632.76 results: success (0) buildid: 20160430031536 builduid: d5efdbc96c00466680fa5be674687721 revision: 49d3cd645f038fdf64f52d65414f98c59dff148b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-30 05:50:32.762255) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-30 05:50:32.762821) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-30 05:50:32.763489) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-30 05:50:32.800322) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 05:50:32.800609) ========= 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=00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-30 05:50:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 60.8M=0s 2016-04-30 05:50:33 (60.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124014 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 05:50:32.945004) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 05:50:32.945590) ========= 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=00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018802 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 05:50:33.030633) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 05:50:33.030971) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 49d3cd645f038fdf64f52d65414f98c59dff148b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 49d3cd645f038fdf64f52d65414f98c59dff148b --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=00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-30 05:50:33,240 truncating revision to first 12 chars 2016-04-30 05:50:33,240 Setting DEBUG logging. 2016-04-30 05:50:33,241 attempt 1/10 2016-04-30 05:50:33,241 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/49d3cd645f03?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-30 05:50:33,472 unpacking tar archive at: mozilla-beta-49d3cd645f03/testing/mozharness/ program finished with exit code 0 elapsedTime=0.493047 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 05:50:33.540354) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-30 05:50:33.540717) ========= script_repo_revision: 49d3cd645f038fdf64f52d65414f98c59dff148b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-30 05:50:33.541177) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-30 05:50:33.541511) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-30 05:50:33.552460) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-04-30 05:50:33.552884) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:50:33 INFO - MultiFileLogger online at 20160430 05:50:33 in /builds/slave/test 05:50:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:50:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:50:33 INFO - {'append_to_log': False, 05:50:33 INFO - 'base_work_dir': '/builds/slave/test', 05:50:33 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:50:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:50:33 INFO - 'branch': 'Mozilla-Beta', 05:50:33 INFO - 'buildbot_json_path': 'buildprops.json', 05:50:33 INFO - 'config_files': ('talos/linux_config.py',), 05:50:33 INFO - 'default_actions': ('clobber', 05:50:33 INFO - 'read-buildbot-config', 05:50:33 INFO - 'download-and-extract', 05:50:33 INFO - 'populate-webroot', 05:50:33 INFO - 'create-virtualenv', 05:50:33 INFO - 'install', 05:50:33 INFO - 'run-tests'), 05:50:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:50:33 INFO - 'download_minidump_stackwalk': True, 05:50:33 INFO - 'download_symbols': 'ondemand', 05:50:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:50:33 INFO - 'tooltool.py': '/tools/tooltool.py', 05:50:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:50:33 INFO - '/tools/misc-python/virtualenv.py')}, 05:50:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:50:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:50:33 INFO - 'installer_path': 'installer.exe', 05:50:33 INFO - 'log_level': 'info', 05:50:33 INFO - 'log_name': 'talos', 05:50:33 INFO - 'log_to_console': True, 05:50:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:50:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:50:33 INFO - 'opt_config_files': (), 05:50:33 INFO - 'pip_index': False, 05:50:33 INFO - 'sps_profile': False, 05:50:33 INFO - 'sps_profile_interval': 0, 05:50:33 INFO - 'suite': 'dromaeojs', 05:50:33 INFO - 'system_bits': '32', 05:50:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:50:33 INFO - 'title': 'talos-linux64-ix-016', 05:50:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:50:33 INFO - 'use_talos_json': True, 05:50:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:50:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:50:33 INFO - 'work_dir': 'build'} 05:50:33 INFO - ##### 05:50:33 INFO - ##### Running clobber step. 05:50:33 INFO - ##### 05:50:33 INFO - Running pre-action listener: _resource_record_pre_action 05:50:33 INFO - Running main action method: clobber 05:50:33 INFO - rmtree: /builds/slave/test/build 05:50:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:50:34 INFO - Running post-action listener: _resource_record_post_action 05:50:34 INFO - ##### 05:50:34 INFO - ##### Running read-buildbot-config step. 05:50:34 INFO - ##### 05:50:34 INFO - Running pre-action listener: _resource_record_pre_action 05:50:34 INFO - Running main action method: read_buildbot_config 05:50:34 INFO - Using buildbot properties: 05:50:34 INFO - { 05:50:34 INFO - "project": "", 05:50:34 INFO - "product": "firefox", 05:50:34 INFO - "script_repo_revision": "production", 05:50:34 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 05:50:34 INFO - "repository": "", 05:50:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 05:50:34 INFO - "buildid": "20160430031536", 05:50:34 INFO - "pgo_build": "True", 05:50:34 INFO - "basedir": "/builds/slave/test", 05:50:34 INFO - "buildnumber": 58, 05:50:34 INFO - "slavename": "talos-linux64-ix-016", 05:50:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:50:34 INFO - "platform": "ubuntu64_hw", 05:50:34 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:50:34 INFO - "branch": "mozilla-beta", 05:50:34 INFO - "repo_path": "releases/mozilla-beta", 05:50:34 INFO - "revision": "49d3cd645f038fdf64f52d65414f98c59dff148b", 05:50:34 INFO - "stage_platform": "linux64-pgo", 05:50:34 INFO - "builduid": "d5efdbc96c00466680fa5be674687721", 05:50:34 INFO - "slavebuilddir": "test" 05:50:34 INFO - } 05:50:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 05:50:34 INFO - Running post-action listener: _resource_record_post_action 05:50:34 INFO - ##### 05:50:34 INFO - ##### Running download-and-extract step. 05:50:34 INFO - ##### 05:50:34 INFO - Running pre-action listener: _resource_record_pre_action 05:50:34 INFO - Running main action method: download_and_extract 05:50:34 INFO - mkdir: /builds/slave/test/build/tests 05:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:34 INFO - https://queue.taskcluster.net/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:50:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 05:50:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 05:50:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 05:50:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:50:37 INFO - Downloaded 1412 bytes. 05:50:37 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 05:50:37 INFO - Using the following test package requirements: 05:50:37 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 05:50:37 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 05:50:37 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:50:37 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 05:50:37 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 05:50:37 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 05:50:37 INFO - u'jsshell-linux-x86_64.zip'], 05:50:37 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 05:50:37 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:50:37 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 05:50:37 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 05:50:37 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 05:50:37 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 05:50:37 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 05:50:37 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 05:50:37 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:50:37 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 05:50:37 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 05:50:37 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:50:37 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:50:37 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')]} 05:50:37 INFO - https://queue.taskcluster.net/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:50:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 05:50:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 05:50:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 05:50:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:50:38 INFO - Downloaded 23362846 bytes. 05:50:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:50:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:50:39 INFO - Return code: 0 05:50:39 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:50:39 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')]} 05:50:39 INFO - https://queue.taskcluster.net/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:50:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 05:50:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 05:50:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 05:50:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:50:41 INFO - Downloaded 23362846 bytes. 05:50:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:50:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:50:43 INFO - Return code: 0 05:50:43 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')]} 05:50:43 INFO - https://queue.taskcluster.net/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:50:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 05:50:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 05:50:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 05:50:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:50:44 INFO - Downloaded 10845194 bytes. 05:50:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:50:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:50:44 INFO - Return code: 0 05:50:44 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')]} 05:50:44 INFO - https://queue.taskcluster.net/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:50:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 05:50:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 05:50:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 05:50:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:50:45 INFO - Downloaded 53794942 bytes. 05:50:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 05:50:45 INFO - mkdir: /builds/slave/test/properties 05:50:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:50:45 INFO - Writing to file /builds/slave/test/properties/build_url 05:50:45 INFO - Contents: 05:50:45 INFO - build_url:https://queue.taskcluster.net/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 05:50:46 INFO - Running post-action listener: _resource_record_post_action 05:50:46 INFO - Running post-action listener: set_extra_try_arguments 05:50:46 INFO - ##### 05:50:46 INFO - ##### Running populate-webroot step. 05:50:46 INFO - ##### 05:50:46 INFO - Running pre-action listener: _resource_record_pre_action 05:50:46 INFO - Running main action method: populate_webroot 05:50:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:50:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:50:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:50:46 INFO - '--tppagecycles', 05:50:46 INFO - '7'], 05:50:46 INFO - 'tests': ['tsvgm']}}, 05:50:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:50:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:50:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:50:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:50:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:50:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:50:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:50:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:46 INFO - 'talos_options': ['--e10s'], 05:50:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:50:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:46 INFO - 'tests': ['damp', 'tps']}, 05:50:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:46 INFO - 'talos_options': ['--e10s'], 05:50:46 INFO - 'tests': ['damp', 'tps']}, 05:50:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:50:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:50:46 INFO - 'other': {'tests': ['a11yr', 05:50:46 INFO - 'ts_paint', 05:50:46 INFO - 'tpaint', 05:50:46 INFO - 'sessionrestore', 05:50:46 INFO - 'sessionrestore_no_auto_restore', 05:50:46 INFO - 'tabpaint']}, 05:50:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:50:46 INFO - 'tests': ['a11yr', 05:50:46 INFO - 'ts_paint', 05:50:46 INFO - 'tpaint', 05:50:46 INFO - 'sessionrestore', 05:50:46 INFO - 'sessionrestore_no_auto_restore', 05:50:46 INFO - 'tabpaint']}, 05:50:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:50:46 INFO - 'tests': ['a11yr', 05:50:46 INFO - 'ts_paint', 05:50:46 INFO - 'tpaint', 05:50:46 INFO - 'sessionrestore', 05:50:46 INFO - 'sessionrestore_no_auto_restore', 05:50:46 INFO - 'tabpaint']}, 05:50:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:50:46 INFO - 'tests': ['a11yr', 05:50:46 INFO - 'ts_paint', 05:50:46 INFO - 'tpaint', 05:50:46 INFO - 'sessionrestore', 05:50:46 INFO - 'sessionrestore_no_auto_restore', 05:50:46 INFO - 'tabpaint']}, 05:50:46 INFO - 'other_l64': {'tests': ['a11yr', 05:50:46 INFO - 'ts_paint', 05:50:46 INFO - 'tpaint', 05:50:46 INFO - 'sessionrestore', 05:50:46 INFO - 'sessionrestore_no_auto_restore', 05:50:46 INFO - 'tabpaint']}, 05:50:46 INFO - 'other_nol64': {'tests': ['a11yr', 05:50:46 INFO - 'ts_paint', 05:50:46 INFO - 'tpaint', 05:50:46 INFO - 'sessionrestore', 05:50:46 INFO - 'sessionrestore_no_auto_restore', 05:50:46 INFO - 'tabpaint']}, 05:50:46 INFO - 'svgr': {'tests': ['tsvgx', 05:50:46 INFO - 'tsvgr_opacity', 05:50:46 INFO - 'tart', 05:50:46 INFO - 'tscrollx', 05:50:46 INFO - 'cart']}, 05:50:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:50:46 INFO - 'tests': ['tsvgx', 05:50:46 INFO - 'tsvgr_opacity', 05:50:46 INFO - 'tart', 05:50:46 INFO - 'tscrollx', 05:50:46 INFO - 'cart']}, 05:50:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:46 INFO - 'tests': ['tp5o']}, 05:50:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:46 INFO - 'talos_options': ['--e10s'], 05:50:46 INFO - 'tests': ['tp5o']}, 05:50:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:46 INFO - 'talos_options': ['--xperf_path', 05:50:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:50:46 INFO - 'tests': ['tp5n']}, 05:50:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:46 INFO - 'talos_options': ['--e10s', 05:50:46 INFO - '--xperf_path', 05:50:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:50:46 INFO - 'tests': ['tp5n']}}, 05:50:46 INFO - 'talos.zip': {'path': '', 05:50:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:50:46 INFO - Running post-action listener: _resource_record_post_action 05:50:46 INFO - ##### 05:50:46 INFO - ##### Running create-virtualenv step. 05:50:46 INFO - ##### 05:50:46 INFO - Running pre-action listener: _resource_record_pre_action 05:50:46 INFO - Running main action method: create_virtualenv 05:50:46 INFO - Creating virtualenv /builds/slave/test/build/venv 05:50:46 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 05:50:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:50:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:50:46 INFO - Using real prefix '/usr' 05:50:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:50:46 INFO - Installing distribute.............................................................................................................................................................................................done. 05:50:48 INFO - Installing pip.................done. 05:50:48 INFO - Return code: 0 05:50:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:50:48 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')]} 05:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:48 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')]} 05:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:48 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 0x7ff5beae5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde4160>, '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 0xde5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde54f0>, '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': '00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250', '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 05:50:48 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 05:50:48 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 05:50:48 INFO - Using env: {'DISPLAY': ':0', 05:50:48 INFO - 'HOME': '/home/cltbld', 05:50:48 INFO - 'LANG': 'en_US.UTF-8', 05:50:48 INFO - 'LANGUAGE': 'en_US:en', 05:50:48 INFO - 'LOGNAME': 'cltbld', 05:50:48 INFO - 'MAIL': '/var/mail/cltbld', 05:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:48 INFO - 'MOZ_NO_REMOTE': '1', 05:50:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:48 INFO - 'NO_EM_RESTART': '1', 05:50:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:48 INFO - 'PWD': '/builds/slave/test', 05:50:48 INFO - 'SHELL': '/bin/bash', 05:50:48 INFO - 'SHLVL': '1', 05:50:48 INFO - 'TERM': 'linux', 05:50:48 INFO - 'TMOUT': '86400', 05:50:48 INFO - 'USER': 'cltbld', 05:50:48 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250', 05:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:48 INFO - '_': '/tools/buildbot/bin/python'} 05:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:49 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 05:50:49 INFO - Cleaning up... 05:50:49 INFO - Return code: 0 05:50:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:50:49 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')]} 05:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:49 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')]} 05:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:49 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 0x7ff5beae5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde4160>, '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 0xde5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde54f0>, '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': '00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250', '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 05:50:49 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 05:50:49 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 05:50:49 INFO - Using env: {'DISPLAY': ':0', 05:50:49 INFO - 'HOME': '/home/cltbld', 05:50:49 INFO - 'LANG': 'en_US.UTF-8', 05:50:49 INFO - 'LANGUAGE': 'en_US:en', 05:50:49 INFO - 'LOGNAME': 'cltbld', 05:50:49 INFO - 'MAIL': '/var/mail/cltbld', 05:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:49 INFO - 'MOZ_NO_REMOTE': '1', 05:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:49 INFO - 'NO_EM_RESTART': '1', 05:50:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:49 INFO - 'PWD': '/builds/slave/test', 05:50:49 INFO - 'SHELL': '/bin/bash', 05:50:49 INFO - 'SHLVL': '1', 05:50:49 INFO - 'TERM': 'linux', 05:50:49 INFO - 'TMOUT': '86400', 05:50:49 INFO - 'USER': 'cltbld', 05:50:49 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250', 05:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:49 INFO - '_': '/tools/buildbot/bin/python'} 05:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:49 INFO - Downloading/unpacking psutil>=0.7.1 05:50: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 05:50: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 05:50: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 05:50: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 05:50: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 05:50: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 05:50:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:50:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:50:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:50:51 INFO - Installing collected packages: psutil 05:50:51 INFO - Running setup.py install for psutil 05:50:51 INFO - building 'psutil._psutil_linux' extension 05:50:51 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 05:50:51 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 05:50:51 INFO - building 'psutil._psutil_posix' extension 05:50:51 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 05:50:51 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 05:50:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:50:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:50:51 INFO - Successfully installed psutil 05:50:51 INFO - Cleaning up... 05:50:51 INFO - Return code: 0 05:50:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:51 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 0x7ff5beae5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde4160>, '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 0xde5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde54f0>, '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': '00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250', '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 05:50:51 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 05:50:51 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 05:50:51 INFO - Using env: {'DISPLAY': ':0', 05:50:51 INFO - 'HOME': '/home/cltbld', 05:50:51 INFO - 'LANG': 'en_US.UTF-8', 05:50:51 INFO - 'LANGUAGE': 'en_US:en', 05:50:51 INFO - 'LOGNAME': 'cltbld', 05:50:51 INFO - 'MAIL': '/var/mail/cltbld', 05:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:51 INFO - 'MOZ_NO_REMOTE': '1', 05:50:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:51 INFO - 'NO_EM_RESTART': '1', 05:50:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:51 INFO - 'PWD': '/builds/slave/test', 05:50:51 INFO - 'SHELL': '/bin/bash', 05:50:51 INFO - 'SHLVL': '1', 05:50:51 INFO - 'TERM': 'linux', 05:50:51 INFO - 'TMOUT': '86400', 05:50:51 INFO - 'USER': 'cltbld', 05:50:51 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250', 05:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:51 INFO - '_': '/tools/buildbot/bin/python'} 05:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:50:52 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 05:50:52 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 05:50:52 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 05:50:52 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 05:50:52 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 05:50:52 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 05:50:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:50:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:50:54 INFO - Installing collected packages: mozsystemmonitor 05:50:54 INFO - Running setup.py install for mozsystemmonitor 05:50:54 INFO - Successfully installed mozsystemmonitor 05:50:54 INFO - Cleaning up... 05:50:54 INFO - Return code: 0 05:50:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:50: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')]} 05:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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')]} 05:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:54 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 0x7ff5beae5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde4160>, '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 0xde5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde54f0>, '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': '00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250', '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 05:50:54 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 05:50:54 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 05:50:54 INFO - Using env: {'DISPLAY': ':0', 05:50:54 INFO - 'HOME': '/home/cltbld', 05:50:54 INFO - 'LANG': 'en_US.UTF-8', 05:50:54 INFO - 'LANGUAGE': 'en_US:en', 05:50:54 INFO - 'LOGNAME': 'cltbld', 05:50:54 INFO - 'MAIL': '/var/mail/cltbld', 05:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:54 INFO - 'MOZ_NO_REMOTE': '1', 05:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:54 INFO - 'NO_EM_RESTART': '1', 05:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:54 INFO - 'PWD': '/builds/slave/test', 05:50:54 INFO - 'SHELL': '/bin/bash', 05:50:54 INFO - 'SHLVL': '1', 05:50:54 INFO - 'TERM': 'linux', 05:50:54 INFO - 'TMOUT': '86400', 05:50:54 INFO - 'USER': 'cltbld', 05:50:54 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250', 05:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:54 INFO - '_': '/tools/buildbot/bin/python'} 05:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:54 INFO - Downloading/unpacking blobuploader==1.2.4 05:50:54 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 05:50:54 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 05:50:54 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 05:50:54 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 05:50:54 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 05:50:54 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 05:50:56 INFO - Downloading blobuploader-1.2.4.tar.gz 05:50:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:50:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:50:56 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 05:50:56 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 05:50:56 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 05:50:56 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 05:50:56 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 05:50:56 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 05:50:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:50:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:50:56 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 05:50:56 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 05:50:56 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 05:50:56 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 05:50:56 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 05:50:56 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 05:50:56 INFO - Downloading docopt-0.6.1.tar.gz 05:50:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:50:57 INFO - Installing collected packages: blobuploader, requests, docopt 05:50:57 INFO - Running setup.py install for blobuploader 05:50:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:50:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:50:57 INFO - Running setup.py install for requests 05:50:57 INFO - Running setup.py install for docopt 05:50:57 INFO - Successfully installed blobuploader requests docopt 05:50:57 INFO - Cleaning up... 05:50:57 INFO - Return code: 0 05:50:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:50: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')]} 05:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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')]} 05:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:57 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 0x7ff5beae5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde4160>, '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 0xde5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde54f0>, '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': '00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250', '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 05:50:57 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 05:50:57 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 05:50:57 INFO - Using env: {'DISPLAY': ':0', 05:50:57 INFO - 'HOME': '/home/cltbld', 05:50:57 INFO - 'LANG': 'en_US.UTF-8', 05:50:57 INFO - 'LANGUAGE': 'en_US:en', 05:50:57 INFO - 'LOGNAME': 'cltbld', 05:50:57 INFO - 'MAIL': '/var/mail/cltbld', 05:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:57 INFO - 'MOZ_NO_REMOTE': '1', 05:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:57 INFO - 'NO_EM_RESTART': '1', 05:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:57 INFO - 'PWD': '/builds/slave/test', 05:50:57 INFO - 'SHELL': '/bin/bash', 05:50:57 INFO - 'SHLVL': '1', 05:50:57 INFO - 'TERM': 'linux', 05:50:57 INFO - 'TMOUT': '86400', 05:50:57 INFO - 'USER': 'cltbld', 05:50:57 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250', 05:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:57 INFO - '_': '/tools/buildbot/bin/python'} 05:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:50:57 INFO - Running setup.py (path:/tmp/pip-4zrsps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:50:57 INFO - Running setup.py (path:/tmp/pip-c6tkie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:50:58 INFO - Running setup.py (path:/tmp/pip-RmpZ35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:50:58 INFO - Running setup.py (path:/tmp/pip-74g572-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:50:58 INFO - Running setup.py (path:/tmp/pip-Rc6NhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:50:58 INFO - Running setup.py (path:/tmp/pip-WJl9fO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:50:58 INFO - Running setup.py (path:/tmp/pip-MtCi7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:50:58 INFO - Running setup.py (path:/tmp/pip-57qwr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:50:58 INFO - Running setup.py (path:/tmp/pip-o70Mz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:50:58 INFO - Running setup.py (path:/tmp/pip-MbyzAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:50:58 INFO - Running setup.py (path:/tmp/pip-IKxeZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:50:58 INFO - Running setup.py (path:/tmp/pip-NvGiVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:50:58 INFO - Running setup.py (path:/tmp/pip-PQwjZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:50:58 INFO - Running setup.py (path:/tmp/pip-b1XFX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:58 INFO - Running setup.py (path:/tmp/pip-s_emvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:50:58 INFO - Running setup.py (path:/tmp/pip-ryzU8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:50:59 INFO - Running setup.py (path:/tmp/pip-MJyp6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:50:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:50:59 INFO - Running setup.py install for manifestparser 05:50:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:50:59 INFO - Running setup.py install for mozcrash 05:50:59 INFO - Running setup.py install for mozdebug 05:50:59 INFO - Running setup.py install for mozdevice 05:50:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:50:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:50:59 INFO - Running setup.py install for mozfile 05:50:59 INFO - Running setup.py install for mozhttpd 05:50:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:50:59 INFO - Running setup.py install for mozinfo 05:50:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:50:59 INFO - Running setup.py install for mozInstall 05:50:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:50:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:50:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:50:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:50:59 INFO - Running setup.py install for mozleak 05:51:00 INFO - Running setup.py install for mozlog 05:51:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:51:00 INFO - Running setup.py install for moznetwork 05:51:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:51:00 INFO - Running setup.py install for mozprocess 05:51:00 INFO - Running setup.py install for mozprofile 05:51:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:51:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:51:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:51:00 INFO - Running setup.py install for mozrunner 05:51:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:51:00 INFO - Running setup.py install for mozscreenshot 05:51:00 INFO - Running setup.py install for moztest 05:51:00 INFO - Running setup.py install for mozversion 05:51:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:51:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:51:00 INFO - Cleaning up... 05:51:00 INFO - Return code: 0 05:51:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51: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')]} 05:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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')]} 05:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:00 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 0x7ff5beae5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde4160>, '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 0xde5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde54f0>, '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': '00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250', '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 05:51:00 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 05:51:00 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 05:51:00 INFO - Using env: {'DISPLAY': ':0', 05:51:00 INFO - 'HOME': '/home/cltbld', 05:51:00 INFO - 'LANG': 'en_US.UTF-8', 05:51:00 INFO - 'LANGUAGE': 'en_US:en', 05:51:00 INFO - 'LOGNAME': 'cltbld', 05:51:00 INFO - 'MAIL': '/var/mail/cltbld', 05:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:00 INFO - 'MOZ_NO_REMOTE': '1', 05:51:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:00 INFO - 'NO_EM_RESTART': '1', 05:51:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:00 INFO - 'PWD': '/builds/slave/test', 05:51:00 INFO - 'SHELL': '/bin/bash', 05:51:00 INFO - 'SHLVL': '1', 05:51:00 INFO - 'TERM': 'linux', 05:51:00 INFO - 'TMOUT': '86400', 05:51:00 INFO - 'USER': 'cltbld', 05:51:00 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250', 05:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:00 INFO - '_': '/tools/buildbot/bin/python'} 05:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:51:01 INFO - Running setup.py (path:/tmp/pip-BjuznV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:51:01 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)) 05:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:51:01 INFO - Running setup.py (path:/tmp/pip-6Mgbfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:51:01 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)) 05:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:51:01 INFO - Running setup.py (path:/tmp/pip-fsLupa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:51:01 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)) 05:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:51:01 INFO - Running setup.py (path:/tmp/pip-bun1o3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:51:01 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)) 05:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:51:01 INFO - Running setup.py (path:/tmp/pip-PnjChZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:51:01 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)) 05:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:51:01 INFO - Running setup.py (path:/tmp/pip-ep_xV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:51:01 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)) 05:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:51:01 INFO - Running setup.py (path:/tmp/pip-KhbKoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:51:01 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)) 05:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:51:01 INFO - Running setup.py (path:/tmp/pip-H1SLV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:51:01 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)) 05:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:51:01 INFO - Running setup.py (path:/tmp/pip-lIvWlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:51:01 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)) 05:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:51:01 INFO - Running setup.py (path:/tmp/pip-TUj5Ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:51:01 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)) 05:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:51:01 INFO - Running setup.py (path:/tmp/pip-MUaz7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:51:01 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)) 05:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:51:01 INFO - Running setup.py (path:/tmp/pip-_ecKdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:51:01 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)) 05:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:51:01 INFO - Running setup.py (path:/tmp/pip-WSsY9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:51:02 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)) 05:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:51:02 INFO - Running setup.py (path:/tmp/pip-VDr9bP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:51:02 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)) 05:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:02 INFO - Running setup.py (path:/tmp/pip-FSnDQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:02 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)) 05:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:51:02 INFO - Running setup.py (path:/tmp/pip-Q89rnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:51:02 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)) 05:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:51:02 INFO - Running setup.py (path:/tmp/pip-iwr35a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:51:02 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)) 05:51:02 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)) 05:51:02 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)) 05:51:02 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)) 05:51:02 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)) 05:51:02 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)) 05:51:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51:04 INFO - Downloading blessings-1.6.tar.gz 05:51:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:51:04 INFO - Installing collected packages: blessings 05:51:04 INFO - Running setup.py install for blessings 05:51:04 INFO - Successfully installed blessings 05:51:04 INFO - Cleaning up... 05:51:04 INFO - Return code: 0 05:51:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:51:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:51:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:51:04 INFO - Reading from file tmpfile_stdout 05:51:04 INFO - Current package versions: 05:51:04 INFO - argparse == 1.2.1 05:51:04 INFO - blessings == 1.6 05:51:04 INFO - blobuploader == 1.2.4 05:51:04 INFO - docopt == 0.6.1 05:51:04 INFO - manifestparser == 1.1 05:51:04 INFO - mozInstall == 1.12 05:51:04 INFO - mozcrash == 0.17 05:51:04 INFO - mozdebug == 0.1 05:51:04 INFO - mozdevice == 0.48 05:51:04 INFO - mozfile == 1.2 05:51:04 INFO - mozhttpd == 0.7 05:51:04 INFO - mozinfo == 0.9 05:51:04 INFO - mozleak == 0.1 05:51:04 INFO - mozlog == 3.1 05:51:04 INFO - moznetwork == 0.27 05:51:04 INFO - mozprocess == 0.22 05:51:04 INFO - mozprofile == 0.28 05:51:04 INFO - mozrunner == 6.11 05:51:04 INFO - mozscreenshot == 0.1 05:51:04 INFO - mozsystemmonitor == 0.0 05:51:04 INFO - moztest == 0.7 05:51:04 INFO - mozversion == 1.4 05:51:04 INFO - psutil == 3.1.1 05:51:04 INFO - requests == 1.2.3 05:51:04 INFO - wsgiref == 0.1.2 05:51:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51:04 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')]} 05:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:04 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')]} 05:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:04 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 0x7ff5beae5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde4160>, '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 0xde5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde54f0>, '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': '00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250', '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 05:51:04 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 05:51:04 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 05:51:04 INFO - Using env: {'DISPLAY': ':0', 05:51:04 INFO - 'HOME': '/home/cltbld', 05:51:04 INFO - 'LANG': 'en_US.UTF-8', 05:51:04 INFO - 'LANGUAGE': 'en_US:en', 05:51:04 INFO - 'LOGNAME': 'cltbld', 05:51:04 INFO - 'MAIL': '/var/mail/cltbld', 05:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:04 INFO - 'MOZ_NO_REMOTE': '1', 05:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:04 INFO - 'NO_EM_RESTART': '1', 05:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:04 INFO - 'PWD': '/builds/slave/test', 05:51:04 INFO - 'SHELL': '/bin/bash', 05:51:04 INFO - 'SHLVL': '1', 05:51:04 INFO - 'TERM': 'linux', 05:51:04 INFO - 'TMOUT': '86400', 05:51:04 INFO - 'USER': 'cltbld', 05:51:04 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250', 05:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:04 INFO - '_': '/tools/buildbot/bin/python'} 05:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:04 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)) 05:51:04 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)) 05:51:04 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)) 05:51:04 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)) 05:51:04 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)) 05:51:04 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)) 05:51:04 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)) 05:51:04 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)) 05:51:04 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)) 05:51:04 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)) 05:51:04 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)) 05:51:04 INFO - Cleaning up... 05:51:04 INFO - Return code: 0 05:51:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:51:04 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')]} 05:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:04 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')]} 05:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:04 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 0x7ff5beae5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde4160>, '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 0xde5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde54f0>, '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': '00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250', '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 05:51:04 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 05:51:04 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 05:51:04 INFO - Using env: {'DISPLAY': ':0', 05:51:04 INFO - 'HOME': '/home/cltbld', 05:51:04 INFO - 'LANG': 'en_US.UTF-8', 05:51:04 INFO - 'LANGUAGE': 'en_US:en', 05:51:04 INFO - 'LOGNAME': 'cltbld', 05:51:04 INFO - 'MAIL': '/var/mail/cltbld', 05:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:04 INFO - 'MOZ_NO_REMOTE': '1', 05:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:04 INFO - 'NO_EM_RESTART': '1', 05:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:04 INFO - 'PWD': '/builds/slave/test', 05:51:04 INFO - 'SHELL': '/bin/bash', 05:51:04 INFO - 'SHLVL': '1', 05:51:04 INFO - 'TERM': 'linux', 05:51:04 INFO - 'TMOUT': '86400', 05:51:04 INFO - 'USER': 'cltbld', 05:51:04 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250', 05:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:04 INFO - '_': '/tools/buildbot/bin/python'} 05:51:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:05 INFO - Downloading/unpacking jsonschema 05:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:05 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 05:51:05 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 05:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:51:06 INFO - Downloading/unpacking functools32 (from jsonschema) 05:51:06 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 05:51:06 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 05:51:06 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 05:51:06 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 05:51:06 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 05:51:06 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 05:51:07 INFO - Downloading functools32-3.2.3-2.tar.gz 05:51:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:51:07 INFO - warning: no files found matching '*.txt' 05:51:07 INFO - no previously-included directories found matching 'build' 05:51:07 INFO - no previously-included directories found matching 'dist' 05:51:07 INFO - no previously-included directories found matching '.git*' 05:51:07 INFO - Installing collected packages: jsonschema, functools32 05:51:07 INFO - Running setup.py install for functools32 05:51:07 INFO - warning: no files found matching '*.txt' 05:51:07 INFO - no previously-included directories found matching 'build' 05:51:07 INFO - no previously-included directories found matching 'dist' 05:51:07 INFO - no previously-included directories found matching '.git*' 05:51:07 INFO - Successfully installed jsonschema functools32 05:51:07 INFO - Cleaning up... 05:51:07 INFO - Return code: 0 05:51:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:51:07 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')]} 05:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:07 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')]} 05:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7ff5beae5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde4160>, '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 0xde5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde54f0>, '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': '00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250', '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 05:51:07 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 05:51:07 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 05:51:07 INFO - Using env: {'DISPLAY': ':0', 05:51:07 INFO - 'HOME': '/home/cltbld', 05:51:07 INFO - 'LANG': 'en_US.UTF-8', 05:51:07 INFO - 'LANGUAGE': 'en_US:en', 05:51:07 INFO - 'LOGNAME': 'cltbld', 05:51:07 INFO - 'MAIL': '/var/mail/cltbld', 05:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:07 INFO - 'MOZ_NO_REMOTE': '1', 05:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:07 INFO - 'NO_EM_RESTART': '1', 05:51:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:07 INFO - 'PWD': '/builds/slave/test', 05:51:07 INFO - 'SHELL': '/bin/bash', 05:51:07 INFO - 'SHLVL': '1', 05:51:07 INFO - 'TERM': 'linux', 05:51:07 INFO - 'TMOUT': '86400', 05:51:07 INFO - 'USER': 'cltbld', 05:51:07 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250', 05:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:07 INFO - '_': '/tools/buildbot/bin/python'} 05:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:07 INFO - Downloading/unpacking flake8 05:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:07 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 05:51:07 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 05:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:51:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:09 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 05:51:09 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 05:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:51:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:09 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 05:51:09 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 05:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:09 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 05:51:09 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 05:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:51:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:51:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:51:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:51:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:51:10 INFO - no previously-included directories found matching 'docs/_build' 05:51:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:51:10 INFO - Running setup.py install for pep8 05:51:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:51:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:51:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:51:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:51:10 INFO - no previously-included directories found matching 'docs/_build' 05:51:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:51:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:51:10 INFO - Cleaning up... 05:51:10 INFO - Return code: 0 05:51:10 INFO - Running post-action listener: _resource_record_post_action 05:51:10 INFO - Running post-action listener: _start_resource_monitoring 05:51:10 INFO - Starting resource monitoring. 05:51:10 INFO - ##### 05:51:10 INFO - ##### Running install step. 05:51:10 INFO - ##### 05:51:10 INFO - Running pre-action listener: _resource_record_pre_action 05:51:10 INFO - Running main action method: install 05:51:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:51:10 INFO - Reading from file tmpfile_stdout 05:51:10 INFO - Detecting whether we're running mozinstall >=1.0... 05:51:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:51:10 INFO - Reading from file tmpfile_stdout 05:51:10 INFO - Output received: 05:51:10 INFO - Usage: mozinstall [options] installer 05:51:10 INFO - Options: 05:51:10 INFO - -h, --help show this help message and exit 05:51:10 INFO - -d DEST, --destination=DEST 05:51:10 INFO - Directory to install application into. [default: 05:51:10 INFO - "/builds/slave/test"] 05:51:10 INFO - --app=APP Application being installed. [default: firefox] 05:51:10 INFO - mkdir: /builds/slave/test/build/application 05:51:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:51:23 INFO - Reading from file tmpfile_stdout 05:51:23 INFO - Output received: 05:51:23 INFO - /builds/slave/test/build/application/firefox/firefox 05:51:23 INFO - Running post-action listener: _resource_record_post_action 05:51:23 INFO - ##### 05:51:23 INFO - ##### Running run-tests step. 05:51:23 INFO - ##### 05:51:23 INFO - Running pre-action listener: _resource_record_pre_action 05:51:23 INFO - Running main action method: run_tests 05:51:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:51:23 INFO - Python 2.7.3 05:51:23 INFO - Return code: 0 05:51:23 INFO - grabbing minidump binary from tooltool 05:51: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')]} 05:51:23 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 0xde4160>, '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 0xde5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde54f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:51:23 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 05:51:23 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 05:51:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:51:23 INFO - Return code: 0 05:51:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:51:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:51:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:51:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:51:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:51:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:51:24 INFO - Return code: 0 05:51:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 05:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 05:51:24 INFO - Using env: {'DISPLAY': ':0', 05:51:24 INFO - 'HOME': '/home/cltbld', 05:51:24 INFO - 'LANG': 'en_US.UTF-8', 05:51:24 INFO - 'LANGUAGE': 'en_US:en', 05:51:24 INFO - 'LOGNAME': 'cltbld', 05:51:24 INFO - 'MAIL': '/var/mail/cltbld', 05:51:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:51:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:24 INFO - 'MOZ_NO_REMOTE': '1', 05:51:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:51:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:24 INFO - 'NO_EM_RESTART': '1', 05:51:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:24 INFO - 'PWD': '/builds/slave/test', 05:51:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:51:24 INFO - 'SHELL': '/bin/bash', 05:51:24 INFO - 'SHLVL': '1', 05:51:24 INFO - 'TERM': 'linux', 05:51:24 INFO - 'TMOUT': '86400', 05:51:24 INFO - 'USER': 'cltbld', 05:51:24 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250', 05:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:24 INFO - '_': '/tools/buildbot/bin/python'} 05:51:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 05:51:24 INFO - mozversion application_buildid: 20160430031536 05:51:24 INFO - mozversion application_changeset: 49d3cd645f038fdf64f52d65414f98c59dff148b 05:51:24 INFO - mozversion application_display_name: Firefox 05:51:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:51:24 INFO - mozversion application_name: Firefox 05:51:24 INFO - mozversion application_remotingname: firefox 05:51:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:51:24 INFO - mozversion application_vendor: Mozilla 05:51:24 INFO - mozversion application_version: 47.0 05:51:24 INFO - mozversion platform_buildid: 20160430031536 05:51:24 INFO - mozversion platform_changeset: 49d3cd645f038fdf64f52d65414f98c59dff148b 05:51:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:51:24 INFO - mozversion platform_version: 47.0 05:51:24 INFO - using testdate: 1462020684 05:51:24 INFO - actual date: 1462020684 05:51:24 INFO - starting webserver on 'localhost:49111' 05:51:24 INFO - SUITE-START | Running 2 tests 05:51:24 INFO - TEST-START | dromaeo_css 05:51:24 INFO - operating with platform_type : linux_ 05:51:24 INFO - Initialising browser for dromaeo_css test... 05:51:24 INFO - TEST-INFO | started process 25759 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzg3HBJ/profile http://localhost:49111/getInfo.html) 05:51:29 INFO - PROCESS | 25759 | __metrics Screen width/height:1600/1200 05:51:29 INFO - PROCESS | 25759 | colorDepth:24 05:51:29 INFO - PROCESS | 25759 | Browser inner width/height: 1024/697 05:51:29 INFO - PROCESS | 25759 | __metrics 05:51:30 INFO - PROCESS | 25759 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:51:30 INFO - TEST-INFO | 25759: exit 0 05:51:30 INFO - Browser initialized. 05:51:30 INFO - Running cycle 1/1 for dromaeo_css test... 05:51:30 INFO - TEST-INFO | started process 25849 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzg3HBJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:51:42 INFO - PROCESS | 25849 | RSS: Main: 139079680 05:51:42 INFO - PROCESS | 25849 | 05:52:34 INFO - PROCESS | 25849 | 1462020754226 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] 05:54:41 INFO - PROCESS | 25849 | Cycle 1(1): loaded http://localhost:49111/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49111/tests/dromaeo/cssquery-ext.html) 05:54:42 INFO - PROCESS | 25849 | RSS: Main: 287416320 05:54:42 INFO - PROCESS | 25849 | 05:57:44 INFO - PROCESS | 25849 | Cycle 1(1): loaded http://localhost:49111/tests/dromaeo/cssquery-ext.html (next: http://localhost:49111/tests/dromaeo/cssquery-jquery.html) 05:57:45 INFO - PROCESS | 25849 | RSS: Main: 229597184 05:57:45 INFO - PROCESS | 25849 | 06:00:47 INFO - PROCESS | 25849 | Cycle 1(1): loaded http://localhost:49111/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49111/tests/dromaeo/cssquery-mootools.html) 06:00:47 INFO - PROCESS | 25849 | RSS: Main: 231915520 06:00:47 INFO - PROCESS | 25849 | 06:03:49 INFO - PROCESS | 25849 | Cycle 1(1): loaded http://localhost:49111/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49111/tests/dromaeo/cssquery-prototype.html) 06:03:50 INFO - PROCESS | 25849 | RSS: Main: 203612160 06:03:50 INFO - PROCESS | 25849 | 06:06:52 INFO - PROCESS | 25849 | Cycle 1(1): loaded http://localhost:49111/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49111/tests/dromaeo/cssquery-yui.html) 06:06:53 INFO - PROCESS | 25849 | RSS: Main: 211464192 06:06:53 INFO - PROCESS | 25849 | 06:09:55 INFO - PROCESS | 25849 | Cycle 1(1): loaded http://localhost:49111/tests/dromaeo/cssquery-yui.html (next: http://localhost:49111/tests/dromaeo/cssquery-dojo.html) 06:09:55 INFO - PROCESS | 25849 | RSS: Main: 255598592 06:09:55 INFO - PROCESS | 25849 | 06:09:55 INFO - PROCESS | 25849 | __start_tp_report 06:09:55 INFO - PROCESS | 25849 | _x_x_mozilla_page_load 06:09:55 INFO - PROCESS | 25849 | _x_x_mozilla_page_load_details 06:09:55 INFO - PROCESS | 25849 | |i|pagename|runs| 06:09:55 INFO - PROCESS | 25849 | |0;dojo.html;3288.753343499238;3353.2287573858;3370.3259348130364;3378.020374091512;3397.626261111278;5436.782528698852;5448.727563621823;5461.0716178249695;5468.7812487500505;5497.47773961473;5453.263809385731;5526.889462210764;5529.253550770644;5529.640573362729;5536.363318218406;4852.17513022787;4992.251162325662;5017.498250174972;5074.644774865761;5094.337736094302;4944.678595891256;5028.220625803006;5035;5036.093503169428;5039.924401133986;5074.84775456735;5081.390233172025;5095.796168153288;5137.255098010786;5140.820071297505;4976.825811096594;5098.566621837148;5110.412302585213;5112.97443512782;5128.102582048145;4831.903361932742;4957.529034741694;4966.130927087781;5002.1496345621335;5009.624278179152;5282.7622756976025;5331.546818520431;5351.411344752074;5374.140137578008;5393.1370980643305;5956.106584012389;5976.940230597682;5982.6410415374785;5983.820485385445;5987.311459182206;5853.2976042875125;5905.763769449217;5967.880642387171;5972.761089556412;6000.75996960121;5502.80740174092;5513.862153446196;5515.145152501329;5517.310336207974;5548.389677135512;5980.43185897339;5980.700964951735;5982.940170598238;5983.222181116427;5990.64056156632;5654.46282603152;5761.971190144022;5770.682612456271;5790.565707571949;5872.823815285548;5978.671173085435;5982.252218472691;5990.64056156632;5992.041273396236;5997.580169388189;5930.851728706817;5948.196993405922;5949.196858424144;5950.642961422329;5953.404659534012;5710.2862142232225;5885.058390657474;5925.496332811673;6001.699915004232;6009.1587177795145;4500.167469018242;4506.459224893034;4531;4532.048269863366;4551.362809206714;4052.3516237401873;4076.673866090765;4080.8571699990357;4083.571225021389;4105.3020986432375;5554.91667624986;5651.745671444794;5686.260786097863;5704.201411802351;5724.370319264877;5943.465088142088;5951.880962380728;6013.819585412444;6015.0676645120075;6025.427584379565;5401.351837779492;5637.8590535236945;5666.235058267163;5667.234923285386;5669.092945128842;5152.793888244503;5177.016366890279;5182.1190397631735;5204.609654275944;5218.399884013387;6155.569110162246;6196.411340922605;6207.751689932352;6214.316425193225;6221.751129954841;5798.304203495608;5966.582339236385;5989.820305390758;6018.9398106020135;6019.789307374221;5981.999999999826;5998.070299103646;5999.820005399845;6001.819945401645;6034.517238620988;5680.517156041617;5717.571182161271;5725.885482290248;5732.598718089694;5739.483446489836;5811.360750317377;5813.970930145322;5837.270341207349;5863.824085277449;5914.083317085859;5695.686737229492;5702.34423041339;5702.971485142713;5706.914396283976;5736.569757268305;5668.773249069991;5712.371639119777;5721.256236689203;5732.226149469935;5743.052396354555;5499.532539734168;5649;5672.659640421588;5739.713014349182;5763.135529670415;5693.8861222774485;5753.079507278815;5754.165645981393;5793.565482588739;5793.91309130355;5620.437956204511;5621.831345059655;5661.235733175969;5665.0935850265405;5682.516986056066 06:09:55 INFO - PROCESS | 25849 | |1;ext.html;547.5646860745709;565.053535328325;568.2016766443147;572.9914051289231;577.9971749015457;30466;39203.41194882076;39368.015799605026;39376.60623393765;39430;43322;43829.34255986155;43835;43892.78053609728;43913;8952.328575356842;9167.404118732295;9173.95413022934;9184.173424391804;9186.54067296636;8948.06045365237;9052.8642070369;9082.046385129566;9095.454272743624;9311.72064838056;9285.117913798213;9361.4383137012;9377.76555586109;9387.389819661701;9389.577469013877;9258.861117083248;9353;9362.01698821624;9372.90627093734;9375.062493750638;9187.540622968825;9309.34834561581;9328.113829186217;9331.76670583234;9335.626574936994;42978.57021429777;43079.35380969288;43165.13669726588;43195;43232;3326.8170250636203;3471.600765911902;3569.37535931211;4000.939750965996;4103.4870641169855;32310.35379292401;32843;33024.834875825465;33151.6684833151;33773.15567110817;4289.978550107261;4291.763952982585;4306.2344438780265;4314.115606300732;4319.740815551077;288134;288409;289307;290767;291709;59909.10136347958;60924.390756091874;60968.39031609716;61059.08411373833;61110.69444652748;66527.33472665308;72677.2732272681;73852;73863.26136738672;73953.26046739463;16950.745738813683;17076.060816654954;17125.48623541296;17142.057186854592;17168.828311716723;12816.35918204086;12816.935915320364;12819.230846149261;12823;12829.486820527074;22009.66985495219;22340.21809236669;22346.329610111723;22368.55262894733;22442.32673019812;7775;8265.752027439186;8295.377846661524;8305.584720763938;8389.32885369169;1002.5607814832723;1018.3635227982511;1069.3744159666526;1106.6956586938657;1133.9603113890973;29147.85426072856;29225.02984480709;29611.703882960894;29706.702932970828;29799.957001504845;1102.2890235797865;1142.1205671632963;1187.0562902492538;1188.3285943441927;1240.4851986425713;15602.765958510632;15621.921890390702;15783.210839457981;15881.570658640778;16114;327561;332008;332372;332448;332574;56094.71952640292;57092.429075708715;57130.14304785432;57185.71407142938;57204.14193787097;1315.4014923209916;1447.6887469193964;1471.065873170523;1475.948341808053;1589.9903561238696;27195.80882755777;27255;28981.56527652129;29106.417871642025;29659.40681186321;44658.77670611626;45002.099958;45365;45388.54611453843;45401.54598454105;193919;195745;195819;195922;196612;30043;33992;35258.8237058813;35313.64686353206;35339.46990795089;40140.59859401369;40379.798101009306;40481.39277910775;41588;41693.79153104215;34867.4769878447;34975.65024349724;35177.82411087928;35202.823985879906;35719.64280357163;36817.07957301089;36937.26125477422;37016;37278.44082338713;37501.06247343838;36400.81799590985;37270.25459490849;37942.051448714;37959.81020094882;37973.620263797005;36584.81707591445;37524.249515010095;37857.81071094627;38312.616873830906;38360.2327953445;25025;25603.35991600225;26355.341116472242;26386.472270554867;26721.19836404911 06:09:55 INFO - PROCESS | 25849 | |2;jquery.html;363.3931334671099;380.6821304210985;383.4765545031033;387.5136703437186;388.5609261534466;17879.64240715185;18261.178246978885;19060.809391906078;19080.522986925334;19107.331243406483;17517.299308027694;17801;18007.90996045021;18043.90978045111;18066.27734890606;5592.832215033545;5795.942040579604;5830.941690583082;5833.620814647034;5844.064949608063;4191.077962848184;5730.226419433386;5985.760569577212;6395.424411802936;6445.065465507499;6386.552941294111;6388.009858471944;6390.904136437957;6408.903866442007;6415.390537898916;6044.153818465418;6410.935890641127;6430.453411460008;6457.321981191978;6482.254540727829;3880.553736320331;5525.585581081395;5713.6000479966415;5723.284589426322;5738.45484678959;21759.347219583437;22082;22760.20339288117;23490.882545587163;23517.412064698347;2338.263447014185;2445.3275349279093;2498.7876030537427;2775.722427757228;2822.294426393381;13284.867151328557;13908.652283692887;14228.857711422961;14777.778333325008;15519.456819011393;1989.9502512437305;2012.5471768852037;2023.817856392917;2025.6961455781604;2039.0620314655275;71693.64153179253;71747.64126179335;74066;75019.6249018757;76682;15247.390104395921;15807.604809879615;15867.603309917344;15939.840601594067;16114.274857631435;27505.86247068752;27596;27876.86061569679;27962.161135165978;27996.160115196577;9122.908770912338;9465.952670236606;9501.762455938519;9529.952350238205;9587.808243835085;8030.959845200737;8042.798930026796;8054.758357249292;8133.552654604054;8169;7926.841463170705;7936.761897143095;7982.082060562993;7983.880241796378;8149.470284431493;2524.7475252474605;2862.0343703674107;3007.9699203008126;3062.1732132324146;3252.577164968539;897.8159477307137;973.2992245583168;994.2443742755557;1039.5737747523478;1055.4694546741139;16382.180890955404;16587.336506539843;16739.16304184786;16852.410165644145;17290.22194001273;943.6508491858057;971.3928794503436;971.9076687714655;1007.4459047523833;1022.8874823769379;9689.467079310705;9902.702918912444;9988.151007164328;10017;10083.596656133672;441153;441286;455675;458020;459487;75939.62030189813;76301.61849190718;76471;77378;77562;957.7653474898555;1041.390786389955;1089.477051015501;1095.3044816541553;1096.6709987003867;15000.924995374953;15167.544973650809;15248.237588120328;15354.92322538425;15545.68908621844;31597.21006974752;31830.204244894063;32748.18129546685;32990.67009329876;33916.32167356688;38726.80636596799;40695.796521017204;40849.38725919054;41157.1768564633;41770.37344439897;7729.729459468892;7811.687532498637;7948.483348582324;7986.241307075818;8125.146859579659;9248.583813728534;11814.940925295663;11818.113641477095;12005.519779208735;12102.939485302517;9955.153811925778;10043.347182433119;10507;10554.630587929385;10579.36523808574;10659.840102398626;10780.472729810128;10951.56193752241;11146.275492092987;11211.60759373418;10598.629047983284;10887.18346124028;10907.18196135309;10933.83599246028;11127;8109.918900810916;8135.633896474555;8168.83662326762;8234.752957411287;8315.584220788814;8229.382796290422;10381.53283102247;10766.461676915966;10935.28920620157;10954.123670106213 06:09:55 INFO - PROCESS | 25849 | |3;mootools.html;1434.4190602805854;1575.2438829361909;1577.140458450145;1782.9019403932778;1939.3309308288635;7230.421566274698;7777.18339574345;7833.177516360785;7901.723439679612;7924.92075079249;7928.9207107928905;8091.514509129456;8107.554084525349;8110.513369197837;8128.349732021439;2418.407490164912;2441.5361081394567;2441.6215486599604;2442.804575633954;2446.4862378900452;2364.8226383021256;2390.4501964548163;2403.3030421177837;2407.9277621671376;2422.2369953464604;2421.092090466075;2433.476802487474;2447.2535876557645;2458.791002764767;2486;2391.485830546432;2398.8800559972105;2401.4476670365825;2421.4430680943306;2460.2865169100937;2370.9644355334685;2438.5488684593406;2449.1060762821444;2451.6935383077116;2452.6811514503;8095.554744489051;8271.793205169859;8272.793180170484;8279.958600207021;8284.171582841727;5045.84862454127;5143.3570803649545;5165.845024649229;5168.664036837594;5170.948290517084;3197.2965947491516;3226.177324782189;3243.3837570861697;3255.674432556725;3280.2947366316116;1048.7797562511882;1944.0182707732504;1956.0806420982115;1964.361582485698;1976.328048463515;10795.406252656101;10833.079188269006;10888.61889833852;10899.182561307935;10902.563897444094;4198.895027624334;4295.871123866226;4339.067100573328;4402.119576084732;4408.933865992013;8843.513606751561;8878.556072196365;8888.200061994452;8890.59992300348;8901;4945.381827271591;4959.628027897922;4982.576480999083;4983.626228032912;4983.8006479741125;4039.8384064637085;4101.958980410217;4487.080148569536;4585.266357382803;4619.5611416915335;3614.710823134143;3641.599424063351;3664.285464334429;3672.926541469156;3694.6120657330594;1090.650991682654;1108.800415925125;1115.1747706696985;1116.8380584815156;1122.2480937771713;1109.7336639206533;1127.0082327551702;1139.2993309114834;1379.3034517568565;1470.3677418709844;7815.53106813593;7868.606569671608;7902.051753789582;8021.478603890729;8022.959885200653;511.3582454020181;516.2179298362983;518.8884389856199;519;524.8530411484791;5867.237259156283;5899.233099697012;5909.113632955091;5919.1713160157615;5972.611780234271;9834.508274586386;10087.848682269772;10479.476026198812;10492.108170805413;10493.947530262452;9758.268129890144;9940.602375905028;9949.452780097019;9976.201903847676;10336.17310615149;7899;8034.678612855537;8132.390070744717;8152.225538573707;8167.060788009336;7504;7511.06111736033;7573.2805383488485;7586.810329741801;7668.846623067396;8830.293576513992;8876.156765107304;9076.909230907606;9174.357794954556;9190.816183676423;9024.052474490347;9060.90939090627;9072.501012444114;9303.72088837336;9311.674091406769;5990.610610310316;6471.546991710535;6641.03704962768;6650.501212409185;6737.764178253738;7643.350315223268;7665.6933722650465;7677.155512893689;7706.537607743553;7708.884366734392;6408.969962009441;6541;6564.146660934048;6643.734250630114;6648.800535983928;6422.2614399344675;6573.04690819838;6577.14497115372;6615;6671.766488172891;6926.995585640155;6939.167299924042;6995.055667484824;7006.684699188447;7008.123984501937;6412.967935160481;6567.638779867153;6636.303188165173;6637.734490620321;6643.7674681385915;6632.602043877383;6648.90026649591;6651.567648102858;6652.567583107082;6672.165979252593 06:09:55 INFO - PROCESS | 25849 | |4;prototype.html;343.67866045247695;349.82683571632043;351.69051234913275;352.7231123567998;356.52760092876935;5942.76228950842;5946.197263369444;5963.254593175853;5994.340622531518;6027.126066720323;5895.882082358361;5905.763769449228;5914.438128377808;5917.142014407908;5934.851628709284;4423.3807266982485;4519.8418055368065;4625.213713668668;4647.60495357895;4668.76656167192;4615.3077038444335;4642.373279607244;4654.790534425959;4657.604103651193;4659.254519276917;4606.884827879297;4615.46922103959;4618.237990731542;4620.145273124466;4629.23617603095;4400.229959757045;4507.616852567536;4607.677462577587;4608.723476591415;4615.307703844416;4057.472528571296;4063.7358571692744;4064.5325787534516;4076.286649836267;4085.6527195188446;5659.547236221092;5660.971695141539;5661.377248502661;5663.745131469093;5671.489565939044;5380;5380.300560927094;5385;5387.919181212285;5407.945920540784;6306.432421082125;6315.210598675166;6316.557840951135;6317.399847014526;6317.715702793385;4385.144896745136;4489.6408287336935;4495.57292057254;4504.09918016398;4546.704464209815;6451.258105317902;6586.143801305848;6588.341165883421;6599.901001484982;6611.008348747679;4670.53294670537;4672.229082201398;4673.883152921137;4680.438347398334;4683.555062269147;4721.480637129913;4734.526547345238;4734.928976065362;4739.526047395302;4741.596964258077;5387.003404370204;5389.865253368619;5392.029434701792;5401.270828438189;5405.729713514309;6235.625862448268;6334.619922804646;6350.682465876687;6360.6501642409185;6366.936330636634;1634.967300654004;1654.4953789094202;1655.793025871766;1663.3014134063721;1671.2479384277124;1074.5809134437575;1101.3997371432588;1117.7596816684452;1121.8036843552345;1145.169751929844;6046.3651316612;6125.663088530174;6130.264368275746;6134.171886795315;6139.539534534928;6454.967725161344;6496.123023391876;6522.315156908551;6522.673866306665;6527.314631963671;6113.694315284307;6122.26532816056;6122.693865306717;6128;6132.724027418777;3477.965220347764;3517.9472307915403;3525.206828463575;3526.7883926964464;3528.9647103528637;6656.400923916871;6744.325567443217;6874;6887.345702158287;6888.931110688929;6762.1209242799105;6777.932220677829;6788.321167883271;6798.52410331272;6805.727770889109;6834.829129271709;6841.110655614738;6843.520953533205;6862;6864.1419822523185;6631.535792494672;6637.6349300788925;6640.335966403321;6640.402363787282;6656.167979002625;6293.37066293367;6496.837579060561;6507.707153178024;6508.544401891822;6548.508861835477;6845.520813543004;6856.862862742817;6862.107925969592;6868.210155832143;6879.380855723009;4445.444319460067;4455.309427038814;4470.083632855322;4471.8658440246845;4475.820967161408;6658.667066646552;6658.933410665832;6659.067730517634;6688.598684078971;6745.3591908768585;6245.125682404558;6446.484281257582;6456.418922297016;6459.031145328238;6463.870722585428;6437.25971513282;6460.870782584416;6468.579542329733;6468.579542329733;6482.092507048923;6330.746770129143;6340.4927605792345;6341.175647165839;6343.55595108338;6347.111404403479;6507.154069971063;6510.869782604226;6510.9674451629335;6515;6524;6071.635701857903;6193.659348735863;6245.344238854855;6350.460210881942;6355.7457701693265 06:09:55 INFO - PROCESS | 25849 | |5;yui.html;655.5149189599698;666.5300962821211;688.4698781937908;745.985080298394;898.8247291778101;14510.63723406914;14735;14737.557873263819;14740.705185896275;14754.926225368872;13199.142055766393;13324.200547967128;13335.666608334797;13336.533221337231;13478.663033424169;930.7580029192408;944.3908678902104;949.952502374882;951.8286708392486;951.9904800952006;922.7600823785797;925.1904583489446;925.6528801699362;928.9256859451261;929.251952178496;974.3471873844542;978.9510524473783;979.4221409368471;980.3284749946309;981.3474039763548;973.2943615878502;974.9366291191085;975.65851951817;975.9072888075622;976.6874600127926;721.0734206544618;721.4661150748461;721.6752461392342;722.0324764815173;722.0468980945102;13670.17978921258;13764.793528097087;13785.310734463237;13804.447822087104;13835;12037.217580857216;12238.510459581606;12322.81515777264;12378.133530652858;12526.74946501065;10445.112165465944;10472.937702277433;10492.580296788119;10666.253362264644;10746.247762656618;3666.1201311685004;3806.695464362844;3841.5582208046153;3866.381378979378;3881.262560113569;48226.27660585094;50248.74875625598;51517;51619;51810.7409462954;10490.16078713701;10696;10875.728106797393;11045.226834121535;11063.446827658585;18685.626287474446;18689.25242990265;18702.719459207852;18712.064396780108;18713.251469941322;8160.551169685724;8175.509469431853;8342.708005219789;8345.956755405574;8486.490810551386;3776.4335349697767;3873.86441474547;3940.2710498557285;4318.265894797892;4465.977670111629;3400.353932752769;3401.727861771052;3412.812295323731;3414.402479566066;3415.316936612687;593.1636392686291;601.6871226962043;602.1178972804862;610.6793933185024;612.5773216480615;605.4671888737882;634.3624657219465;692.4737199728243;694.7498900395854;699.3670727991176;7981.561014144278;8031.277185053374;8151.429399942066;8324.66701331952;8368.623411946477;672.582998540898;675.1729131813587;686.2245662401455;697.9755708550176;698.8148140742708;3954.8022598870516;3979.7612143271494;4007.959920400817;4010.57888921659;4019.7990100495444;56654.43345566574;57437.71281143651;57525.71237143871;58352.40502298577;58459.123113152484;49763.25355119676;51671.22493162606;52180.47819521832;52206.738966304925;54110.7294463533;42555.36166957498;42594.57405425906;43148.78425607852;43186.35220471695;44099.45651902168;8330.250277475056;8332.791680208044;8424.578771061544;8543.273821724973;8674.739757807276;33530.161745956546;34204.82897585496;34317.14207144841;34410;36256;40586.39120413255;41094.79452602718;44448.33327500025;44534.77732611446;44787.55212447834;10815.56737730482;11121.165912556753;11833.171677982458;11886.702832429259;12050.397480126134;11363.715907102389;11376.203665743318;12273.570425035081;13393.531226407029;14099.224542650252;10930.289531180448;10956.34261944286;11131.888681113085;11387.601433949772;11718.121140914636;11017.724556886142;11270.887291126985;11460.312381256817;11486.483108259981;11494.252873563191;10675.733106672395;10766.192535559707;11022.779544409228;11271.04196143337;11282.887171128512;9635.614575416905;9829.85255221158;10188;10561.366318020944;11004.339739615649;9208.769780755534;9282.535873206178;9336.159745622926;9349.859752103588;9617.086376794194 06:09:55 INFO - PROCESS | 25849 | __end_tp_report 06:09:55 INFO - PROCESS | 25849 | __start_cc_report 06:09:55 INFO - PROCESS | 25849 | _x_x_mozilla_cycle_collect,1201 06:09:55 INFO - PROCESS | 25849 | __end_cc_report 06:09:55 INFO - PROCESS | 25849 | __startTimestamp1462021795559__endTimestamp 06:09:55 INFO - PROCESS | 25849 | 06:09:55 INFO - PROCESS | 25849 | ------- Summary: start ------- 06:09:55 INFO - PROCESS | 25849 | Number of tests: 6 06:09:55 INFO - PROCESS | 25849 | 06:09:55 INFO - PROCESS | 25849 | [#0] dojo.html Cycles:165 Average:5489.71 Median:5682.52 stddev:599.76 (10.6%) stddev-sans-first:576.22 06:09:55 INFO - PROCESS | 25849 | Values: 3288.8 3353.2 3370.3 3378.0 3397.6 5436.8 5448.7 5461.1 5468.8 5497.5 5453.3 5526.9 5529.3 5529.6 5536.4 4852.2 4992.3 5017.5 5074.6 5094.3 4944.7 5028.2 5035.0 5036.1 5039.9 5074.8 5081.4 5095.8 5137.3 5140.8 4976.8 5098.6 5110.4 5113.0 5128.1 4831.9 4957.5 4966.1 5002.1 5009.6 5282.8 5331.5 5351.4 5374.1 5393.1 5956.1 5976.9 5982.6 5983.8 5987.3 5853.3 5905.8 5967.9 5972.8 6000.8 5502.8 5513.9 5515.1 5517.3 5548.4 5980.4 5980.7 5982.9 5983.2 5990.6 5654.5 5762.0 5770.7 5790.6 5872.8 5978.7 5982.3 5990.6 5992.0 5997.6 5930.9 5948.2 5949.2 5950.6 5953.4 5710.3 5885.1 5925.5 6001.7 6009.2 4500.2 4506.5 4531.0 4532.0 4551.4 4052.4 4076.7 4080.9 4083.6 4105.3 5554.9 5651.7 5686.3 5704.2 5724.4 5943.5 5951.9 6013.8 6015.1 6025.4 5401.4 5637.9 5666.2 5667.2 5669.1 5152.8 5177.0 5182.1 5204.6 5218.4 6155.6 6196.4 6207.8 6214.3 6221.8 5798.3 5966.6 5989.8 6018.9 6019.8 5982.0 5998.1 5999.8 6001.8 6034.5 5680.5 5717.6 5725.9 5732.6 5739.5 5811.4 5814.0 5837.3 5863.8 5914.1 5695.7 5702.3 5703.0 5706.9 5736.6 5668.8 5712.4 5721.3 5732.2 5743.1 5499.5 5649.0 5672.7 5739.7 5763.1 5693.9 5753.1 5754.2 5793.6 5793.9 5620.4 5621.8 5661.2 5665.1 5682.5 06:09:55 INFO - PROCESS | 25849 | 06:09:55 INFO - PROCESS | 25849 | [#1] ext.html Cycles:180 Average:45840.84 Median:37389.75 stddev:72697.21 (194.4%) stddev-sans-first:72821.60 06:09:55 INFO - PROCESS | 25849 | Values: 547.6 565.1 568.2 573.0 578.0 30466.0 39203.4 39368.0 39376.6 39430.0 43322.0 43829.3 43835.0 43892.8 43913.0 8952.3 9167.4 9174.0 9184.2 9186.5 8948.1 9052.9 9082.0 9095.5 9311.7 9285.1 9361.4 9377.8 9387.4 9389.6 9258.9 9353.0 9362.0 9372.9 9375.1 9187.5 9309.3 9328.1 9331.8 9335.6 42978.6 43079.4 43165.1 43195.0 43232.0 3326.8 3471.6 3569.4 4000.9 4103.5 32310.4 32843.0 33024.8 33151.7 33773.2 4290.0 4291.8 4306.2 4314.1 4319.7 288134.0 288409.0 289307.0 290767.0 291709.0 59909.1 60924.4 60968.4 61059.1 61110.7 66527.3 72677.3 73852.0 73863.3 73953.3 16950.7 17076.1 17125.5 17142.1 17168.8 12816.4 12816.9 12819.2 12823.0 12829.5 22009.7 22340.2 22346.3 22368.6 22442.3 7775.0 8265.8 8295.4 8305.6 8389.3 1002.6 1018.4 1069.4 1106.7 1134.0 29147.9 29225.0 29611.7 29706.7 29800.0 1102.3 1142.1 1187.1 1188.3 1240.5 15602.8 15621.9 15783.2 15881.6 16114.0 327561.0 332008.0 332372.0 332448.0 332574.0 56094.7 57092.4 57130.1 57185.7 57204.1 1315.4 1447.7 1471.1 1475.9 1590.0 27195.8 27255.0 28981.6 29106.4 29659.4 44658.8 45002.1 45365.0 45388.5 45401.5 193919.0 195745.0 195819.0 195922.0 196612.0 30043.0 33992.0 35258.8 35313.6 35339.5 40140.6 40379.8 40481.4 41588.0 41693.8 34867.5 34975.7 35177.8 35202.8 35719.6 36817.1 36937.3 37016.0 37278.4 37501.1 36400.8 37270.3 37942.1 37959.8 37973.6 36584.8 37524.2 37857.8 38312.6 38360.2 25025.0 25603.4 26355.3 26386.5 26721.2 06:09:55 INFO - PROCESS | 25849 | 06:09:55 INFO - PROCESS | 25849 | [#2] jquery.html Cycles:180 Average:26948.62 Median:33453.50 stddev:73927.21 (221.0%) stddev-sans-first:74107.65 06:09:55 INFO - PROCESS | 25849 | Values: 363.4 380.7 383.5 387.5 388.6 17879.6 18261.2 19060.8 19080.5 19107.3 17517.3 17801.0 18007.9 18043.9 18066.3 5592.8 5795.9 5830.9 5833.6 5844.1 4191.1 5730.2 5985.8 6395.4 6445.1 6386.6 6388.0 6390.9 6408.9 6415.4 6044.2 6410.9 6430.5 6457.3 6482.3 3880.6 5525.6 5713.6 5723.3 5738.5 21759.3 22082.0 22760.2 23490.9 23517.4 2338.3 2445.3 2498.8 2775.7 2822.3 13284.9 13908.7 14228.9 14777.8 15519.5 1990.0 2012.5 2023.8 2025.7 2039.1 71693.6 71747.6 74066.0 75019.6 76682.0 15247.4 15807.6 15867.6 15939.8 16114.3 27505.9 27596.0 27876.9 27962.2 27996.2 9122.9 9466.0 9501.8 9530.0 9587.8 8031.0 8042.8 8054.8 8133.6 8169.0 7926.8 7936.8 7982.1 7983.9 8149.5 2524.7 2862.0 3008.0 3062.2 3252.6 897.8 973.3 994.2 1039.6 1055.5 16382.2 16587.3 16739.2 16852.4 17290.2 943.7 971.4 971.9 1007.4 1022.9 9689.5 9902.7 9988.2 10017.0 10083.6 441153.0 441286.0 455675.0 458020.0 459487.0 75939.6 76301.6 76471.0 77378.0 77562.0 957.8 1041.4 1089.5 1095.3 1096.7 15000.9 15167.5 15248.2 15354.9 15545.7 31597.2 31830.2 32748.2 32990.7 33916.3 38726.8 40695.8 40849.4 41157.2 41770.4 7729.7 7811.7 7948.5 7986.2 8125.1 9248.6 11814.9 11818.1 12005.5 12102.9 9955.2 10043.3 10507.0 10554.6 10579.4 10659.8 10780.5 10951.6 11146.3 11211.6 10598.6 10887.2 10907.2 10933.8 11127.0 8109.9 8135.6 8168.8 8234.8 8315.6 8229.4 10381.5 10766.5 10935.3 10954.1 06:09:55 INFO - PROCESS | 25849 | 06:09:55 INFO - PROCESS | 25849 | [#3] mootools.html Cycles:180 Average:5649.99 Median:5883.24 stddev:2929.23 (49.8%) stddev-sans-first:2920.31 06:09:55 INFO - PROCESS | 25849 | Values: 1434.4 1575.2 1577.1 1782.9 1939.3 7230.4 7777.2 7833.2 7901.7 7924.9 7928.9 8091.5 8107.6 8110.5 8128.3 2418.4 2441.5 2441.6 2442.8 2446.5 2364.8 2390.5 2403.3 2407.9 2422.2 2421.1 2433.5 2447.3 2458.8 2486.0 2391.5 2398.9 2401.4 2421.4 2460.3 2371.0 2438.5 2449.1 2451.7 2452.7 8095.6 8271.8 8272.8 8280.0 8284.2 5045.8 5143.4 5165.8 5168.7 5170.9 3197.3 3226.2 3243.4 3255.7 3280.3 1048.8 1944.0 1956.1 1964.4 1976.3 10795.4 10833.1 10888.6 10899.2 10902.6 4198.9 4295.9 4339.1 4402.1 4408.9 8843.5 8878.6 8888.2 8890.6 8901.0 4945.4 4959.6 4982.6 4983.6 4983.8 4039.8 4102.0 4487.1 4585.3 4619.6 3614.7 3641.6 3664.3 3672.9 3694.6 1090.7 1108.8 1115.2 1116.8 1122.2 1109.7 1127.0 1139.3 1379.3 1470.4 7815.5 7868.6 7902.1 8021.5 8023.0 511.4 516.2 518.9 519.0 524.9 5867.2 5899.2 5909.1 5919.2 5972.6 9834.5 10087.8 10479.5 10492.1 10493.9 9758.3 9940.6 9949.5 9976.2 10336.2 7899.0 8034.7 8132.4 8152.2 8167.1 7504.0 7511.1 7573.3 7586.8 7668.8 8830.3 8876.2 9076.9 9174.4 9190.8 9024.1 9060.9 9072.5 9303.7 9311.7 5990.6 6471.5 6641.0 6650.5 6737.8 7643.4 7665.7 7677.2 7706.5 7708.9 6409.0 6541.0 6564.1 6643.7 6648.8 6422.3 6573.0 6577.1 6615.0 6671.8 6927.0 6939.2 6995.1 7006.7 7008.1 6413.0 6567.6 6636.3 6637.7 6643.8 6632.6 6648.9 6651.6 6652.6 6672.2 06:09:55 INFO - PROCESS | 25849 | 06:09:55 INFO - PROCESS | 25849 | [#4] prototype.html Cycles:180 Average:5356.10 Median:6059.00 stddev:1602.57 (26.4%) stddev-sans-first:1562.28 06:09:55 INFO - PROCESS | 25849 | Values: 343.7 349.8 351.7 352.7 356.5 5942.8 5946.2 5963.3 5994.3 6027.1 5895.9 5905.8 5914.4 5917.1 5934.9 4423.4 4519.8 4625.2 4647.6 4668.8 4615.3 4642.4 4654.8 4657.6 4659.3 4606.9 4615.5 4618.2 4620.1 4629.2 4400.2 4507.6 4607.7 4608.7 4615.3 4057.5 4063.7 4064.5 4076.3 4085.7 5659.5 5661.0 5661.4 5663.7 5671.5 5380.0 5380.3 5385.0 5387.9 5407.9 6306.4 6315.2 6316.6 6317.4 6317.7 4385.1 4489.6 4495.6 4504.1 4546.7 6451.3 6586.1 6588.3 6599.9 6611.0 4670.5 4672.2 4673.9 4680.4 4683.6 4721.5 4734.5 4734.9 4739.5 4741.6 5387.0 5389.9 5392.0 5401.3 5405.7 6235.6 6334.6 6350.7 6360.7 6366.9 1635.0 1654.5 1655.8 1663.3 1671.2 1074.6 1101.4 1117.8 1121.8 1145.2 6046.4 6125.7 6130.3 6134.2 6139.5 6455.0 6496.1 6522.3 6522.7 6527.3 6113.7 6122.3 6122.7 6128.0 6132.7 3478.0 3517.9 3525.2 3526.8 3529.0 6656.4 6744.3 6874.0 6887.3 6888.9 6762.1 6777.9 6788.3 6798.5 6805.7 6834.8 6841.1 6843.5 6862.0 6864.1 6631.5 6637.6 6640.3 6640.4 6656.2 6293.4 6496.8 6507.7 6508.5 6548.5 6845.5 6856.9 6862.1 6868.2 6879.4 4445.4 4455.3 4470.1 4471.9 4475.8 6658.7 6658.9 6659.1 6688.6 6745.4 6245.1 6446.5 6456.4 6459.0 6463.9 6437.3 6460.9 6468.6 6468.6 6482.1 6330.7 6340.5 6341.2 6343.6 6347.1 6507.2 6510.9 6511.0 6515.0 6524.0 6071.6 6193.7 6245.3 6350.5 6355.7 06:09:55 INFO - PROCESS | 25849 | 06:09:55 INFO - PROCESS | 25849 | [#5] yui.html Cycles:180 Average:13888.62 Median:23733.53 stddev:15871.54 (66.9%) stddev-sans-first:15884.96 06:09:55 INFO - PROCESS | 25849 | Values: 655.5 666.5 688.5 746.0 898.8 14510.6 14735.0 14737.6 14740.7 14754.9 13199.1 13324.2 13335.7 13336.5 13478.7 930.8 944.4 950.0 951.8 952.0 922.8 925.2 925.7 928.9 929.3 974.3 979.0 979.4 980.3 981.3 973.3 974.9 975.7 975.9 976.7 721.1 721.5 721.7 722.0 722.0 13670.2 13764.8 13785.3 13804.4 13835.0 12037.2 12238.5 12322.8 12378.1 12526.7 10445.1 10472.9 10492.6 10666.3 10746.2 3666.1 3806.7 3841.6 3866.4 3881.3 48226.3 50248.7 51517.0 51619.0 51810.7 10490.2 10696.0 10875.7 11045.2 11063.4 18685.6 18689.3 18702.7 18712.1 18713.3 8160.6 8175.5 8342.7 8346.0 8486.5 3776.4 3873.9 3940.3 4318.3 4466.0 3400.4 3401.7 3412.8 3414.4 3415.3 593.2 601.7 602.1 610.7 612.6 605.5 634.4 692.5 694.7 699.4 7981.6 8031.3 8151.4 8324.7 8368.6 672.6 675.2 686.2 698.0 698.8 3954.8 3979.8 4008.0 4010.6 4019.8 56654.4 57437.7 57525.7 58352.4 58459.1 49763.3 51671.2 52180.5 52206.7 54110.7 42555.4 42594.6 43148.8 43186.4 44099.5 8330.3 8332.8 8424.6 8543.3 8674.7 33530.2 34204.8 34317.1 34410.0 36256.0 40586.4 41094.8 44448.3 44534.8 44787.6 10815.6 11121.2 11833.2 11886.7 12050.4 11363.7 11376.2 12273.6 13393.5 14099.2 10930.3 10956.3 11131.9 11387.6 11718.1 11017.7 11270.9 11460.3 11486.5 11494.3 10675.7 10766.2 11022.8 11271.0 11282.9 9635.6 9829.9 10188.0 10561.4 11004.3 9208.8 9282.5 9336.2 9349.9 9617.1 06:09:55 INFO - PROCESS | 25849 | -------- Summary: end -------- 06:09:55 INFO - PROCESS | 25849 | 06:09:56 INFO - TEST-INFO | 25849: exit 0 06:09:56 INFO - TEST-OK | dromaeo_css | took 1111431ms 06:09:56 INFO - TEST-START | kraken 06:09:56 INFO - operating with platform_type : linux_ 06:09:56 INFO - Initialising browser for kraken test... 06:09:56 INFO - TEST-INFO | started process 26046 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpij9pxw/profile http://localhost:49111/getInfo.html) 06:10:00 INFO - PROCESS | 26046 | __metrics Screen width/height:1600/1200 06:10:00 INFO - PROCESS | 26046 | colorDepth:24 06:10:00 INFO - PROCESS | 26046 | Browser inner width/height: 1024/697 06:10:00 INFO - PROCESS | 26046 | __metrics 06:10:01 INFO - PROCESS | 26046 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:10:02 INFO - TEST-INFO | 26046: exit 0 06:10:02 INFO - Browser initialized. 06:10:02 INFO - Running cycle 1/1 for kraken test... 06:10:02 INFO - TEST-INFO | started process 26136 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpij9pxw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:10:14 INFO - PROCESS | 26136 | RSS: Main: 139345920 06:10:14 INFO - PROCESS | 26136 | 06:10:16 INFO - PROCESS | 26136 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49111/tests/kraken/driver.html?testName=audio-beat-detection) 06:10:17 INFO - PROCESS | 26136 | RSS: Main: 175620096 06:10:17 INFO - PROCESS | 26136 | 06:10:19 INFO - PROCESS | 26136 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49111/tests/kraken/driver.html?testName=audio-dft) 06:10:20 INFO - PROCESS | 26136 | RSS: Main: 174104576 06:10:20 INFO - PROCESS | 26136 | 06:10:23 INFO - PROCESS | 26136 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49111/tests/kraken/driver.html?testName=audio-fft) 06:10:23 INFO - PROCESS | 26136 | RSS: Main: 169545728 06:10:23 INFO - PROCESS | 26136 | 06:10:25 INFO - PROCESS | 26136 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49111/tests/kraken/driver.html?testName=audio-oscillator) 06:10:26 INFO - PROCESS | 26136 | RSS: Main: 171118592 06:10:26 INFO - PROCESS | 26136 | 06:10:28 INFO - PROCESS | 26136 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49111/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:10:29 INFO - PROCESS | 26136 | RSS: Main: 168751104 06:10:29 INFO - PROCESS | 26136 | 06:10:32 INFO - PROCESS | 26136 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49111/tests/kraken/driver.html?testName=imaging-darkroom) 06:10:32 INFO - PROCESS | 26136 | RSS: Main: 168357888 06:10:32 INFO - PROCESS | 26136 | 06:10:36 INFO - PROCESS | 26136 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49111/tests/kraken/driver.html?testName=imaging-desaturate) 06:10:36 INFO - PROCESS | 26136 | RSS: Main: 168853504 06:10:36 INFO - PROCESS | 26136 | 06:10:39 INFO - PROCESS | 26136 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49111/tests/kraken/driver.html?testName=json-parse-financial) 06:10:40 INFO - PROCESS | 26136 | RSS: Main: 168247296 06:10:40 INFO - PROCESS | 26136 | 06:10:41 INFO - PROCESS | 26136 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49111/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:10:42 INFO - PROCESS | 26136 | RSS: Main: 173731840 06:10:42 INFO - PROCESS | 26136 | 06:10:43 INFO - PROCESS | 26136 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49111/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:10:44 INFO - PROCESS | 26136 | RSS: Main: 171253760 06:10:44 INFO - PROCESS | 26136 | 06:10:46 INFO - PROCESS | 26136 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49111/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:10:47 INFO - PROCESS | 26136 | RSS: Main: 178102272 06:10:47 INFO - PROCESS | 26136 | 06:10:49 INFO - PROCESS | 26136 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49111/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:10:50 INFO - PROCESS | 26136 | RSS: Main: 181567488 06:10:50 INFO - PROCESS | 26136 | 06:10:52 INFO - PROCESS | 26136 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49111/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:10:53 INFO - PROCESS | 26136 | RSS: Main: 181518336 06:10:53 INFO - PROCESS | 26136 | 06:10:54 INFO - PROCESS | 26136 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49111/tests/kraken/driver.html?testName=ai-astar) 06:10:55 INFO - PROCESS | 26136 | RSS: Main: 243666944 06:10:55 INFO - PROCESS | 26136 | 06:10:55 INFO - PROCESS | 26136 | __start_tp_report 06:10:55 INFO - PROCESS | 26136 | _x_x_mozilla_page_load 06:10:55 INFO - PROCESS | 26136 | _x_x_mozilla_page_load_details 06:10:55 INFO - PROCESS | 26136 | |i|pagename|runs| 06:10:55 INFO - PROCESS | 26136 | |0;ai-astar;109;110;105;109;111;110;101;112;109;110 06:10:55 INFO - PROCESS | 26136 | |1;audio-beat-detection;162;128;153;166;131;161;154;128;171;126 06:10:55 INFO - PROCESS | 26136 | |2;audio-dft;162;162;161;161;161;160;161;165;162;162 06:10:55 INFO - PROCESS | 26136 | |3;audio-fft;76;76;75;166;76;76;76;75;173;76 06:10:55 INFO - PROCESS | 26136 | |4;audio-oscillator;94;93;147;93;93;92;138;94;92;150 06:10:55 INFO - PROCESS | 26136 | |5;imaging-gaussian-blur;117;123;116;117;117;117;116;117;117;116 06:10:55 INFO - PROCESS | 26136 | |6;imaging-darkroom;146;146;145;147;146;146;147;147;146;147 06:10:55 INFO - PROCESS | 26136 | |7;imaging-desaturate;96;95;96;99;95;95;95;95;95;95 06:10:55 INFO - PROCESS | 26136 | |8;json-parse-financial;54;56;54;54;58;55;56;55;54;55 06:10:55 INFO - PROCESS | 26136 | |9;json-stringify-tinderbox;76;75;75;76;77;76;77;76;76;77 06:10:55 INFO - PROCESS | 26136 | |10;stanford-crypto-aes;76;78;86;77;80;77;90;78;77;77 06:10:55 INFO - PROCESS | 26136 | |11;stanford-crypto-ccm;118;127;118;125;115;113;119;114;114;111 06:10:55 INFO - PROCESS | 26136 | |12;stanford-crypto-pbkdf2;147;130;130;144;144;129;132;141;142;132 06:10:55 INFO - PROCESS | 26136 | |13;stanford-crypto-sha256-iterative;66;69;67;65;68;66;66;67;66;67 06:10:55 INFO - PROCESS | 26136 | __end_tp_report 06:10:55 INFO - PROCESS | 26136 | __start_cc_report 06:10:55 INFO - PROCESS | 26136 | _x_x_mozilla_cycle_collect,1037 06:10:55 INFO - PROCESS | 26136 | __end_cc_report 06:10:55 INFO - PROCESS | 26136 | __startTimestamp1462021855075__endTimestamp 06:10:55 INFO - PROCESS | 26136 | 06:10:55 INFO - PROCESS | 26136 | ------- Summary: start ------- 06:10:55 INFO - PROCESS | 26136 | Number of tests: 14 06:10:55 INFO - PROCESS | 26136 | 06:10:55 INFO - PROCESS | 26136 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:3.24 (2.9%) stddev-sans-first:3.43 06:10:55 INFO - PROCESS | 26136 | Values: 109.0 110.0 105.0 109.0 111.0 110.0 101.0 112.0 109.0 110.0 06:10:55 INFO - PROCESS | 26136 | 06:10:55 INFO - PROCESS | 26136 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:157.50 stddev:17.80 (11.3%) stddev-sans-first:18.15 06:10:55 INFO - PROCESS | 26136 | Values: 162.0 128.0 153.0 166.0 131.0 161.0 154.0 128.0 171.0 126.0 06:10:55 INFO - PROCESS | 26136 | 06:10:55 INFO - PROCESS | 26136 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.34 (0.8%) stddev-sans-first:1.41 06:10:55 INFO - PROCESS | 26136 | Values: 162.0 162.0 161.0 161.0 161.0 160.0 161.0 165.0 162.0 162.0 06:10:55 INFO - PROCESS | 26136 | 06:10:55 INFO - PROCESS | 26136 | [#3] audio-fft Cycles:10 Average:94.50 Median:76.00 stddev:39.56 (52.1%) stddev-sans-first:41.39 06:10:55 INFO - PROCESS | 26136 | Values: 76.0 76.0 75.0 166.0 76.0 76.0 76.0 75.0 173.0 76.0 06:10:55 INFO - PROCESS | 26136 | 06:10:55 INFO - PROCESS | 26136 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:93.00 stddev:25.30 (27.2%) stddev-sans-first:26.28 06:10:55 INFO - PROCESS | 26136 | Values: 94.0 93.0 147.0 93.0 93.0 92.0 138.0 94.0 92.0 150.0 06:10:55 INFO - PROCESS | 26136 | 06:10:55 INFO - PROCESS | 26136 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:2.06 (1.8%) stddev-sans-first:2.18 06:10:55 INFO - PROCESS | 26136 | Values: 117.0 123.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 06:10:55 INFO - PROCESS | 26136 | 06:10:55 INFO - PROCESS | 26136 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 06:10:55 INFO - PROCESS | 26136 | Values: 146.0 146.0 145.0 147.0 146.0 146.0 147.0 147.0 146.0 147.0 06:10:55 INFO - PROCESS | 26136 | 06:10:55 INFO - PROCESS | 26136 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.00 stddev:1.26 (1.3%) stddev-sans-first:1.33 06:10:55 INFO - PROCESS | 26136 | Values: 96.0 95.0 96.0 99.0 95.0 95.0 95.0 95.0 95.0 95.0 06:10:55 INFO - PROCESS | 26136 | 06:10:55 INFO - PROCESS | 26136 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:1.29 (2.3%) stddev-sans-first:1.30 06:10:55 INFO - PROCESS | 26136 | Values: 54.0 56.0 54.0 54.0 58.0 55.0 56.0 55.0 54.0 55.0 06:10:55 INFO - PROCESS | 26136 | 06:10:55 INFO - PROCESS | 26136 | [#9] json-stringify-tinderbox Cycles:10 Average:76.10 Median:76.00 stddev:0.74 (1.0%) stddev-sans-first:0.78 06:10:55 INFO - PROCESS | 26136 | Values: 76.0 75.0 75.0 76.0 77.0 76.0 77.0 76.0 76.0 77.0 06:10:55 INFO - PROCESS | 26136 | 06:10:55 INFO - PROCESS | 26136 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:78.00 stddev:4.65 (6.0%) stddev-sans-first:4.74 06:10:55 INFO - PROCESS | 26136 | Values: 76.0 78.0 86.0 77.0 80.0 77.0 90.0 78.0 77.0 77.0 06:10:55 INFO - PROCESS | 26136 | 06:10:55 INFO - PROCESS | 26136 | [#11] stanford-crypto-ccm Cycles:10 Average:117.40 Median:118.00 stddev:5.19 (4.4%) stddev-sans-first:5.50 06:10:55 INFO - PROCESS | 26136 | Values: 118.0 127.0 118.0 125.0 115.0 113.0 119.0 114.0 114.0 111.0 06:10:55 INFO - PROCESS | 26136 | 06:10:55 INFO - PROCESS | 26136 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.10 Median:141.50 stddev:7.08 (5.0%) stddev-sans-first:6.54 06:10:55 INFO - PROCESS | 26136 | Values: 147.0 130.0 130.0 144.0 144.0 129.0 132.0 141.0 142.0 132.0 06:10:55 INFO - PROCESS | 26136 | 06:10:55 INFO - PROCESS | 26136 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.16 (1.7%) stddev-sans-first:1.20 06:10:55 INFO - PROCESS | 26136 | Values: 66.0 69.0 67.0 65.0 68.0 66.0 66.0 67.0 66.0 67.0 06:10:55 INFO - PROCESS | 26136 | -------- Summary: end -------- 06:10:55 INFO - PROCESS | 26136 | 06:10:56 INFO - TEST-INFO | 26136: exit 0 06:10:56 INFO - TEST-OK | kraken | took 59833ms 06:10:56 INFO - SUITE-END | took 1171s 06:10:56 INFO - Completed test suite (00:19:31) 06:10:56 INFO - javascript benchmark 06:10:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3288.753343499238, 3353.2287573858, 3370.3259348130364, 3378.020374091512, 3397.626261111278, 5436.782528698852, 5448.727563621823, 5461.0716178249695, 5468.7812487500505, 5497.47773961473, 5453.263809385731, 5526.889462210764, 5529.253550770644, 5529.640573362729, 5536.363318218406, 4852.17513022787, 4992.251162325662, 5017.498250174972, 5074.644774865761, 5094.337736094302, 4944.678595891256, 5028.220625803006, 5035.0, 5036.093503169428, 5039.924401133986, 5074.84775456735, 5081.390233172025, 5095.796168153288, 5137.255098010786, 5140.820071297505, 4976.825811096594, 5098.566621837148, 5110.412302585213, 5112.97443512782, 5128.102582048145, 4831.903361932742, 4957.529034741694, 4966.130927087781, 5002.1496345621335, 5009.624278179152, 5282.7622756976025, 5331.546818520431, 5351.411344752074, 5374.140137578008, 5393.1370980643305, 5956.106584012389, 5976.940230597682, 5982.6410415374785, 5983.820485385445, 5987.311459182206, 5853.2976042875125, 5905.763769449217, 5967.880642387171, 5972.761089556412, 6000.75996960121, 5502.80740174092, 5513.862153446196, 5515.145152501329, 5517.310336207974, 5548.389677135512, 5980.43185897339, 5980.700964951735, 5982.940170598238, 5983.222181116427, 5990.64056156632, 5654.46282603152, 5761.971190144022, 5770.682612456271, 5790.565707571949, 5872.823815285548, 5978.671173085435, 5982.252218472691, 5990.64056156632, 5992.041273396236, 5997.580169388189, 5930.851728706817, 5948.196993405922, 5949.196858424144, 5950.642961422329, 5953.404659534012, 5710.2862142232225, 5885.058390657474, 5925.496332811673, 6001.699915004232, 6009.1587177795145, 4500.167469018242, 4506.459224893034, 4531.0, 4532.048269863366, 4551.362809206714, 4052.3516237401873, 4076.673866090765, 4080.8571699990357, 4083.571225021389, 4105.3020986432375, 5554.91667624986, 5651.745671444794, 5686.260786097863, 5704.201411802351, 5724.370319264877, 5943.465088142088, 5951.880962380728, 6013.819585412444, 6015.0676645120075, 6025.427584379565, 5401.351837779492, 5637.8590535236945, 5666.235058267163, 5667.234923285386, 5669.092945128842, 5152.793888244503, 5177.016366890279, 5182.1190397631735, 5204.609654275944, 5218.399884013387, 6155.569110162246, 6196.411340922605, 6207.751689932352, 6214.316425193225, 6221.751129954841, 5798.304203495608, 5966.582339236385, 5989.820305390758, 6018.9398106020135, 6019.789307374221, 5981.999999999826, 5998.070299103646, 5999.820005399845, 6001.819945401645, 6034.517238620988, 5680.517156041617, 5717.571182161271, 5725.885482290248, 5732.598718089694, 5739.483446489836, 5811.360750317377, 5813.970930145322, 5837.270341207349, 5863.824085277449, 5914.083317085859, 5695.686737229492, 5702.34423041339, 5702.971485142713, 5706.914396283976, 5736.569757268305, 5668.773249069991, 5712.371639119777, 5721.256236689203, 5732.226149469935, 5743.052396354555, 5499.532539734168, 5649.0, 5672.659640421588, 5739.713014349182, 5763.135529670415, 5693.8861222774485, 5753.079507278815, 5754.165645981393, 5793.565482588739, 5793.91309130355, 5620.437956204511, 5621.831345059655, 5661.235733175969, 5665.0935850265405, 5682.516986056066], "unit": "score", "name": "dojo.html", "value": 5451.6311734879055}, {"lowerIsBetter": false, "replicates": [547.5646860745709, 565.053535328325, 568.2016766443147, 572.9914051289231, 577.9971749015457, 30466.0, 39203.41194882076, 39368.015799605026, 39376.60623393765, 39430.0, 43322.0, 43829.34255986155, 43835.0, 43892.78053609728, 43913.0, 8952.328575356842, 9167.404118732295, 9173.95413022934, 9184.173424391804, 9186.54067296636, 8948.06045365237, 9052.8642070369, 9082.046385129566, 9095.454272743624, 9311.72064838056, 9285.117913798213, 9361.4383137012, 9377.76555586109, 9387.389819661701, 9389.577469013877, 9258.861117083248, 9353.0, 9362.01698821624, 9372.90627093734, 9375.062493750638, 9187.540622968825, 9309.34834561581, 9328.113829186217, 9331.76670583234, 9335.626574936994, 42978.57021429777, 43079.35380969288, 43165.13669726588, 43195.0, 43232.0, 3326.8170250636203, 3471.600765911902, 3569.37535931211, 4000.939750965996, 4103.4870641169855, 32310.35379292401, 32843.0, 33024.834875825465, 33151.6684833151, 33773.15567110817, 4289.978550107261, 4291.763952982585, 4306.2344438780265, 4314.115606300732, 4319.740815551077, 288134.0, 288409.0, 289307.0, 290767.0, 291709.0, 59909.10136347958, 60924.390756091874, 60968.39031609716, 61059.08411373833, 61110.69444652748, 66527.33472665308, 72677.2732272681, 73852.0, 73863.26136738672, 73953.26046739463, 16950.745738813683, 17076.060816654954, 17125.48623541296, 17142.057186854592, 17168.828311716723, 12816.35918204086, 12816.935915320364, 12819.230846149261, 12823.0, 12829.486820527074, 22009.66985495219, 22340.21809236669, 22346.329610111723, 22368.55262894733, 22442.32673019812, 7775.0, 8265.752027439186, 8295.377846661524, 8305.584720763938, 8389.32885369169, 1002.5607814832723, 1018.3635227982511, 1069.3744159666526, 1106.6956586938657, 1133.9603113890973, 29147.85426072856, 29225.02984480709, 29611.703882960894, 29706.702932970828, 29799.957001504845, 1102.2890235797865, 1142.1205671632963, 1187.0562902492538, 1188.3285943441927, 1240.4851986425713, 15602.765958510632, 15621.921890390702, 15783.210839457981, 15881.570658640778, 16114.0, 327561.0, 332008.0, 332372.0, 332448.0, 332574.0, 56094.71952640292, 57092.429075708715, 57130.14304785432, 57185.71407142938, 57204.14193787097, 1315.4014923209916, 1447.6887469193964, 1471.065873170523, 1475.948341808053, 1589.9903561238696, 27195.80882755777, 27255.0, 28981.56527652129, 29106.417871642025, 29659.40681186321, 44658.77670611626, 45002.099958, 45365.0, 45388.54611453843, 45401.54598454105, 193919.0, 195745.0, 195819.0, 195922.0, 196612.0, 30043.0, 33992.0, 35258.8237058813, 35313.64686353206, 35339.46990795089, 40140.59859401369, 40379.798101009306, 40481.39277910775, 41588.0, 41693.79153104215, 34867.4769878447, 34975.65024349724, 35177.82411087928, 35202.823985879906, 35719.64280357163, 36817.07957301089, 36937.26125477422, 37016.0, 37278.44082338713, 37501.06247343838, 36400.81799590985, 37270.25459490849, 37942.051448714, 37959.81020094882, 37973.620263797005, 36584.81707591445, 37524.249515010095, 37857.81071094627, 38312.616873830906, 38360.2327953445, 25025.0, 25603.35991600225, 26355.341116472242, 26386.472270554867, 26721.19836404911], "unit": "score", "name": "ext.html", "value": 19316.04294637483}, {"lowerIsBetter": false, "replicates": [363.3931334671099, 380.6821304210985, 383.4765545031033, 387.5136703437186, 388.5609261534466, 17879.64240715185, 18261.178246978885, 19060.809391906078, 19080.522986925334, 19107.331243406483, 17517.299308027694, 17801.0, 18007.90996045021, 18043.90978045111, 18066.27734890606, 5592.832215033545, 5795.942040579604, 5830.941690583082, 5833.620814647034, 5844.064949608063, 4191.077962848184, 5730.226419433386, 5985.760569577212, 6395.424411802936, 6445.065465507499, 6386.552941294111, 6388.009858471944, 6390.904136437957, 6408.903866442007, 6415.390537898916, 6044.153818465418, 6410.935890641127, 6430.453411460008, 6457.321981191978, 6482.254540727829, 3880.553736320331, 5525.585581081395, 5713.6000479966415, 5723.284589426322, 5738.45484678959, 21759.347219583437, 22082.0, 22760.20339288117, 23490.882545587163, 23517.412064698347, 2338.263447014185, 2445.3275349279093, 2498.7876030537427, 2775.722427757228, 2822.294426393381, 13284.867151328557, 13908.652283692887, 14228.857711422961, 14777.778333325008, 15519.456819011393, 1989.9502512437305, 2012.5471768852037, 2023.817856392917, 2025.6961455781604, 2039.0620314655275, 71693.64153179253, 71747.64126179335, 74066.0, 75019.6249018757, 76682.0, 15247.390104395921, 15807.604809879615, 15867.603309917344, 15939.840601594067, 16114.274857631435, 27505.86247068752, 27596.0, 27876.86061569679, 27962.161135165978, 27996.160115196577, 9122.908770912338, 9465.952670236606, 9501.762455938519, 9529.952350238205, 9587.808243835085, 8030.959845200737, 8042.798930026796, 8054.758357249292, 8133.552654604054, 8169.0, 7926.841463170705, 7936.761897143095, 7982.082060562993, 7983.880241796378, 8149.470284431493, 2524.7475252474605, 2862.0343703674107, 3007.9699203008126, 3062.1732132324146, 3252.577164968539, 897.8159477307137, 973.2992245583168, 994.2443742755557, 1039.5737747523478, 1055.4694546741139, 16382.180890955404, 16587.336506539843, 16739.16304184786, 16852.410165644145, 17290.22194001273, 943.6508491858057, 971.3928794503436, 971.9076687714655, 1007.4459047523833, 1022.8874823769379, 9689.467079310705, 9902.702918912444, 9988.151007164328, 10017.0, 10083.596656133672, 441153.0, 441286.0, 455675.0, 458020.0, 459487.0, 75939.62030189813, 76301.61849190718, 76471.0, 77378.0, 77562.0, 957.7653474898555, 1041.390786389955, 1089.477051015501, 1095.3044816541553, 1096.6709987003867, 15000.924995374953, 15167.544973650809, 15248.237588120328, 15354.92322538425, 15545.68908621844, 31597.21006974752, 31830.204244894063, 32748.18129546685, 32990.67009329876, 33916.32167356688, 38726.80636596799, 40695.796521017204, 40849.38725919054, 41157.1768564633, 41770.37344439897, 7729.729459468892, 7811.687532498637, 7948.483348582324, 7986.241307075818, 8125.146859579659, 9248.583813728534, 11814.940925295663, 11818.113641477095, 12005.519779208735, 12102.939485302517, 9955.153811925778, 10043.347182433119, 10507.0, 10554.630587929385, 10579.36523808574, 10659.840102398626, 10780.472729810128, 10951.56193752241, 11146.275492092987, 11211.60759373418, 10598.629047983284, 10887.18346124028, 10907.18196135309, 10933.83599246028, 11127.0, 8109.918900810916, 8135.633896474555, 8168.83662326762, 8234.752957411287, 8315.584220788814, 8229.382796290422, 10381.53283102247, 10766.461676915966, 10935.28920620157, 10954.123670106213], "unit": "score", "name": "jquery.html", "value": 9385.400020159786}, {"lowerIsBetter": false, "replicates": [1434.4190602805854, 1575.2438829361909, 1577.140458450145, 1782.9019403932778, 1939.3309308288635, 7230.421566274698, 7777.18339574345, 7833.177516360785, 7901.723439679612, 7924.92075079249, 7928.9207107928905, 8091.514509129456, 8107.554084525349, 8110.513369197837, 8128.349732021439, 2418.407490164912, 2441.5361081394567, 2441.6215486599604, 2442.804575633954, 2446.4862378900452, 2364.8226383021256, 2390.4501964548163, 2403.3030421177837, 2407.9277621671376, 2422.2369953464604, 2421.092090466075, 2433.476802487474, 2447.2535876557645, 2458.791002764767, 2486.0, 2391.485830546432, 2398.8800559972105, 2401.4476670365825, 2421.4430680943306, 2460.2865169100937, 2370.9644355334685, 2438.5488684593406, 2449.1060762821444, 2451.6935383077116, 2452.6811514503, 8095.554744489051, 8271.793205169859, 8272.793180170484, 8279.958600207021, 8284.171582841727, 5045.84862454127, 5143.3570803649545, 5165.845024649229, 5168.664036837594, 5170.948290517084, 3197.2965947491516, 3226.177324782189, 3243.3837570861697, 3255.674432556725, 3280.2947366316116, 1048.7797562511882, 1944.0182707732504, 1956.0806420982115, 1964.361582485698, 1976.328048463515, 10795.406252656101, 10833.079188269006, 10888.61889833852, 10899.182561307935, 10902.563897444094, 4198.895027624334, 4295.871123866226, 4339.067100573328, 4402.119576084732, 4408.933865992013, 8843.513606751561, 8878.556072196365, 8888.200061994452, 8890.59992300348, 8901.0, 4945.381827271591, 4959.628027897922, 4982.576480999083, 4983.626228032912, 4983.8006479741125, 4039.8384064637085, 4101.958980410217, 4487.080148569536, 4585.266357382803, 4619.5611416915335, 3614.710823134143, 3641.599424063351, 3664.285464334429, 3672.926541469156, 3694.6120657330594, 1090.650991682654, 1108.800415925125, 1115.1747706696985, 1116.8380584815156, 1122.2480937771713, 1109.7336639206533, 1127.0082327551702, 1139.2993309114834, 1379.3034517568565, 1470.3677418709844, 7815.53106813593, 7868.606569671608, 7902.051753789582, 8021.478603890729, 8022.959885200653, 511.3582454020181, 516.2179298362983, 518.8884389856199, 519.0, 524.8530411484791, 5867.237259156283, 5899.233099697012, 5909.113632955091, 5919.1713160157615, 5972.611780234271, 9834.508274586386, 10087.848682269772, 10479.476026198812, 10492.108170805413, 10493.947530262452, 9758.268129890144, 9940.602375905028, 9949.452780097019, 9976.201903847676, 10336.17310615149, 7899.0, 8034.678612855537, 8132.390070744717, 8152.225538573707, 8167.060788009336, 7504.0, 7511.06111736033, 7573.2805383488485, 7586.810329741801, 7668.846623067396, 8830.293576513992, 8876.156765107304, 9076.909230907606, 9174.357794954556, 9190.816183676423, 9024.052474490347, 9060.90939090627, 9072.501012444114, 9303.72088837336, 9311.674091406769, 5990.610610310316, 6471.546991710535, 6641.03704962768, 6650.501212409185, 6737.764178253738, 7643.350315223268, 7665.6933722650465, 7677.155512893689, 7706.537607743553, 7708.884366734392, 6408.969962009441, 6541.0, 6564.146660934048, 6643.734250630114, 6648.800535983928, 6422.2614399344675, 6573.04690819838, 6577.14497115372, 6615.0, 6671.766488172891, 6926.995585640155, 6939.167299924042, 6995.055667484824, 7006.684699188447, 7008.123984501937, 6412.967935160481, 6567.638779867153, 6636.303188165173, 6637.734490620321, 6643.7674681385915, 6632.602043877383, 6648.90026649591, 6651.567648102858, 6652.567583107082, 6672.165979252593], "unit": "score", "name": "mootools.html", "value": 4614.643565239622}, {"lowerIsBetter": false, "replicates": [343.67866045247695, 349.82683571632043, 351.69051234913275, 352.7231123567998, 356.52760092876935, 5942.76228950842, 5946.197263369444, 5963.254593175853, 5994.340622531518, 6027.126066720323, 5895.882082358361, 5905.763769449228, 5914.438128377808, 5917.142014407908, 5934.851628709284, 4423.3807266982485, 4519.8418055368065, 4625.213713668668, 4647.60495357895, 4668.76656167192, 4615.3077038444335, 4642.373279607244, 4654.790534425959, 4657.604103651193, 4659.254519276917, 4606.884827879297, 4615.46922103959, 4618.237990731542, 4620.145273124466, 4629.23617603095, 4400.229959757045, 4507.616852567536, 4607.677462577587, 4608.723476591415, 4615.307703844416, 4057.472528571296, 4063.7358571692744, 4064.5325787534516, 4076.286649836267, 4085.6527195188446, 5659.547236221092, 5660.971695141539, 5661.377248502661, 5663.745131469093, 5671.489565939044, 5380.0, 5380.300560927094, 5385.0, 5387.919181212285, 5407.945920540784, 6306.432421082125, 6315.210598675166, 6316.557840951135, 6317.399847014526, 6317.715702793385, 4385.144896745136, 4489.6408287336935, 4495.57292057254, 4504.09918016398, 4546.704464209815, 6451.258105317902, 6586.143801305848, 6588.341165883421, 6599.901001484982, 6611.008348747679, 4670.53294670537, 4672.229082201398, 4673.883152921137, 4680.438347398334, 4683.555062269147, 4721.480637129913, 4734.526547345238, 4734.928976065362, 4739.526047395302, 4741.596964258077, 5387.003404370204, 5389.865253368619, 5392.029434701792, 5401.270828438189, 5405.729713514309, 6235.625862448268, 6334.619922804646, 6350.682465876687, 6360.6501642409185, 6366.936330636634, 1634.967300654004, 1654.4953789094202, 1655.793025871766, 1663.3014134063721, 1671.2479384277124, 1074.5809134437575, 1101.3997371432588, 1117.7596816684452, 1121.8036843552345, 1145.169751929844, 6046.3651316612, 6125.663088530174, 6130.264368275746, 6134.171886795315, 6139.539534534928, 6454.967725161344, 6496.123023391876, 6522.315156908551, 6522.673866306665, 6527.314631963671, 6113.694315284307, 6122.26532816056, 6122.693865306717, 6128.0, 6132.724027418777, 3477.965220347764, 3517.9472307915403, 3525.206828463575, 3526.7883926964464, 3528.9647103528637, 6656.400923916871, 6744.325567443217, 6874.0, 6887.345702158287, 6888.931110688929, 6762.1209242799105, 6777.932220677829, 6788.321167883271, 6798.52410331272, 6805.727770889109, 6834.829129271709, 6841.110655614738, 6843.520953533205, 6862.0, 6864.1419822523185, 6631.535792494672, 6637.6349300788925, 6640.335966403321, 6640.402363787282, 6656.167979002625, 6293.37066293367, 6496.837579060561, 6507.707153178024, 6508.544401891822, 6548.508861835477, 6845.520813543004, 6856.862862742817, 6862.107925969592, 6868.210155832143, 6879.380855723009, 4445.444319460067, 4455.309427038814, 4470.083632855322, 4471.8658440246845, 4475.820967161408, 6658.667066646552, 6658.933410665832, 6659.067730517634, 6688.598684078971, 6745.3591908768585, 6245.125682404558, 6446.484281257582, 6456.418922297016, 6459.031145328238, 6463.870722585428, 6437.25971513282, 6460.870782584416, 6468.579542329733, 6468.579542329733, 6482.092507048923, 6330.746770129143, 6340.4927605792345, 6341.175647165839, 6343.55595108338, 6347.111404403479, 6507.154069971063, 6510.869782604226, 6510.9674451629335, 6515.0, 6524.0, 6071.635701857903, 6193.659348735863, 6245.344238854855, 6350.460210881942, 6355.7457701693265], "unit": "score", "name": "prototype.html", "value": 4841.134263709613}, {"lowerIsBetter": false, "replicates": [655.5149189599698, 666.5300962821211, 688.4698781937908, 745.985080298394, 898.8247291778101, 14510.63723406914, 14735.0, 14737.557873263819, 14740.705185896275, 14754.926225368872, 13199.142055766393, 13324.200547967128, 13335.666608334797, 13336.533221337231, 13478.663033424169, 930.7580029192408, 944.3908678902104, 949.952502374882, 951.8286708392486, 951.9904800952006, 922.7600823785797, 925.1904583489446, 925.6528801699362, 928.9256859451261, 929.251952178496, 974.3471873844542, 978.9510524473783, 979.4221409368471, 980.3284749946309, 981.3474039763548, 973.2943615878502, 974.9366291191085, 975.65851951817, 975.9072888075622, 976.6874600127926, 721.0734206544618, 721.4661150748461, 721.6752461392342, 722.0324764815173, 722.0468980945102, 13670.17978921258, 13764.793528097087, 13785.310734463237, 13804.447822087104, 13835.0, 12037.217580857216, 12238.510459581606, 12322.81515777264, 12378.133530652858, 12526.74946501065, 10445.112165465944, 10472.937702277433, 10492.580296788119, 10666.253362264644, 10746.247762656618, 3666.1201311685004, 3806.695464362844, 3841.5582208046153, 3866.381378979378, 3881.262560113569, 48226.27660585094, 50248.74875625598, 51517.0, 51619.0, 51810.7409462954, 10490.16078713701, 10696.0, 10875.728106797393, 11045.226834121535, 11063.446827658585, 18685.626287474446, 18689.25242990265, 18702.719459207852, 18712.064396780108, 18713.251469941322, 8160.551169685724, 8175.509469431853, 8342.708005219789, 8345.956755405574, 8486.490810551386, 3776.4335349697767, 3873.86441474547, 3940.2710498557285, 4318.265894797892, 4465.977670111629, 3400.353932752769, 3401.727861771052, 3412.812295323731, 3414.402479566066, 3415.316936612687, 593.1636392686291, 601.6871226962043, 602.1178972804862, 610.6793933185024, 612.5773216480615, 605.4671888737882, 634.3624657219465, 692.4737199728243, 694.7498900395854, 699.3670727991176, 7981.561014144278, 8031.277185053374, 8151.429399942066, 8324.66701331952, 8368.623411946477, 672.582998540898, 675.1729131813587, 686.2245662401455, 697.9755708550176, 698.8148140742708, 3954.8022598870516, 3979.7612143271494, 4007.959920400817, 4010.57888921659, 4019.7990100495444, 56654.43345566574, 57437.71281143651, 57525.71237143871, 58352.40502298577, 58459.123113152484, 49763.25355119676, 51671.22493162606, 52180.47819521832, 52206.738966304925, 54110.7294463533, 42555.36166957498, 42594.57405425906, 43148.78425607852, 43186.35220471695, 44099.45651902168, 8330.250277475056, 8332.791680208044, 8424.578771061544, 8543.273821724973, 8674.739757807276, 33530.161745956546, 34204.82897585496, 34317.14207144841, 34410.0, 36256.0, 40586.39120413255, 41094.79452602718, 44448.33327500025, 44534.77732611446, 44787.55212447834, 10815.56737730482, 11121.165912556753, 11833.171677982458, 11886.702832429259, 12050.397480126134, 11363.715907102389, 11376.203665743318, 12273.570425035081, 13393.531226407029, 14099.224542650252, 10930.289531180448, 10956.34261944286, 11131.888681113085, 11387.601433949772, 11718.121140914636, 11017.724556886142, 11270.887291126985, 11460.312381256817, 11486.483108259981, 11494.252873563191, 10675.733106672395, 10766.192535559707, 11022.779544409228, 11271.04196143337, 11282.887171128512, 9635.614575416905, 9829.85255221158, 10188.0, 10561.366318020944, 11004.339739615649, 9208.769780755534, 9282.535873206178, 9336.159745622926, 9349.859752103588, 9617.086376794194], "unit": "score", "name": "yui.html", "value": 6515.304966388996}], "name": "dromaeo_css", "value": 7238.680267053245}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 105.0, 109.0, 111.0, 110.0, 101.0, 112.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [162.0, 128.0, 153.0, 166.0, 131.0, 161.0, 154.0, 128.0, 171.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 148.0}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 161.0, 161.0, 160.0, 161.0, 165.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 75.0, 166.0, 76.0, 76.0, 76.0, 75.0, 173.0, 76.0], "unit": "score", "name": "audio-fft", "value": 94.5}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 147.0, 93.0, 93.0, 92.0, 138.0, 94.0, 92.0, 150.0], "unit": "score", "name": "audio-oscillator", "value": 108.6}, {"lowerIsBetter": true, "replicates": [117.0, 123.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.3}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 99.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [54.0, 56.0, 54.0, 54.0, 58.0, 55.0, 56.0, 55.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 55.1}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 75.0, 76.0, 77.0, 76.0, 77.0, 76.0, 76.0, 77.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 76.1}, {"lowerIsBetter": true, "replicates": [76.0, 78.0, 86.0, 77.0, 80.0, 77.0, 90.0, 78.0, 77.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.6}, {"lowerIsBetter": true, "replicates": [118.0, 127.0, 118.0, 125.0, 115.0, 113.0, 119.0, 114.0, 114.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.4}, {"lowerIsBetter": true, "replicates": [147.0, 130.0, 130.0, 144.0, 144.0, 129.0, 132.0, 141.0, 142.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.1}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 67.0, 65.0, 68.0, 66.0, 66.0, 67.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1512.6}]} 06:10:56 INFO - Return code: 0 06:10:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:10:56 INFO - # TBPL SUCCESS # 06:10:56 INFO - Running post-action listener: _resource_record_post_action 06:10:56 INFO - Running post-run listener: _resource_record_post_run 06:10:57 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 16384; Write bytes: 468971520; Read time: 36; Write time: 311424 06:10:57 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 247197696; Read time: 0; Write time: 208728 06:10:57 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 16384; Write bytes: 221773824; Read time: 36; Write time: 102696 06:10:57 INFO - Running post-run listener: _upload_blobber_files 06:10:57 INFO - Blob upload gear active. 06:10:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:10:57 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 06:10:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:10:57 INFO - (blobuploader) - INFO - Open directory for files ... 06:10:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:10:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:10:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:10:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:58 INFO - (blobuploader) - INFO - Done attempting. 06:10:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:10:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:10:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:10:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:59 INFO - (blobuploader) - INFO - Done attempting. 06:10:59 INFO - (blobuploader) - INFO - Iteration through files over. 06:10:59 INFO - Return code: 0 06:10:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:10:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:10:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2aa026db80c6011b69578b71883278bd29b8ef8695313203210b4c7499c55e54c61da42a56d388fc76dd264245baaabaa503249e2c511d553d7d910364e8c710", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/914b1db2baed366c03e5df18cd5dfc7ede183f22392397f37d331b8ea3014e49673e9e968262e00d14edaa2accaf5b3fcfa24d556a94a909dd1d0aa718d858ac"} 06:10:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:10:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:10:59 INFO - Contents: 06:10:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2aa026db80c6011b69578b71883278bd29b8ef8695313203210b4c7499c55e54c61da42a56d388fc76dd264245baaabaa503249e2c511d553d7d910364e8c710", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/914b1db2baed366c03e5df18cd5dfc7ede183f22392397f37d331b8ea3014e49673e9e968262e00d14edaa2accaf5b3fcfa24d556a94a909dd1d0aa718d858ac"} 06:10:59 INFO - Running post-run listener: copy_logs_to_upload_dir 06:10:59 INFO - Copying logs to upload dir... 06:10:59 INFO - mkdir: /builds/slave/test/build/upload/logs 06:10:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.921432 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-04-30 06:10:59.498301) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-30 06:10:59.501482) ========= 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=00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2aa026db80c6011b69578b71883278bd29b8ef8695313203210b4c7499c55e54c61da42a56d388fc76dd264245baaabaa503249e2c511d553d7d910364e8c710", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/914b1db2baed366c03e5df18cd5dfc7ede183f22392397f37d331b8ea3014e49673e9e968262e00d14edaa2accaf5b3fcfa24d556a94a909dd1d0aa718d858ac"} build_url:https://queue.taskcluster.net/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011142 build_url: 'https://queue.taskcluster.net/v1/task/cSNPFLEsTGuJBPlCWCes6w/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2aa026db80c6011b69578b71883278bd29b8ef8695313203210b4c7499c55e54c61da42a56d388fc76dd264245baaabaa503249e2c511d553d7d910364e8c710", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/914b1db2baed366c03e5df18cd5dfc7ede183f22392397f37d331b8ea3014e49673e9e968262e00d14edaa2accaf5b3fcfa24d556a94a909dd1d0aa718d858ac"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-30 06:10:59.526459) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 06:10:59.526828) ========= 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=00204705a9daa57ed339a427000001b9-1462018819.392010-1663890250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 06:10:59.612230) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-30 06:10:59.612584) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-30 06:10:59.612886) ========= ========= Total master_lag: 0.22 =========