builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1463796402.82 results: success (0) buildid: 20160520162336 builduid: e38a8976e8ac4cc58d44f0d7275e05a5 revision: 782b4767770b8d7f9ddea913167c49a12087d6af ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 19:06:42.815958) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 19:06:42.816412) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 19:06:42.816703) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 19:06:42.834923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 19:06:42.835415) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-20 19:06:43-- 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% 46.6M=0s 2016-05-20 19:06:43 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076915 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 19:06:42.928468) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 19:06:42.928995) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017062 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 19:06:42.980944) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 19:06:42.981549) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 782b4767770b8d7f9ddea913167c49a12087d6af --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-aurora --rev 782b4767770b8d7f9ddea913167c49a12087d6af --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=516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-20 19:06:43,225 truncating revision to first 12 chars 2016-05-20 19:06:43,225 Setting DEBUG logging. 2016-05-20 19:06:43,225 attempt 1/10 2016-05-20 19:06:43,225 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/782b4767770b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-20 19:06:43,749 unpacking tar archive at: mozilla-aurora-782b4767770b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.794906 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 19:06:43.790643) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 19:06:43.791059) ========= script_repo_revision: 782b4767770b8d7f9ddea913167c49a12087d6af ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 19:06:43.791584) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 19:06:43.791865) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 19:06:43.800935) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-05-20 19:06:43.801257) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:06:44 INFO - MultiFileLogger online at 20160520 19:06:44 in /builds/slave/test 19:06:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:06:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:06:44 INFO - {'append_to_log': False, 19:06:44 INFO - 'base_work_dir': '/builds/slave/test', 19:06:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:06:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:06:44 INFO - 'branch': 'Mozilla-Aurora', 19:06:44 INFO - 'buildbot_json_path': 'buildprops.json', 19:06:44 INFO - 'config_files': ('talos/linux_config.py',), 19:06:44 INFO - 'default_actions': ('clobber', 19:06:44 INFO - 'read-buildbot-config', 19:06:44 INFO - 'download-and-extract', 19:06:44 INFO - 'populate-webroot', 19:06:44 INFO - 'create-virtualenv', 19:06:44 INFO - 'install', 19:06:44 INFO - 'run-tests'), 19:06:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:06:44 INFO - 'download_minidump_stackwalk': True, 19:06:44 INFO - 'download_symbols': 'ondemand', 19:06:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:06:44 INFO - 'tooltool.py': '/tools/tooltool.py', 19:06:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:06:44 INFO - '/tools/misc-python/virtualenv.py')}, 19:06:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:06:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:06:44 INFO - 'installer_path': 'installer.exe', 19:06:44 INFO - 'log_level': 'info', 19:06:44 INFO - 'log_name': 'talos', 19:06:44 INFO - 'log_to_console': True, 19:06:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:06:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:06:44 INFO - 'opt_config_files': (), 19:06:44 INFO - 'pip_index': False, 19:06:44 INFO - 'sps_profile': False, 19:06:44 INFO - 'sps_profile_interval': 0, 19:06:44 INFO - 'suite': 'dromaeojs', 19:06:44 INFO - 'system_bits': '32', 19:06:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:06:44 INFO - 'title': 'talos-linux64-ix-061', 19:06:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:06:44 INFO - 'use_talos_json': True, 19:06:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:06:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:06:44 INFO - 'work_dir': 'build'} 19:06:44 INFO - ##### 19:06:44 INFO - ##### Running clobber step. 19:06:44 INFO - ##### 19:06:44 INFO - Running pre-action listener: _resource_record_pre_action 19:06:44 INFO - Running main action method: clobber 19:06:44 INFO - rmtree: /builds/slave/test/build 19:06:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:06:44 INFO - Running post-action listener: _resource_record_post_action 19:06:44 INFO - ##### 19:06:44 INFO - ##### Running read-buildbot-config step. 19:06:44 INFO - ##### 19:06:44 INFO - Running pre-action listener: _resource_record_pre_action 19:06:44 INFO - Running main action method: read_buildbot_config 19:06:44 INFO - Using buildbot properties: 19:06:44 INFO - { 19:06:44 INFO - "project": "", 19:06:44 INFO - "product": "firefox", 19:06:44 INFO - "script_repo_revision": "production", 19:06:44 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 19:06:44 INFO - "repository": "", 19:06:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 19:06:44 INFO - "buildid": "20160520162336", 19:06:44 INFO - "pgo_build": "True", 19:06:44 INFO - "basedir": "/builds/slave/test", 19:06:44 INFO - "buildnumber": 244, 19:06:44 INFO - "slavename": "talos-linux64-ix-061", 19:06:44 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:06:44 INFO - "platform": "ubuntu64_hw", 19:06:44 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 19:06:44 INFO - "branch": "mozilla-aurora", 19:06:44 INFO - "repo_path": "releases/mozilla-aurora", 19:06:44 INFO - "revision": "782b4767770b8d7f9ddea913167c49a12087d6af", 19:06:44 INFO - "stage_platform": "linux64-pgo", 19:06:44 INFO - "builduid": "e38a8976e8ac4cc58d44f0d7275e05a5", 19:06:44 INFO - "slavebuilddir": "test" 19:06:44 INFO - } 19:06:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 19:06:44 INFO - Running post-action listener: _resource_record_post_action 19:06:44 INFO - ##### 19:06:44 INFO - ##### Running download-and-extract step. 19:06:44 INFO - ##### 19:06:44 INFO - Running pre-action listener: _resource_record_pre_action 19:06:44 INFO - Running main action method: download_and_extract 19:06:44 INFO - mkdir: /builds/slave/test/build/tests 19:06: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')]} 19:06:44 INFO - https://queue.taskcluster.net/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:06:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:06:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:06:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:06:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:06:45 INFO - Downloaded 1361 bytes. 19:06:45 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:06:45 INFO - Using the following test package requirements: 19:06:45 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 19:06:45 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:06:45 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 19:06:45 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:06:45 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 19:06:45 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:06:45 INFO - u'jsshell-linux-x86_64.zip'], 19:06:45 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:06:45 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 19:06:45 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 19:06:45 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:06:45 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 19:06:45 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:06:45 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 19:06:45 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:06:45 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 19:06:45 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:06:45 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 19:06:45 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:45 INFO - https://queue.taskcluster.net/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:06:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:06:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:06:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:06:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:06:46 INFO - Downloaded 23812944 bytes. 19:06:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:06:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:06:47 INFO - Return code: 0 19:06:47 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:47 INFO - https://queue.taskcluster.net/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:06:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:06:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:06:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:06:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:06:49 INFO - Downloaded 23812944 bytes. 19:06:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:06:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:06:50 INFO - Return code: 0 19:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:50 INFO - https://queue.taskcluster.net/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:06:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 19:06:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 19:06:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 19:06:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:06:52 INFO - Downloaded 10840145 bytes. 19:06:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:06:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:06:52 INFO - Return code: 0 19:06:52 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')]} 19:06:52 INFO - https://queue.taskcluster.net/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:06:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:06:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:06:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:06:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:06:53 INFO - Downloaded 62694234 bytes. 19:06:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:06:53 INFO - mkdir: /builds/slave/test/properties 19:06:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:06:53 INFO - Writing to file /builds/slave/test/properties/build_url 19:06:53 INFO - Contents: 19:06:53 INFO - build_url:https://queue.taskcluster.net/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:06:54 INFO - Running post-action listener: _resource_record_post_action 19:06:54 INFO - Running post-action listener: set_extra_try_arguments 19:06:54 INFO - ##### 19:06:54 INFO - ##### Running populate-webroot step. 19:06:54 INFO - ##### 19:06:54 INFO - Running pre-action listener: _resource_record_pre_action 19:06:54 INFO - Running main action method: populate_webroot 19:06:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:06:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:06:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:06:54 INFO - '--tppagecycles', 19:06:54 INFO - '7'], 19:06:54 INFO - 'tests': ['tsvgm']}}, 19:06:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:06:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:06:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:06:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:06:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:06:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:06:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:54 INFO - 'talos_options': ['--disable-e10s'], 19:06:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:06:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:06:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:54 INFO - 'talos_options': ['--disable-e10s'], 19:06:54 INFO - 'tests': ['damp', 'tps']}, 19:06:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:54 INFO - 'tests': ['damp', 'tps']}, 19:06:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:06:54 INFO - 'tests': ['dromaeo_dom']}, 19:06:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:06:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:06:54 INFO - 'tests': ['a11yr', 19:06:54 INFO - 'ts_paint', 19:06:54 INFO - 'tpaint', 19:06:54 INFO - 'sessionrestore', 19:06:54 INFO - 'sessionrestore_no_auto_restore', 19:06:54 INFO - 'tabpaint']}, 19:06:54 INFO - 'other-e10s': {'tests': ['a11yr', 19:06:54 INFO - 'ts_paint', 19:06:54 INFO - 'tpaint', 19:06:54 INFO - 'sessionrestore', 19:06:54 INFO - 'sessionrestore_no_auto_restore', 19:06:54 INFO - 'tabpaint']}, 19:06:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:06:54 INFO - 'ts_paint', 19:06:54 INFO - 'tpaint', 19:06:54 INFO - 'sessionrestore', 19:06:54 INFO - 'sessionrestore_no_auto_restore', 19:06:54 INFO - 'tabpaint']}, 19:06:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:06:54 INFO - 'ts_paint', 19:06:54 INFO - 'tpaint', 19:06:54 INFO - 'sessionrestore', 19:06:54 INFO - 'sessionrestore_no_auto_restore', 19:06:54 INFO - 'tabpaint']}, 19:06:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:06:54 INFO - 'tests': ['a11yr', 19:06:54 INFO - 'ts_paint', 19:06:54 INFO - 'tpaint', 19:06:54 INFO - 'sessionrestore', 19:06:54 INFO - 'sessionrestore_no_auto_restore', 19:06:54 INFO - 'tabpaint']}, 19:06:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:06:54 INFO - 'tests': ['a11yr', 19:06:54 INFO - 'ts_paint', 19:06:54 INFO - 'tpaint', 19:06:54 INFO - 'sessionrestore', 19:06:54 INFO - 'sessionrestore_no_auto_restore', 19:06:54 INFO - 'tabpaint']}, 19:06:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:06:54 INFO - 'tests': ['tsvgx', 19:06:54 INFO - 'tsvgr_opacity', 19:06:54 INFO - 'tart', 19:06:54 INFO - 'tscrollx', 19:06:54 INFO - 'cart']}, 19:06:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:06:54 INFO - 'tsvgr_opacity', 19:06:54 INFO - 'tart', 19:06:54 INFO - 'tscrollx', 19:06:54 INFO - 'cart']}, 19:06:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:54 INFO - 'talos_options': ['--disable-e10s'], 19:06:54 INFO - 'tests': ['tp5o']}, 19:06:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:54 INFO - 'tests': ['tp5o']}, 19:06:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:54 INFO - 'talos_options': ['--disable-e10s', 19:06:54 INFO - '--xperf_path', 19:06:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:06:54 INFO - 'tests': ['tp5n']}, 19:06:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:54 INFO - 'talos_options': ['--xperf_path', 19:06:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:06:54 INFO - 'tests': ['tp5n']}}, 19:06:54 INFO - 'talos.zip': {'path': '', 19:06:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:06:54 INFO - Running post-action listener: _resource_record_post_action 19:06:54 INFO - ##### 19:06:54 INFO - ##### Running create-virtualenv step. 19:06:54 INFO - ##### 19:06:54 INFO - Running pre-action listener: _resource_record_pre_action 19:06:54 INFO - Running main action method: create_virtualenv 19:06:54 INFO - Creating virtualenv /builds/slave/test/build/venv 19:06:54 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 19:06:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:06:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:06:54 INFO - Using real prefix '/usr' 19:06:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:06:55 INFO - Installing distribute.............................................................................................................................................................................................done. 19:06:57 INFO - Installing pip.................done. 19:06:57 INFO - Return code: 0 19:06:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:06: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')]} 19:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06: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')]} 19:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:57 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 0x7f8478331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdb410>, '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 0x2bdc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc7a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136', '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 19:06:57 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 19:06:57 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 19:06:57 INFO - Using env: {'DISPLAY': ':0', 19:06:57 INFO - 'HOME': '/home/cltbld', 19:06:57 INFO - 'LANG': 'en_US.UTF-8', 19:06:57 INFO - 'LANGUAGE': 'en_US:en', 19:06:57 INFO - 'LOGNAME': 'cltbld', 19:06:57 INFO - 'MAIL': '/var/mail/cltbld', 19:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:57 INFO - 'MOZ_NO_REMOTE': '1', 19:06:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:57 INFO - 'NO_EM_RESTART': '1', 19:06:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:57 INFO - 'PWD': '/builds/slave/test', 19:06:57 INFO - 'SHELL': '/bin/bash', 19:06:57 INFO - 'SHLVL': '1', 19:06:57 INFO - 'TERM': 'linux', 19:06:57 INFO - 'TMOUT': '86400', 19:06:57 INFO - 'USER': 'cltbld', 19:06:57 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136', 19:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:57 INFO - '_': '/tools/buildbot/bin/python'} 19:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:57 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 19:06:57 INFO - Cleaning up... 19:06:57 INFO - Return code: 0 19:06:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:06: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')]} 19:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06: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')]} 19:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:57 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 0x7f8478331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdb410>, '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 0x2bdc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc7a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136', '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 19:06:57 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 19:06:57 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 19:06:57 INFO - Using env: {'DISPLAY': ':0', 19:06:57 INFO - 'HOME': '/home/cltbld', 19:06:57 INFO - 'LANG': 'en_US.UTF-8', 19:06:57 INFO - 'LANGUAGE': 'en_US:en', 19:06:57 INFO - 'LOGNAME': 'cltbld', 19:06:57 INFO - 'MAIL': '/var/mail/cltbld', 19:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:57 INFO - 'MOZ_NO_REMOTE': '1', 19:06:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:57 INFO - 'NO_EM_RESTART': '1', 19:06:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:57 INFO - 'PWD': '/builds/slave/test', 19:06:57 INFO - 'SHELL': '/bin/bash', 19:06:57 INFO - 'SHLVL': '1', 19:06:57 INFO - 'TERM': 'linux', 19:06:57 INFO - 'TMOUT': '86400', 19:06:57 INFO - 'USER': 'cltbld', 19:06:57 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136', 19:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:57 INFO - '_': '/tools/buildbot/bin/python'} 19:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:57 INFO - Downloading/unpacking psutil>=0.7.1 19:06:57 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 19:06:57 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 19:06:57 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 19:06:57 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 19:06:57 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 19:06:57 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 19:06:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:06:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:06:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:06:59 INFO - Installing collected packages: psutil 19:06:59 INFO - Running setup.py install for psutil 19:06:59 INFO - building 'psutil._psutil_linux' extension 19:06:59 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 19:06:59 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 19:06:59 INFO - building 'psutil._psutil_posix' extension 19:06:59 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 19:07:00 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 19:07:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:07:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:07:00 INFO - Successfully installed psutil 19:07:00 INFO - Cleaning up... 19:07:00 INFO - Return code: 0 19:07:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:07: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')]} 19:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07: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')]} 19:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8478331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdb410>, '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 0x2bdc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc7a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136', '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 19:07:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 19:07:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:07:00 INFO - Using env: {'DISPLAY': ':0', 19:07:00 INFO - 'HOME': '/home/cltbld', 19:07:00 INFO - 'LANG': 'en_US.UTF-8', 19:07:00 INFO - 'LANGUAGE': 'en_US:en', 19:07:00 INFO - 'LOGNAME': 'cltbld', 19:07:00 INFO - 'MAIL': '/var/mail/cltbld', 19:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:00 INFO - 'MOZ_NO_REMOTE': '1', 19:07:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:00 INFO - 'NO_EM_RESTART': '1', 19:07:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:00 INFO - 'PWD': '/builds/slave/test', 19:07:00 INFO - 'SHELL': '/bin/bash', 19:07:00 INFO - 'SHLVL': '1', 19:07:00 INFO - 'TERM': 'linux', 19:07:00 INFO - 'TMOUT': '86400', 19:07:00 INFO - 'USER': 'cltbld', 19:07:00 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136', 19:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:00 INFO - '_': '/tools/buildbot/bin/python'} 19:07:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:07:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:07:02 INFO - Installing collected packages: mozsystemmonitor 19:07:02 INFO - Running setup.py install for mozsystemmonitor 19:07:02 INFO - Successfully installed mozsystemmonitor 19:07:02 INFO - Cleaning up... 19:07:02 INFO - Return code: 0 19:07:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:07:02 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')]} 19:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:02 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')]} 19:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:02 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 0x7f8478331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdb410>, '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 0x2bdc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc7a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136', '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 19:07:02 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 19:07:02 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 19:07:02 INFO - Using env: {'DISPLAY': ':0', 19:07:02 INFO - 'HOME': '/home/cltbld', 19:07:02 INFO - 'LANG': 'en_US.UTF-8', 19:07:02 INFO - 'LANGUAGE': 'en_US:en', 19:07:02 INFO - 'LOGNAME': 'cltbld', 19:07:02 INFO - 'MAIL': '/var/mail/cltbld', 19:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:02 INFO - 'MOZ_NO_REMOTE': '1', 19:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:02 INFO - 'NO_EM_RESTART': '1', 19:07:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:02 INFO - 'PWD': '/builds/slave/test', 19:07:02 INFO - 'SHELL': '/bin/bash', 19:07:02 INFO - 'SHLVL': '1', 19:07:02 INFO - 'TERM': 'linux', 19:07:02 INFO - 'TMOUT': '86400', 19:07:02 INFO - 'USER': 'cltbld', 19:07:02 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136', 19:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:02 INFO - '_': '/tools/buildbot/bin/python'} 19:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:02 INFO - Downloading/unpacking blobuploader==1.2.4 19:07: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 19:07: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 19:07: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 19:07: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 19:07: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 19:07: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 19:07:04 INFO - Downloading blobuploader-1.2.4.tar.gz 19:07:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:07:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:07:04 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 19:07:04 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 19:07:04 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 19:07:04 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 19:07:04 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 19:07:04 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 19:07:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:07:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:07: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 19:07: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 19:07: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 19:07: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 19:07: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 19:07: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 19:07:05 INFO - Downloading docopt-0.6.1.tar.gz 19:07:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:07:05 INFO - Installing collected packages: blobuploader, requests, docopt 19:07:05 INFO - Running setup.py install for blobuploader 19:07:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:07:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:07:05 INFO - Running setup.py install for requests 19:07:05 INFO - Running setup.py install for docopt 19:07:05 INFO - Successfully installed blobuploader requests docopt 19:07:05 INFO - Cleaning up... 19:07:06 INFO - Return code: 0 19:07:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:07:06 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')]} 19:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:06 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')]} 19:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:06 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 0x7f8478331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdb410>, '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 0x2bdc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc7a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136', '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 19:07:06 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 19:07:06 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 19:07:06 INFO - Using env: {'DISPLAY': ':0', 19:07:06 INFO - 'HOME': '/home/cltbld', 19:07:06 INFO - 'LANG': 'en_US.UTF-8', 19:07:06 INFO - 'LANGUAGE': 'en_US:en', 19:07:06 INFO - 'LOGNAME': 'cltbld', 19:07:06 INFO - 'MAIL': '/var/mail/cltbld', 19:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:06 INFO - 'MOZ_NO_REMOTE': '1', 19:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:06 INFO - 'NO_EM_RESTART': '1', 19:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:06 INFO - 'PWD': '/builds/slave/test', 19:07:06 INFO - 'SHELL': '/bin/bash', 19:07:06 INFO - 'SHLVL': '1', 19:07:06 INFO - 'TERM': 'linux', 19:07:06 INFO - 'TMOUT': '86400', 19:07:06 INFO - 'USER': 'cltbld', 19:07:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136', 19:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:06 INFO - '_': '/tools/buildbot/bin/python'} 19:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:07:06 INFO - Running setup.py (path:/tmp/pip-qGrMtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:07:06 INFO - Running setup.py (path:/tmp/pip-3X8LAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:07:06 INFO - Running setup.py (path:/tmp/pip-GWbK7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:07:06 INFO - Running setup.py (path:/tmp/pip-r8xoe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:07:06 INFO - Running setup.py (path:/tmp/pip-1ehFeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:07:06 INFO - Running setup.py (path:/tmp/pip-vcDlZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:07:06 INFO - Running setup.py (path:/tmp/pip-3P0Jdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:07:06 INFO - Running setup.py (path:/tmp/pip-67wBmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:07:06 INFO - Running setup.py (path:/tmp/pip-nljpTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:07:06 INFO - Running setup.py (path:/tmp/pip-6JpStT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:07:06 INFO - Running setup.py (path:/tmp/pip-NsdOrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:07:07 INFO - Running setup.py (path:/tmp/pip-i6036w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:07:07 INFO - Running setup.py (path:/tmp/pip-8C4i4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:07:07 INFO - Running setup.py (path:/tmp/pip-tNqLXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:07:07 INFO - Running setup.py (path:/tmp/pip-sStzNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:07:07 INFO - Running setup.py (path:/tmp/pip-DMAsH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:07:07 INFO - Running setup.py (path:/tmp/pip-KlxPto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:07:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:07:07 INFO - Running setup.py install for manifestparser 19:07:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:07:07 INFO - Running setup.py install for mozcrash 19:07:07 INFO - Running setup.py install for mozdebug 19:07:07 INFO - Running setup.py install for mozdevice 19:07:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:07:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:07:07 INFO - Running setup.py install for mozfile 19:07:07 INFO - Running setup.py install for mozhttpd 19:07:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:07:08 INFO - Running setup.py install for mozinfo 19:07:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:07:08 INFO - Running setup.py install for mozInstall 19:07:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:07:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:07:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:07:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:07:08 INFO - Running setup.py install for mozleak 19:07:08 INFO - Running setup.py install for mozlog 19:07:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:07:08 INFO - Running setup.py install for moznetwork 19:07:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:07:08 INFO - Running setup.py install for mozprocess 19:07:08 INFO - Running setup.py install for mozprofile 19:07:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:07:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:07:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:07:08 INFO - Running setup.py install for mozrunner 19:07:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:07:08 INFO - Running setup.py install for mozscreenshot 19:07:09 INFO - Running setup.py install for moztest 19:07:09 INFO - Running setup.py install for mozversion 19:07:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:07:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:07:09 INFO - Cleaning up... 19:07:09 INFO - Return code: 0 19:07:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:07:09 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')]} 19:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:09 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')]} 19:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:09 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 0x7f8478331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdb410>, '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 0x2bdc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc7a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136', '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 19:07:09 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 19:07:09 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 19:07:09 INFO - Using env: {'DISPLAY': ':0', 19:07:09 INFO - 'HOME': '/home/cltbld', 19:07:09 INFO - 'LANG': 'en_US.UTF-8', 19:07:09 INFO - 'LANGUAGE': 'en_US:en', 19:07:09 INFO - 'LOGNAME': 'cltbld', 19:07:09 INFO - 'MAIL': '/var/mail/cltbld', 19:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:09 INFO - 'MOZ_NO_REMOTE': '1', 19:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:09 INFO - 'NO_EM_RESTART': '1', 19:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:09 INFO - 'PWD': '/builds/slave/test', 19:07:09 INFO - 'SHELL': '/bin/bash', 19:07:09 INFO - 'SHLVL': '1', 19:07:09 INFO - 'TERM': 'linux', 19:07:09 INFO - 'TMOUT': '86400', 19:07:09 INFO - 'USER': 'cltbld', 19:07:09 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136', 19:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:09 INFO - '_': '/tools/buildbot/bin/python'} 19:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:07:09 INFO - Running setup.py (path:/tmp/pip-b8LmUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:07:09 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)) 19:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:07:09 INFO - Running setup.py (path:/tmp/pip-CGOHy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:07:09 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)) 19:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:07:09 INFO - Running setup.py (path:/tmp/pip-zC8luW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:07:09 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)) 19:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:07:09 INFO - Running setup.py (path:/tmp/pip-ZRW_kR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:07:09 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)) 19:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:07:09 INFO - Running setup.py (path:/tmp/pip-jkf2cD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:07:09 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)) 19:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:07:09 INFO - Running setup.py (path:/tmp/pip-Txn2Ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:07:09 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)) 19:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:07:09 INFO - Running setup.py (path:/tmp/pip-rjIsFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:07:09 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)) 19:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:07:09 INFO - Running setup.py (path:/tmp/pip-OIYCRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:07:10 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)) 19:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:07:10 INFO - Running setup.py (path:/tmp/pip-bYlWUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:07:10 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)) 19:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:07:10 INFO - Running setup.py (path:/tmp/pip-k1wJg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:07:10 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)) 19:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:07:10 INFO - Running setup.py (path:/tmp/pip-ae7Cnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:07:10 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)) 19:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:07:10 INFO - Running setup.py (path:/tmp/pip-k3Uf5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:07:10 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)) 19:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:07:10 INFO - Running setup.py (path:/tmp/pip-ETN5iV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:07:10 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)) 19:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:07:10 INFO - Running setup.py (path:/tmp/pip-l5QH5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:07:10 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)) 19:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:07:10 INFO - Running setup.py (path:/tmp/pip-PUMfQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:07:10 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)) 19:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:07:10 INFO - Running setup.py (path:/tmp/pip-12uIVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:07:10 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)) 19:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:07:10 INFO - Running setup.py (path:/tmp/pip-2yvGCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:07:10 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)) 19:07:10 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)) 19:07:10 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)) 19:07:10 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)) 19:07:10 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)) 19:07:10 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)) 19:07:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:07:10 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 19:07:10 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 19:07:10 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 19:07:10 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 19:07:10 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 19:07:10 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 19:07:12 INFO - Downloading blessings-1.6.tar.gz 19:07:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:07:12 INFO - Installing collected packages: blessings 19:07:12 INFO - Running setup.py install for blessings 19:07:12 INFO - Successfully installed blessings 19:07:12 INFO - Cleaning up... 19:07:12 INFO - Return code: 0 19:07:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:07:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:07:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:07:13 INFO - Reading from file tmpfile_stdout 19:07:13 INFO - Current package versions: 19:07:13 INFO - argparse == 1.2.1 19:07:13 INFO - blessings == 1.6 19:07:13 INFO - blobuploader == 1.2.4 19:07:13 INFO - docopt == 0.6.1 19:07:13 INFO - manifestparser == 1.1 19:07:13 INFO - mozInstall == 1.12 19:07:13 INFO - mozcrash == 0.17 19:07:13 INFO - mozdebug == 0.1 19:07:13 INFO - mozdevice == 0.48 19:07:13 INFO - mozfile == 1.2 19:07:13 INFO - mozhttpd == 0.7 19:07:13 INFO - mozinfo == 0.9 19:07:13 INFO - mozleak == 0.1 19:07:13 INFO - mozlog == 3.1 19:07:13 INFO - moznetwork == 0.27 19:07:13 INFO - mozprocess == 0.22 19:07:13 INFO - mozprofile == 0.28 19:07:13 INFO - mozrunner == 6.11 19:07:13 INFO - mozscreenshot == 0.1 19:07:13 INFO - mozsystemmonitor == 0.0 19:07:13 INFO - moztest == 0.7 19:07:13 INFO - mozversion == 1.4 19:07:13 INFO - psutil == 3.1.1 19:07:13 INFO - requests == 1.2.3 19:07:13 INFO - wsgiref == 0.1.2 19:07:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:07:13 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')]} 19:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:13 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')]} 19:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:13 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 0x7f8478331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdb410>, '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 0x2bdc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc7a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136', '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 19:07:13 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 19:07:13 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 19:07:13 INFO - Using env: {'DISPLAY': ':0', 19:07:13 INFO - 'HOME': '/home/cltbld', 19:07:13 INFO - 'LANG': 'en_US.UTF-8', 19:07:13 INFO - 'LANGUAGE': 'en_US:en', 19:07:13 INFO - 'LOGNAME': 'cltbld', 19:07:13 INFO - 'MAIL': '/var/mail/cltbld', 19:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:13 INFO - 'MOZ_NO_REMOTE': '1', 19:07:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:13 INFO - 'NO_EM_RESTART': '1', 19:07:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:13 INFO - 'PWD': '/builds/slave/test', 19:07:13 INFO - 'SHELL': '/bin/bash', 19:07:13 INFO - 'SHLVL': '1', 19:07:13 INFO - 'TERM': 'linux', 19:07:13 INFO - 'TMOUT': '86400', 19:07:13 INFO - 'USER': 'cltbld', 19:07:13 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136', 19:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:13 INFO - '_': '/tools/buildbot/bin/python'} 19:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:13 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)) 19:07:13 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)) 19:07:13 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)) 19:07:13 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)) 19:07:13 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)) 19:07:13 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)) 19:07:13 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)) 19:07:13 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)) 19:07:13 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)) 19:07:13 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)) 19:07:13 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)) 19:07:13 INFO - Cleaning up... 19:07:13 INFO - Return code: 0 19:07:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:07:13 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')]} 19:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:13 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')]} 19:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:13 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 0x7f8478331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdb410>, '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 0x2bdc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc7a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136', '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 19:07:13 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 19:07:13 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 19:07:13 INFO - Using env: {'DISPLAY': ':0', 19:07:13 INFO - 'HOME': '/home/cltbld', 19:07:13 INFO - 'LANG': 'en_US.UTF-8', 19:07:13 INFO - 'LANGUAGE': 'en_US:en', 19:07:13 INFO - 'LOGNAME': 'cltbld', 19:07:13 INFO - 'MAIL': '/var/mail/cltbld', 19:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:13 INFO - 'MOZ_NO_REMOTE': '1', 19:07:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:13 INFO - 'NO_EM_RESTART': '1', 19:07:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:13 INFO - 'PWD': '/builds/slave/test', 19:07:13 INFO - 'SHELL': '/bin/bash', 19:07:13 INFO - 'SHLVL': '1', 19:07:13 INFO - 'TERM': 'linux', 19:07:13 INFO - 'TMOUT': '86400', 19:07:13 INFO - 'USER': 'cltbld', 19:07:13 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136', 19:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:13 INFO - '_': '/tools/buildbot/bin/python'} 19:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:13 INFO - Downloading/unpacking jsonschema 19:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:13 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 19:07:13 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 19:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:07:15 INFO - Downloading/unpacking functools32 (from jsonschema) 19:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:15 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 19:07:15 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 19:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:15 INFO - Downloading functools32-3.2.3-2.tar.gz 19:07:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:07:15 INFO - warning: no files found matching '*.txt' 19:07:15 INFO - no previously-included directories found matching 'build' 19:07:15 INFO - no previously-included directories found matching 'dist' 19:07:15 INFO - no previously-included directories found matching '.git*' 19:07:15 INFO - Installing collected packages: jsonschema, functools32 19:07:15 INFO - Running setup.py install for functools32 19:07:15 INFO - warning: no files found matching '*.txt' 19:07:15 INFO - no previously-included directories found matching 'build' 19:07:15 INFO - no previously-included directories found matching 'dist' 19:07:15 INFO - no previously-included directories found matching '.git*' 19:07:15 INFO - Successfully installed jsonschema functools32 19:07:15 INFO - Cleaning up... 19:07:15 INFO - Return code: 0 19:07:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:07:15 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')]} 19:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:15 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')]} 19:07:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:15 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 0x7f8478331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdb410>, '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 0x2bdc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc7a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136', '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 19:07:15 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 19:07:15 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 19:07:15 INFO - Using env: {'DISPLAY': ':0', 19:07:15 INFO - 'HOME': '/home/cltbld', 19:07:15 INFO - 'LANG': 'en_US.UTF-8', 19:07:15 INFO - 'LANGUAGE': 'en_US:en', 19:07:15 INFO - 'LOGNAME': 'cltbld', 19:07:15 INFO - 'MAIL': '/var/mail/cltbld', 19:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:15 INFO - 'MOZ_NO_REMOTE': '1', 19:07:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:15 INFO - 'NO_EM_RESTART': '1', 19:07:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:15 INFO - 'PWD': '/builds/slave/test', 19:07:15 INFO - 'SHELL': '/bin/bash', 19:07:15 INFO - 'SHLVL': '1', 19:07:15 INFO - 'TERM': 'linux', 19:07:15 INFO - 'TMOUT': '86400', 19:07:15 INFO - 'USER': 'cltbld', 19:07:15 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136', 19:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:15 INFO - '_': '/tools/buildbot/bin/python'} 19:07:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:16 INFO - Downloading/unpacking flake8 19:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:16 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 19:07:16 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 19:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:07:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:07:17 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 19:07:17 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 19:07:17 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 19:07:17 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 19:07:17 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 19:07:17 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 19:07:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:07:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:07:18 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 19:07:18 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 19:07:18 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 19:07:18 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 19:07:18 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 19:07:18 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 19:07:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:07:18 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 19:07:18 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 19:07:18 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 19:07:18 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 19:07:18 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 19:07:18 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 19:07:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:07:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:07:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:07:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:07:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:07:18 INFO - no previously-included directories found matching 'docs/_build' 19:07:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:07:18 INFO - Running setup.py install for pep8 19:07:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:07:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:07:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:07:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:07:18 INFO - no previously-included directories found matching 'docs/_build' 19:07:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:07:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:07:18 INFO - Cleaning up... 19:07:18 INFO - Return code: 0 19:07:18 INFO - Running post-action listener: _resource_record_post_action 19:07:18 INFO - Running post-action listener: _start_resource_monitoring 19:07:18 INFO - Starting resource monitoring. 19:07:18 INFO - ##### 19:07:18 INFO - ##### Running install step. 19:07:18 INFO - ##### 19:07:18 INFO - Running pre-action listener: _resource_record_pre_action 19:07:18 INFO - Running main action method: install 19:07:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:07:19 INFO - Reading from file tmpfile_stdout 19:07:19 INFO - Detecting whether we're running mozinstall >=1.0... 19:07:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:07:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:07:19 INFO - Reading from file tmpfile_stdout 19:07:19 INFO - Output received: 19:07:19 INFO - Usage: mozinstall [options] installer 19:07:19 INFO - Options: 19:07:19 INFO - -h, --help show this help message and exit 19:07:19 INFO - -d DEST, --destination=DEST 19:07:19 INFO - Directory to install application into. [default: 19:07:19 INFO - "/builds/slave/test"] 19:07:19 INFO - --app=APP Application being installed. [default: firefox] 19:07:19 INFO - mkdir: /builds/slave/test/build/application 19:07:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:07:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:07:34 INFO - Reading from file tmpfile_stdout 19:07:34 INFO - Output received: 19:07:34 INFO - /builds/slave/test/build/application/firefox/firefox 19:07:34 INFO - Running post-action listener: _resource_record_post_action 19:07:34 INFO - ##### 19:07:34 INFO - ##### Running run-tests step. 19:07:34 INFO - ##### 19:07:34 INFO - Running pre-action listener: _resource_record_pre_action 19:07:34 INFO - Running main action method: run_tests 19:07:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:07:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:07:34 INFO - Python 2.7.3 19:07:34 INFO - Return code: 0 19:07:34 INFO - grabbing minidump binary from tooltool 19:07: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')]} 19:07:34 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 0x2bdb410>, '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 0x2bdc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:07:34 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 19:07:34 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 19:07:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:07:34 INFO - Return code: 0 19:07:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:07:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:07:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:07:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:07:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:07:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:07:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:07:35 INFO - Return code: 0 19:07:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 19:07:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 19:07:35 INFO - Using env: {'DISPLAY': ':0', 19:07:35 INFO - 'HOME': '/home/cltbld', 19:07:35 INFO - 'LANG': 'en_US.UTF-8', 19:07:35 INFO - 'LANGUAGE': 'en_US:en', 19:07:35 INFO - 'LOGNAME': 'cltbld', 19:07:35 INFO - 'MAIL': '/var/mail/cltbld', 19:07:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:07:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:35 INFO - 'MOZ_NO_REMOTE': '1', 19:07:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:07:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:35 INFO - 'NO_EM_RESTART': '1', 19:07:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:35 INFO - 'PWD': '/builds/slave/test', 19:07:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:07:35 INFO - 'SHELL': '/bin/bash', 19:07:35 INFO - 'SHLVL': '1', 19:07:35 INFO - 'TERM': 'linux', 19:07:35 INFO - 'TMOUT': '86400', 19:07:35 INFO - 'USER': 'cltbld', 19:07:35 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136', 19:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:35 INFO - '_': '/tools/buildbot/bin/python'} 19:07:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 19:07:36 INFO - mozversion application_buildid: 20160520162336 19:07:36 INFO - mozversion application_changeset: 782b4767770b8d7f9ddea913167c49a12087d6af 19:07:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:07:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:07:36 INFO - mozversion application_name: Firefox 19:07:36 INFO - mozversion application_remotingname: firefox-dev 19:07:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:07:36 INFO - mozversion application_vendor: Mozilla 19:07:36 INFO - mozversion application_version: 48.0a2 19:07:36 INFO - mozversion platform_buildid: 20160520162336 19:07:36 INFO - mozversion platform_changeset: 782b4767770b8d7f9ddea913167c49a12087d6af 19:07:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:07:36 INFO - mozversion platform_version: 48.0a2 19:07:36 INFO - using testdate: 1463796456 19:07:36 INFO - actual date: 1463796456 19:07:36 INFO - starting webserver on 'localhost:39006' 19:07:36 INFO - SUITE-START | Running 2 tests 19:07:36 INFO - TEST-START | dromaeo_css 19:07:36 INFO - operating with platform_type : linux_ 19:07:36 INFO - Initialising browser for dromaeo_css test... 19:07:36 INFO - TEST-INFO | started process 27169 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7_usUY/profile http://localhost:39006/getInfo.html) 19:07:40 INFO - PROCESS | 27169 | __metrics Screen width/height:1600/1200 19:07:40 INFO - PROCESS | 27169 | colorDepth:24 19:07:40 INFO - PROCESS | 27169 | Browser inner width/height: 1024/697 19:07:40 INFO - PROCESS | 27169 | __metrics 19:07:41 ERROR - PROCESS | 27169 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:07:42 INFO - TEST-INFO | 27169: exit 0 19:07:42 INFO - Browser initialized. 19:07:42 INFO - Running cycle 1/1 for dromaeo_css test... 19:07:42 INFO - TEST-INFO | started process 27261 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7_usUY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:07:54 INFO - PROCESS | 27261 | RSS: Main: 141934592 19:07:54 INFO - PROCESS | 27261 | 19:08:45 INFO - PROCESS | 27261 | 1463796525316 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] 19:10:52 INFO - PROCESS | 27261 | Cycle 1(1): loaded http://localhost:39006/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39006/tests/dromaeo/cssquery-ext.html) 19:10:53 INFO - PROCESS | 27261 | RSS: Main: 254861312 19:10:53 INFO - PROCESS | 27261 | 19:13:56 INFO - PROCESS | 27261 | Cycle 1(1): loaded http://localhost:39006/tests/dromaeo/cssquery-ext.html (next: http://localhost:39006/tests/dromaeo/cssquery-jquery.html) 19:13:56 INFO - PROCESS | 27261 | RSS: Main: 223277056 19:13:56 INFO - PROCESS | 27261 | 19:16:58 INFO - PROCESS | 27261 | Cycle 1(1): loaded http://localhost:39006/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39006/tests/dromaeo/cssquery-mootools.html) 19:16:59 INFO - PROCESS | 27261 | RSS: Main: 220532736 19:16:59 INFO - PROCESS | 27261 | 19:20:01 INFO - PROCESS | 27261 | Cycle 1(1): loaded http://localhost:39006/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39006/tests/dromaeo/cssquery-prototype.html) 19:20:01 INFO - PROCESS | 27261 | RSS: Main: 219258880 19:20:01 INFO - PROCESS | 27261 | 19:23:04 INFO - PROCESS | 27261 | Cycle 1(1): loaded http://localhost:39006/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39006/tests/dromaeo/cssquery-yui.html) 19:23:04 INFO - PROCESS | 27261 | RSS: Main: 215511040 19:23:04 INFO - PROCESS | 27261 | 19:26:07 INFO - PROCESS | 27261 | Cycle 1(1): loaded http://localhost:39006/tests/dromaeo/cssquery-yui.html (next: http://localhost:39006/tests/dromaeo/cssquery-dojo.html) 19:26:07 INFO - PROCESS | 27261 | RSS: Main: 257359872 19:26:07 INFO - PROCESS | 27261 | 19:26:07 INFO - PROCESS | 27261 | __start_tp_report 19:26:07 INFO - PROCESS | 27261 | _x_x_mozilla_page_load 19:26:07 INFO - PROCESS | 27261 | _x_x_mozilla_page_load_details 19:26:07 INFO - PROCESS | 27261 | |i|pagename|runs| 19:26:07 INFO - PROCESS | 27261 | |0;dojo.html;3283.934321313574;3331.7001469867705;3345.715614172795;3354.4800555913844;3384.949225761614;5402.054640437927;5404.91892621611;5411.729413529322;5438.048341540224;5445.428230035848;5412.431694672052;5439.5376393006545;5443.782248710057;5463.2078348639525;5485.396606373296;4858;4894.09459250039;4979.626528010395;5021.723805190713;5072.543471087602;4866.58634016109;4918.065567542156;4919.13915064864;4921.458639549646;4924.039812236615;4842.61259099273;4902.0931127741305;4915.950840491585;4926.9753651231695;4941.308216849644;5035.597152227813;5043.621728370387;5064.544191022789;5072;5098.9235161472425;4773.06925149596;4814.66297359185;4887.780049897763;4978.751062446863;5001.774920128603;5378.112611419111;5403.054465468527;5416.91874621881;5424.5660347172525;5425.3489581250105;5840.15317778924;5881.441263080001;5886.381929897342;5889.911651325234;5893.5579831512805;5783.479486846162;5886.234789477383;5900.43945825146;5926.496247818941;5939.613925094898;5491.28613280271;5523.7238138093335;5534.695591742453;5545.279113715191;5553.139263414178;5896.616719913192;6039.63762174271;6040.305364883095;6047.123167140828;6052.092186172022;5661.405552416937;5728.828135155952;5732.398098199712;5737.3115226172295;5738.512226460714;5864.2083318752275;5886.8822623547285;5890.764369425261;5898.026825573818;5912.23140991677;5664.490195882308;5716.342620598684;5840.094785308199;5862;5865.677387743715;5822.679752613562;5857.970710146422;5869.501092407193;5876.206712093813;5895.115732640053;4481.395011673448;4492.236319825637;4494.078713863715;4496.280595104768;4520.819167233274;3977.2244412339896;3980.522337319482;4025.456563363967;4034.435179074932;4064.1871625674985;5599.384067752544;5623.325200975827;5626;5627.718614069362;5636.549076073986;5918;5924.437178468039;5924.763009479572;5925.585209035412;5929.3181284152015;5390.865228369244;5610.579206559524;5626.43735626434;5699.458551437607;5721;5039;5062.594992400599;5075;5077.035363280965;5104;6080.179175811298;6081.300650425169;6081.483073938676;6084.726187321581;6091.786787462506;5738.08190689496;5909.645421274738;5971.253593300838;6008.54935879802;6010;6129.816105516842;6156.384361563808;6158.3225845157895;6160.722767475385;6165.691715414301;5690.3456102548735;5855.3266374365785;5857.853553661193;5864.32560255576;5864.765409383577;5912.260967379078;5959.970200148971;5968.104784282393;5974.103884417198;6009.128676341818;5743.712814359349;5764.510016648464;5770.365259821332;5773.3072031356505;5780;5590.273264475592;5724.8282551523525;5726.713664316851;5727.971360143172;5802.94197058024;5748.109043098327;5777.364489906023;5780.190773291826;5781.884362312814;5819.534437244925;5892.469677729025;5893.469587737124;5898.085796701518;5903.675297858659;5910.290765108214;5466;5540.168974653834;5548.195511650869;5780.21967034445;5798.217240672624 19:26:07 INFO - PROCESS | 27261 | |1;ext.html;658.0885473619036;669.9548704021727;671.5936858200788;672.9495287853406;735.4043224987761;32088;32482;32487.67512324876;32497.837510812413;32519.67480325196;32796.344073118584;39029.609703902956;39656.80171599145;39876.601233987654;39895.40156897641;8839.734807955756;8980.820383592325;8984.775380615472;8987;8990.28077753778;8228;8821.029686734453;8935.77660558488;8945.105489451067;10740;10664.413457259847;10760.40817755023;10767.784644307108;10769.438431427438;10786.191035672317;10546.103581195608;10611.204159688054;10620.362778233331;10628.840567391495;10633.202509811796;8198.221168988937;10256.384616922935;10409.739756506073;10413.479326033668;10434;39617.20765584701;39897.40153897694;40030.59969400298;40204.79897600493;40302.39546406806;3823.8470461181796;3854.9057684168765;3915.725899187058;3949.407588861665;3950.9012274693077;33789.32421351559;34466.82766586151;34615.65384346175;34705.65294347075;35063.4740478893;4560.247559152735;4643.442786865598;4680.672352935296;4704.364910737041;4754.02542478791;269965;272671;272800;273223;273294;41832;63695.681521592094;64539.35460645334;64795.35204647893;70321;41819;41979.7901010493;42004;42141.57858421438;42198.367024494655;17723.645527089386;18065.819341806415;18098.547536311697;18102.90948545249;18108.547286317684;15097;15181.392744290104;15238;15242.847571524142;15252.542423727306;8882.733517994471;9062.637494500277;9329.253659707207;9551.856722149174;9556.761080972892;3591.2278860045217;3661.0847288177956;3674.6692797647806;3708.2583483303447;3725.3480640887738;1066.6906597086759;1139.9487023083982;1142.5147308498917;1168.0655475619471;1234.7468768902354;32476.512852307234;33221.33557328888;33253.66746332554;33851;33961.32077358439;1176.2942234659135;1215.7203843115956;1230.4708975140775;1269.032998851776;1315.6579289384638;15809;16137.838621613868;16187.757183642254;16341.673166536602;16523.752143717855;572662;580057;580060;581110;582351;58513.12230316549;59670.403295966484;59751.40248597545;59954;59967;1387.195426652539;1490.9701805964037;1519.2631573686754;1526.5267766992047;1592.1402442680824;29623;30363.392732145676;30535.389292214477;33578.99263022113;36453;58951.705241473515;59745.103823443555;59929.20212393635;59944.40055599388;60174.39825601688;489465;492444;493190;495421;499197;39812.40281395723;39927.80036099801;47872.521274788196;48587;48894.75552622214;43865.78067109644;43882.56117438785;44093;44151.11697766091;44884.551154488036;39623.80188099041;39791;39984.4002339971;40459.39310910398;41446.79276603598;39482.80258598689;39837.40243896402;40422.79788601038;40776.79611601923;40842.591574083875;40506.1898762029;41402.792986034874;42172;42724.1455170901;42763;34133.65866341305;36122.45816312705;36341.9109375706;36499;36721.44917826181;28092.578611320438;28183.859080704464;28485.287867803472;28746.568801468413;30616.693833061385 19:26:07 INFO - PROCESS | 27261 | |2;jquery.html;421.8354841611772;424.3168498717063;428.8434721326715;433.25912689301293;436.4631503251001;14816.6295842604;18571.62856742866;19048.714269285938;19195.808041919576;21142.89428552855;15216.771748423782;19132.61734765304;19584.70622940657;19920.70118948217;20189.19243230269;5574.386817450088;5640.717964101799;5642.746076426571;5736.885262294752;5741.167530708045;5646.6894320812335;5662.915056274159;5682.971585142089;5686.744096515646;5694;4197.454330936974;5970.104484327364;6190.380961903797;6198.628082315053;6204.410580994799;6112.786052488142;6137.018077107664;6141.201643786279;6149.477294430001;6195.287541932667;5576.247206627135;5654.095344744821;5690.971545142248;5692.601517893749;5703.116017017369;23092.65361019586;23390.415239618975;23463.7653623465;24300.513989720283;24399.512009759885;2714.687810901732;2733.5489644208683;2747.8213916095588;2759.820611660256;3093.254421417439;14418.783718244234;15009.849901500955;15143.545693629208;15215.923920380328;15499.380024798995;1998.2306811877386;2059.577786553753;2131.9786802131935;2163.0806907064593;2242.428180813882;68930.31069689339;70745.2925470749;71083.64458177728;71854.28145718528;72195.63902180508;11202.495887685074;11243.60647377338;11320.830187547193;11337.1497137715;11387.829182562267;15223.31495082724;15277.923610381877;15422.460213892684;15442.382304707911;15502.457413990682;8352.373571982125;8461.576921154041;8468;8527.317814574819;8755.824883502422;8613.612387442456;8617.09520500351;8640.870386944202;8698.521581312962;8747.737567872973;4622.722636641745;4855.6601037927;4884.072026314989;5070.264811602297;5094.4141423736;1856.1832793570786;1977.3686708465573;2003.4790954351975;2051.589682063593;2062.5359294158993;975.2149519636761;1040.7398150462384;1061.2147011211803;1076.1390887290293;1082;19317.51706207356;19470.70793938092;19473.513162170777;19653;19681.456200227578;1099.2415233488866;1114.147677027075;1118.0217309853879;1125.442905761637;1131.1120770195357;10834.512446939907;11214.663560093048;11231.887681123248;11240.49417776202;11402.486888090056;480046;484356;491249;491251;493292;87147;89031;90334.54832725794;90794;91926.54036729774;1095.7151140703315;1153.342594721001;1162.7906976744098;1165.685264978451;1167.4046236419488;17243.65512689714;17355.56611084733;17461.30154793794;17549.473515794547;17713.202905869526;40008.599914000486;40193.39709904295;41209.1758164841;41675.16649667051;41703.165936681704;58756;59786.10320845104;60179;60379.69810151097;60440.395596043476;8875.955620222116;8915.28677705769;9090.954545227496;9192.95403522978;9211.078892110736;9841.557129929313;13147.211167329991;13342.666433339244;13421.261830599411;13639.181649101085;11217.71955701114;11800.586979455678;11827.231229970024;11983.520659173535;12135.514579416724;9685.951570242103;11818.76362472763;11949.10381721357;11972.521099156285;12199.87800122023;11641.952224299854;11942.223755455867;12209.877901220874;12293.262404255773;12436;8896.110388961051;8961.462312261285;8999;9100.180983711498;9172.724818255463;9163.86254206174;11116.722081948015;11901.76196476083;12008.219465734699;12146.453409596767 19:26:07 INFO - PROCESS | 27261 | |3;mootools.html;1403.2492616450188;1548.063421629914;1553.386412367115;1774.183875417308;1902.628987347467;7168.569885806855;7868.055833300004;7986.081600615931;7991.081025682041;8000.759977200693;7892.56590887501;7995.680172793096;8053.43625946184;8076.71731489398;8083.151269116732;2087.926922557711;2345.6129738593113;2367.2188177901294;2389.761023897605;2405.7714517120935;2400.303911865557;2407.4583218775724;2408.4821763320883;2409.915652952147;2411.8794060297005;2268.8411811173223;2333.0317918063984;2333.125078095714;2334.4163959010248;2336.042222688698;2029.1578994717174;2309.08791027544;2373.074500944633;2374.442006128558;2376.334626304646;2338.5089131282452;2346.0733010460945;2351.5179388225374;2351.6825228594093;2392.784649381564;8058.153893841121;8107.473014254114;8110;8137.918620813834;8149.7147599833725;4965.826196083156;5038.672486288379;5039.420466646346;5042.218456139304;5056.62075344347;3364.5794275715534;3446.4485682290965;3456.8962931112105;3478.339115568034;3515;1131.8132508136148;1153.5674122204173;1157.346099453806;1175.9706007349798;1192.201225179132;11120.888791112147;11189.552417903275;11191.66425007243;11196.944015279953;11221.270617409842;4473.329000649928;4485.192665320208;4528.705634133837;4576;4581.152486789888;9643.132118109404;9648.71053868385;9651.517424128766;9652.613895444103;9665;4581.060882519076;5178.663386879841;5184.533391994739;5203.895922081537;5207.973960130175;4522.796474158671;4581.221192397301;4591.288350305708;4591.609713174351;4607.516210797885;3866.304065268279;3948.605139486086;3976.900577485586;3977.4033894915992;4011.8997025074023;1295.7019885426405;1299.2529295655036;1299.9415026323838;1304.4651692806094;1311.5999620115956;973.6786860336072;1004.1364426593124;1019.4189312092036;1053.2416660004785;1060.1677683018793;5723.942760572341;5753.050746626844;5762.423757624204;5779.2775903012125;5915.231019967377;984.8670429491926;1016.0905989139826;1029.5675816157232;1037.0200160847926;1043.7338478687886;3893.0851249956236;3900.8244628991765;3908.785016824102;3938.960610393917;3948.9210215796097;9815.656452024145;10028.097471227624;10054.296199266128;10082.546285417175;10091.69724908254;9675.951620241854;10120.645777397756;10146;10157.644482443078;10187.847182292124;7895.249951254506;7922.088959769585;7946.125926148119;7972.083210430758;7977.960110199528;5431.212474191141;5481.698506582016;5494.945050549443;5627.268455100811;5628.352739435018;8500.107488713596;8629.654813807629;8720.73837784842;8733;8805.339599529932;8570.65717371323;8856.512891790755;8864.601092950961;8911.197992180734;8935.285177185939;6489.123968264224;6771.864562708817;6927.965360173167;7139.357457828821;7239.095113110861;7628;7692.38460923136;7707.730229441942;7756.767296981099;7773.183815699496;6772.085768421397;6917.896231556631;6933.549319294431;7029.5430796998035;7051;6983.615901125487;6985.301469852974;7016.964915175391;7103.786886393416;7115.85768284621;6441.742330306735;6486.578372405778;6490.935090649222;6718.496112791658;6721.294264102199;4942.061008408391;4963.553280204799;4964.826231081895;4989.525995030466;5024.84925452237;5099.617528685438;5113;5160.896782064413;5175.068487672255;5241.397239317374 19:26:07 INFO - PROCESS | 27261 | |4;prototype.html;353.73116431512057;355.5644335688781;356.60060731980184;364.3259969057246;364.8394706329217;6118.357572454889;6219.036049412337;6255.468285195764;6258.655773932432;6265.3421390754;6156.384361563842;6184.474319682821;6186.443220110189;6186.659733714644;6192.876142477147;4497.9325310120375;4632.559906808848;4699.7415142167165;4712.104700106968;4716.57550820427;4752.76236188191;4761.952380476203;4762.809487620491;4765.0946320199055;4768.952310476903;4666.346711460398;4700.3889494365685;4705.694129881546;4707.435107787071;4714.764261786914;4478.910421791578;4570.657200709927;4704.153252414564;4707.693999889996;4711.081339138869;4134.4831896013;4138.296489596776;4144.088300573899;4144.171165766858;4170.270202714543;5932.9406705932815;5933.762649494015;5944.97027514864;5950.489211365315;5968.7015649217365;5516.724163791834;5519.530839878616;5522.502974732253;5533.142362933751;5533.557315414757;6528.608283503005;6529.183852018497;6532.836679083013;6538.509611779135;6539.476841852688;4559.6580256480565;4638.1883170445035;4647.1170477609485;4649.95350046502;4653.976730116327;6774.695138718769;6846.144231971004;6849.520533562652;6851.588904665686;6853.143357080365;4753.83361582343;4775.617950563947;4777.116233496814;4786.712797232177;4790.568848803624;4842.685225460334;4844.709317440965;4845.152098382769;4850.660453768273;4853.587445067138;5528.9723551381985;5531.612787104945;5532.834014979557;5534.252875861707;5541.667499950016;6468.676566171673;6554.541182117206;6607.80176594703;6609.702563384659;6619.437347825393;1686.2833295849216;1690.7548405481136;1701.6896989318402;1705.0536951991764;1706.0446150155951;1126.4255229832681;1129.0854407929603;1142.9885701142882;1155.7861795567846;1159.7738441003924;6258.530610204253;6325.652089135142;6421.357864213542;6470.708818103197;6474.449671777952;6854.828629284208;6861.416779573692;6867.07294515234;6880.208775990725;6880.793576192722;6434.034894765729;6443.420092191725;6447.709853056624;6449.451796597248;6455.9677201613695;3660.084978755311;3696.963030369716;3702.8889133326043;3704.1665625234646;3704.240630670706;6942.652867356612;7086.433085353159;7103.112110986127;7109.857802843914;7114.430845532345;6959.373656370951;6987.965060174768;6989.89515157273;6996.405305549085;7005.509614326948;7082.5396349237135;7084.397826184729;7099.858002839915;7100.082977596124;7105.04081948951;6844.794656160323;6845.349691779273;6854.657267136723;6863.485238607024;6865.450763938973;6577;6739.528233023641;6741.662916854236;6752.324767523209;6753.932460675331;7063.328983746741;7096.7516136934955;7107.573545587281;7108.680109394986;7118.181409137808;4797.664163508521;4798.928016079832;4799.9760001199775;4800.423949125988;4803.03939212152;6839.62382068991;6840.213375461885;6844.349786770249;6847.6576171190245;6847.897281540681;6542.116814230209;6679.599224046573;6691;6691.5315927884585;6761.188657361148;6622.271550129578;6646;6647.567908085959;6651.06885036105;6652.301508341555;6534.215894092739;6535.411812936859;6538.967305163444;6551.246606640298;6552.737890484518;6663.400293973566;6674.566153200027;6677;6683.665816709243;6695.765648202289;6334;6508.642024688498;6511.2512061113575;6521.347865213441;6523.6738163092605 19:26:07 INFO - PROCESS | 27261 | |5;yui.html;891.7815135291852;910.6493999810072;917.7797328641126;920.8572671235961;925.5326060339528;13980;14206.573802785908;14207.218602976833;14237.78643320351;14247.715045699093;14505.912056595746;14630.707385852276;14939.92530037351;14942.402303907831;14962.17708026058;703.0824773670383;850.5704619167312;858.0518527027638;867.3668222197799;870.2515836380708;865.6926790989203;867.1285358214985;867.7093173786789;868.0104680664048;868.1752335281476;900.4282280751704;901.7069452427954;902.0933961368816;902.3818684201343;903;734.1520543771925;741.6959046790844;876.9429987050885;892.834825557274;898.0660113481971;649.772579597142;655.5018186178492;657.2146285189201;658.0819756439739;658.7628453756644;14605.78091328631;14648.267586620626;14687.77968330476;14734.63163420923;14754.631134221623;14118.435262589484;14570.562883113524;14901.105933644016;14908.478203262943;15190.848091519054;11645.767084658344;11987.160898737093;12060.155789094766;12137.575184868487;12251.93874030633;3974.4435778990965;4000.975119526779;4044.635982761536;4065.8170382332864;4108.281050816125;56898;56976.71511642415;57467.712661436846;57740.711296443245;57817;11449.141314401286;11503.482343294572;11592.189167059558;11877.168598198043;12104.213226140273;21406.57186856254;21447.78552214458;21450.463738406666;21468.570628587342;21478.355649330544;8174.059983102019;8417.200365965346;8706.471390666971;8836.425632334007;8838.602262898185;5008.17365134756;5132.230706936239;5136.871578210575;5152.793888244429;5285.445028272053;3322.601287845474;3372.072680013016;3376.2403459221478;3376.44288692363;3384.4077286474767;548.8710153114015;616.7964571691331;646.2309851277059;653.0628548033587;663.1081195791653;675.8850995330805;716.9675667039446;749.1721647579456;768.5811232878095;781.3124450483651;9452.10205030521;9816.65641702537;9828.606855725833;9911.45486998222;10165.695029149138;620.5687047502033;745.9104907411146;762.8283636181815;771.3135309574483;798.3812545277341;4402.3836662867225;4611.100835337077;4617.3304870793545;4707.411573553306;4760.166970780099;60954.69522652358;61027.38972610217;61663.691681541306;61726.69136654288;62283.6885815568;51293.23060154101;51816.74091629518;51853;52500.73749631227;57083.14375284374;49958.75020624946;50671.493285067416;51458.48541514537;52820.73589632104;52938.73530632322;10093.889672135912;10138.230549695993;10288.897111028793;10301.278910476194;10470.738231544272;38099;38694.6130538691;38726.6127338723;39790.80104599459;39919.60080399159;47692.7615361921;49259.75370123127;49801.25298120458;50952.235716465024;51448.48551514587;12804.487820487077;12850.164739291917;12964.22214667123;13041.087123901236;13586.79619805684;14039.157650541;14439.92780036093;14693.706125877208;15190.240487975778;15190.544283671508;11661.24201926872;13727.519536816164;13783.51757688476;14351.569452916428;14449.49426770058;12570.874291257336;12644.293020442123;12856.035797315051;13257.469701212229;13405.262710551013;13079.346032698137;13354;13619.18284902909;13659.04386692922;13876.375563099482;11251.738594572133;11334.94332528332;11343.262687925258;11776;12091.334976576372;11529.135314851252;11570.59502917394;11658.678995247199;11751.706207344885;11755.059595232531 19:26:07 INFO - PROCESS | 27261 | __end_tp_report 19:26:07 INFO - PROCESS | 27261 | __start_cc_report 19:26:07 INFO - PROCESS | 27261 | _x_x_mozilla_cycle_collect,910 19:26:07 INFO - PROCESS | 27261 | __end_cc_report 19:26:07 INFO - PROCESS | 27261 | __startTimestamp1463797567637__endTimestamp 19:26:07 INFO - PROCESS | 27261 | 19:26:07 INFO - PROCESS | 27261 | ------- Summary: start ------- 19:26:07 INFO - PROCESS | 27261 | Number of tests: 6 19:26:07 INFO - PROCESS | 27261 | 19:26:07 INFO - PROCESS | 27261 | [#0] dojo.html Cycles:165 Average:5467.13 Median:5721.00 stddev:617.49 (10.8%) stddev-sans-first:595.16 19:26:07 INFO - PROCESS | 27261 | Values: 3283.9 3331.7 3345.7 3354.5 3384.9 5402.1 5404.9 5411.7 5438.0 5445.4 5412.4 5439.5 5443.8 5463.2 5485.4 4858.0 4894.1 4979.6 5021.7 5072.5 4866.6 4918.1 4919.1 4921.5 4924.0 4842.6 4902.1 4916.0 4927.0 4941.3 5035.6 5043.6 5064.5 5072.0 5098.9 4773.1 4814.7 4887.8 4978.8 5001.8 5378.1 5403.1 5416.9 5424.6 5425.3 5840.2 5881.4 5886.4 5889.9 5893.6 5783.5 5886.2 5900.4 5926.5 5939.6 5491.3 5523.7 5534.7 5545.3 5553.1 5896.6 6039.6 6040.3 6047.1 6052.1 5661.4 5728.8 5732.4 5737.3 5738.5 5864.2 5886.9 5890.8 5898.0 5912.2 5664.5 5716.3 5840.1 5862.0 5865.7 5822.7 5858.0 5869.5 5876.2 5895.1 4481.4 4492.2 4494.1 4496.3 4520.8 3977.2 3980.5 4025.5 4034.4 4064.2 5599.4 5623.3 5626.0 5627.7 5636.5 5918.0 5924.4 5924.8 5925.6 5929.3 5390.9 5610.6 5626.4 5699.5 5721.0 5039.0 5062.6 5075.0 5077.0 5104.0 6080.2 6081.3 6081.5 6084.7 6091.8 5738.1 5909.6 5971.3 6008.5 6010.0 6129.8 6156.4 6158.3 6160.7 6165.7 5690.3 5855.3 5857.9 5864.3 5864.8 5912.3 5960.0 5968.1 5974.1 6009.1 5743.7 5764.5 5770.4 5773.3 5780.0 5590.3 5724.8 5726.7 5728.0 5802.9 5748.1 5777.4 5780.2 5781.9 5819.5 5892.5 5893.5 5898.1 5903.7 5910.3 5466.0 5540.2 5548.2 5780.2 5798.2 19:26:07 INFO - PROCESS | 27261 | 19:26:07 INFO - PROCESS | 27261 | [#1] ext.html Cycles:180 Average:60554.76 Median:21716.11 stddev:124450.80 (573.1%) stddev-sans-first:124718.66 19:26:07 INFO - PROCESS | 27261 | Values: 658.1 670.0 671.6 672.9 735.4 32088.0 32482.0 32487.7 32497.8 32519.7 32796.3 39029.6 39656.8 39876.6 39895.4 8839.7 8980.8 8984.8 8987.0 8990.3 8228.0 8821.0 8935.8 8945.1 10740.0 10664.4 10760.4 10767.8 10769.4 10786.2 10546.1 10611.2 10620.4 10628.8 10633.2 8198.2 10256.4 10409.7 10413.5 10434.0 39617.2 39897.4 40030.6 40204.8 40302.4 3823.8 3854.9 3915.7 3949.4 3950.9 33789.3 34466.8 34615.7 34705.7 35063.5 4560.2 4643.4 4680.7 4704.4 4754.0 269965.0 272671.0 272800.0 273223.0 273294.0 41832.0 63695.7 64539.4 64795.4 70321.0 41819.0 41979.8 42004.0 42141.6 42198.4 17723.6 18065.8 18098.5 18102.9 18108.5 15097.0 15181.4 15238.0 15242.8 15252.5 8882.7 9062.6 9329.3 9551.9 9556.8 3591.2 3661.1 3674.7 3708.3 3725.3 1066.7 1139.9 1142.5 1168.1 1234.7 32476.5 33221.3 33253.7 33851.0 33961.3 1176.3 1215.7 1230.5 1269.0 1315.7 15809.0 16137.8 16187.8 16341.7 16523.8 572662.0 580057.0 580060.0 581110.0 582351.0 58513.1 59670.4 59751.4 59954.0 59967.0 1387.2 1491.0 1519.3 1526.5 1592.1 29623.0 30363.4 30535.4 33579.0 36453.0 58951.7 59745.1 59929.2 59944.4 60174.4 489465.0 492444.0 493190.0 495421.0 499197.0 39812.4 39927.8 47872.5 48587.0 48894.8 43865.8 43882.6 44093.0 44151.1 44884.6 39623.8 39791.0 39984.4 40459.4 41446.8 39482.8 39837.4 40422.8 40776.8 40842.6 40506.2 41402.8 42172.0 42724.1 42763.0 34133.7 36122.5 36341.9 36499.0 36721.4 28092.6 28183.9 28485.3 28746.6 30616.7 19:26:07 INFO - PROCESS | 27261 | 19:26:07 INFO - PROCESS | 27261 | [#2] jquery.html Cycles:180 Average:28883.47 Median:13557.10 stddev:80233.26 (591.8%) stddev-sans-first:80429.88 19:26:07 INFO - PROCESS | 27261 | Values: 421.8 424.3 428.8 433.3 436.5 14816.6 18571.6 19048.7 19195.8 21142.9 15216.8 19132.6 19584.7 19920.7 20189.2 5574.4 5640.7 5642.7 5736.9 5741.2 5646.7 5662.9 5683.0 5686.7 5694.0 4197.5 5970.1 6190.4 6198.6 6204.4 6112.8 6137.0 6141.2 6149.5 6195.3 5576.2 5654.1 5691.0 5692.6 5703.1 23092.7 23390.4 23463.8 24300.5 24399.5 2714.7 2733.5 2747.8 2759.8 3093.3 14418.8 15009.8 15143.5 15215.9 15499.4 1998.2 2059.6 2132.0 2163.1 2242.4 68930.3 70745.3 71083.6 71854.3 72195.6 11202.5 11243.6 11320.8 11337.1 11387.8 15223.3 15277.9 15422.5 15442.4 15502.5 8352.4 8461.6 8468.0 8527.3 8755.8 8613.6 8617.1 8640.9 8698.5 8747.7 4622.7 4855.7 4884.1 5070.3 5094.4 1856.2 1977.4 2003.5 2051.6 2062.5 975.2 1040.7 1061.2 1076.1 1082.0 19317.5 19470.7 19473.5 19653.0 19681.5 1099.2 1114.1 1118.0 1125.4 1131.1 10834.5 11214.7 11231.9 11240.5 11402.5 480046.0 484356.0 491249.0 491251.0 493292.0 87147.0 89031.0 90334.5 90794.0 91926.5 1095.7 1153.3 1162.8 1165.7 1167.4 17243.7 17355.6 17461.3 17549.5 17713.2 40008.6 40193.4 41209.2 41675.2 41703.2 58756.0 59786.1 60179.0 60379.7 60440.4 8876.0 8915.3 9091.0 9193.0 9211.1 9841.6 13147.2 13342.7 13421.3 13639.2 11217.7 11800.6 11827.2 11983.5 12135.5 9686.0 11818.8 11949.1 11972.5 12199.9 11642.0 11942.2 12209.9 12293.3 12436.0 8896.1 8961.5 8999.0 9100.2 9172.7 9163.9 11116.7 11901.8 12008.2 12146.5 19:26:07 INFO - PROCESS | 27261 | 19:26:07 INFO - PROCESS | 27261 | [#3] mootools.html Cycles:180 Average:5425.04 Median:4977.68 stddev:2905.51 (58.4%) stddev-sans-first:2897.94 19:26:07 INFO - PROCESS | 27261 | Values: 1403.2 1548.1 1553.4 1774.2 1902.6 7168.6 7868.1 7986.1 7991.1 8000.8 7892.6 7995.7 8053.4 8076.7 8083.2 2087.9 2345.6 2367.2 2389.8 2405.8 2400.3 2407.5 2408.5 2409.9 2411.9 2268.8 2333.0 2333.1 2334.4 2336.0 2029.2 2309.1 2373.1 2374.4 2376.3 2338.5 2346.1 2351.5 2351.7 2392.8 8058.2 8107.5 8110.0 8137.9 8149.7 4965.8 5038.7 5039.4 5042.2 5056.6 3364.6 3446.4 3456.9 3478.3 3515.0 1131.8 1153.6 1157.3 1176.0 1192.2 11120.9 11189.6 11191.7 11196.9 11221.3 4473.3 4485.2 4528.7 4576.0 4581.2 9643.1 9648.7 9651.5 9652.6 9665.0 4581.1 5178.7 5184.5 5203.9 5208.0 4522.8 4581.2 4591.3 4591.6 4607.5 3866.3 3948.6 3976.9 3977.4 4011.9 1295.7 1299.3 1299.9 1304.5 1311.6 973.7 1004.1 1019.4 1053.2 1060.2 5723.9 5753.1 5762.4 5779.3 5915.2 984.9 1016.1 1029.6 1037.0 1043.7 3893.1 3900.8 3908.8 3939.0 3948.9 9815.7 10028.1 10054.3 10082.5 10091.7 9676.0 10120.6 10146.0 10157.6 10187.8 7895.2 7922.1 7946.1 7972.1 7978.0 5431.2 5481.7 5494.9 5627.3 5628.4 8500.1 8629.7 8720.7 8733.0 8805.3 8570.7 8856.5 8864.6 8911.2 8935.3 6489.1 6771.9 6928.0 7139.4 7239.1 7628.0 7692.4 7707.7 7756.8 7773.2 6772.1 6917.9 6933.5 7029.5 7051.0 6983.6 6985.3 7017.0 7103.8 7115.9 6441.7 6486.6 6490.9 6718.5 6721.3 4942.1 4963.6 4964.8 4989.5 5024.8 5099.6 5113.0 5160.9 5175.1 5241.4 19:26:07 INFO - PROCESS | 27261 | 19:26:07 INFO - PROCESS | 27261 | [#4] prototype.html Cycles:180 Average:5543.86 Median:6295.50 stddev:1667.68 (26.5%) stddev-sans-first:1626.22 19:26:07 INFO - PROCESS | 27261 | Values: 353.7 355.6 356.6 364.3 364.8 6118.4 6219.0 6255.5 6258.7 6265.3 6156.4 6184.5 6186.4 6186.7 6192.9 4497.9 4632.6 4699.7 4712.1 4716.6 4752.8 4762.0 4762.8 4765.1 4769.0 4666.3 4700.4 4705.7 4707.4 4714.8 4478.9 4570.7 4704.2 4707.7 4711.1 4134.5 4138.3 4144.1 4144.2 4170.3 5932.9 5933.8 5945.0 5950.5 5968.7 5516.7 5519.5 5522.5 5533.1 5533.6 6528.6 6529.2 6532.8 6538.5 6539.5 4559.7 4638.2 4647.1 4650.0 4654.0 6774.7 6846.1 6849.5 6851.6 6853.1 4753.8 4775.6 4777.1 4786.7 4790.6 4842.7 4844.7 4845.2 4850.7 4853.6 5529.0 5531.6 5532.8 5534.3 5541.7 6468.7 6554.5 6607.8 6609.7 6619.4 1686.3 1690.8 1701.7 1705.1 1706.0 1126.4 1129.1 1143.0 1155.8 1159.8 6258.5 6325.7 6421.4 6470.7 6474.4 6854.8 6861.4 6867.1 6880.2 6880.8 6434.0 6443.4 6447.7 6449.5 6456.0 3660.1 3697.0 3702.9 3704.2 3704.2 6942.7 7086.4 7103.1 7109.9 7114.4 6959.4 6988.0 6989.9 6996.4 7005.5 7082.5 7084.4 7099.9 7100.1 7105.0 6844.8 6845.3 6854.7 6863.5 6865.5 6577.0 6739.5 6741.7 6752.3 6753.9 7063.3 7096.8 7107.6 7108.7 7118.2 4797.7 4798.9 4800.0 4800.4 4803.0 6839.6 6840.2 6844.3 6847.7 6847.9 6542.1 6679.6 6691.0 6691.5 6761.2 6622.3 6646.0 6647.6 6651.1 6652.3 6534.2 6535.4 6539.0 6551.2 6552.7 6663.4 6674.6 6677.0 6683.7 6695.8 6334.0 6508.6 6511.3 6521.3 6523.7 19:26:07 INFO - PROCESS | 27261 | 19:26:07 INFO - PROCESS | 27261 | [#5] yui.html Cycles:180 Average:15550.67 Median:4255.33 stddev:17522.97 (411.8%) stddev-sans-first:17537.55 19:26:07 INFO - PROCESS | 27261 | Values: 891.8 910.6 917.8 920.9 925.5 13980.0 14206.6 14207.2 14237.8 14247.7 14505.9 14630.7 14939.9 14942.4 14962.2 703.1 850.6 858.1 867.4 870.3 865.7 867.1 867.7 868.0 868.2 900.4 901.7 902.1 902.4 903.0 734.2 741.7 876.9 892.8 898.1 649.8 655.5 657.2 658.1 658.8 14605.8 14648.3 14687.8 14734.6 14754.6 14118.4 14570.6 14901.1 14908.5 15190.8 11645.8 11987.2 12060.2 12137.6 12251.9 3974.4 4001.0 4044.6 4065.8 4108.3 56898.0 56976.7 57467.7 57740.7 57817.0 11449.1 11503.5 11592.2 11877.2 12104.2 21406.6 21447.8 21450.5 21468.6 21478.4 8174.1 8417.2 8706.5 8836.4 8838.6 5008.2 5132.2 5136.9 5152.8 5285.4 3322.6 3372.1 3376.2 3376.4 3384.4 548.9 616.8 646.2 653.1 663.1 675.9 717.0 749.2 768.6 781.3 9452.1 9816.7 9828.6 9911.5 10165.7 620.6 745.9 762.8 771.3 798.4 4402.4 4611.1 4617.3 4707.4 4760.2 60954.7 61027.4 61663.7 61726.7 62283.7 51293.2 51816.7 51853.0 52500.7 57083.1 49958.8 50671.5 51458.5 52820.7 52938.7 10093.9 10138.2 10288.9 10301.3 10470.7 38099.0 38694.6 38726.6 39790.8 39919.6 47692.8 49259.8 49801.3 50952.2 51448.5 12804.5 12850.2 12964.2 13041.1 13586.8 14039.2 14439.9 14693.7 15190.2 15190.5 11661.2 13727.5 13783.5 14351.6 14449.5 12570.9 12644.3 12856.0 13257.5 13405.3 13079.3 13354.0 13619.2 13659.0 13876.4 11251.7 11334.9 11343.3 11776.0 12091.3 11529.1 11570.6 11658.7 11751.7 11755.1 19:26:07 INFO - PROCESS | 27261 | -------- Summary: end -------- 19:26:07 INFO - PROCESS | 27261 | 19:26:08 INFO - TEST-INFO | 27261: exit 0 19:26:08 INFO - TEST-OK | dromaeo_css | took 1112324ms 19:26:08 INFO - TEST-START | kraken 19:26:08 INFO - operating with platform_type : linux_ 19:26:08 INFO - Initialising browser for kraken test... 19:26:08 INFO - TEST-INFO | started process 27451 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiqb3VX/profile http://localhost:39006/getInfo.html) 19:26:12 INFO - PROCESS | 27451 | __metrics Screen width/height:1600/1200 19:26:12 INFO - PROCESS | 27451 | colorDepth:24 19:26:12 INFO - PROCESS | 27451 | Browser inner width/height: 1024/697 19:26:12 INFO - PROCESS | 27451 | __metrics 19:26:13 ERROR - PROCESS | 27451 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:26:14 INFO - TEST-INFO | 27451: exit 0 19:26:14 INFO - Browser initialized. 19:26:14 INFO - Running cycle 1/1 for kraken test... 19:26:14 INFO - TEST-INFO | started process 27542 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiqb3VX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:26:26 INFO - PROCESS | 27542 | RSS: Main: 142098432 19:26:26 INFO - PROCESS | 27542 | 19:26:28 INFO - PROCESS | 27542 | Cycle 1(1): loaded http://localhost:39006/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39006/tests/kraken/driver.html?testName=audio-beat-detection) 19:26:29 INFO - PROCESS | 27542 | RSS: Main: 196644864 19:26:29 INFO - PROCESS | 27542 | 19:26:32 INFO - PROCESS | 27542 | Cycle 1(1): loaded http://localhost:39006/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39006/tests/kraken/driver.html?testName=audio-dft) 19:26:32 INFO - PROCESS | 27542 | RSS: Main: 182456320 19:26:32 INFO - PROCESS | 27542 | 19:26:35 INFO - PROCESS | 27542 | Cycle 1(1): loaded http://localhost:39006/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39006/tests/kraken/driver.html?testName=audio-fft) 19:26:36 INFO - PROCESS | 27542 | RSS: Main: 272867328 19:26:36 INFO - PROCESS | 27542 | 19:26:38 INFO - PROCESS | 27542 | Cycle 1(1): loaded http://localhost:39006/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39006/tests/kraken/driver.html?testName=audio-oscillator) 19:26:38 INFO - PROCESS | 27542 | RSS: Main: 179580928 19:26:38 INFO - PROCESS | 27542 | 19:26:41 INFO - PROCESS | 27542 | Cycle 1(1): loaded http://localhost:39006/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39006/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:26:41 INFO - PROCESS | 27542 | RSS: Main: 177647616 19:26:41 INFO - PROCESS | 27542 | 19:26:44 INFO - PROCESS | 27542 | Cycle 1(1): loaded http://localhost:39006/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39006/tests/kraken/driver.html?testName=imaging-darkroom) 19:26:45 INFO - PROCESS | 27542 | RSS: Main: 212201472 19:26:45 INFO - PROCESS | 27542 | 19:26:48 INFO - PROCESS | 27542 | Cycle 1(1): loaded http://localhost:39006/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39006/tests/kraken/driver.html?testName=imaging-desaturate) 19:26:49 INFO - PROCESS | 27542 | RSS: Main: 212766720 19:26:49 INFO - PROCESS | 27542 | 19:26:51 INFO - PROCESS | 27542 | Cycle 1(1): loaded http://localhost:39006/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39006/tests/kraken/driver.html?testName=json-parse-financial) 19:26:52 INFO - PROCESS | 27542 | RSS: Main: 212672512 19:26:52 INFO - PROCESS | 27542 | 19:26:54 INFO - PROCESS | 27542 | Cycle 1(1): loaded http://localhost:39006/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39006/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:26:54 INFO - PROCESS | 27542 | RSS: Main: 192061440 19:26:54 INFO - PROCESS | 27542 | 19:26:56 INFO - PROCESS | 27542 | Cycle 1(1): loaded http://localhost:39006/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39006/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:26:56 INFO - PROCESS | 27542 | RSS: Main: 195072000 19:26:56 INFO - PROCESS | 27542 | 19:26:58 INFO - PROCESS | 27542 | Cycle 1(1): loaded http://localhost:39006/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39006/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:26:59 INFO - PROCESS | 27542 | RSS: Main: 208412672 19:26:59 INFO - PROCESS | 27542 | 19:27:01 INFO - PROCESS | 27542 | Cycle 1(1): loaded http://localhost:39006/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39006/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:27:02 INFO - PROCESS | 27542 | RSS: Main: 215027712 19:27:02 INFO - PROCESS | 27542 | 19:27:05 INFO - PROCESS | 27542 | Cycle 1(1): loaded http://localhost:39006/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39006/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:27:05 INFO - PROCESS | 27542 | RSS: Main: 211501056 19:27:05 INFO - PROCESS | 27542 | 19:27:07 INFO - PROCESS | 27542 | Cycle 1(1): loaded http://localhost:39006/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39006/tests/kraken/driver.html?testName=ai-astar) 19:27:07 INFO - PROCESS | 27542 | RSS: Main: 274960384 19:27:07 INFO - PROCESS | 27542 | 19:27:07 INFO - PROCESS | 27542 | __start_tp_report 19:27:07 INFO - PROCESS | 27542 | _x_x_mozilla_page_load 19:27:07 INFO - PROCESS | 27542 | _x_x_mozilla_page_load_details 19:27:07 INFO - PROCESS | 27542 | |i|pagename|runs| 19:27:07 INFO - PROCESS | 27542 | |0;ai-astar;112;111;110;109;109;110;106;109;109;109 19:27:07 INFO - PROCESS | 27542 | |1;audio-beat-detection;154;126;153;169;126;153;162;128;183;126 19:27:07 INFO - PROCESS | 27542 | |2;audio-dft;161;161;162;160;161;159;162;162;162;160 19:27:07 INFO - PROCESS | 27542 | |3;audio-fft;76;76;76;166;77;77;77;77;158;74 19:27:07 INFO - PROCESS | 27542 | |4;audio-oscillator;93;94;157;93;93;92;154;91;92;151 19:27:07 INFO - PROCESS | 27542 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;117;118;117 19:27:07 INFO - PROCESS | 27542 | |6;imaging-darkroom;145;145;145;146;146;145;145;147;145;145 19:27:07 INFO - PROCESS | 27542 | |7;imaging-desaturate;94;94;95;95;95;94;95;94;95;95 19:27:07 INFO - PROCESS | 27542 | |8;json-parse-financial;53;54;54;54;54;54;54;80;52;51 19:27:07 INFO - PROCESS | 27542 | |9;json-stringify-tinderbox;59;61;59;59;60;60;60;60;60;60 19:27:07 INFO - PROCESS | 27542 | |10;stanford-crypto-aes;72;71;73;71;74;72;80;72;74;73 19:27:07 INFO - PROCESS | 27542 | |11;stanford-crypto-ccm;114;113;115;116;121;111;114;112;132;128 19:27:07 INFO - PROCESS | 27542 | |12;stanford-crypto-pbkdf2;158;160;154;155;160;157;156;155;159;156 19:27:07 INFO - PROCESS | 27542 | |13;stanford-crypto-sha256-iterative;68;67;65;67;65;64;67;66;72;64 19:27:07 INFO - PROCESS | 27542 | __end_tp_report 19:27:07 INFO - PROCESS | 27542 | __start_cc_report 19:27:07 INFO - PROCESS | 27542 | _x_x_mozilla_cycle_collect,1572 19:27:07 INFO - PROCESS | 27542 | __end_cc_report 19:27:07 INFO - PROCESS | 27542 | __startTimestamp1463797627807__endTimestamp 19:27:07 INFO - PROCESS | 27542 | 19:27:07 INFO - PROCESS | 27542 | ------- Summary: start ------- 19:27:07 INFO - PROCESS | 27542 | Number of tests: 14 19:27:07 INFO - PROCESS | 27542 | 19:27:07 INFO - PROCESS | 27542 | [#0] ai-astar Cycles:10 Average:109.40 Median:109.50 stddev:1.58 (1.4%) stddev-sans-first:1.36 19:27:07 INFO - PROCESS | 27542 | Values: 112.0 111.0 110.0 109.0 109.0 110.0 106.0 109.0 109.0 109.0 19:27:07 INFO - PROCESS | 27542 | 19:27:07 INFO - PROCESS | 27542 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:153.50 stddev:20.55 (13.4%) stddev-sans-first:21.68 19:27:07 INFO - PROCESS | 27542 | Values: 154.0 126.0 153.0 169.0 126.0 153.0 162.0 128.0 183.0 126.0 19:27:07 INFO - PROCESS | 27542 | 19:27:07 INFO - PROCESS | 27542 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.05 (0.7%) stddev-sans-first:1.12 19:27:07 INFO - PROCESS | 27542 | Values: 161.0 161.0 162.0 160.0 161.0 159.0 162.0 162.0 162.0 160.0 19:27:07 INFO - PROCESS | 27542 | 19:27:07 INFO - PROCESS | 27542 | [#3] audio-fft Cycles:10 Average:93.40 Median:76.50 stddev:36.22 (47.3%) stddev-sans-first:37.86 19:27:07 INFO - PROCESS | 27542 | Values: 76.0 76.0 76.0 166.0 77.0 77.0 77.0 77.0 158.0 74.0 19:27:07 INFO - PROCESS | 27542 | 19:27:07 INFO - PROCESS | 27542 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:92.50 stddev:29.72 (32.1%) stddev-sans-first:30.80 19:27:07 INFO - PROCESS | 27542 | Values: 93.0 94.0 157.0 93.0 93.0 92.0 154.0 91.0 92.0 151.0 19:27:07 INFO - PROCESS | 27542 | 19:27:07 INFO - PROCESS | 27542 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:27:07 INFO - PROCESS | 27542 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 19:27:07 INFO - PROCESS | 27542 | 19:27:07 INFO - PROCESS | 27542 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 19:27:07 INFO - PROCESS | 27542 | Values: 145.0 145.0 145.0 146.0 146.0 145.0 145.0 147.0 145.0 145.0 19:27:07 INFO - PROCESS | 27542 | 19:27:07 INFO - PROCESS | 27542 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 19:27:07 INFO - PROCESS | 27542 | Values: 94.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 19:27:07 INFO - PROCESS | 27542 | 19:27:07 INFO - PROCESS | 27542 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:54.00 stddev:8.50 (15.7%) stddev-sans-first:8.94 19:27:07 INFO - PROCESS | 27542 | Values: 53.0 54.0 54.0 54.0 54.0 54.0 54.0 80.0 52.0 51.0 19:27:07 INFO - PROCESS | 27542 | 19:27:07 INFO - PROCESS | 27542 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 19:27:07 INFO - PROCESS | 27542 | Values: 59.0 61.0 59.0 59.0 60.0 60.0 60.0 60.0 60.0 60.0 19:27:07 INFO - PROCESS | 27542 | 19:27:07 INFO - PROCESS | 27542 | [#10] stanford-crypto-aes Cycles:10 Average:73.20 Median:73.00 stddev:2.62 (3.6%) stddev-sans-first:2.74 19:27:07 INFO - PROCESS | 27542 | Values: 72.0 71.0 73.0 71.0 74.0 72.0 80.0 72.0 74.0 73.0 19:27:07 INFO - PROCESS | 27542 | 19:27:07 INFO - PROCESS | 27542 | [#11] stanford-crypto-ccm Cycles:10 Average:117.60 Median:115.50 stddev:7.14 (6.2%) stddev-sans-first:7.45 19:27:07 INFO - PROCESS | 27542 | Values: 114.0 113.0 115.0 116.0 121.0 111.0 114.0 112.0 132.0 128.0 19:27:07 INFO - PROCESS | 27542 | 19:27:07 INFO - PROCESS | 27542 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.00 Median:157.50 stddev:2.16 (1.4%) stddev-sans-first:2.26 19:27:07 INFO - PROCESS | 27542 | Values: 158.0 160.0 154.0 155.0 160.0 157.0 156.0 155.0 159.0 156.0 19:27:07 INFO - PROCESS | 27542 | 19:27:07 INFO - PROCESS | 27542 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:2.37 (3.5%) stddev-sans-first:2.45 19:27:07 INFO - PROCESS | 27542 | Values: 68.0 67.0 65.0 67.0 65.0 64.0 67.0 66.0 72.0 64.0 19:27:07 INFO - PROCESS | 27542 | -------- Summary: end -------- 19:27:07 INFO - PROCESS | 27542 | 19:27:08 INFO - TEST-INFO | 27542: exit 0 19:27:08 INFO - TEST-OK | kraken | took 60373ms 19:27:08 INFO - SUITE-END | took 1172s 19:27:08 INFO - Completed test suite (00:19:32) 19:27:08 INFO - javascript benchmark 19:27:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3283.934321313574, 3331.7001469867705, 3345.715614172795, 3354.4800555913844, 3384.949225761614, 5402.054640437927, 5404.91892621611, 5411.729413529322, 5438.048341540224, 5445.428230035848, 5412.431694672052, 5439.5376393006545, 5443.782248710057, 5463.2078348639525, 5485.396606373296, 4858.0, 4894.09459250039, 4979.626528010395, 5021.723805190713, 5072.543471087602, 4866.58634016109, 4918.065567542156, 4919.13915064864, 4921.458639549646, 4924.039812236615, 4842.61259099273, 4902.0931127741305, 4915.950840491585, 4926.9753651231695, 4941.308216849644, 5035.597152227813, 5043.621728370387, 5064.544191022789, 5072.0, 5098.9235161472425, 4773.06925149596, 4814.66297359185, 4887.780049897763, 4978.751062446863, 5001.774920128603, 5378.112611419111, 5403.054465468527, 5416.91874621881, 5424.5660347172525, 5425.3489581250105, 5840.15317778924, 5881.441263080001, 5886.381929897342, 5889.911651325234, 5893.5579831512805, 5783.479486846162, 5886.234789477383, 5900.43945825146, 5926.496247818941, 5939.613925094898, 5491.28613280271, 5523.7238138093335, 5534.695591742453, 5545.279113715191, 5553.139263414178, 5896.616719913192, 6039.63762174271, 6040.305364883095, 6047.123167140828, 6052.092186172022, 5661.405552416937, 5728.828135155952, 5732.398098199712, 5737.3115226172295, 5738.512226460714, 5864.2083318752275, 5886.8822623547285, 5890.764369425261, 5898.026825573818, 5912.23140991677, 5664.490195882308, 5716.342620598684, 5840.094785308199, 5862.0, 5865.677387743715, 5822.679752613562, 5857.970710146422, 5869.501092407193, 5876.206712093813, 5895.115732640053, 4481.395011673448, 4492.236319825637, 4494.078713863715, 4496.280595104768, 4520.819167233274, 3977.2244412339896, 3980.522337319482, 4025.456563363967, 4034.435179074932, 4064.1871625674985, 5599.384067752544, 5623.325200975827, 5626.0, 5627.718614069362, 5636.549076073986, 5918.0, 5924.437178468039, 5924.763009479572, 5925.585209035412, 5929.3181284152015, 5390.865228369244, 5610.579206559524, 5626.43735626434, 5699.458551437607, 5721.0, 5039.0, 5062.594992400599, 5075.0, 5077.035363280965, 5104.0, 6080.179175811298, 6081.300650425169, 6081.483073938676, 6084.726187321581, 6091.786787462506, 5738.08190689496, 5909.645421274738, 5971.253593300838, 6008.54935879802, 6010.0, 6129.816105516842, 6156.384361563808, 6158.3225845157895, 6160.722767475385, 6165.691715414301, 5690.3456102548735, 5855.3266374365785, 5857.853553661193, 5864.32560255576, 5864.765409383577, 5912.260967379078, 5959.970200148971, 5968.104784282393, 5974.103884417198, 6009.128676341818, 5743.712814359349, 5764.510016648464, 5770.365259821332, 5773.3072031356505, 5780.0, 5590.273264475592, 5724.8282551523525, 5726.713664316851, 5727.971360143172, 5802.94197058024, 5748.109043098327, 5777.364489906023, 5780.190773291826, 5781.884362312814, 5819.534437244925, 5892.469677729025, 5893.469587737124, 5898.085796701518, 5903.675297858659, 5910.290765108214, 5466.0, 5540.168974653834, 5548.195511650869, 5780.21967034445, 5798.217240672624], "value": 5426.800273539283, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.0885473619036, 669.9548704021727, 671.5936858200788, 672.9495287853406, 735.4043224987761, 32088.0, 32482.0, 32487.67512324876, 32497.837510812413, 32519.67480325196, 32796.344073118584, 39029.609703902956, 39656.80171599145, 39876.601233987654, 39895.40156897641, 8839.734807955756, 8980.820383592325, 8984.775380615472, 8987.0, 8990.28077753778, 8228.0, 8821.029686734453, 8935.77660558488, 8945.105489451067, 10740.0, 10664.413457259847, 10760.40817755023, 10767.784644307108, 10769.438431427438, 10786.191035672317, 10546.103581195608, 10611.204159688054, 10620.362778233331, 10628.840567391495, 10633.202509811796, 8198.221168988937, 10256.384616922935, 10409.739756506073, 10413.479326033668, 10434.0, 39617.20765584701, 39897.40153897694, 40030.59969400298, 40204.79897600493, 40302.39546406806, 3823.8470461181796, 3854.9057684168765, 3915.725899187058, 3949.407588861665, 3950.9012274693077, 33789.32421351559, 34466.82766586151, 34615.65384346175, 34705.65294347075, 35063.4740478893, 4560.247559152735, 4643.442786865598, 4680.672352935296, 4704.364910737041, 4754.02542478791, 269965.0, 272671.0, 272800.0, 273223.0, 273294.0, 41832.0, 63695.681521592094, 64539.35460645334, 64795.35204647893, 70321.0, 41819.0, 41979.7901010493, 42004.0, 42141.57858421438, 42198.367024494655, 17723.645527089386, 18065.819341806415, 18098.547536311697, 18102.90948545249, 18108.547286317684, 15097.0, 15181.392744290104, 15238.0, 15242.847571524142, 15252.542423727306, 8882.733517994471, 9062.637494500277, 9329.253659707207, 9551.856722149174, 9556.761080972892, 3591.2278860045217, 3661.0847288177956, 3674.6692797647806, 3708.2583483303447, 3725.3480640887738, 1066.6906597086759, 1139.9487023083982, 1142.5147308498917, 1168.0655475619471, 1234.7468768902354, 32476.512852307234, 33221.33557328888, 33253.66746332554, 33851.0, 33961.32077358439, 1176.2942234659135, 1215.7203843115956, 1230.4708975140775, 1269.032998851776, 1315.6579289384638, 15809.0, 16137.838621613868, 16187.757183642254, 16341.673166536602, 16523.752143717855, 572662.0, 580057.0, 580060.0, 581110.0, 582351.0, 58513.12230316549, 59670.403295966484, 59751.40248597545, 59954.0, 59967.0, 1387.195426652539, 1490.9701805964037, 1519.2631573686754, 1526.5267766992047, 1592.1402442680824, 29623.0, 30363.392732145676, 30535.389292214477, 33578.99263022113, 36453.0, 58951.705241473515, 59745.103823443555, 59929.20212393635, 59944.40055599388, 60174.39825601688, 489465.0, 492444.0, 493190.0, 495421.0, 499197.0, 39812.40281395723, 39927.80036099801, 47872.521274788196, 48587.0, 48894.75552622214, 43865.78067109644, 43882.56117438785, 44093.0, 44151.11697766091, 44884.551154488036, 39623.80188099041, 39791.0, 39984.4002339971, 40459.39310910398, 41446.79276603598, 39482.80258598689, 39837.40243896402, 40422.79788601038, 40776.79611601923, 40842.591574083875, 40506.1898762029, 41402.792986034874, 42172.0, 42724.1455170901, 42763.0, 34133.65866341305, 36122.45816312705, 36341.9109375706, 36499.0, 36721.44917826181, 28092.578611320438, 28183.859080704464, 28485.287867803472, 28746.568801468413, 30616.693833061385], "value": 19998.86682889777, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.8354841611772, 424.3168498717063, 428.8434721326715, 433.25912689301293, 436.4631503251001, 14816.6295842604, 18571.62856742866, 19048.714269285938, 19195.808041919576, 21142.89428552855, 15216.771748423782, 19132.61734765304, 19584.70622940657, 19920.70118948217, 20189.19243230269, 5574.386817450088, 5640.717964101799, 5642.746076426571, 5736.885262294752, 5741.167530708045, 5646.6894320812335, 5662.915056274159, 5682.971585142089, 5686.744096515646, 5694.0, 4197.454330936974, 5970.104484327364, 6190.380961903797, 6198.628082315053, 6204.410580994799, 6112.786052488142, 6137.018077107664, 6141.201643786279, 6149.477294430001, 6195.287541932667, 5576.247206627135, 5654.095344744821, 5690.971545142248, 5692.601517893749, 5703.116017017369, 23092.65361019586, 23390.415239618975, 23463.7653623465, 24300.513989720283, 24399.512009759885, 2714.687810901732, 2733.5489644208683, 2747.8213916095588, 2759.820611660256, 3093.254421417439, 14418.783718244234, 15009.849901500955, 15143.545693629208, 15215.923920380328, 15499.380024798995, 1998.2306811877386, 2059.577786553753, 2131.9786802131935, 2163.0806907064593, 2242.428180813882, 68930.31069689339, 70745.2925470749, 71083.64458177728, 71854.28145718528, 72195.63902180508, 11202.495887685074, 11243.60647377338, 11320.830187547193, 11337.1497137715, 11387.829182562267, 15223.31495082724, 15277.923610381877, 15422.460213892684, 15442.382304707911, 15502.457413990682, 8352.373571982125, 8461.576921154041, 8468.0, 8527.317814574819, 8755.824883502422, 8613.612387442456, 8617.09520500351, 8640.870386944202, 8698.521581312962, 8747.737567872973, 4622.722636641745, 4855.6601037927, 4884.072026314989, 5070.264811602297, 5094.4141423736, 1856.1832793570786, 1977.3686708465573, 2003.4790954351975, 2051.589682063593, 2062.5359294158993, 975.2149519636761, 1040.7398150462384, 1061.2147011211803, 1076.1390887290293, 1082.0, 19317.51706207356, 19470.70793938092, 19473.513162170777, 19653.0, 19681.456200227578, 1099.2415233488866, 1114.147677027075, 1118.0217309853879, 1125.442905761637, 1131.1120770195357, 10834.512446939907, 11214.663560093048, 11231.887681123248, 11240.49417776202, 11402.486888090056, 480046.0, 484356.0, 491249.0, 491251.0, 493292.0, 87147.0, 89031.0, 90334.54832725794, 90794.0, 91926.54036729774, 1095.7151140703315, 1153.342594721001, 1162.7906976744098, 1165.685264978451, 1167.4046236419488, 17243.65512689714, 17355.56611084733, 17461.30154793794, 17549.473515794547, 17713.202905869526, 40008.599914000486, 40193.39709904295, 41209.1758164841, 41675.16649667051, 41703.165936681704, 58756.0, 59786.10320845104, 60179.0, 60379.69810151097, 60440.395596043476, 8875.955620222116, 8915.28677705769, 9090.954545227496, 9192.95403522978, 9211.078892110736, 9841.557129929313, 13147.211167329991, 13342.666433339244, 13421.261830599411, 13639.181649101085, 11217.71955701114, 11800.586979455678, 11827.231229970024, 11983.520659173535, 12135.514579416724, 9685.951570242103, 11818.76362472763, 11949.10381721357, 11972.521099156285, 12199.87800122023, 11641.952224299854, 11942.223755455867, 12209.877901220874, 12293.262404255773, 12436.0, 8896.110388961051, 8961.462312261285, 8999.0, 9100.180983711498, 9172.724818255463, 9163.86254206174, 11116.722081948015, 11901.76196476083, 12008.219465734699, 12146.453409596767], "value": 9554.578455968714, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1403.2492616450188, 1548.063421629914, 1553.386412367115, 1774.183875417308, 1902.628987347467, 7168.569885806855, 7868.055833300004, 7986.081600615931, 7991.081025682041, 8000.759977200693, 7892.56590887501, 7995.680172793096, 8053.43625946184, 8076.71731489398, 8083.151269116732, 2087.926922557711, 2345.6129738593113, 2367.2188177901294, 2389.761023897605, 2405.7714517120935, 2400.303911865557, 2407.4583218775724, 2408.4821763320883, 2409.915652952147, 2411.8794060297005, 2268.8411811173223, 2333.0317918063984, 2333.125078095714, 2334.4163959010248, 2336.042222688698, 2029.1578994717174, 2309.08791027544, 2373.074500944633, 2374.442006128558, 2376.334626304646, 2338.5089131282452, 2346.0733010460945, 2351.5179388225374, 2351.6825228594093, 2392.784649381564, 8058.153893841121, 8107.473014254114, 8110.0, 8137.918620813834, 8149.7147599833725, 4965.826196083156, 5038.672486288379, 5039.420466646346, 5042.218456139304, 5056.62075344347, 3364.5794275715534, 3446.4485682290965, 3456.8962931112105, 3478.339115568034, 3515.0, 1131.8132508136148, 1153.5674122204173, 1157.346099453806, 1175.9706007349798, 1192.201225179132, 11120.888791112147, 11189.552417903275, 11191.66425007243, 11196.944015279953, 11221.270617409842, 4473.329000649928, 4485.192665320208, 4528.705634133837, 4576.0, 4581.152486789888, 9643.132118109404, 9648.71053868385, 9651.517424128766, 9652.613895444103, 9665.0, 4581.060882519076, 5178.663386879841, 5184.533391994739, 5203.895922081537, 5207.973960130175, 4522.796474158671, 4581.221192397301, 4591.288350305708, 4591.609713174351, 4607.516210797885, 3866.304065268279, 3948.605139486086, 3976.900577485586, 3977.4033894915992, 4011.8997025074023, 1295.7019885426405, 1299.2529295655036, 1299.9415026323838, 1304.4651692806094, 1311.5999620115956, 973.6786860336072, 1004.1364426593124, 1019.4189312092036, 1053.2416660004785, 1060.1677683018793, 5723.942760572341, 5753.050746626844, 5762.423757624204, 5779.2775903012125, 5915.231019967377, 984.8670429491926, 1016.0905989139826, 1029.5675816157232, 1037.0200160847926, 1043.7338478687886, 3893.0851249956236, 3900.8244628991765, 3908.785016824102, 3938.960610393917, 3948.9210215796097, 9815.656452024145, 10028.097471227624, 10054.296199266128, 10082.546285417175, 10091.69724908254, 9675.951620241854, 10120.645777397756, 10146.0, 10157.644482443078, 10187.847182292124, 7895.249951254506, 7922.088959769585, 7946.125926148119, 7972.083210430758, 7977.960110199528, 5431.212474191141, 5481.698506582016, 5494.945050549443, 5627.268455100811, 5628.352739435018, 8500.107488713596, 8629.654813807629, 8720.73837784842, 8733.0, 8805.339599529932, 8570.65717371323, 8856.512891790755, 8864.601092950961, 8911.197992180734, 8935.285177185939, 6489.123968264224, 6771.864562708817, 6927.965360173167, 7139.357457828821, 7239.095113110861, 7628.0, 7692.38460923136, 7707.730229441942, 7756.767296981099, 7773.183815699496, 6772.085768421397, 6917.896231556631, 6933.549319294431, 7029.5430796998035, 7051.0, 6983.615901125487, 6985.301469852974, 7016.964915175391, 7103.786886393416, 7115.85768284621, 6441.742330306735, 6486.578372405778, 6490.935090649222, 6718.496112791658, 6721.294264102199, 4942.061008408391, 4963.553280204799, 4964.826231081895, 4989.525995030466, 5024.84925452237, 5099.617528685438, 5113.0, 5160.896782064413, 5175.068487672255, 5241.397239317374], "value": 4462.671565215971, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.73116431512057, 355.5644335688781, 356.60060731980184, 364.3259969057246, 364.8394706329217, 6118.357572454889, 6219.036049412337, 6255.468285195764, 6258.655773932432, 6265.3421390754, 6156.384361563842, 6184.474319682821, 6186.443220110189, 6186.659733714644, 6192.876142477147, 4497.9325310120375, 4632.559906808848, 4699.7415142167165, 4712.104700106968, 4716.57550820427, 4752.76236188191, 4761.952380476203, 4762.809487620491, 4765.0946320199055, 4768.952310476903, 4666.346711460398, 4700.3889494365685, 4705.694129881546, 4707.435107787071, 4714.764261786914, 4478.910421791578, 4570.657200709927, 4704.153252414564, 4707.693999889996, 4711.081339138869, 4134.4831896013, 4138.296489596776, 4144.088300573899, 4144.171165766858, 4170.270202714543, 5932.9406705932815, 5933.762649494015, 5944.97027514864, 5950.489211365315, 5968.7015649217365, 5516.724163791834, 5519.530839878616, 5522.502974732253, 5533.142362933751, 5533.557315414757, 6528.608283503005, 6529.183852018497, 6532.836679083013, 6538.509611779135, 6539.476841852688, 4559.6580256480565, 4638.1883170445035, 4647.1170477609485, 4649.95350046502, 4653.976730116327, 6774.695138718769, 6846.144231971004, 6849.520533562652, 6851.588904665686, 6853.143357080365, 4753.83361582343, 4775.617950563947, 4777.116233496814, 4786.712797232177, 4790.568848803624, 4842.685225460334, 4844.709317440965, 4845.152098382769, 4850.660453768273, 4853.587445067138, 5528.9723551381985, 5531.612787104945, 5532.834014979557, 5534.252875861707, 5541.667499950016, 6468.676566171673, 6554.541182117206, 6607.80176594703, 6609.702563384659, 6619.437347825393, 1686.2833295849216, 1690.7548405481136, 1701.6896989318402, 1705.0536951991764, 1706.0446150155951, 1126.4255229832681, 1129.0854407929603, 1142.9885701142882, 1155.7861795567846, 1159.7738441003924, 6258.530610204253, 6325.652089135142, 6421.357864213542, 6470.708818103197, 6474.449671777952, 6854.828629284208, 6861.416779573692, 6867.07294515234, 6880.208775990725, 6880.793576192722, 6434.034894765729, 6443.420092191725, 6447.709853056624, 6449.451796597248, 6455.9677201613695, 3660.084978755311, 3696.963030369716, 3702.8889133326043, 3704.1665625234646, 3704.240630670706, 6942.652867356612, 7086.433085353159, 7103.112110986127, 7109.857802843914, 7114.430845532345, 6959.373656370951, 6987.965060174768, 6989.89515157273, 6996.405305549085, 7005.509614326948, 7082.5396349237135, 7084.397826184729, 7099.858002839915, 7100.082977596124, 7105.04081948951, 6844.794656160323, 6845.349691779273, 6854.657267136723, 6863.485238607024, 6865.450763938973, 6577.0, 6739.528233023641, 6741.662916854236, 6752.324767523209, 6753.932460675331, 7063.328983746741, 7096.7516136934955, 7107.573545587281, 7108.680109394986, 7118.181409137808, 4797.664163508521, 4798.928016079832, 4799.9760001199775, 4800.423949125988, 4803.03939212152, 6839.62382068991, 6840.213375461885, 6844.349786770249, 6847.6576171190245, 6847.897281540681, 6542.116814230209, 6679.599224046573, 6691.0, 6691.5315927884585, 6761.188657361148, 6622.271550129578, 6646.0, 6647.567908085959, 6651.06885036105, 6652.301508341555, 6534.215894092739, 6535.411812936859, 6538.967305163444, 6551.246606640298, 6552.737890484518, 6663.400293973566, 6674.566153200027, 6677.0, 6683.665816709243, 6695.765648202289, 6334.0, 6508.642024688498, 6511.2512061113575, 6521.347865213441, 6523.6738163092605], "value": 5005.82921807095, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [891.7815135291852, 910.6493999810072, 917.7797328641126, 920.8572671235961, 925.5326060339528, 13980.0, 14206.573802785908, 14207.218602976833, 14237.78643320351, 14247.715045699093, 14505.912056595746, 14630.707385852276, 14939.92530037351, 14942.402303907831, 14962.17708026058, 703.0824773670383, 850.5704619167312, 858.0518527027638, 867.3668222197799, 870.2515836380708, 865.6926790989203, 867.1285358214985, 867.7093173786789, 868.0104680664048, 868.1752335281476, 900.4282280751704, 901.7069452427954, 902.0933961368816, 902.3818684201343, 903.0, 734.1520543771925, 741.6959046790844, 876.9429987050885, 892.834825557274, 898.0660113481971, 649.772579597142, 655.5018186178492, 657.2146285189201, 658.0819756439739, 658.7628453756644, 14605.78091328631, 14648.267586620626, 14687.77968330476, 14734.63163420923, 14754.631134221623, 14118.435262589484, 14570.562883113524, 14901.105933644016, 14908.478203262943, 15190.848091519054, 11645.767084658344, 11987.160898737093, 12060.155789094766, 12137.575184868487, 12251.93874030633, 3974.4435778990965, 4000.975119526779, 4044.635982761536, 4065.8170382332864, 4108.281050816125, 56898.0, 56976.71511642415, 57467.712661436846, 57740.711296443245, 57817.0, 11449.141314401286, 11503.482343294572, 11592.189167059558, 11877.168598198043, 12104.213226140273, 21406.57186856254, 21447.78552214458, 21450.463738406666, 21468.570628587342, 21478.355649330544, 8174.059983102019, 8417.200365965346, 8706.471390666971, 8836.425632334007, 8838.602262898185, 5008.17365134756, 5132.230706936239, 5136.871578210575, 5152.793888244429, 5285.445028272053, 3322.601287845474, 3372.072680013016, 3376.2403459221478, 3376.44288692363, 3384.4077286474767, 548.8710153114015, 616.7964571691331, 646.2309851277059, 653.0628548033587, 663.1081195791653, 675.8850995330805, 716.9675667039446, 749.1721647579456, 768.5811232878095, 781.3124450483651, 9452.10205030521, 9816.65641702537, 9828.606855725833, 9911.45486998222, 10165.695029149138, 620.5687047502033, 745.9104907411146, 762.8283636181815, 771.3135309574483, 798.3812545277341, 4402.3836662867225, 4611.100835337077, 4617.3304870793545, 4707.411573553306, 4760.166970780099, 60954.69522652358, 61027.38972610217, 61663.691681541306, 61726.69136654288, 62283.6885815568, 51293.23060154101, 51816.74091629518, 51853.0, 52500.73749631227, 57083.14375284374, 49958.75020624946, 50671.493285067416, 51458.48541514537, 52820.73589632104, 52938.73530632322, 10093.889672135912, 10138.230549695993, 10288.897111028793, 10301.278910476194, 10470.738231544272, 38099.0, 38694.6130538691, 38726.6127338723, 39790.80104599459, 39919.60080399159, 47692.7615361921, 49259.75370123127, 49801.25298120458, 50952.235716465024, 51448.48551514587, 12804.487820487077, 12850.164739291917, 12964.22214667123, 13041.087123901236, 13586.79619805684, 14039.157650541, 14439.92780036093, 14693.706125877208, 15190.240487975778, 15190.544283671508, 11661.24201926872, 13727.519536816164, 13783.51757688476, 14351.569452916428, 14449.49426770058, 12570.874291257336, 12644.293020442123, 12856.035797315051, 13257.469701212229, 13405.262710551013, 13079.346032698137, 13354.0, 13619.18284902909, 13659.04386692922, 13876.375563099482, 11251.738594572133, 11334.94332528332, 11343.262687925258, 11776.0, 12091.334976576372, 11529.135314851252, 11570.59502917394, 11658.678995247199, 11751.706207344885, 11755.059595232531], "value": 7121.091716041207, "unit": "score"}], "name": "dromaeo_css", "value": 7405.7625069830265, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 110.0, 109.0, 109.0, 110.0, 106.0, 109.0, 109.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 153.0, 169.0, 126.0, 153.0, 162.0, 128.0, 183.0, 126.0], "value": 148.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 160.0, 161.0, 159.0, 162.0, 162.0, 162.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 166.0, 77.0, 77.0, 77.0, 77.0, 158.0, 74.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 157.0, 93.0, 93.0, 92.0, 154.0, 91.0, 92.0, 151.0], "value": 111.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 147.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 80.0, 52.0, 51.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 59.0, 59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 73.0, 71.0, 74.0, 72.0, 80.0, 72.0, 74.0, 73.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 115.0, 116.0, 121.0, 111.0, 114.0, 112.0, 132.0, 128.0], "value": 117.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 160.0, 154.0, 155.0, 160.0, 157.0, 156.0, 155.0, 159.0, 156.0], "value": 157.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 65.0, 67.0, 65.0, 64.0, 67.0, 66.0, 72.0, 64.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1510.1, "alertThreshold": 2.0}]} 19:27:09 INFO - Return code: 0 19:27:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:27:09 ERROR - # TBPL SUCCESS # 19:27:09 INFO - Running post-action listener: _resource_record_post_action 19:27:09 INFO - Running post-run listener: _resource_record_post_run 19:27:10 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 274432; Write bytes: 497573888; Read time: 44; Write time: 411240 19:27:10 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 249008128; Read time: 0; Write time: 239464 19:27:10 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 274432; Write bytes: 248565760; Read time: 44; Write time: 171776 19:27:10 INFO - Running post-run listener: _upload_blobber_files 19:27:10 INFO - Blob upload gear active. 19:27:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:27:10 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 19:27:10 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:27:10 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:27:10 INFO - (blobuploader) - INFO - Open directory for files ... 19:27:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:27:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:27:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:27:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:27:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:27:11 INFO - (blobuploader) - INFO - Done attempting. 19:27:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:27:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:27:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:27:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:27:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:27:12 INFO - (blobuploader) - INFO - Done attempting. 19:27:12 INFO - (blobuploader) - INFO - Iteration through files over. 19:27:12 INFO - Return code: 0 19:27:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:27:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:27:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/afea4cca8dd2655e6e40c3a73cd2911babb4b53a20f9afb55e15ae9f6762c7cd312d57a102d118838ed64b27c4a91f8a1079e7ed14f3874af2ddde51a3d0032f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac3f1c404c4561026da703bce32a2c4b53ccfe60094bbc1eb99e86a39bd0fa66fb5fdfbc0e021731992ddfb5a4e208f71ee5861c8afaad5dc54d39a50475acce"} 19:27:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:27:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:27:12 INFO - Contents: 19:27:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/afea4cca8dd2655e6e40c3a73cd2911babb4b53a20f9afb55e15ae9f6762c7cd312d57a102d118838ed64b27c4a91f8a1079e7ed14f3874af2ddde51a3d0032f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac3f1c404c4561026da703bce32a2c4b53ccfe60094bbc1eb99e86a39bd0fa66fb5fdfbc0e021731992ddfb5a4e208f71ee5861c8afaad5dc54d39a50475acce"} 19:27:12 INFO - Running post-run listener: copy_logs_to_upload_dir 19:27:12 INFO - Copying logs to upload dir... 19:27:12 INFO - mkdir: /builds/slave/test/build/upload/logs 19:27:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.361861 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-05-20 19:27:12.186962) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 19:27:12.191981) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136 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-Aurora/sha512/afea4cca8dd2655e6e40c3a73cd2911babb4b53a20f9afb55e15ae9f6762c7cd312d57a102d118838ed64b27c4a91f8a1079e7ed14f3874af2ddde51a3d0032f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac3f1c404c4561026da703bce32a2c4b53ccfe60094bbc1eb99e86a39bd0fa66fb5fdfbc0e021731992ddfb5a4e208f71ee5861c8afaad5dc54d39a50475acce"} build_url:https://queue.taskcluster.net/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011408 build_url: 'https://queue.taskcluster.net/v1/task/fJr97Xx5Qbe3DqxbD3ue5g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/afea4cca8dd2655e6e40c3a73cd2911babb4b53a20f9afb55e15ae9f6762c7cd312d57a102d118838ed64b27c4a91f8a1079e7ed14f3874af2ddde51a3d0032f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac3f1c404c4561026da703bce32a2c4b53ccfe60094bbc1eb99e86a39bd0fa66fb5fdfbc0e021731992ddfb5a4e208f71ee5861c8afaad5dc54d39a50475acce"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 19:27:12.217384) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 19:27:12.217745) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1463796402.233680-500397136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 19:27:12.302433) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 19:27:12.302760) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 19:27:12.303064) ========= ========= Total master_lag: 0.18 =========