builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1468665838.11 results: success (0) buildid: 20160716005753 builduid: 32178d7fcc1347eeb657e50ccd208da7 revision: cf21aa15aad09135bfd84d75c5936b13ef9105e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 03:43:58.110709) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 03:43:58.111106) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 03:43:58.111372) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 03:43:58.125968) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:43:58.126223) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-16 03:43:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.6M=0s 2016-07-16 03:43:59 (66.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.364041 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:43:58.522652) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:43:58.525937) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018292 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:43:58.581839) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-16 03:43:58.582165) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cf21aa15aad09135bfd84d75c5936b13ef9105e8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cf21aa15aad09135bfd84d75c5936b13ef9105e8 --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=c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-16 03:43:59,430 truncating revision to first 12 chars 2016-07-16 03:43:59,430 Setting DEBUG logging. 2016-07-16 03:43:59,430 attempt 1/10 2016-07-16 03:43:59,430 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/cf21aa15aad0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-16 03:44:00,777 unpacking tar archive at: mozilla-beta-cf21aa15aad0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.714088 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-16 03:44:00.321738) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 03:44:00.322525) ========= script_repo_revision: cf21aa15aad09135bfd84d75c5936b13ef9105e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 03:44:00.323581) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 03:44:00.324797) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 03:44:00.336738) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-16 03:44:00.337052) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:44:01 INFO - MultiFileLogger online at 20160716 03:44:01 in /builds/slave/test 03:44:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 03:44:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:44:01 INFO - {'append_to_log': False, 03:44:01 INFO - 'base_work_dir': '/builds/slave/test', 03:44:01 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:44:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:44:01 INFO - 'branch': 'Mozilla-Beta', 03:44:01 INFO - 'buildbot_json_path': 'buildprops.json', 03:44:01 INFO - 'config_files': ('talos/linux_config.py',), 03:44:01 INFO - 'default_actions': ('clobber', 03:44:01 INFO - 'read-buildbot-config', 03:44:01 INFO - 'download-and-extract', 03:44:01 INFO - 'populate-webroot', 03:44:01 INFO - 'create-virtualenv', 03:44:01 INFO - 'install', 03:44:01 INFO - 'run-tests'), 03:44:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:44:01 INFO - 'download_minidump_stackwalk': True, 03:44:01 INFO - 'download_symbols': 'ondemand', 03:44:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:44:01 INFO - 'tooltool.py': '/tools/tooltool.py', 03:44:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:44:01 INFO - '/tools/misc-python/virtualenv.py')}, 03:44:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:44:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:44:01 INFO - 'installer_path': 'installer.exe', 03:44:01 INFO - 'log_level': 'info', 03:44:01 INFO - 'log_name': 'talos', 03:44:01 INFO - 'log_to_console': True, 03:44:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:44:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:44:01 INFO - 'opt_config_files': (), 03:44:01 INFO - 'pip_index': False, 03:44:01 INFO - 'sps_profile': False, 03:44:01 INFO - 'sps_profile_interval': 0, 03:44:01 INFO - 'suite': 'dromaeojs-e10s', 03:44:01 INFO - 'system_bits': '32', 03:44:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:44:01 INFO - 'title': 'talos-linux64-ix-004', 03:44:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:44:01 INFO - 'use_talos_json': True, 03:44:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:44:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:44:01 INFO - 'work_dir': 'build'} 03:44:01 INFO - ##### 03:44:01 INFO - ##### Running clobber step. 03:44:01 INFO - ##### 03:44:01 INFO - Running pre-action listener: _resource_record_pre_action 03:44:01 INFO - Running main action method: clobber 03:44:01 INFO - rmtree: /builds/slave/test/build 03:44:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:44:01 INFO - Running post-action listener: _resource_record_post_action 03:44:01 INFO - ##### 03:44:01 INFO - ##### Running read-buildbot-config step. 03:44:01 INFO - ##### 03:44:01 INFO - Running pre-action listener: _resource_record_pre_action 03:44:01 INFO - Running main action method: read_buildbot_config 03:44:01 INFO - Using buildbot properties: 03:44:01 INFO - { 03:44:01 INFO - "project": "", 03:44:01 INFO - "product": "firefox", 03:44:01 INFO - "script_repo_revision": "production", 03:44:01 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 03:44:01 INFO - "repository": "", 03:44:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 03:44:01 INFO - "buildid": "20160716005753", 03:44:01 INFO - "pgo_build": "True", 03:44:01 INFO - "basedir": "/builds/slave/test", 03:44:01 INFO - "buildnumber": 52, 03:44:01 INFO - "slavename": "talos-linux64-ix-004", 03:44:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:44:01 INFO - "platform": "ubuntu64_hw", 03:44:01 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 03:44:01 INFO - "branch": "mozilla-beta", 03:44:01 INFO - "repo_path": "releases/mozilla-beta", 03:44:01 INFO - "revision": "cf21aa15aad09135bfd84d75c5936b13ef9105e8", 03:44:01 INFO - "stage_platform": "linux64-pgo", 03:44:01 INFO - "builduid": "32178d7fcc1347eeb657e50ccd208da7", 03:44:01 INFO - "slavebuilddir": "test" 03:44:01 INFO - } 03:44:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 03:44:01 INFO - Running post-action listener: _resource_record_post_action 03:44:01 INFO - ##### 03:44:01 INFO - ##### Running download-and-extract step. 03:44:01 INFO - ##### 03:44:01 INFO - Running pre-action listener: _resource_record_pre_action 03:44:01 INFO - Running main action method: download_and_extract 03:44:01 INFO - mkdir: /builds/slave/test/build/tests 03:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:01 INFO - https://queue.taskcluster.net/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:44:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:44:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:44:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:44:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:44:07 INFO - Downloaded 1327 bytes. 03:44:07 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:44:07 INFO - Using the following test package requirements: 03:44:07 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 03:44:07 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:44:07 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 03:44:07 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:44:07 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 03:44:07 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:44:07 INFO - u'jsshell-linux-x86_64.zip'], 03:44:07 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:44:07 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 03:44:07 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 03:44:07 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:44:07 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 03:44:07 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:44:07 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 03:44:07 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:44:07 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 03:44:07 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:44:07 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 03:44:07 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:07 INFO - https://queue.taskcluster.net/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:44:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:44:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:44:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:44:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:44:13 INFO - Downloaded 24199485 bytes. 03:44:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:44:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:44:14 INFO - Return code: 0 03:44:14 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:44:14 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')]} 03:44:14 INFO - https://queue.taskcluster.net/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:44:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:44:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:44:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:44:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:44:21 INFO - Downloaded 24199485 bytes. 03:44:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:44:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:44:23 INFO - Return code: 0 03:44:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:23 INFO - https://queue.taskcluster.net/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:44:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 03:44:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 03:44:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 03:44:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:44:24 INFO - Downloaded 10840145 bytes. 03:44:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:44:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:44:24 INFO - Return code: 0 03:44:24 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')]} 03:44:24 INFO - https://queue.taskcluster.net/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:44:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:44:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:44:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:44:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:44:26 INFO - Downloaded 56043718 bytes. 03:44:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:44:26 INFO - mkdir: /builds/slave/test/properties 03:44:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:44:26 INFO - Writing to file /builds/slave/test/properties/build_url 03:44:26 INFO - Contents: 03:44:26 INFO - build_url:https://queue.taskcluster.net/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:44:27 INFO - Running post-action listener: _resource_record_post_action 03:44:27 INFO - Running post-action listener: set_extra_try_arguments 03:44:27 INFO - ##### 03:44:27 INFO - ##### Running populate-webroot step. 03:44:27 INFO - ##### 03:44:27 INFO - Running pre-action listener: _resource_record_pre_action 03:44:27 INFO - Running main action method: populate_webroot 03:44:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:44:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:44:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:44:27 INFO - '--tppagecycles', 03:44:27 INFO - '7'], 03:44:27 INFO - 'tests': ['tsvgm']}}, 03:44:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:44:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:44:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:44:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:44:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:44:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:44:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:27 INFO - 'talos_options': ['--disable-e10s'], 03:44:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:44:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:44:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:27 INFO - 'talos_options': ['--disable-e10s'], 03:44:27 INFO - 'tests': ['damp', 'tps']}, 03:44:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:27 INFO - 'tests': ['damp', 'tps']}, 03:44:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:44:27 INFO - 'tests': ['dromaeo_dom']}, 03:44:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:44:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:44:27 INFO - 'tests': ['a11yr', 03:44:27 INFO - 'ts_paint', 03:44:27 INFO - 'tpaint', 03:44:27 INFO - 'sessionrestore', 03:44:27 INFO - 'sessionrestore_no_auto_restore', 03:44:27 INFO - 'tabpaint']}, 03:44:27 INFO - 'other-e10s': {'tests': ['a11yr', 03:44:27 INFO - 'ts_paint', 03:44:27 INFO - 'tpaint', 03:44:27 INFO - 'sessionrestore', 03:44:27 INFO - 'sessionrestore_no_auto_restore', 03:44:27 INFO - 'tabpaint']}, 03:44:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:44:27 INFO - 'ts_paint', 03:44:27 INFO - 'tpaint', 03:44:27 INFO - 'sessionrestore', 03:44:27 INFO - 'sessionrestore_no_auto_restore', 03:44:27 INFO - 'tabpaint']}, 03:44:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:44:27 INFO - 'ts_paint', 03:44:27 INFO - 'tpaint', 03:44:27 INFO - 'sessionrestore', 03:44:27 INFO - 'sessionrestore_no_auto_restore', 03:44:27 INFO - 'tabpaint']}, 03:44:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:44:27 INFO - 'tests': ['a11yr', 03:44:27 INFO - 'ts_paint', 03:44:27 INFO - 'tpaint', 03:44:27 INFO - 'sessionrestore', 03:44:27 INFO - 'sessionrestore_no_auto_restore', 03:44:27 INFO - 'tabpaint']}, 03:44:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:44:27 INFO - 'tests': ['a11yr', 03:44:27 INFO - 'ts_paint', 03:44:27 INFO - 'tpaint', 03:44:27 INFO - 'sessionrestore', 03:44:27 INFO - 'sessionrestore_no_auto_restore', 03:44:27 INFO - 'tabpaint']}, 03:44:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:44:27 INFO - 'tests': ['tsvgx', 03:44:27 INFO - 'tsvgr_opacity', 03:44:27 INFO - 'tart', 03:44:27 INFO - 'tscrollx', 03:44:27 INFO - 'cart']}, 03:44:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:44:27 INFO - 'tsvgr_opacity', 03:44:27 INFO - 'tart', 03:44:27 INFO - 'tscrollx', 03:44:27 INFO - 'cart']}, 03:44:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:27 INFO - 'talos_options': ['--disable-e10s'], 03:44:27 INFO - 'tests': ['tp5o']}, 03:44:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:27 INFO - 'tests': ['tp5o']}, 03:44:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:27 INFO - 'talos_options': ['--disable-e10s', 03:44:27 INFO - '--xperf_path', 03:44:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:44:27 INFO - 'tests': ['tp5n']}, 03:44:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:27 INFO - 'talos_options': ['--xperf_path', 03:44:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:44:27 INFO - 'tests': ['tp5n']}}, 03:44:27 INFO - 'talos.zip': {'path': '', 03:44:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:44:27 INFO - Running post-action listener: _resource_record_post_action 03:44:27 INFO - ##### 03:44:27 INFO - ##### Running create-virtualenv step. 03:44:27 INFO - ##### 03:44:27 INFO - Running pre-action listener: _resource_record_pre_action 03:44:27 INFO - Running main action method: create_virtualenv 03:44:27 INFO - Creating virtualenv /builds/slave/test/build/venv 03:44:27 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 03:44:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:44:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:44:27 INFO - Using real prefix '/usr' 03:44:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:44:27 INFO - Installing distribute.............................................................................................................................................................................................done. 03:44:29 INFO - Installing pip.................done. 03:44:29 INFO - Return code: 0 03:44:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:44:29 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')]} 03:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:29 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')]} 03:44:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:29 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 0x7f0a297d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17807d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180f640>, '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 0x1810540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18109d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884', '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 03:44:29 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 03:44:29 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 03:44:29 INFO - Using env: {'DISPLAY': ':0', 03:44:29 INFO - 'HOME': '/home/cltbld', 03:44:29 INFO - 'LANG': 'en_US.UTF-8', 03:44:29 INFO - 'LANGUAGE': 'en_US:en', 03:44:29 INFO - 'LOGNAME': 'cltbld', 03:44:29 INFO - 'MAIL': '/var/mail/cltbld', 03:44:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:29 INFO - 'MOZ_NO_REMOTE': '1', 03:44:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:29 INFO - 'NO_EM_RESTART': '1', 03:44:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:29 INFO - 'PWD': '/builds/slave/test', 03:44:29 INFO - 'SHELL': '/bin/bash', 03:44:29 INFO - 'SHLVL': '1', 03:44:29 INFO - 'TERM': 'linux', 03:44:29 INFO - 'TMOUT': '86400', 03:44:29 INFO - 'USER': 'cltbld', 03:44:29 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884', 03:44:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:29 INFO - '_': '/tools/buildbot/bin/python'} 03:44:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:30 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 03:44:30 INFO - Cleaning up... 03:44:30 INFO - Return code: 0 03:44:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:44:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:30 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 0x7f0a297d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17807d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180f640>, '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 0x1810540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18109d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884', '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 03:44:30 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 03:44:30 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 03:44:30 INFO - Using env: {'DISPLAY': ':0', 03:44:30 INFO - 'HOME': '/home/cltbld', 03:44:30 INFO - 'LANG': 'en_US.UTF-8', 03:44:30 INFO - 'LANGUAGE': 'en_US:en', 03:44:30 INFO - 'LOGNAME': 'cltbld', 03:44:30 INFO - 'MAIL': '/var/mail/cltbld', 03:44:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:30 INFO - 'MOZ_NO_REMOTE': '1', 03:44:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:30 INFO - 'NO_EM_RESTART': '1', 03:44:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:30 INFO - 'PWD': '/builds/slave/test', 03:44:30 INFO - 'SHELL': '/bin/bash', 03:44:30 INFO - 'SHLVL': '1', 03:44:30 INFO - 'TERM': 'linux', 03:44:30 INFO - 'TMOUT': '86400', 03:44:30 INFO - 'USER': 'cltbld', 03:44:30 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884', 03:44:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:30 INFO - '_': '/tools/buildbot/bin/python'} 03:44:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:30 INFO - Downloading/unpacking psutil>=0.7.1 03:44:30 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 03:44:30 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 03:44:30 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 03:44:30 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 03:44:30 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 03:44:30 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 03:44:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:44:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:44:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:44:32 INFO - Installing collected packages: psutil 03:44:32 INFO - Running setup.py install for psutil 03:44:32 INFO - building 'psutil._psutil_linux' extension 03:44:32 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 03:44:32 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 03:44:32 INFO - building 'psutil._psutil_posix' extension 03:44:32 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 03:44:32 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 03:44:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:44:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:44:32 INFO - Successfully installed psutil 03:44:32 INFO - Cleaning up... 03:44:32 INFO - Return code: 0 03:44:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:32 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 0x7f0a297d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17807d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180f640>, '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 0x1810540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18109d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884', '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 03:44:32 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 03:44:32 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 03:44:32 INFO - Using env: {'DISPLAY': ':0', 03:44:32 INFO - 'HOME': '/home/cltbld', 03:44:32 INFO - 'LANG': 'en_US.UTF-8', 03:44:32 INFO - 'LANGUAGE': 'en_US:en', 03:44:32 INFO - 'LOGNAME': 'cltbld', 03:44:32 INFO - 'MAIL': '/var/mail/cltbld', 03:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:32 INFO - 'MOZ_NO_REMOTE': '1', 03:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:32 INFO - 'NO_EM_RESTART': '1', 03:44:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:32 INFO - 'PWD': '/builds/slave/test', 03:44:32 INFO - 'SHELL': '/bin/bash', 03:44:32 INFO - 'SHLVL': '1', 03:44:32 INFO - 'TERM': 'linux', 03:44:32 INFO - 'TMOUT': '86400', 03:44:32 INFO - 'USER': 'cltbld', 03:44:32 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884', 03:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:32 INFO - '_': '/tools/buildbot/bin/python'} 03:44:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:44:33 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 03:44:33 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 03:44:33 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 03:44:33 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 03:44:33 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 03:44:33 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 03:44:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:44:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:44:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:44:35 INFO - Installing collected packages: mozsystemmonitor 03:44:35 INFO - Running setup.py install for mozsystemmonitor 03:44:35 INFO - Successfully installed mozsystemmonitor 03:44:35 INFO - Cleaning up... 03:44:35 INFO - Return code: 0 03:44:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:35 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 0x7f0a297d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17807d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180f640>, '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 0x1810540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18109d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884', '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 03:44:35 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 03:44:35 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 03:44:35 INFO - Using env: {'DISPLAY': ':0', 03:44:35 INFO - 'HOME': '/home/cltbld', 03:44:35 INFO - 'LANG': 'en_US.UTF-8', 03:44:35 INFO - 'LANGUAGE': 'en_US:en', 03:44:35 INFO - 'LOGNAME': 'cltbld', 03:44:35 INFO - 'MAIL': '/var/mail/cltbld', 03:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:35 INFO - 'MOZ_NO_REMOTE': '1', 03:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:35 INFO - 'NO_EM_RESTART': '1', 03:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:35 INFO - 'PWD': '/builds/slave/test', 03:44:35 INFO - 'SHELL': '/bin/bash', 03:44:35 INFO - 'SHLVL': '1', 03:44:35 INFO - 'TERM': 'linux', 03:44:35 INFO - 'TMOUT': '86400', 03:44:35 INFO - 'USER': 'cltbld', 03:44:35 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884', 03:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:35 INFO - '_': '/tools/buildbot/bin/python'} 03:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:35 INFO - Downloading/unpacking blobuploader==1.2.4 03:44:35 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 03:44:35 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 03:44:35 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 03:44:35 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 03:44:35 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 03:44:35 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 03:44:37 INFO - Downloading blobuploader-1.2.4.tar.gz 03:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:44:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:44:37 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 03:44:37 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 03:44:37 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 03:44:37 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 03:44:37 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 03:44:37 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 03:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:44:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:44:37 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 03:44:37 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 03:44:37 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 03:44:37 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 03:44:37 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 03:44:37 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 03:44:38 INFO - Downloading docopt-0.6.1.tar.gz 03:44:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:44:38 INFO - Installing collected packages: blobuploader, requests, docopt 03:44:38 INFO - Running setup.py install for blobuploader 03:44:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:44:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:44:38 INFO - Running setup.py install for requests 03:44:38 INFO - Running setup.py install for docopt 03:44:38 INFO - Successfully installed blobuploader requests docopt 03:44:38 INFO - Cleaning up... 03:44:38 INFO - Return code: 0 03:44:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:38 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')]} 03:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:38 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')]} 03:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:38 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 0x7f0a297d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17807d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180f640>, '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 0x1810540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18109d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884', '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 03:44:38 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 03:44:38 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 03:44:38 INFO - Using env: {'DISPLAY': ':0', 03:44:38 INFO - 'HOME': '/home/cltbld', 03:44:38 INFO - 'LANG': 'en_US.UTF-8', 03:44:38 INFO - 'LANGUAGE': 'en_US:en', 03:44:38 INFO - 'LOGNAME': 'cltbld', 03:44:38 INFO - 'MAIL': '/var/mail/cltbld', 03:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:38 INFO - 'MOZ_NO_REMOTE': '1', 03:44:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:38 INFO - 'NO_EM_RESTART': '1', 03:44:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:38 INFO - 'PWD': '/builds/slave/test', 03:44:38 INFO - 'SHELL': '/bin/bash', 03:44:38 INFO - 'SHLVL': '1', 03:44:38 INFO - 'TERM': 'linux', 03:44:38 INFO - 'TMOUT': '86400', 03:44:38 INFO - 'USER': 'cltbld', 03:44:38 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884', 03:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:38 INFO - '_': '/tools/buildbot/bin/python'} 03:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:44:38 INFO - Running setup.py (path:/tmp/pip-UTNMIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:44:39 INFO - Running setup.py (path:/tmp/pip-RSb4fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:44:39 INFO - Running setup.py (path:/tmp/pip-PjahtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:44:39 INFO - Running setup.py (path:/tmp/pip-2Fg3sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:44:39 INFO - Running setup.py (path:/tmp/pip-2Ba5Te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:44:39 INFO - Running setup.py (path:/tmp/pip-91Q6qR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:44:39 INFO - Running setup.py (path:/tmp/pip-ULzrQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:44:39 INFO - Running setup.py (path:/tmp/pip-Ef_Tjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:44:39 INFO - Running setup.py (path:/tmp/pip-sB6cJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:44:39 INFO - Running setup.py (path:/tmp/pip-ygsuq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:44:39 INFO - Running setup.py (path:/tmp/pip-FeRaZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:44:39 INFO - Running setup.py (path:/tmp/pip-Jz7MUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:44:39 INFO - Running setup.py (path:/tmp/pip-6Za6WO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:44:39 INFO - Running setup.py (path:/tmp/pip-EoXXDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:40 INFO - Running setup.py (path:/tmp/pip-liiFIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:44:40 INFO - Running setup.py (path:/tmp/pip-DKqIDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:44:40 INFO - Running setup.py (path:/tmp/pip-HjfYXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:44:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:44:40 INFO - Running setup.py install for manifestparser 03:44:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:44:40 INFO - Running setup.py install for mozcrash 03:44:40 INFO - Running setup.py install for mozdebug 03:44:40 INFO - Running setup.py install for mozdevice 03:44:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:44:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:44:40 INFO - Running setup.py install for mozfile 03:44:40 INFO - Running setup.py install for mozhttpd 03:44:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:44:40 INFO - Running setup.py install for mozinfo 03:44:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:44:40 INFO - Running setup.py install for mozInstall 03:44:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:44:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:44:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:44:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:44:41 INFO - Running setup.py install for mozleak 03:44:41 INFO - Running setup.py install for mozlog 03:44:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:44:41 INFO - Running setup.py install for moznetwork 03:44:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:44:41 INFO - Running setup.py install for mozprocess 03:44:41 INFO - Running setup.py install for mozprofile 03:44:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:44:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:44:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:44:41 INFO - Running setup.py install for mozrunner 03:44:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:44:41 INFO - Running setup.py install for mozscreenshot 03:44:41 INFO - Running setup.py install for moztest 03:44:41 INFO - Running setup.py install for mozversion 03:44:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:44:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:44:41 INFO - Cleaning up... 03:44:42 INFO - Return code: 0 03:44:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:42 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 0x7f0a297d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17807d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180f640>, '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 0x1810540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18109d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884', '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 03:44:42 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 03:44:42 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 03:44:42 INFO - Using env: {'DISPLAY': ':0', 03:44:42 INFO - 'HOME': '/home/cltbld', 03:44:42 INFO - 'LANG': 'en_US.UTF-8', 03:44:42 INFO - 'LANGUAGE': 'en_US:en', 03:44:42 INFO - 'LOGNAME': 'cltbld', 03:44:42 INFO - 'MAIL': '/var/mail/cltbld', 03:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:42 INFO - 'MOZ_NO_REMOTE': '1', 03:44:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:42 INFO - 'NO_EM_RESTART': '1', 03:44:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:42 INFO - 'PWD': '/builds/slave/test', 03:44:42 INFO - 'SHELL': '/bin/bash', 03:44:42 INFO - 'SHLVL': '1', 03:44:42 INFO - 'TERM': 'linux', 03:44:42 INFO - 'TMOUT': '86400', 03:44:42 INFO - 'USER': 'cltbld', 03:44:42 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884', 03:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:42 INFO - '_': '/tools/buildbot/bin/python'} 03:44:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:44:42 INFO - Running setup.py (path:/tmp/pip-YHQLyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:44:42 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)) 03:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:44:42 INFO - Running setup.py (path:/tmp/pip-OoTqtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:44:42 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)) 03:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:44:42 INFO - Running setup.py (path:/tmp/pip-YUOL4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:44:42 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)) 03:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:44:42 INFO - Running setup.py (path:/tmp/pip-ShLszM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:44:42 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)) 03:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:44:42 INFO - Running setup.py (path:/tmp/pip-VQzA93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:44:42 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)) 03:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:44:42 INFO - Running setup.py (path:/tmp/pip-xCU0Ul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:44:42 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)) 03:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:44:42 INFO - Running setup.py (path:/tmp/pip-m3UPiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:44:42 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)) 03:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:44:42 INFO - Running setup.py (path:/tmp/pip-d2T99y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:44:42 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)) 03:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:44:42 INFO - Running setup.py (path:/tmp/pip-slpR2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:44:42 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)) 03:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:44:42 INFO - Running setup.py (path:/tmp/pip-n_xiub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:44:42 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)) 03:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:44:42 INFO - Running setup.py (path:/tmp/pip-Ey43FN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:44:43 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)) 03:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:44:43 INFO - Running setup.py (path:/tmp/pip-xrq5xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:44:43 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)) 03:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:44:43 INFO - Running setup.py (path:/tmp/pip-WqiP9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:44:43 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)) 03:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:44:43 INFO - Running setup.py (path:/tmp/pip-nrsK9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:44:43 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)) 03:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:43 INFO - Running setup.py (path:/tmp/pip-oVjvGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:43 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)) 03:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:44:43 INFO - Running setup.py (path:/tmp/pip-Ddw5J7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:44:43 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)) 03:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:44:43 INFO - Running setup.py (path:/tmp/pip-J0EMzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:44:43 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)) 03:44:43 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)) 03:44:43 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)) 03:44:43 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)) 03:44:43 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)) 03:44:43 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)) 03:44:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:44:43 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 03:44:43 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 03:44:43 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 03:44:43 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 03:44:43 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 03:44:43 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 03:44:45 INFO - Downloading blessings-1.6.tar.gz 03:44:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:44:45 INFO - Installing collected packages: blessings 03:44:45 INFO - Running setup.py install for blessings 03:44:45 INFO - Successfully installed blessings 03:44:45 INFO - Cleaning up... 03:44:45 INFO - Return code: 0 03:44:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:44:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:44:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:44:45 INFO - Reading from file tmpfile_stdout 03:44:45 INFO - Current package versions: 03:44:45 INFO - argparse == 1.2.1 03:44:45 INFO - blessings == 1.6 03:44:45 INFO - blobuploader == 1.2.4 03:44:45 INFO - docopt == 0.6.1 03:44:45 INFO - manifestparser == 1.1 03:44:45 INFO - mozInstall == 1.12 03:44:45 INFO - mozcrash == 0.17 03:44:45 INFO - mozdebug == 0.1 03:44:45 INFO - mozdevice == 0.48 03:44:45 INFO - mozfile == 1.2 03:44:45 INFO - mozhttpd == 0.7 03:44:45 INFO - mozinfo == 0.9 03:44:45 INFO - mozleak == 0.1 03:44:45 INFO - mozlog == 3.1 03:44:45 INFO - moznetwork == 0.27 03:44:45 INFO - mozprocess == 0.22 03:44:45 INFO - mozprofile == 0.28 03:44:45 INFO - mozrunner == 6.11 03:44:45 INFO - mozscreenshot == 0.1 03:44:45 INFO - mozsystemmonitor == 0.0 03:44:45 INFO - moztest == 0.7 03:44:45 INFO - mozversion == 1.4 03:44:45 INFO - psutil == 3.1.1 03:44:45 INFO - requests == 1.2.3 03:44:45 INFO - wsgiref == 0.1.2 03:44:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44: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')]} 03:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44: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')]} 03:44:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:45 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 0x7f0a297d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17807d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180f640>, '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 0x1810540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18109d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884', '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 03:44:45 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 03:44:45 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 03:44:45 INFO - Using env: {'DISPLAY': ':0', 03:44:45 INFO - 'HOME': '/home/cltbld', 03:44:45 INFO - 'LANG': 'en_US.UTF-8', 03:44:45 INFO - 'LANGUAGE': 'en_US:en', 03:44:45 INFO - 'LOGNAME': 'cltbld', 03:44:45 INFO - 'MAIL': '/var/mail/cltbld', 03:44:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:45 INFO - 'MOZ_NO_REMOTE': '1', 03:44:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:45 INFO - 'NO_EM_RESTART': '1', 03:44:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:45 INFO - 'PWD': '/builds/slave/test', 03:44:45 INFO - 'SHELL': '/bin/bash', 03:44:45 INFO - 'SHLVL': '1', 03:44:45 INFO - 'TERM': 'linux', 03:44:45 INFO - 'TMOUT': '86400', 03:44:45 INFO - 'USER': 'cltbld', 03:44:45 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884', 03:44:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:45 INFO - '_': '/tools/buildbot/bin/python'} 03:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:46 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)) 03:44:46 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)) 03:44:46 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)) 03:44:46 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)) 03:44:46 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)) 03:44:46 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)) 03:44:46 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)) 03:44:46 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)) 03:44:46 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)) 03:44:46 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)) 03:44:46 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)) 03:44:46 INFO - Cleaning up... 03:44:46 INFO - Return code: 0 03:44:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:44:46 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')]} 03:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:46 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')]} 03:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:46 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 0x7f0a297d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17807d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180f640>, '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 0x1810540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18109d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884', '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 03:44:46 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 03:44:46 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 03:44:46 INFO - Using env: {'DISPLAY': ':0', 03:44:46 INFO - 'HOME': '/home/cltbld', 03:44:46 INFO - 'LANG': 'en_US.UTF-8', 03:44:46 INFO - 'LANGUAGE': 'en_US:en', 03:44:46 INFO - 'LOGNAME': 'cltbld', 03:44:46 INFO - 'MAIL': '/var/mail/cltbld', 03:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:46 INFO - 'MOZ_NO_REMOTE': '1', 03:44:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:46 INFO - 'NO_EM_RESTART': '1', 03:44:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:46 INFO - 'PWD': '/builds/slave/test', 03:44:46 INFO - 'SHELL': '/bin/bash', 03:44:46 INFO - 'SHLVL': '1', 03:44:46 INFO - 'TERM': 'linux', 03:44:46 INFO - 'TMOUT': '86400', 03:44:46 INFO - 'USER': 'cltbld', 03:44:46 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884', 03:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:46 INFO - '_': '/tools/buildbot/bin/python'} 03:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:46 INFO - Downloading/unpacking jsonschema 03:44:46 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 03:44:46 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 03:44:46 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 03:44:46 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 03:44:46 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 03:44:46 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 03:44:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:44:48 INFO - Downloading/unpacking functools32 (from jsonschema) 03:44:48 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 03:44:48 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 03:44:48 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 03:44:48 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 03:44:48 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 03:44:48 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 03:44:48 INFO - Downloading functools32-3.2.3-2.tar.gz 03:44:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:44:48 INFO - warning: no files found matching '*.txt' 03:44:48 INFO - no previously-included directories found matching 'build' 03:44:48 INFO - no previously-included directories found matching 'dist' 03:44:48 INFO - no previously-included directories found matching '.git*' 03:44:48 INFO - Installing collected packages: jsonschema, functools32 03:44:48 INFO - Running setup.py install for functools32 03:44:48 INFO - warning: no files found matching '*.txt' 03:44:48 INFO - no previously-included directories found matching 'build' 03:44:48 INFO - no previously-included directories found matching 'dist' 03:44:48 INFO - no previously-included directories found matching '.git*' 03:44:48 INFO - Successfully installed jsonschema functools32 03:44:48 INFO - Cleaning up... 03:44:48 INFO - Return code: 0 03:44:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0a297d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17807d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180f640>, '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 0x1810540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18109d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884', '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 03:44:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:44:48 INFO - Using env: {'DISPLAY': ':0', 03:44:48 INFO - 'HOME': '/home/cltbld', 03:44:48 INFO - 'LANG': 'en_US.UTF-8', 03:44:48 INFO - 'LANGUAGE': 'en_US:en', 03:44:48 INFO - 'LOGNAME': 'cltbld', 03:44:48 INFO - 'MAIL': '/var/mail/cltbld', 03:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:48 INFO - 'MOZ_NO_REMOTE': '1', 03:44:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:48 INFO - 'NO_EM_RESTART': '1', 03:44:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:48 INFO - 'PWD': '/builds/slave/test', 03:44:48 INFO - 'SHELL': '/bin/bash', 03:44:48 INFO - 'SHLVL': '1', 03:44:48 INFO - 'TERM': 'linux', 03:44:48 INFO - 'TMOUT': '86400', 03:44:48 INFO - 'USER': 'cltbld', 03:44:48 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884', 03:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:48 INFO - '_': '/tools/buildbot/bin/python'} 03:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:48 INFO - Downloading/unpacking flake8 03:44:48 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 03:44:48 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 03:44:48 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 03:44:48 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 03:44:48 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 03:44:48 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 03:44:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:44:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:44:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:44:51 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 03:44:51 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 03:44:51 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 03:44:51 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 03:44:51 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 03:44:51 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 03:44:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:44:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:44:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:44:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:44:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:44:51 INFO - no previously-included directories found matching 'docs/_build' 03:44:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:44:51 INFO - Running setup.py install for pep8 03:44:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:44:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:44:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:44:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:44:51 INFO - no previously-included directories found matching 'docs/_build' 03:44:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:44:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:44:51 INFO - Cleaning up... 03:44:51 INFO - Return code: 0 03:44:51 INFO - Running post-action listener: _resource_record_post_action 03:44:51 INFO - Running post-action listener: _start_resource_monitoring 03:44:51 INFO - Starting resource monitoring. 03:44:51 INFO - ##### 03:44:51 INFO - ##### Running install step. 03:44:51 INFO - ##### 03:44:51 INFO - Running pre-action listener: _resource_record_pre_action 03:44:51 INFO - Running main action method: install 03:44:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:44:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:44:51 INFO - Reading from file tmpfile_stdout 03:44:51 INFO - Detecting whether we're running mozinstall >=1.0... 03:44:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:44:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:44:52 INFO - Reading from file tmpfile_stdout 03:44:52 INFO - Output received: 03:44:52 INFO - Usage: mozinstall [options] installer 03:44:52 INFO - Options: 03:44:52 INFO - -h, --help show this help message and exit 03:44:52 INFO - -d DEST, --destination=DEST 03:44:52 INFO - Directory to install application into. [default: 03:44:52 INFO - "/builds/slave/test"] 03:44:52 INFO - --app=APP Application being installed. [default: firefox] 03:44:52 INFO - mkdir: /builds/slave/test/build/application 03:44:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:44:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:45:05 INFO - Reading from file tmpfile_stdout 03:45:05 INFO - Output received: 03:45:05 INFO - /builds/slave/test/build/application/firefox/firefox 03:45:05 INFO - Running post-action listener: _resource_record_post_action 03:45:05 INFO - ##### 03:45:05 INFO - ##### Running run-tests step. 03:45:05 INFO - ##### 03:45:05 INFO - Running pre-action listener: _resource_record_pre_action 03:45:05 INFO - Running main action method: run_tests 03:45:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:45:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:45:05 INFO - Python 2.7.3 03:45:05 INFO - Return code: 0 03:45:05 INFO - grabbing minidump binary from tooltool 03:45:05 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')]} 03:45:05 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 0x180f640>, '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 0x1810540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18109d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:45:05 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 03:45:05 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 03:45:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:45:05 INFO - Return code: 0 03:45:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:45:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:45:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:45:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:45:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:45:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:45:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:45:06 INFO - Return code: 0 03:45:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:45:06 INFO - Using env: {'DISPLAY': ':0', 03:45:06 INFO - 'HOME': '/home/cltbld', 03:45:06 INFO - 'LANG': 'en_US.UTF-8', 03:45:06 INFO - 'LANGUAGE': 'en_US:en', 03:45:06 INFO - 'LOGNAME': 'cltbld', 03:45:06 INFO - 'MAIL': '/var/mail/cltbld', 03:45:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:45:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:45:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:06 INFO - 'MOZ_NO_REMOTE': '1', 03:45:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:45:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:06 INFO - 'NO_EM_RESTART': '1', 03:45:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:06 INFO - 'PWD': '/builds/slave/test', 03:45:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:45:06 INFO - 'SHELL': '/bin/bash', 03:45:06 INFO - 'SHLVL': '1', 03:45:06 INFO - 'TERM': 'linux', 03:45:06 INFO - 'TMOUT': '86400', 03:45:06 INFO - 'USER': 'cltbld', 03:45:06 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884', 03:45:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:06 INFO - '_': '/tools/buildbot/bin/python'} 03:45:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:45:06 INFO - mozversion application_buildid: 20160716005753 03:45:06 INFO - mozversion application_changeset: cf21aa15aad09135bfd84d75c5936b13ef9105e8 03:45:06 INFO - mozversion application_display_name: Firefox 03:45:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:45:06 INFO - mozversion application_name: Firefox 03:45:06 INFO - mozversion application_remotingname: firefox 03:45:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:45:06 INFO - mozversion application_vendor: Mozilla 03:45:06 INFO - mozversion application_version: 48.0 03:45:06 INFO - mozversion platform_buildid: 20160716005753 03:45:06 INFO - mozversion platform_changeset: cf21aa15aad09135bfd84d75c5936b13ef9105e8 03:45:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:45:06 INFO - mozversion platform_version: 48.0 03:45:06 INFO - using testdate: 1468665906 03:45:06 INFO - actual date: 1468665906 03:45:06 INFO - starting webserver on 'localhost:39401' 03:45:06 INFO - SUITE-START | Running 2 tests 03:45:06 INFO - TEST-START | dromaeo_css 03:45:06 INFO - operating with platform_type : linux_ 03:45:06 INFO - Initialising browser for dromaeo_css test... 03:45:06 INFO - TEST-INFO | started process 13935 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcb2u7Z/profile http://localhost:39401/getInfo.html) 03:45:10 INFO - PROCESS | 13935 | 03:45:10 INFO - PROCESS | 13935 | (process:14013): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:45:10 INFO - PROCESS | 13935 | __metrics Screen width/height:1600/1200 03:45:10 INFO - PROCESS | 13935 | colorDepth:24 03:45:10 INFO - PROCESS | 13935 | Browser inner width/height: 1024/697 03:45:10 INFO - PROCESS | 13935 | __metrics 03:45:11 ERROR - PROCESS | 13935 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 03:45:12 INFO - TEST-INFO | 13935: exit 0 03:45:12 INFO - Browser initialized. 03:45:12 INFO - Running cycle 1/1 for dromaeo_css test... 03:45:12 INFO - TEST-INFO | started process 14064 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcb2u7Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:14 INFO - PROCESS | 14064 | 03:45:14 INFO - PROCESS | 14064 | (process:14131): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:45:24 INFO - PROCESS | 14064 | RSS: Main: 151085056 03:45:24 INFO - PROCESS | 14064 | 03:46:13 INFO - PROCESS | 14064 | 1468665973724 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] 03:48:20 INFO - PROCESS | 14064 | Cycle 1(1): loaded http://localhost:39401/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39401/tests/dromaeo/cssquery-ext.html) 03:48:21 INFO - PROCESS | 14064 | RSS: Main: 154603520 03:48:21 INFO - PROCESS | 14064 | 03:51:23 INFO - PROCESS | 14064 | Cycle 1(1): loaded http://localhost:39401/tests/dromaeo/cssquery-ext.html (next: http://localhost:39401/tests/dromaeo/cssquery-jquery.html) 03:51:24 INFO - PROCESS | 14064 | RSS: Main: 152002560 03:51:24 INFO - PROCESS | 14064 | 03:54:26 INFO - PROCESS | 14064 | Cycle 1(1): loaded http://localhost:39401/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39401/tests/dromaeo/cssquery-mootools.html) 03:54:26 INFO - PROCESS | 14064 | RSS: Main: 152285184 03:54:26 INFO - PROCESS | 14064 | 03:57:28 INFO - PROCESS | 14064 | Cycle 1(1): loaded http://localhost:39401/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39401/tests/dromaeo/cssquery-prototype.html) 03:57:28 INFO - PROCESS | 14064 | RSS: Main: 153530368 03:57:28 INFO - PROCESS | 14064 | 04:00:31 INFO - PROCESS | 14064 | Cycle 1(1): loaded http://localhost:39401/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39401/tests/dromaeo/cssquery-yui.html) 04:00:31 INFO - PROCESS | 14064 | RSS: Main: 152330240 04:00:31 INFO - PROCESS | 14064 | 04:03:34 INFO - PROCESS | 14064 | Cycle 1(1): loaded http://localhost:39401/tests/dromaeo/cssquery-yui.html (next: http://localhost:39401/tests/dromaeo/cssquery-dojo.html) 04:03:34 INFO - PROCESS | 14064 | RSS: Main: 156295168 04:03:34 INFO - PROCESS | 14064 | 04:03:34 INFO - PROCESS | 14064 | __start_tp_report 04:03:34 INFO - PROCESS | 14064 | _x_x_mozilla_page_load 04:03:34 INFO - PROCESS | 14064 | _x_x_mozilla_page_load_details 04:03:34 INFO - PROCESS | 14064 | |i|pagename|runs| 04:03:34 INFO - PROCESS | 14064 | |0;dojo.html;3266.575345205123;3268.4933835255542;3303;3305.272839975206;3306.3717893600224;5433.8369848904495;5442.993046286435;5443.455654434554;5461.18082287657;5466.726663666821;5405.18922161676;5448.591355648323;5474.124140137579;5495.093309603911;5496.780128794843;4914.655974081816;4934.4325402578625;4989.376327959005;5006.974965125188;5037.042961837239;4777.90444191116;4811.615070794328;5045.394552653686;5083.237514372837;5089.236614507817;5009.298698182258;5026.874328141807;5053.974730126344;5056.84829455117;5089.923651145235;5024.673396229252;5051.873703157414;5055.4186268579215;5062.468440813698;5091.66904151229;4826.155422800995;4939.032573953771;4959.330490383824;4980.452150263468;5014.047331007097;5225.033368826741;5236.81671141512;5261.342332208474;5288.10102282609;5294;5724.5992780505385;5728.598998070137;5730.997075511768;5732.197492351074;5743.54051675865;5748.281464816898;5816.796412125597;5839.9124013139835;5849.44430279127;5902.675352855634;5418.485243901823;5432.29380180574;5439.265699130607;5446.1558458439;5485.61600687952;5842.444967728059;5906.409359064145;5908.763649454059;5929.822105336847;5940.257467816523;5438.320209973754;5655.688937108416;5699.031164702011;5717.885642287131;5755.366909639936;5716.056850619684;5721.542276617861;5729.455701708331;5733.827985160452;5743.4543718346695;5708.486236238676;5714.285714285715;5716.942830571724;5746.109353050284;5751.654900705971;5679.630823996427;5842.824715258549;5855.59010869235;5880.676562789002;5912.379200184005;4458;4459.1304695584695;4466.240739074366;4485.686001979895;4508.549145085531;3958.802059897051;4016.49793775778;4035.051762835731;4039.3738970459626;4043.0903046814233;5519.254900588449;5567.49892509668;5584.944150558524;5586.245856809279;5605.943940560543;5869.20765696634;5875.588708790344;5877.089051197071;5877.147813567009;5892.6759028253;5548.112302031655;5631.7747290108755;5643.943560564342;5650.124230744241;5653.038983372837;5046.369203849519;5050.141475949097;5094.592432605456;5102.897942041139;5116.513931176607;6097.939020609826;6106.664133472702;6142.385761423822;6153.169322141453;6154.569180157436;5832.445917637818;5855.151003104611;5880.500157486662;5894.115882617642;5903.616264942765;6137.285055221685;6191.690415479118;6241.531885108544;6242.063690446469;6242.875142497034;5651.8304450866535;5653.123765816141;5662.377138514677;5667.688277144796;5698.2592263005545;5665.915011274752;5727.942720572908;5735.655860648374;5777.7977770777825;5801.709914504342;5604.971975140098;5676.375598684224;5676.659400435987;5678.602497825113;5710.543156547383;5617.634853734494;5634.549236061187;5643.407442218672;5668.7165641718575;5672.12082127271;5567.164925261243;5567.498925096761;5568.192612071146;5646.463585959327;5713.371529131875;5682.14767784819;5716.314042314949;5725.942740572707;5742.569307301886;5748.597598168255;5558.610897237155;5591.888162236651;5605.383407825218;5615.5507559395965;5619.522340601095 04:03:34 INFO - PROCESS | 14064 | |1;ext.html;650.4178760009792;667.12939613804;667.672840308249;678.257308247469;694.9722011119555;30968.690313096864;39997.60002399975;40132.1973560529;40284.79857600715;40563.39154912671;42677;43284.56715432853;43306.78346608271;43391.132177356434;43397.56602433975;8814.427062240933;8976.506292153928;8979;8997.145271199226;8997.640094396216;8873.645054197825;8954.552272386387;8966.0585638508;8987.955060224689;9150.130737579919;9050.5022223778;9171.40385874916;9186;9205.953970230139;9208.355415120945;9108.954455227748;9149.313801464918;9165.450072995609;9165.908340916572;9174.54127293636;8998.595063222105;9073.183413492752;9077.63689452421;9082.40964337316;9096.181343679034;43412.34881476781;44014.55985440168;44085.559144408464;44217.55782442167;44278.335824962654;3891.0466935600675;3920.2159568086495;4018.2566225248424;4167.91664166715;4323.546027667081;32906.835465822754;33278.6672133278;33604.1598960028;33947.490787638206;34465.483017754756;4468.597826195625;4521.163584736802;4577.3362862384765;4651.395318608559;4653.325267836145;302685;305166;306044;306625;307026.4648676765;60086;60242;60607;60638.39361606327;60643.69678151581;71490.64254678797;73056.63471682607;73097.2690273101;73104;73247.63376183085;18595.25618975253;18785.15466803997;18814.435566933014;18842.71735923962;18897.905510472636;14594.927025365017;14662.63343416423;14667.92666036663;14712.190829504267;14764.114153150846;20843.791562084487;20994.580108397746;21073;21091.8945405272;21136.577268454545;7677.577733224614;7788.57162856037;7825.178356272623;7836.608169591497;7903.288704016666;1112.6217086190734;1120.3389999900098;1137.9473986562396;1151.073385924322;1155.1625071822862;32345.35309293801;33081.48598237872;33105;33224.83387583047;33729.83135084358;1226.9141160118706;1234.9320787356783;1236;1260.6407173955379;1269.361240711068;17114.14429278556;17359.633694888507;17418.912905435645;17496.47510574685;17656;459651;466754;540032;843594;858317;61029;62150.37849621446;62177.68911155415;62291;62634;1451.6878871042777;1522.5889009967248;1533.7776022476678;1542.4524293875736;1549.504158669215;32556.348873021932;32956.01131966045;32999.34001320008;33306;33966.32067358688;52864;53517;53636.46363536315;53692.73153634207;53729.73135134299;401927;402417;405032;405203;405325;30722.385552289277;30994.84502577563;31172.53241201429;31226.687733122377;31439.21401964969;49682;49868.25197621966;49980.50019499904;49982.25026624676;50820.49179508157;40506.69583764173;41472.37791433191;41632;41646.1670766589;42260.36609450799;40960.79519602502;41252.58747412608;42097.15805683808;42746.78626606847;43814.56185438105;40892.38661420141;41460.79269603753;41887.371689425294;42305.78847105745;42372.1525569493;35046.47430288497;35109.12227194341;35243.29513409666;35445.46831797577;35608.46587301141;28211.43577128405;28679.56980645334;28884.855575721987;28899;29102.417951641273 04:03:34 INFO - PROCESS | 14064 | |2;jquery.html;413.1468517511337;413.31389892777986;420.85480509224305;425.98296068157276;426.66293628033856;15456.22718864058;18502.444926652206;19273.421797346084;19313.613727725453;19509.804901950974;18776.71834922477;19032.238710451566;19642.214311427524;20040.0981955812;20054.097565609547;5583.35791383991;5656.943430565703;5900.586958912878;5993.250843644544;6011.218541589609;5888;5927.673977931212;5937.079752638348;5944.910826337608;5973;5722.2274992876055;5920.88158236835;5941.7029148542615;5957;5966;5902.468777809975;5906.37983011784;5930.169776231352;5942.435468630473;5968.67172305523;5152.768125434364;5292.497212764782;5340.599455040849;5344.706041167734;5361.142217245261;22456.550868982693;22614;22654.88672556643;22656;22990;2300.470891694903;2390.497995420964;2408.980281130479;2433.3186707721866;2462.1382516119393;14818.40726370944;15204.543863684106;15352.232388380537;15360.846391536053;15500.767488487681;2004.2984955265686;2060.5981833542464;2113.4821968617634;2116.4920419099303;2148.1192710988576;79612.20387796164;79853;80071.599642002;82555;82644.58677706633;10826.837597436044;11209.412987843813;11293.548258069584;11485.425728713531;11503.482343294572;15545.922270388575;15676.451324203597;15725.135117568414;15770.76343854843;16110.919445402698;8610.268127209258;8727.083656216006;8912.420692654956;8924.375293729507;8989.516060556176;8759.722472157158;8797.252233560092;8855.291576673852;8871.556422178865;8923.196912277926;5025.899482010339;5044.974775126101;5102.4897510248675;5104.744762761847;5128.615353848476;2112.8732276063483;2126.2239282662026;2170.1536400803698;2170.8914554272224;2176.7061446704492;1033.7932413517326;1041.146260066738;1093.9781204375868;1145.123980155182;1188.2395267029108;19080.332188373617;19317;19466.70799938002;19865.205391784166;19907.800921990885;1048.9790204195874;1055.2507719519228;1102.652664410708;1114.3759494683004;1127.301073334538;10850.294730842628;10991.230613856953;11021.779564408667;11066.225364224589;11102.333859968428;445612;465279;466686;468160;469030;95962;96472;96601.51699241459;96818.51590742;100855;1062.1502797761914;1074.5540600650643;1081.5241293830688;1088.2762962629763;1094.020851338048;17057.402990895258;17313.567160820578;17337.393191238247;17403.651926961138;17523.82476175273;37721.434178486794;38809.41785873158;39345;39370;41572.168556628094;55007;59313.11030334462;59600.40399595949;60315.69842150761;60396.69801650964;8563.571821409028;8680.175383338572;8728.73813785562;8832.02847686741;12123.272603643809;13423.731525369632;13825.723485530032;14043.859561404255;14206;14491.565253042425;12779.680507987374;12825.871741282841;12866.549670761478;13195.406206720529;13345.399457024263;12288;12518.270311117167;12528.874711253135;12594.24434533931;12598.61379320688;12769.808452873029;12931.353432328535;13235;13264.403101860247;13325.533606323732;12761.085837124134;12813.807792882928;12849;12884.35578221104;13124.803127952897;12873.549425770054;12970.546030888874;12975.351232438528;12990.545330913372;13065 04:03:34 INFO - PROCESS | 14064 | |3;mootools.html;1599.8720102391806;1603.7915071040766;1830.3319288459709;1902.73361729358;1932.7197556354329;8556.786080347994;8656.220940115389;8776.429532080418;8790.208881200699;8842.734717958456;8762.737117886474;8829.072947340517;8849.778755531115;8882.95558522208;8924;2462.3597864555254;2469.2592222333274;2471.1104002559064;2481.5905375613;2486.4529803443215;2462.692163479565;2538.4415428605676;2542.4660821227562;2544.74552544745;2545.032887502756;2375.928722138339;2385.3917251100943;2510.7112682041616;2524.482481091372;2526.7725904668578;2463.3472129885595;2465.2480993297036;2480.094765410621;2489.3154382544762;2503.924882253535;2488.427661637815;2496.737842526527;2506.1980166346775;2532.8733563321944;2535.632333311678;8863.11368863115;8865.955670221672;8872.911270887273;8892.244159246471;8892.955535222347;5298.36419629643;5479.479449452336;5481.479259470344;5488.780448782044;5500.147477141049;3341.298327351259;3372.6627337266077;3444.3800115979116;3500.457429098494;3501.9474707879403;1123.4607388453505;1133.1501373969522;1150.2868221702515;1167.5913430299413;1170.7834050700562;12345.93827030859;12407.44166512509;12434.440450179764;12460.43928023232;12477.50089996399;4633.72197668141;4668.50980647034;4741.976290118528;4754.4532378776885;4824.903501929942;9837.704868853945;9872.259580531489;9873.111419972238;9882.11061004513;9882.654107106217;5421.186821976735;5428.9185662215095;5452.154915988028;5454.945450545523;5467.425920278393;4876.975835074674;4981.651284410056;5024.246363045572;5055.848324550269;5065.39215294167;4073.572274911151;4092.672586193157;4125.419910584481;4126.773027483458;4129.814158362881;1190.9047276217882;1261.1235191541791;1262.8547717012661;1271.5994461744706;1275.7002104505434;1005.4218824176128;1067.9412632305298;1083.7724077943562;1101.24014430043;1109.4064675398622;6042.879142417127;6066.150738896558;6096.939030609726;6258.468030217391;6315.621062736251;977.2475194100645;1042.8227201375785;1053.847192157133;1054.46222426563;1082.4209048159198;4066.877993660195;4151.543330233671;4156.418101465797;4174.979125104355;4188.539260681323;10501.264911456277;10729.463526823783;10761.192910531741;10879.347239165518;10882.020618144405;10075.848862267072;10674.359538427563;10743.623973160902;10904.236703430843;10985.725356866142;8145.714899978472;8207.425480216447;8225.506469611842;8298.751037468886;8354.58227088643;5689.431056894443;6044.718735332623;6066.1507388966465;6138.202033735586;6202;9426.434413935185;9443.669471568463;9446.905530944603;9493.05069493045;9554.187894029086;9518.61925522999;9652.855207171757;9658.565364558752;9761;9959.253056020973;7341.74303899361;7468.327850493264;7501.962490187732;7690.80792477167;7865.331446827084;8251.711190108557;8257.133001034805;8261.09127995932;8308.127646597262;8323.417360784686;7167.641617919187;7207.71169153228;7256.7822965311125;7262.237465066303;7403.481756277224;7255.818604534928;7361.742339018108;7403.185649578434;7413.443991700752;7668.233176682287;6899.17209934811;6920.619365934721;6963.234044255027;6986.476014298846;6986.895196572157;5115.846524604268;5175.861310511681;5271.868203294948;5312.442193569619;5386.218998245311;5364.275822763877;5383.353997520323;5395.244665746877;5484.314460692413;5488.670679759227 04:03:34 INFO - PROCESS | 14064 | |4;prototype.html;366.75427463599385;369.49563845351094;370.6682519145364;373.05244678516567;376.49361608636394;6528.7714929977465;6585.078089067534;6593.142891424108;6615.669216539178;6732.697028633711;6559.868802623944;6576.342365763421;6617.437517810979;6619.371159739817;6622.0729097926205;4827.131116399056;4891.461939186686;4912.484189160123;4919.286703428001;4934.876628084308;4903.632227582928;4904.558589726924;4915.6313276504225;4915.926261106087;4920.458749537566;4879;4884.267359896008;4933.284673722308;4948.678335908173;4952.603791696673;4952.281919121743;4957.3059771632;4958.330625365584;4962.131626965284;4965.280034394992;4315.050688848449;4327.37253098299;4327.8052487637815;4330.545292744279;4339.132173565299;6079.483243924272;6282.246130464374;6284.811455656338;6314.116023756677;6338.556301058928;5730.398308177665;5758.395368486333;5760.711964401763;5770.711464426804;5773.162891380726;6946.409555187815;6953.687084081229;6959.095317608729;6980.267071957423;6980.9650951745425;4721.079389519045;4757.26262429324;4758.072175925696;4765.28520721891;4766.785494652749;7128.857422851565;7173.067501224859;7194.064771579661;7203.495755297131;7208.098987626547;4577.198990176772;4624.213883639789;4626.4910859805395;4634.23535116702;4852.636052296092;4655.231886738718;4683.1336202802595;4688.179568575554;4688.226442636927;4688.296755486705;5520.585956053312;5521.337439507285;5523.7238138092935;5693.572982026281;5710.65736055838;6931.410830079399;6964.199117101497;6981.720731170696;6986.9650651746415;6998.370146686822;1705.5821323775754;1738.8869723467933;1741.2512619573452;1743.1371471121622;1745.1972092837184;1101.8898110189077;1128.3568366031284;1144;1151.6084531259412;1152.0783373301326;6739.932600674028;6759.797206083826;6763.289854565298;6772;6789.253182150058;7164.391026762679;7166.104236970379;7167.749128780468;7214.350708436161;7224.060872086595;6750.493712971547;6847.452203823682;6857.348551887562;6858.3141685831015;6871.244163142051;3806.2197249563774;3875.7868317242824;3894.6105389461395;3900.64894159527;3907.1208977979727;7521.548707077593;7586.203448637924;7597;7601.46789724725;7606;7300.087489063867;7302.087239095114;7319.63401829917;7320.231375705581;7326.633668316669;7571.659275332623;7576.886346704804;7582.317591416799;7585.355244804143;7590.696372145163;6975.686094125675;7181.174164971095;7190.856182876418;7193.352598265972;7204.171520275236;7039.1553013638695;7064.32888875556;7066.081409416743;7078.292170782881;7092.716291348494;7560.130584982798;7564.583947882699;7564.810879728051;7585.734499292498;7588.241175882367;4878.121938051185;4880.243562247857;4902.583280421204;4906.779194936165;4908.607311415007;6973.267806880204;7153.35619794221;7168.713251469882;7224.89162662571;7239.674214660247;6996.965015174892;6997.685104170223;7014.193367762568;7028;7031.753888613874;7016.087908572057;7017.614031228331;7019.789406317818;7021.087258656342;7022.824429389306;6924.065251191025;6929.272426395156;6978.965105174441;6979.546329488567;6983.406410455168;6916.654167291515;7052.753153639598;7055.894161587683;7056.50604457683;7064.434845212473;6849.897251541331;6864.313568643096;6875.48433867452;6880.65596720152;6890.793276201722 04:03:34 INFO - PROCESS | 14064 | |5;yui.html;863.3309185381329;930.3766476460771;934.5187228577288;947.8815148106487;964.8118616869709;12574.245545267278;12772.68068298293;12823.935880320598;13941.233232172226;14030.158190508577;14723.852761472383;14724;14761.040532365389;14799.778003329959;14857.034292770963;908.872757813905;919.5769945824928;925.3568769705058;926.2404828041009;926.8934072581671;895.771578247546;922.6125027488471;923.8845144356956;925.1534845616253;925.1719710858778;963.494165563078;973.7760315127525;976.6776963601994;979.5102448775613;985.9260555458334;963.8072385522888;970.7961328121067;975.5609975510978;978.427619842393;980.3578655980344;703.7220297982319;710.9040279562245;719.3310221494008;724.5906063074347;726.989095163573;14088.788668169986;14195.148291102463;14197.432102715879;14199.503017394445;14235.430582776677;14199.290035498183;14239.715205695828;14375.353109110116;14380.784288235685;14423.423063077464;12121;12210.389480525939;12274.570390036306;12291.385430728427;12345.629631111082;3831.616838316174;3867.9806600967095;3881.7088718346236;3946.171304026158;3956.3867600521967;58291.417085829446;58605.41394586085;58774.70612646909;58951;59197.40802591962;9888.406695598287;10166.390016599027;10315.17478601725;11892.04863610909;12079.3356365399;19882.403527894185;20343.38969830878;20369.490762730755;20389.286374977102;20557.48606284825;8514.191151840565;8730.781730456789;8747.650093996295;9142.588583513625;9227.492487913229;4684.695494792828;4713.3872596562915;4721.4570324413135;4770.594499467584;4814.542618451242;3510.5611798525183;3532.6643968822923;3536.8762093327123;3553.236054248349;3559.733020023457;663.6217356106972;671.3085521912438;674.5514233035075;701.2006312803409;704.520925770481;637.9808605741836;791.3352783661752;795.3319211862064;801.8155824160359;845.6194712379454;9030.27757779376;9248.26013918885;9276.536173191313;9464.52677366129;9510.096540828748;732.9083864516936;769.9037620297463;813.0690359538296;827.5655280977535;832.9916700832914;4163.937540936889;4310.181065597527;4473.35136405226;4528.864134075983;4595.333676616939;64594;66298.61232218004;66502.33497664961;66764.6661766688;67012;56922;57410;58301.70849145727;58604.41395586075;59015.93444229431;52555.21167182495;56321.99999999918;56913.71543142258;57070.42929570651;57248.42751572431;9890.85163722559;9923.576366153955;10023.097921187129;10049.648262310784;10097.545610447694;38678.419823702105;38851.41722874215;39496.802515987234;39750.80124599474;39882.80058599688;50155;51294.48705513046;51412.48587514077;52071.218931716816;52219;12157.148999569945;12646.620601381974;12735.681607959876;13014.089013768946;13037;13943.90998537543;13989.720205596035;14024.158550487004;14455;14523.78214326807;12669.113162078565;12887.871121289043;13107.475700971854;13282.800757988445;13465.663358416117;12788.680282993;12808.807867881802;12879.098463107492;13054.216746995211;13225.867741322463;13218.60344189676;13225;13306;13644.727105458034;13745.106568073043;9758.512074396394;9817.165540929102;9943.850842237227;10002.949985250027;10391.480425978822;8398.286145677686;8648.870266945874;8650.653973840976;8671;8741.388102832741 04:03:34 INFO - PROCESS | 14064 | __end_tp_report 04:03:34 INFO - PROCESS | 14064 | __start_cc_report 04:03:34 INFO - PROCESS | 14064 | _x_x_mozilla_cycle_collect,341 04:03:34 INFO - PROCESS | 14064 | __end_cc_report 04:03:34 INFO - PROCESS | 14064 | __startTimestamp1468667014330__endTimestamp 04:03:34 INFO - PROCESS | 14064 | 04:03:34 INFO - PROCESS | 14064 | ------- Summary: start ------- 04:03:34 INFO - PROCESS | 14064 | Number of tests: 6 04:03:34 INFO - PROCESS | 14064 | 04:03:34 INFO - PROCESS | 14064 | [#0] dojo.html Cycles:165 Average:5419.24 Median:5631.77 stddev:591.56 (10.5%) stddev-sans-first:568.76 04:03:34 INFO - PROCESS | 14064 | Values: 3266.6 3268.5 3303.0 3305.3 3306.4 5433.8 5443.0 5443.5 5461.2 5466.7 5405.2 5448.6 5474.1 5495.1 5496.8 4914.7 4934.4 4989.4 5007.0 5037.0 4777.9 4811.6 5045.4 5083.2 5089.2 5009.3 5026.9 5054.0 5056.8 5089.9 5024.7 5051.9 5055.4 5062.5 5091.7 4826.2 4939.0 4959.3 4980.5 5014.0 5225.0 5236.8 5261.3 5288.1 5294.0 5724.6 5728.6 5731.0 5732.2 5743.5 5748.3 5816.8 5839.9 5849.4 5902.7 5418.5 5432.3 5439.3 5446.2 5485.6 5842.4 5906.4 5908.8 5929.8 5940.3 5438.3 5655.7 5699.0 5717.9 5755.4 5716.1 5721.5 5729.5 5733.8 5743.5 5708.5 5714.3 5716.9 5746.1 5751.7 5679.6 5842.8 5855.6 5880.7 5912.4 4458.0 4459.1 4466.2 4485.7 4508.5 3958.8 4016.5 4035.1 4039.4 4043.1 5519.3 5567.5 5584.9 5586.2 5605.9 5869.2 5875.6 5877.1 5877.1 5892.7 5548.1 5631.8 5643.9 5650.1 5653.0 5046.4 5050.1 5094.6 5102.9 5116.5 6097.9 6106.7 6142.4 6153.2 6154.6 5832.4 5855.2 5880.5 5894.1 5903.6 6137.3 6191.7 6241.5 6242.1 6242.9 5651.8 5653.1 5662.4 5667.7 5698.3 5665.9 5727.9 5735.7 5777.8 5801.7 5605.0 5676.4 5676.7 5678.6 5710.5 5617.6 5634.5 5643.4 5668.7 5672.1 5567.2 5567.5 5568.2 5646.5 5713.4 5682.1 5716.3 5725.9 5742.6 5748.6 5558.6 5591.9 5605.4 5615.6 5619.5 04:03:34 INFO - PROCESS | 14064 | 04:03:34 INFO - PROCESS | 14064 | [#1] ext.html Cycles:180 Average:61843.71 Median:22907.04 stddev:128331.49 (560.2%) stddev-sans-first:128609.24 04:03:34 INFO - PROCESS | 14064 | Values: 650.4 667.1 667.7 678.3 695.0 30968.7 39997.6 40132.2 40284.8 40563.4 42677.0 43284.6 43306.8 43391.1 43397.6 8814.4 8976.5 8979.0 8997.1 8997.6 8873.6 8954.6 8966.1 8988.0 9150.1 9050.5 9171.4 9186.0 9206.0 9208.4 9109.0 9149.3 9165.5 9165.9 9174.5 8998.6 9073.2 9077.6 9082.4 9096.2 43412.3 44014.6 44085.6 44217.6 44278.3 3891.0 3920.2 4018.3 4167.9 4323.5 32906.8 33278.7 33604.2 33947.5 34465.5 4468.6 4521.2 4577.3 4651.4 4653.3 302685.0 305166.0 306044.0 306625.0 307026.5 60086.0 60242.0 60607.0 60638.4 60643.7 71490.6 73056.6 73097.3 73104.0 73247.6 18595.3 18785.2 18814.4 18842.7 18897.9 14594.9 14662.6 14667.9 14712.2 14764.1 20843.8 20994.6 21073.0 21091.9 21136.6 7677.6 7788.6 7825.2 7836.6 7903.3 1112.6 1120.3 1137.9 1151.1 1155.2 32345.4 33081.5 33105.0 33224.8 33729.8 1226.9 1234.9 1236.0 1260.6 1269.4 17114.1 17359.6 17418.9 17496.5 17656.0 459651.0 466754.0 540032.0 843594.0 858317.0 61029.0 62150.4 62177.7 62291.0 62634.0 1451.7 1522.6 1533.8 1542.5 1549.5 32556.3 32956.0 32999.3 33306.0 33966.3 52864.0 53517.0 53636.5 53692.7 53729.7 401927.0 402417.0 405032.0 405203.0 405325.0 30722.4 30994.8 31172.5 31226.7 31439.2 49682.0 49868.3 49980.5 49982.3 50820.5 40506.7 41472.4 41632.0 41646.2 42260.4 40960.8 41252.6 42097.2 42746.8 43814.6 40892.4 41460.8 41887.4 42305.8 42372.2 35046.5 35109.1 35243.3 35445.5 35608.5 28211.4 28679.6 28884.9 28899.0 29102.4 04:03:34 INFO - PROCESS | 14064 | 04:03:34 INFO - PROCESS | 14064 | [#2] jquery.html Cycles:180 Average:28891.71 Median:2114.99 stddev:76506.38 (3617.3%) stddev-sans-first:76691.12 04:03:34 INFO - PROCESS | 14064 | Values: 413.1 413.3 420.9 426.0 426.7 15456.2 18502.4 19273.4 19313.6 19509.8 18776.7 19032.2 19642.2 20040.1 20054.1 5583.4 5656.9 5900.6 5993.3 6011.2 5888.0 5927.7 5937.1 5944.9 5973.0 5722.2 5920.9 5941.7 5957.0 5966.0 5902.5 5906.4 5930.2 5942.4 5968.7 5152.8 5292.5 5340.6 5344.7 5361.1 22456.6 22614.0 22654.9 22656.0 22990.0 2300.5 2390.5 2409.0 2433.3 2462.1 14818.4 15204.5 15352.2 15360.8 15500.8 2004.3 2060.6 2113.5 2116.5 2148.1 79612.2 79853.0 80071.6 82555.0 82644.6 10826.8 11209.4 11293.5 11485.4 11503.5 15545.9 15676.5 15725.1 15770.8 16110.9 8610.3 8727.1 8912.4 8924.4 8989.5 8759.7 8797.3 8855.3 8871.6 8923.2 5025.9 5045.0 5102.5 5104.7 5128.6 2112.9 2126.2 2170.2 2170.9 2176.7 1033.8 1041.1 1094.0 1145.1 1188.2 19080.3 19317.0 19466.7 19865.2 19907.8 1049.0 1055.3 1102.7 1114.4 1127.3 10850.3 10991.2 11021.8 11066.2 11102.3 445612.0 465279.0 466686.0 468160.0 469030.0 95962.0 96472.0 96601.5 96818.5 100855.0 1062.2 1074.6 1081.5 1088.3 1094.0 17057.4 17313.6 17337.4 17403.7 17523.8 37721.4 38809.4 39345.0 39370.0 41572.2 55007.0 59313.1 59600.4 60315.7 60396.7 8563.6 8680.2 8728.7 8832.0 12123.3 13423.7 13825.7 14043.9 14206.0 14491.6 12779.7 12825.9 12866.5 13195.4 13345.4 12288.0 12518.3 12528.9 12594.2 12598.6 12769.8 12931.4 13235.0 13264.4 13325.5 12761.1 12813.8 12849.0 12884.4 13124.8 12873.5 12970.5 12975.4 12990.5 13065.0 04:03:34 INFO - PROCESS | 14064 | 04:03:34 INFO - PROCESS | 14064 | [#3] mootools.html Cycles:180 Average:5805.74 Median:5223.86 stddev:3165.08 (60.6%) stddev-sans-first:3158.18 04:03:34 INFO - PROCESS | 14064 | Values: 1599.9 1603.8 1830.3 1902.7 1932.7 8556.8 8656.2 8776.4 8790.2 8842.7 8762.7 8829.1 8849.8 8883.0 8924.0 2462.4 2469.3 2471.1 2481.6 2486.5 2462.7 2538.4 2542.5 2544.7 2545.0 2375.9 2385.4 2510.7 2524.5 2526.8 2463.3 2465.2 2480.1 2489.3 2503.9 2488.4 2496.7 2506.2 2532.9 2535.6 8863.1 8866.0 8872.9 8892.2 8893.0 5298.4 5479.5 5481.5 5488.8 5500.1 3341.3 3372.7 3444.4 3500.5 3501.9 1123.5 1133.2 1150.3 1167.6 1170.8 12345.9 12407.4 12434.4 12460.4 12477.5 4633.7 4668.5 4742.0 4754.5 4824.9 9837.7 9872.3 9873.1 9882.1 9882.7 5421.2 5428.9 5452.2 5454.9 5467.4 4877.0 4981.7 5024.2 5055.8 5065.4 4073.6 4092.7 4125.4 4126.8 4129.8 1190.9 1261.1 1262.9 1271.6 1275.7 1005.4 1067.9 1083.8 1101.2 1109.4 6042.9 6066.2 6096.9 6258.5 6315.6 977.2 1042.8 1053.8 1054.5 1082.4 4066.9 4151.5 4156.4 4175.0 4188.5 10501.3 10729.5 10761.2 10879.3 10882.0 10075.8 10674.4 10743.6 10904.2 10985.7 8145.7 8207.4 8225.5 8298.8 8354.6 5689.4 6044.7 6066.2 6138.2 6202.0 9426.4 9443.7 9446.9 9493.1 9554.2 9518.6 9652.9 9658.6 9761.0 9959.3 7341.7 7468.3 7502.0 7690.8 7865.3 8251.7 8257.1 8261.1 8308.1 8323.4 7167.6 7207.7 7256.8 7262.2 7403.5 7255.8 7361.7 7403.2 7413.4 7668.2 6899.2 6920.6 6963.2 6986.5 6986.9 5115.8 5175.9 5271.9 5312.4 5386.2 5364.3 5383.4 5395.2 5484.3 5488.7 04:03:34 INFO - PROCESS | 14064 | 04:03:34 INFO - PROCESS | 14064 | [#4] prototype.html Cycles:180 Average:5810.27 Median:6745.21 stddev:1795.01 (26.6%) stddev-sans-first:1752.93 04:03:34 INFO - PROCESS | 14064 | Values: 366.8 369.5 370.7 373.1 376.5 6528.8 6585.1 6593.1 6615.7 6732.7 6559.9 6576.3 6617.4 6619.4 6622.1 4827.1 4891.5 4912.5 4919.3 4934.9 4903.6 4904.6 4915.6 4915.9 4920.5 4879.0 4884.3 4933.3 4948.7 4952.6 4952.3 4957.3 4958.3 4962.1 4965.3 4315.1 4327.4 4327.8 4330.5 4339.1 6079.5 6282.2 6284.8 6314.1 6338.6 5730.4 5758.4 5760.7 5770.7 5773.2 6946.4 6953.7 6959.1 6980.3 6981.0 4721.1 4757.3 4758.1 4765.3 4766.8 7128.9 7173.1 7194.1 7203.5 7208.1 4577.2 4624.2 4626.5 4634.2 4852.6 4655.2 4683.1 4688.2 4688.2 4688.3 5520.6 5521.3 5523.7 5693.6 5710.7 6931.4 6964.2 6981.7 6987.0 6998.4 1705.6 1738.9 1741.3 1743.1 1745.2 1101.9 1128.4 1144.0 1151.6 1152.1 6739.9 6759.8 6763.3 6772.0 6789.3 7164.4 7166.1 7167.7 7214.4 7224.1 6750.5 6847.5 6857.3 6858.3 6871.2 3806.2 3875.8 3894.6 3900.6 3907.1 7521.5 7586.2 7597.0 7601.5 7606.0 7300.1 7302.1 7319.6 7320.2 7326.6 7571.7 7576.9 7582.3 7585.4 7590.7 6975.7 7181.2 7190.9 7193.4 7204.2 7039.2 7064.3 7066.1 7078.3 7092.7 7560.1 7564.6 7564.8 7585.7 7588.2 4878.1 4880.2 4902.6 4906.8 4908.6 6973.3 7153.4 7168.7 7224.9 7239.7 6997.0 6997.7 7014.2 7028.0 7031.8 7016.1 7017.6 7019.8 7021.1 7022.8 6924.1 6929.3 6979.0 6979.5 6983.4 6916.7 7052.8 7055.9 7056.5 7064.4 6849.9 6864.3 6875.5 6880.7 6890.8 04:03:34 INFO - PROCESS | 14064 | 04:03:34 INFO - PROCESS | 14064 | [#5] yui.html Cycles:180 Average:15755.37 Median:51353.49 stddev:18677.97 (36.4%) stddev-sans-first:18696.89 04:03:34 INFO - PROCESS | 14064 | Values: 863.3 930.4 934.5 947.9 964.8 12574.2 12772.7 12823.9 13941.2 14030.2 14723.9 14724.0 14761.0 14799.8 14857.0 908.9 919.6 925.4 926.2 926.9 895.8 922.6 923.9 925.2 925.2 963.5 973.8 976.7 979.5 985.9 963.8 970.8 975.6 978.4 980.4 703.7 710.9 719.3 724.6 727.0 14088.8 14195.1 14197.4 14199.5 14235.4 14199.3 14239.7 14375.4 14380.8 14423.4 12121.0 12210.4 12274.6 12291.4 12345.6 3831.6 3868.0 3881.7 3946.2 3956.4 58291.4 58605.4 58774.7 58951.0 59197.4 9888.4 10166.4 10315.2 11892.0 12079.3 19882.4 20343.4 20369.5 20389.3 20557.5 8514.2 8730.8 8747.7 9142.6 9227.5 4684.7 4713.4 4721.5 4770.6 4814.5 3510.6 3532.7 3536.9 3553.2 3559.7 663.6 671.3 674.6 701.2 704.5 638.0 791.3 795.3 801.8 845.6 9030.3 9248.3 9276.5 9464.5 9510.1 732.9 769.9 813.1 827.6 833.0 4163.9 4310.2 4473.4 4528.9 4595.3 64594.0 66298.6 66502.3 66764.7 67012.0 56922.0 57410.0 58301.7 58604.4 59015.9 52555.2 56322.0 56913.7 57070.4 57248.4 9890.9 9923.6 10023.1 10049.6 10097.5 38678.4 38851.4 39496.8 39750.8 39882.8 50155.0 51294.5 51412.5 52071.2 52219.0 12157.1 12646.6 12735.7 13014.1 13037.0 13943.9 13989.7 14024.2 14455.0 14523.8 12669.1 12887.9 13107.5 13282.8 13465.7 12788.7 12808.8 12879.1 13054.2 13225.9 13218.6 13225.0 13306.0 13644.7 13745.1 9758.5 9817.2 9943.9 10002.9 10391.5 8398.3 8648.9 8650.7 8671.0 8741.4 04:03:34 INFO - PROCESS | 14064 | -------- Summary: end -------- 04:03:34 INFO - PROCESS | 14064 | 04:03:34 INFO - TEST-INFO | 14064: exit 0 04:03:35 INFO - TEST-OK | dromaeo_css | took 1108480ms 04:03:35 INFO - TEST-START | kraken 04:03:35 INFO - operating with platform_type : linux_ 04:03:35 INFO - Initialising browser for kraken test... 04:03:35 INFO - TEST-INFO | started process 14299 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi2zRtF/profile http://localhost:39401/getInfo.html) 04:03:38 INFO - PROCESS | 14299 | 04:03:38 INFO - PROCESS | 14299 | (process:14375): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:03:39 INFO - PROCESS | 14299 | __metrics Screen width/height:1600/1200 04:03:39 INFO - PROCESS | 14299 | colorDepth:24 04:03:39 INFO - PROCESS | 14299 | Browser inner width/height: 1024/697 04:03:39 INFO - PROCESS | 14299 | __metrics 04:03:39 ERROR - PROCESS | 14299 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 04:03:40 INFO - TEST-INFO | 14299: exit 0 04:03:40 INFO - Browser initialized. 04:03:40 INFO - Running cycle 1/1 for kraken test... 04:03:40 INFO - TEST-INFO | started process 14425 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi2zRtF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:03:42 INFO - PROCESS | 14425 | 04:03:42 INFO - PROCESS | 14425 | (process:14492): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:03:52 INFO - PROCESS | 14425 | RSS: Main: 150994944 04:03:52 INFO - PROCESS | 14425 | 04:03:54 INFO - PROCESS | 14425 | Cycle 1(1): loaded http://localhost:39401/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39401/tests/kraken/driver.html?testName=audio-beat-detection) 04:03:55 INFO - PROCESS | 14425 | RSS: Main: 156286976 04:03:55 INFO - PROCESS | 14425 | 04:03:58 INFO - PROCESS | 14425 | Cycle 1(1): loaded http://localhost:39401/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39401/tests/kraken/driver.html?testName=audio-dft) 04:03:59 INFO - PROCESS | 14425 | RSS: Main: 156200960 04:03:59 INFO - PROCESS | 14425 | 04:04:01 INFO - PROCESS | 14425 | Cycle 1(1): loaded http://localhost:39401/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39401/tests/kraken/driver.html?testName=audio-fft) 04:04:02 INFO - PROCESS | 14425 | RSS: Main: 156250112 04:04:02 INFO - PROCESS | 14425 | 04:04:04 INFO - PROCESS | 14425 | Cycle 1(1): loaded http://localhost:39401/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39401/tests/kraken/driver.html?testName=audio-oscillator) 04:04:05 INFO - PROCESS | 14425 | RSS: Main: 156278784 04:04:05 INFO - PROCESS | 14425 | 04:04:07 INFO - PROCESS | 14425 | Cycle 1(1): loaded http://localhost:39401/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39401/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:04:07 INFO - PROCESS | 14425 | RSS: Main: 156012544 04:04:07 INFO - PROCESS | 14425 | 04:04:10 INFO - PROCESS | 14425 | Cycle 1(1): loaded http://localhost:39401/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39401/tests/kraken/driver.html?testName=imaging-darkroom) 04:04:11 INFO - PROCESS | 14425 | RSS: Main: 156717056 04:04:11 INFO - PROCESS | 14425 | 04:04:14 INFO - PROCESS | 14425 | Cycle 1(1): loaded http://localhost:39401/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39401/tests/kraken/driver.html?testName=imaging-desaturate) 04:04:15 INFO - PROCESS | 14425 | RSS: Main: 156811264 04:04:15 INFO - PROCESS | 14425 | 04:04:18 INFO - PROCESS | 14425 | Cycle 1(1): loaded http://localhost:39401/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39401/tests/kraken/driver.html?testName=json-parse-financial) 04:04:18 INFO - PROCESS | 14425 | RSS: Main: 156389376 04:04:18 INFO - PROCESS | 14425 | 04:04:20 INFO - PROCESS | 14425 | Cycle 1(1): loaded http://localhost:39401/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39401/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:04:21 INFO - PROCESS | 14425 | RSS: Main: 156094464 04:04:21 INFO - PROCESS | 14425 | 04:04:22 INFO - PROCESS | 14425 | Cycle 1(1): loaded http://localhost:39401/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39401/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:04:23 INFO - PROCESS | 14425 | RSS: Main: 156430336 04:04:23 INFO - PROCESS | 14425 | 04:04:25 INFO - PROCESS | 14425 | Cycle 1(1): loaded http://localhost:39401/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39401/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:04:25 INFO - PROCESS | 14425 | RSS: Main: 156672000 04:04:25 INFO - PROCESS | 14425 | 04:04:28 INFO - PROCESS | 14425 | Cycle 1(1): loaded http://localhost:39401/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:04:29 INFO - PROCESS | 14425 | RSS: Main: 157069312 04:04:29 INFO - PROCESS | 14425 | 04:04:31 INFO - PROCESS | 14425 | Cycle 1(1): loaded http://localhost:39401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:04:32 INFO - PROCESS | 14425 | RSS: Main: 157519872 04:04:32 INFO - PROCESS | 14425 | 04:04:34 INFO - PROCESS | 14425 | Cycle 1(1): loaded http://localhost:39401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39401/tests/kraken/driver.html?testName=ai-astar) 04:04:34 INFO - PROCESS | 14425 | RSS: Main: 158502912 04:04:34 INFO - PROCESS | 14425 | 04:04:34 INFO - PROCESS | 14425 | __start_tp_report 04:04:34 INFO - PROCESS | 14425 | _x_x_mozilla_page_load 04:04:34 INFO - PROCESS | 14425 | _x_x_mozilla_page_load_details 04:04:34 INFO - PROCESS | 14425 | |i|pagename|runs| 04:04:34 INFO - PROCESS | 14425 | |0;ai-astar;108;113;106;114;112;114;100;109;113;112 04:04:34 INFO - PROCESS | 14425 | |1;audio-beat-detection;155;128;156;173;128;156;154;127;185;128 04:04:34 INFO - PROCESS | 14425 | |2;audio-dft;162;163;164;163;163;164;166;163;162;161 04:04:34 INFO - PROCESS | 14425 | |3;audio-fft;77;75;74;165;74;79;75;75;166;74 04:04:34 INFO - PROCESS | 14425 | |4;audio-oscillator;93;92;153;93;93;92;148;92;92;139 04:04:34 INFO - PROCESS | 14425 | |5;imaging-gaussian-blur;117;117;117;118;119;117;117;117;117;117 04:04:34 INFO - PROCESS | 14425 | |6;imaging-darkroom;146;148;148;147;147;147;147;147;148;147 04:04:34 INFO - PROCESS | 14425 | |7;imaging-desaturate;95;95;94;98;95;95;95;95;96;95 04:04:34 INFO - PROCESS | 14425 | |8;json-parse-financial;55;56;59;56;59;56;56;72;59;54 04:04:34 INFO - PROCESS | 14425 | |9;json-stringify-tinderbox;58;59;58;58;58;58;57;57;57;58 04:04:34 INFO - PROCESS | 14425 | |10;stanford-crypto-aes;72;73;74;73;74;74;75;74;73;74 04:04:34 INFO - PROCESS | 14425 | |11;stanford-crypto-ccm;129;124;116;117;116;117;114;122;136;127 04:04:34 INFO - PROCESS | 14425 | |12;stanford-crypto-pbkdf2;165;165;163;170;165;162;168;161;164;163 04:04:34 INFO - PROCESS | 14425 | |13;stanford-crypto-sha256-iterative;69;66;66;72;66;69;65;68;65;67 04:04:34 INFO - PROCESS | 14425 | __end_tp_report 04:04:34 INFO - PROCESS | 14425 | __start_cc_report 04:04:34 INFO - PROCESS | 14425 | _x_x_mozilla_cycle_collect,815 04:04:34 INFO - PROCESS | 14425 | __end_cc_report 04:04:34 INFO - PROCESS | 14425 | __startTimestamp1468667074323__endTimestamp 04:04:34 INFO - PROCESS | 14425 | 04:04:34 INFO - PROCESS | 14425 | ------- Summary: start ------- 04:04:34 INFO - PROCESS | 14425 | Number of tests: 14 04:04:34 INFO - PROCESS | 14425 | 04:04:34 INFO - PROCESS | 14425 | [#0] ai-astar Cycles:10 Average:110.10 Median:112.50 stddev:4.46 (4.0%) stddev-sans-first:4.66 04:04:34 INFO - PROCESS | 14425 | Values: 108.0 113.0 106.0 114.0 112.0 114.0 100.0 109.0 113.0 112.0 04:04:34 INFO - PROCESS | 14425 | 04:04:34 INFO - PROCESS | 14425 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:155.50 stddev:20.65 (13.3%) stddev-sans-first:21.79 04:04:34 INFO - PROCESS | 14425 | Values: 155.0 128.0 156.0 173.0 128.0 156.0 154.0 127.0 185.0 128.0 04:04:34 INFO - PROCESS | 14425 | 04:04:34 INFO - PROCESS | 14425 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:1.37 (0.8%) stddev-sans-first:1.39 04:04:34 INFO - PROCESS | 14425 | Values: 162.0 163.0 164.0 163.0 163.0 164.0 166.0 163.0 162.0 161.0 04:04:34 INFO - PROCESS | 14425 | 04:04:34 INFO - PROCESS | 14425 | [#3] audio-fft Cycles:10 Average:93.40 Median:75.00 stddev:38.03 (50.7%) stddev-sans-first:39.87 04:04:34 INFO - PROCESS | 14425 | Values: 77.0 75.0 74.0 165.0 74.0 79.0 75.0 75.0 166.0 74.0 04:04:34 INFO - PROCESS | 14425 | 04:04:34 INFO - PROCESS | 14425 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:92.00 stddev:26.42 (28.7%) stddev-sans-first:27.40 04:04:34 INFO - PROCESS | 14425 | Values: 93.0 92.0 153.0 93.0 93.0 92.0 148.0 92.0 92.0 139.0 04:04:34 INFO - PROCESS | 14425 | 04:04:34 INFO - PROCESS | 14425 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 04:04:34 INFO - PROCESS | 14425 | Values: 117.0 117.0 117.0 118.0 119.0 117.0 117.0 117.0 117.0 117.0 04:04:34 INFO - PROCESS | 14425 | 04:04:34 INFO - PROCESS | 14425 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 04:04:34 INFO - PROCESS | 14425 | Values: 146.0 148.0 148.0 147.0 147.0 147.0 147.0 147.0 148.0 147.0 04:04:34 INFO - PROCESS | 14425 | 04:04:34 INFO - PROCESS | 14425 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:1.06 (1.1%) stddev-sans-first:1.12 04:04:34 INFO - PROCESS | 14425 | Values: 95.0 95.0 94.0 98.0 95.0 95.0 95.0 95.0 96.0 95.0 04:04:34 INFO - PROCESS | 14425 | 04:04:34 INFO - PROCESS | 14425 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:57.50 stddev:5.16 (9.0%) stddev-sans-first:5.34 04:04:34 INFO - PROCESS | 14425 | Values: 55.0 56.0 59.0 56.0 59.0 56.0 56.0 72.0 59.0 54.0 04:04:34 INFO - PROCESS | 14425 | 04:04:34 INFO - PROCESS | 14425 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:58.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 04:04:34 INFO - PROCESS | 14425 | Values: 58.0 59.0 58.0 58.0 58.0 58.0 57.0 57.0 57.0 58.0 04:04:34 INFO - PROCESS | 14425 | 04:04:34 INFO - PROCESS | 14425 | [#10] stanford-crypto-aes Cycles:10 Average:73.60 Median:74.00 stddev:0.84 (1.1%) stddev-sans-first:0.67 04:04:34 INFO - PROCESS | 14425 | Values: 72.0 73.0 74.0 73.0 74.0 74.0 75.0 74.0 73.0 74.0 04:04:34 INFO - PROCESS | 14425 | 04:04:34 INFO - PROCESS | 14425 | [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:123.00 stddev:7.15 (5.8%) stddev-sans-first:7.09 04:04:34 INFO - PROCESS | 14425 | Values: 129.0 124.0 116.0 117.0 116.0 117.0 114.0 122.0 136.0 127.0 04:04:34 INFO - PROCESS | 14425 | 04:04:34 INFO - PROCESS | 14425 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:165.00 stddev:2.72 (1.6%) stddev-sans-first:2.88 04:04:34 INFO - PROCESS | 14425 | Values: 165.0 165.0 163.0 170.0 165.0 162.0 168.0 161.0 164.0 163.0 04:04:34 INFO - PROCESS | 14425 | 04:04:34 INFO - PROCESS | 14425 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:2.21 (3.3%) stddev-sans-first:2.26 04:04:34 INFO - PROCESS | 14425 | Values: 69.0 66.0 66.0 72.0 66.0 69.0 65.0 68.0 65.0 67.0 04:04:34 INFO - PROCESS | 14425 | -------- Summary: end -------- 04:04:34 INFO - PROCESS | 14425 | 04:04:35 INFO - TEST-INFO | 14425: exit 0 04:04:35 INFO - TEST-OK | kraken | took 60252ms 04:04:35 INFO - SUITE-END | took 1168s 04:04:35 INFO - Completed test suite (00:19:28) 04:04:35 INFO - javascript benchmark 04:04:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3266.575345205123, 3268.4933835255542, 3303.0, 3305.272839975206, 3306.3717893600224, 5433.8369848904495, 5442.993046286435, 5443.455654434554, 5461.18082287657, 5466.726663666821, 5405.18922161676, 5448.591355648323, 5474.124140137579, 5495.093309603911, 5496.780128794843, 4914.655974081816, 4934.4325402578625, 4989.376327959005, 5006.974965125188, 5037.042961837239, 4777.90444191116, 4811.615070794328, 5045.394552653686, 5083.237514372837, 5089.236614507817, 5009.298698182258, 5026.874328141807, 5053.974730126344, 5056.84829455117, 5089.923651145235, 5024.673396229252, 5051.873703157414, 5055.4186268579215, 5062.468440813698, 5091.66904151229, 4826.155422800995, 4939.032573953771, 4959.330490383824, 4980.452150263468, 5014.047331007097, 5225.033368826741, 5236.81671141512, 5261.342332208474, 5288.10102282609, 5294.0, 5724.5992780505385, 5728.598998070137, 5730.997075511768, 5732.197492351074, 5743.54051675865, 5748.281464816898, 5816.796412125597, 5839.9124013139835, 5849.44430279127, 5902.675352855634, 5418.485243901823, 5432.29380180574, 5439.265699130607, 5446.1558458439, 5485.61600687952, 5842.444967728059, 5906.409359064145, 5908.763649454059, 5929.822105336847, 5940.257467816523, 5438.320209973754, 5655.688937108416, 5699.031164702011, 5717.885642287131, 5755.366909639936, 5716.056850619684, 5721.542276617861, 5729.455701708331, 5733.827985160452, 5743.4543718346695, 5708.486236238676, 5714.285714285715, 5716.942830571724, 5746.109353050284, 5751.654900705971, 5679.630823996427, 5842.824715258549, 5855.59010869235, 5880.676562789002, 5912.379200184005, 4458.0, 4459.1304695584695, 4466.240739074366, 4485.686001979895, 4508.549145085531, 3958.802059897051, 4016.49793775778, 4035.051762835731, 4039.3738970459626, 4043.0903046814233, 5519.254900588449, 5567.49892509668, 5584.944150558524, 5586.245856809279, 5605.943940560543, 5869.20765696634, 5875.588708790344, 5877.089051197071, 5877.147813567009, 5892.6759028253, 5548.112302031655, 5631.7747290108755, 5643.943560564342, 5650.124230744241, 5653.038983372837, 5046.369203849519, 5050.141475949097, 5094.592432605456, 5102.897942041139, 5116.513931176607, 6097.939020609826, 6106.664133472702, 6142.385761423822, 6153.169322141453, 6154.569180157436, 5832.445917637818, 5855.151003104611, 5880.500157486662, 5894.115882617642, 5903.616264942765, 6137.285055221685, 6191.690415479118, 6241.531885108544, 6242.063690446469, 6242.875142497034, 5651.8304450866535, 5653.123765816141, 5662.377138514677, 5667.688277144796, 5698.2592263005545, 5665.915011274752, 5727.942720572908, 5735.655860648374, 5777.7977770777825, 5801.709914504342, 5604.971975140098, 5676.375598684224, 5676.659400435987, 5678.602497825113, 5710.543156547383, 5617.634853734494, 5634.549236061187, 5643.407442218672, 5668.7165641718575, 5672.12082127271, 5567.164925261243, 5567.498925096761, 5568.192612071146, 5646.463585959327, 5713.371529131875, 5682.14767784819, 5716.314042314949, 5725.942740572707, 5742.569307301886, 5748.597598168255, 5558.610897237155, 5591.888162236651, 5605.383407825218, 5615.5507559395965, 5619.522340601095], "value": 5381.546318799533, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.4178760009792, 667.12939613804, 667.672840308249, 678.257308247469, 694.9722011119555, 30968.690313096864, 39997.60002399975, 40132.1973560529, 40284.79857600715, 40563.39154912671, 42677.0, 43284.56715432853, 43306.78346608271, 43391.132177356434, 43397.56602433975, 8814.427062240933, 8976.506292153928, 8979.0, 8997.145271199226, 8997.640094396216, 8873.645054197825, 8954.552272386387, 8966.0585638508, 8987.955060224689, 9150.130737579919, 9050.5022223778, 9171.40385874916, 9186.0, 9205.953970230139, 9208.355415120945, 9108.954455227748, 9149.313801464918, 9165.450072995609, 9165.908340916572, 9174.54127293636, 8998.595063222105, 9073.183413492752, 9077.63689452421, 9082.40964337316, 9096.181343679034, 43412.34881476781, 44014.55985440168, 44085.559144408464, 44217.55782442167, 44278.335824962654, 3891.0466935600675, 3920.2159568086495, 4018.2566225248424, 4167.91664166715, 4323.546027667081, 32906.835465822754, 33278.6672133278, 33604.1598960028, 33947.490787638206, 34465.483017754756, 4468.597826195625, 4521.163584736802, 4577.3362862384765, 4651.395318608559, 4653.325267836145, 302685.0, 305166.0, 306044.0, 306625.0, 307026.4648676765, 60086.0, 60242.0, 60607.0, 60638.39361606327, 60643.69678151581, 71490.64254678797, 73056.63471682607, 73097.2690273101, 73104.0, 73247.63376183085, 18595.25618975253, 18785.15466803997, 18814.435566933014, 18842.71735923962, 18897.905510472636, 14594.927025365017, 14662.63343416423, 14667.92666036663, 14712.190829504267, 14764.114153150846, 20843.791562084487, 20994.580108397746, 21073.0, 21091.8945405272, 21136.577268454545, 7677.577733224614, 7788.57162856037, 7825.178356272623, 7836.608169591497, 7903.288704016666, 1112.6217086190734, 1120.3389999900098, 1137.9473986562396, 1151.073385924322, 1155.1625071822862, 32345.35309293801, 33081.48598237872, 33105.0, 33224.83387583047, 33729.83135084358, 1226.9141160118706, 1234.9320787356783, 1236.0, 1260.6407173955379, 1269.361240711068, 17114.14429278556, 17359.633694888507, 17418.912905435645, 17496.47510574685, 17656.0, 459651.0, 466754.0, 540032.0, 843594.0, 858317.0, 61029.0, 62150.37849621446, 62177.68911155415, 62291.0, 62634.0, 1451.6878871042777, 1522.5889009967248, 1533.7776022476678, 1542.4524293875736, 1549.504158669215, 32556.348873021932, 32956.01131966045, 32999.34001320008, 33306.0, 33966.32067358688, 52864.0, 53517.0, 53636.46363536315, 53692.73153634207, 53729.73135134299, 401927.0, 402417.0, 405032.0, 405203.0, 405325.0, 30722.385552289277, 30994.84502577563, 31172.53241201429, 31226.687733122377, 31439.21401964969, 49682.0, 49868.25197621966, 49980.50019499904, 49982.25026624676, 50820.49179508157, 40506.69583764173, 41472.37791433191, 41632.0, 41646.1670766589, 42260.36609450799, 40960.79519602502, 41252.58747412608, 42097.15805683808, 42746.78626606847, 43814.56185438105, 40892.38661420141, 41460.79269603753, 41887.371689425294, 42305.78847105745, 42372.1525569493, 35046.47430288497, 35109.12227194341, 35243.29513409666, 35445.46831797577, 35608.46587301141, 28211.43577128405, 28679.56980645334, 28884.855575721987, 28899.0, 29102.417951641273], "value": 21087.66605652371, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.1468517511337, 413.31389892777986, 420.85480509224305, 425.98296068157276, 426.66293628033856, 15456.22718864058, 18502.444926652206, 19273.421797346084, 19313.613727725453, 19509.804901950974, 18776.71834922477, 19032.238710451566, 19642.214311427524, 20040.0981955812, 20054.097565609547, 5583.35791383991, 5656.943430565703, 5900.586958912878, 5993.250843644544, 6011.218541589609, 5888.0, 5927.673977931212, 5937.079752638348, 5944.910826337608, 5973.0, 5722.2274992876055, 5920.88158236835, 5941.7029148542615, 5957.0, 5966.0, 5902.468777809975, 5906.37983011784, 5930.169776231352, 5942.435468630473, 5968.67172305523, 5152.768125434364, 5292.497212764782, 5340.599455040849, 5344.706041167734, 5361.142217245261, 22456.550868982693, 22614.0, 22654.88672556643, 22656.0, 22990.0, 2300.470891694903, 2390.497995420964, 2408.980281130479, 2433.3186707721866, 2462.1382516119393, 14818.40726370944, 15204.543863684106, 15352.232388380537, 15360.846391536053, 15500.767488487681, 2004.2984955265686, 2060.5981833542464, 2113.4821968617634, 2116.4920419099303, 2148.1192710988576, 79612.20387796164, 79853.0, 80071.599642002, 82555.0, 82644.58677706633, 10826.837597436044, 11209.412987843813, 11293.548258069584, 11485.425728713531, 11503.482343294572, 15545.922270388575, 15676.451324203597, 15725.135117568414, 15770.76343854843, 16110.919445402698, 8610.268127209258, 8727.083656216006, 8912.420692654956, 8924.375293729507, 8989.516060556176, 8759.722472157158, 8797.252233560092, 8855.291576673852, 8871.556422178865, 8923.196912277926, 5025.899482010339, 5044.974775126101, 5102.4897510248675, 5104.744762761847, 5128.615353848476, 2112.8732276063483, 2126.2239282662026, 2170.1536400803698, 2170.8914554272224, 2176.7061446704492, 1033.7932413517326, 1041.146260066738, 1093.9781204375868, 1145.123980155182, 1188.2395267029108, 19080.332188373617, 19317.0, 19466.70799938002, 19865.205391784166, 19907.800921990885, 1048.9790204195874, 1055.2507719519228, 1102.652664410708, 1114.3759494683004, 1127.301073334538, 10850.294730842628, 10991.230613856953, 11021.779564408667, 11066.225364224589, 11102.333859968428, 445612.0, 465279.0, 466686.0, 468160.0, 469030.0, 95962.0, 96472.0, 96601.51699241459, 96818.51590742, 100855.0, 1062.1502797761914, 1074.5540600650643, 1081.5241293830688, 1088.2762962629763, 1094.020851338048, 17057.402990895258, 17313.567160820578, 17337.393191238247, 17403.651926961138, 17523.82476175273, 37721.434178486794, 38809.41785873158, 39345.0, 39370.0, 41572.168556628094, 55007.0, 59313.11030334462, 59600.40399595949, 60315.69842150761, 60396.69801650964, 8563.571821409028, 8680.175383338572, 8728.73813785562, 8832.02847686741, 12123.272603643809, 13423.731525369632, 13825.723485530032, 14043.859561404255, 14206.0, 14491.565253042425, 12779.680507987374, 12825.871741282841, 12866.549670761478, 13195.406206720529, 13345.399457024263, 12288.0, 12518.270311117167, 12528.874711253135, 12594.24434533931, 12598.61379320688, 12769.808452873029, 12931.353432328535, 13235.0, 13264.403101860247, 13325.533606323732, 12761.085837124134, 12813.807792882928, 12849.0, 12884.35578221104, 13124.803127952897, 12873.549425770054, 12970.546030888874, 12975.351232438528, 12990.545330913372, 13065.0], "value": 9802.726973888863, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1599.8720102391806, 1603.7915071040766, 1830.3319288459709, 1902.73361729358, 1932.7197556354329, 8556.786080347994, 8656.220940115389, 8776.429532080418, 8790.208881200699, 8842.734717958456, 8762.737117886474, 8829.072947340517, 8849.778755531115, 8882.95558522208, 8924.0, 2462.3597864555254, 2469.2592222333274, 2471.1104002559064, 2481.5905375613, 2486.4529803443215, 2462.692163479565, 2538.4415428605676, 2542.4660821227562, 2544.74552544745, 2545.032887502756, 2375.928722138339, 2385.3917251100943, 2510.7112682041616, 2524.482481091372, 2526.7725904668578, 2463.3472129885595, 2465.2480993297036, 2480.094765410621, 2489.3154382544762, 2503.924882253535, 2488.427661637815, 2496.737842526527, 2506.1980166346775, 2532.8733563321944, 2535.632333311678, 8863.11368863115, 8865.955670221672, 8872.911270887273, 8892.244159246471, 8892.955535222347, 5298.36419629643, 5479.479449452336, 5481.479259470344, 5488.780448782044, 5500.147477141049, 3341.298327351259, 3372.6627337266077, 3444.3800115979116, 3500.457429098494, 3501.9474707879403, 1123.4607388453505, 1133.1501373969522, 1150.2868221702515, 1167.5913430299413, 1170.7834050700562, 12345.93827030859, 12407.44166512509, 12434.440450179764, 12460.43928023232, 12477.50089996399, 4633.72197668141, 4668.50980647034, 4741.976290118528, 4754.4532378776885, 4824.903501929942, 9837.704868853945, 9872.259580531489, 9873.111419972238, 9882.11061004513, 9882.654107106217, 5421.186821976735, 5428.9185662215095, 5452.154915988028, 5454.945450545523, 5467.425920278393, 4876.975835074674, 4981.651284410056, 5024.246363045572, 5055.848324550269, 5065.39215294167, 4073.572274911151, 4092.672586193157, 4125.419910584481, 4126.773027483458, 4129.814158362881, 1190.9047276217882, 1261.1235191541791, 1262.8547717012661, 1271.5994461744706, 1275.7002104505434, 1005.4218824176128, 1067.9412632305298, 1083.7724077943562, 1101.24014430043, 1109.4064675398622, 6042.879142417127, 6066.150738896558, 6096.939030609726, 6258.468030217391, 6315.621062736251, 977.2475194100645, 1042.8227201375785, 1053.847192157133, 1054.46222426563, 1082.4209048159198, 4066.877993660195, 4151.543330233671, 4156.418101465797, 4174.979125104355, 4188.539260681323, 10501.264911456277, 10729.463526823783, 10761.192910531741, 10879.347239165518, 10882.020618144405, 10075.848862267072, 10674.359538427563, 10743.623973160902, 10904.236703430843, 10985.725356866142, 8145.714899978472, 8207.425480216447, 8225.506469611842, 8298.751037468886, 8354.58227088643, 5689.431056894443, 6044.718735332623, 6066.1507388966465, 6138.202033735586, 6202.0, 9426.434413935185, 9443.669471568463, 9446.905530944603, 9493.05069493045, 9554.187894029086, 9518.61925522999, 9652.855207171757, 9658.565364558752, 9761.0, 9959.253056020973, 7341.74303899361, 7468.327850493264, 7501.962490187732, 7690.80792477167, 7865.331446827084, 8251.711190108557, 8257.133001034805, 8261.09127995932, 8308.127646597262, 8323.417360784686, 7167.641617919187, 7207.71169153228, 7256.7822965311125, 7262.237465066303, 7403.481756277224, 7255.818604534928, 7361.742339018108, 7403.185649578434, 7413.443991700752, 7668.233176682287, 6899.17209934811, 6920.619365934721, 6963.234044255027, 6986.476014298846, 6986.895196572157, 5115.846524604268, 5175.861310511681, 5271.868203294948, 5312.442193569619, 5386.218998245311, 5364.275822763877, 5383.353997520323, 5395.244665746877, 5484.314460692413, 5488.670679759227], "value": 4734.943995712616, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.75427463599385, 369.49563845351094, 370.6682519145364, 373.05244678516567, 376.49361608636394, 6528.7714929977465, 6585.078089067534, 6593.142891424108, 6615.669216539178, 6732.697028633711, 6559.868802623944, 6576.342365763421, 6617.437517810979, 6619.371159739817, 6622.0729097926205, 4827.131116399056, 4891.461939186686, 4912.484189160123, 4919.286703428001, 4934.876628084308, 4903.632227582928, 4904.558589726924, 4915.6313276504225, 4915.926261106087, 4920.458749537566, 4879.0, 4884.267359896008, 4933.284673722308, 4948.678335908173, 4952.603791696673, 4952.281919121743, 4957.3059771632, 4958.330625365584, 4962.131626965284, 4965.280034394992, 4315.050688848449, 4327.37253098299, 4327.8052487637815, 4330.545292744279, 4339.132173565299, 6079.483243924272, 6282.246130464374, 6284.811455656338, 6314.116023756677, 6338.556301058928, 5730.398308177665, 5758.395368486333, 5760.711964401763, 5770.711464426804, 5773.162891380726, 6946.409555187815, 6953.687084081229, 6959.095317608729, 6980.267071957423, 6980.9650951745425, 4721.079389519045, 4757.26262429324, 4758.072175925696, 4765.28520721891, 4766.785494652749, 7128.857422851565, 7173.067501224859, 7194.064771579661, 7203.495755297131, 7208.098987626547, 4577.198990176772, 4624.213883639789, 4626.4910859805395, 4634.23535116702, 4852.636052296092, 4655.231886738718, 4683.1336202802595, 4688.179568575554, 4688.226442636927, 4688.296755486705, 5520.585956053312, 5521.337439507285, 5523.7238138092935, 5693.572982026281, 5710.65736055838, 6931.410830079399, 6964.199117101497, 6981.720731170696, 6986.9650651746415, 6998.370146686822, 1705.5821323775754, 1738.8869723467933, 1741.2512619573452, 1743.1371471121622, 1745.1972092837184, 1101.8898110189077, 1128.3568366031284, 1144.0, 1151.6084531259412, 1152.0783373301326, 6739.932600674028, 6759.797206083826, 6763.289854565298, 6772.0, 6789.253182150058, 7164.391026762679, 7166.104236970379, 7167.749128780468, 7214.350708436161, 7224.060872086595, 6750.493712971547, 6847.452203823682, 6857.348551887562, 6858.3141685831015, 6871.244163142051, 3806.2197249563774, 3875.7868317242824, 3894.6105389461395, 3900.64894159527, 3907.1208977979727, 7521.548707077593, 7586.203448637924, 7597.0, 7601.46789724725, 7606.0, 7300.087489063867, 7302.087239095114, 7319.63401829917, 7320.231375705581, 7326.633668316669, 7571.659275332623, 7576.886346704804, 7582.317591416799, 7585.355244804143, 7590.696372145163, 6975.686094125675, 7181.174164971095, 7190.856182876418, 7193.352598265972, 7204.171520275236, 7039.1553013638695, 7064.32888875556, 7066.081409416743, 7078.292170782881, 7092.716291348494, 7560.130584982798, 7564.583947882699, 7564.810879728051, 7585.734499292498, 7588.241175882367, 4878.121938051185, 4880.243562247857, 4902.583280421204, 4906.779194936165, 4908.607311415007, 6973.267806880204, 7153.35619794221, 7168.713251469882, 7224.89162662571, 7239.674214660247, 6996.965015174892, 6997.685104170223, 7014.193367762568, 7028.0, 7031.753888613874, 7016.087908572057, 7017.614031228331, 7019.789406317818, 7021.087258656342, 7022.824429389306, 6924.065251191025, 6929.272426395156, 6978.965105174441, 6979.546329488567, 6983.406410455168, 6916.654167291515, 7052.753153639598, 7055.894161587683, 7056.50604457683, 7064.434845212473, 6849.897251541331, 6864.313568643096, 6875.48433867452, 6880.65596720152, 6890.793276201722], "value": 5225.531980264045, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [863.3309185381329, 930.3766476460771, 934.5187228577288, 947.8815148106487, 964.8118616869709, 12574.245545267278, 12772.68068298293, 12823.935880320598, 13941.233232172226, 14030.158190508577, 14723.852761472383, 14724.0, 14761.040532365389, 14799.778003329959, 14857.034292770963, 908.872757813905, 919.5769945824928, 925.3568769705058, 926.2404828041009, 926.8934072581671, 895.771578247546, 922.6125027488471, 923.8845144356956, 925.1534845616253, 925.1719710858778, 963.494165563078, 973.7760315127525, 976.6776963601994, 979.5102448775613, 985.9260555458334, 963.8072385522888, 970.7961328121067, 975.5609975510978, 978.427619842393, 980.3578655980344, 703.7220297982319, 710.9040279562245, 719.3310221494008, 724.5906063074347, 726.989095163573, 14088.788668169986, 14195.148291102463, 14197.432102715879, 14199.503017394445, 14235.430582776677, 14199.290035498183, 14239.715205695828, 14375.353109110116, 14380.784288235685, 14423.423063077464, 12121.0, 12210.389480525939, 12274.570390036306, 12291.385430728427, 12345.629631111082, 3831.616838316174, 3867.9806600967095, 3881.7088718346236, 3946.171304026158, 3956.3867600521967, 58291.417085829446, 58605.41394586085, 58774.70612646909, 58951.0, 59197.40802591962, 9888.406695598287, 10166.390016599027, 10315.17478601725, 11892.04863610909, 12079.3356365399, 19882.403527894185, 20343.38969830878, 20369.490762730755, 20389.286374977102, 20557.48606284825, 8514.191151840565, 8730.781730456789, 8747.650093996295, 9142.588583513625, 9227.492487913229, 4684.695494792828, 4713.3872596562915, 4721.4570324413135, 4770.594499467584, 4814.542618451242, 3510.5611798525183, 3532.6643968822923, 3536.8762093327123, 3553.236054248349, 3559.733020023457, 663.6217356106972, 671.3085521912438, 674.5514233035075, 701.2006312803409, 704.520925770481, 637.9808605741836, 791.3352783661752, 795.3319211862064, 801.8155824160359, 845.6194712379454, 9030.27757779376, 9248.26013918885, 9276.536173191313, 9464.52677366129, 9510.096540828748, 732.9083864516936, 769.9037620297463, 813.0690359538296, 827.5655280977535, 832.9916700832914, 4163.937540936889, 4310.181065597527, 4473.35136405226, 4528.864134075983, 4595.333676616939, 64594.0, 66298.61232218004, 66502.33497664961, 66764.6661766688, 67012.0, 56922.0, 57410.0, 58301.70849145727, 58604.41395586075, 59015.93444229431, 52555.21167182495, 56321.99999999918, 56913.71543142258, 57070.42929570651, 57248.42751572431, 9890.85163722559, 9923.576366153955, 10023.097921187129, 10049.648262310784, 10097.545610447694, 38678.419823702105, 38851.41722874215, 39496.802515987234, 39750.80124599474, 39882.80058599688, 50155.0, 51294.48705513046, 51412.48587514077, 52071.218931716816, 52219.0, 12157.148999569945, 12646.620601381974, 12735.681607959876, 13014.089013768946, 13037.0, 13943.90998537543, 13989.720205596035, 14024.158550487004, 14455.0, 14523.78214326807, 12669.113162078565, 12887.871121289043, 13107.475700971854, 13282.800757988445, 13465.663358416117, 12788.680282993, 12808.807867881802, 12879.098463107492, 13054.216746995211, 13225.867741322463, 13218.60344189676, 13225.0, 13306.0, 13644.727105458034, 13745.106568073043, 9758.512074396394, 9817.165540929102, 9943.850842237227, 10002.949985250027, 10391.480425978822, 8398.286145677686, 8648.870266945874, 8650.653973840976, 8671.0, 8741.388102832741], "value": 7134.144651231035, "unit": "score"}], "name": "dromaeo_css", "value": 7624.03499031847, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 113.0, 106.0, 114.0, 112.0, 114.0, 100.0, 109.0, 113.0, 112.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 128.0, 156.0, 173.0, 128.0, 156.0, 154.0, 127.0, 185.0, 128.0], "value": 149.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 163.0, 163.0, 164.0, 166.0, 163.0, 162.0, 161.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 74.0, 165.0, 74.0, 79.0, 75.0, 75.0, 166.0, 74.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 153.0, 93.0, 93.0, 92.0, 148.0, 92.0, 92.0, 139.0], "value": 108.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 119.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 98.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 59.0, 56.0, 59.0, 56.0, 56.0, 72.0, 59.0, 54.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 58.0, 58.0, 57.0, 57.0, 57.0, 58.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 74.0, 73.0, 74.0, 74.0, 75.0, 74.0, 73.0, 74.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 124.0, 116.0, 117.0, 116.0, 117.0, 114.0, 122.0, 136.0, 127.0], "value": 121.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 163.0, 170.0, 165.0, 162.0, 168.0, 161.0, 164.0, 163.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 66.0, 72.0, 66.0, 69.0, 65.0, 68.0, 65.0, 67.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1527.3999999999996, "alertThreshold": 2.0}]} 04:04:35 INFO - Return code: 0 04:04:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:04:35 ERROR - # TBPL SUCCESS # 04:04:35 INFO - Running post-action listener: _resource_record_post_action 04:04:35 INFO - Running post-run listener: _resource_record_post_run 04:04:36 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 464912384; Read time: 8; Write time: 378908 04:04:36 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242069504; Read time: 0; Write time: 236412 04:04:36 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 222306304; Read time: 8; Write time: 142496 04:04:36 INFO - Running post-run listener: _upload_blobber_files 04:04:36 INFO - Blob upload gear active. 04:04:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:04:36 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 04:04:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:04:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:04:37 INFO - (blobuploader) - INFO - Open directory for files ... 04:04:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:04:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:04:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:38 INFO - (blobuploader) - INFO - Done attempting. 04:04:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:04:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:04:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:39 INFO - (blobuploader) - INFO - Done attempting. 04:04:39 INFO - (blobuploader) - INFO - Iteration through files over. 04:04:39 INFO - Return code: 0 04:04:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:04:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:04:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1cf797c7e5323ba9d18660ef62ac4b8264de72431b99047dcd1c7c135265786f6812ff144eed408071ac9c700f7302e143959f93842b91013baf8f5221c146ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03521de15b56c66db63fc8d9ebf6f22e3c555fb7758552f3e71053b9fa1b4680debfea0f6cfe147b54434d5c587d609fad64e6706d81fa773abd7f27728cc445"} 04:04:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:04:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:04:39 INFO - Contents: 04:04:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1cf797c7e5323ba9d18660ef62ac4b8264de72431b99047dcd1c7c135265786f6812ff144eed408071ac9c700f7302e143959f93842b91013baf8f5221c146ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03521de15b56c66db63fc8d9ebf6f22e3c555fb7758552f3e71053b9fa1b4680debfea0f6cfe147b54434d5c587d609fad64e6706d81fa773abd7f27728cc445"} 04:04:39 INFO - Running post-run listener: copy_logs_to_upload_dir 04:04:39 INFO - Copying logs to upload dir... 04:04:39 INFO - mkdir: /builds/slave/test/build/upload/logs 04:04:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.321116 ========= master_lag: 0.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-16 04:04:38.831439) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 04:04:38.836319) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1cf797c7e5323ba9d18660ef62ac4b8264de72431b99047dcd1c7c135265786f6812ff144eed408071ac9c700f7302e143959f93842b91013baf8f5221c146ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03521de15b56c66db63fc8d9ebf6f22e3c555fb7758552f3e71053b9fa1b4680debfea0f6cfe147b54434d5c587d609fad64e6706d81fa773abd7f27728cc445"} build_url:https://queue.taskcluster.net/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011160 build_url: 'https://queue.taskcluster.net/v1/task/LqILkJ6wSf-fK8jsZA3wQg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1cf797c7e5323ba9d18660ef62ac4b8264de72431b99047dcd1c7c135265786f6812ff144eed408071ac9c700f7302e143959f93842b91013baf8f5221c146ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03521de15b56c66db63fc8d9ebf6f22e3c555fb7758552f3e71053b9fa1b4680debfea0f6cfe147b54434d5c587d609fad64e6706d81fa773abd7f27728cc445"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 04:04:38.864257) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 04:04:38.864625) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468664625.892569-6131884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 04:04:38.913717) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 04:04:38.917085) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 04:04:38.917382) ========= ========= Total master_lag: 0.33 =========