builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1460706973.54 results: success (0) buildid: 20160414223109 builduid: 3eb270c1aeb240feaafa1b8db2f26b90 revision: 15a4d633bd2d983566e22a7989af17ed55fd9f21 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 00:56:13.538533) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 00:56:13.539002) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 00:56:13.539312) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 00:56:13.561760) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 00:56:13.562051) ========= 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=62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 00:56:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-04-15 00:56:13 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117157 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 00:56:13.698977) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 00:56:13.699297) ========= 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=62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022632 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 00:56:13.748579) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 00:56:13.748902) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 15a4d633bd2d983566e22a7989af17ed55fd9f21 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 15a4d633bd2d983566e22a7989af17ed55fd9f21 --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=62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 00:56:13,897 truncating revision to first 12 chars 2016-04-15 00:56:13,897 Setting DEBUG logging. 2016-04-15 00:56:13,897 attempt 1/10 2016-04-15 00:56:13,897 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/15a4d633bd2d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 00:56:14,151 unpacking tar archive at: mozilla-inbound-15a4d633bd2d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.529049 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 00:56:14.290621) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 00:56:14.290943) ========= script_repo_revision: 15a4d633bd2d983566e22a7989af17ed55fd9f21 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 00:56:14.291359) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 00:56:14.291644) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 00:56:14.300550) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-15 00:56:14.300842) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:56:14 INFO - MultiFileLogger online at 20160415 00:56:14 in /builds/slave/test 00:56:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 00:56:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:56:14 INFO - {'append_to_log': False, 00:56:14 INFO - 'base_work_dir': '/builds/slave/test', 00:56:14 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 00:56:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:56:14 INFO - 'branch': 'Mozilla-Inbound', 00:56:14 INFO - 'buildbot_json_path': 'buildprops.json', 00:56:14 INFO - 'config_files': ('talos/linux_config.py',), 00:56:14 INFO - 'default_actions': ('clobber', 00:56:14 INFO - 'read-buildbot-config', 00:56:14 INFO - 'download-and-extract', 00:56:14 INFO - 'populate-webroot', 00:56:14 INFO - 'create-virtualenv', 00:56:14 INFO - 'install', 00:56:14 INFO - 'run-tests'), 00:56:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:56:14 INFO - 'download_minidump_stackwalk': True, 00:56:14 INFO - 'download_symbols': 'ondemand', 00:56:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:56:14 INFO - 'tooltool.py': '/tools/tooltool.py', 00:56:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:56:14 INFO - '/tools/misc-python/virtualenv.py')}, 00:56:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:56:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:56:14 INFO - 'installer_path': 'installer.exe', 00:56:14 INFO - 'log_level': 'info', 00:56:14 INFO - 'log_name': 'talos', 00:56:14 INFO - 'log_to_console': True, 00:56:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:56:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:56:14 INFO - 'opt_config_files': (), 00:56:14 INFO - 'pip_index': False, 00:56:14 INFO - 'sps_profile': False, 00:56:14 INFO - 'sps_profile_interval': 0, 00:56:14 INFO - 'suite': 'dromaeojs', 00:56:14 INFO - 'system_bits': '32', 00:56:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:56:14 INFO - 'title': 'talos-linux64-ix-018', 00:56:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:56:14 INFO - 'use_talos_json': True, 00:56:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:56:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:56:14 INFO - 'work_dir': 'build'} 00:56:14 INFO - ##### 00:56:14 INFO - ##### Running clobber step. 00:56:14 INFO - ##### 00:56:14 INFO - Running pre-action listener: _resource_record_pre_action 00:56:14 INFO - Running main action method: clobber 00:56:14 INFO - rmtree: /builds/slave/test/build 00:56:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:56:15 INFO - Running post-action listener: _resource_record_post_action 00:56:15 INFO - ##### 00:56:15 INFO - ##### Running read-buildbot-config step. 00:56:15 INFO - ##### 00:56:15 INFO - Running pre-action listener: _resource_record_pre_action 00:56:15 INFO - Running main action method: read_buildbot_config 00:56:15 INFO - Using buildbot properties: 00:56:15 INFO - { 00:56:15 INFO - "project": "", 00:56:15 INFO - "product": "firefox", 00:56:15 INFO - "script_repo_revision": "production", 00:56:15 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 00:56:15 INFO - "repository": "", 00:56:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 00:56:15 INFO - "buildid": "20160414223109", 00:56:15 INFO - "pgo_build": "True", 00:56:15 INFO - "basedir": "/builds/slave/test", 00:56:15 INFO - "buildnumber": 1709, 00:56:15 INFO - "slavename": "talos-linux64-ix-018", 00:56:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:56:15 INFO - "platform": "ubuntu64_hw", 00:56:15 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 00:56:15 INFO - "branch": "mozilla-inbound", 00:56:15 INFO - "repo_path": "integration/mozilla-inbound", 00:56:15 INFO - "revision": "15a4d633bd2d983566e22a7989af17ed55fd9f21", 00:56:15 INFO - "stage_platform": "linux64-pgo", 00:56:15 INFO - "builduid": "3eb270c1aeb240feaafa1b8db2f26b90", 00:56:15 INFO - "slavebuilddir": "test" 00:56:15 INFO - } 00:56:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 00:56:15 INFO - Running post-action listener: _resource_record_post_action 00:56:15 INFO - ##### 00:56:15 INFO - ##### Running download-and-extract step. 00:56:15 INFO - ##### 00:56:15 INFO - Running pre-action listener: _resource_record_pre_action 00:56:15 INFO - Running main action method: download_and_extract 00:56:15 INFO - mkdir: /builds/slave/test/build/tests 00:56:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:15 INFO - https://queue.taskcluster.net/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:56:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 00:56:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 00:56:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 00:56:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:56:30 INFO - Downloaded 1361 bytes. 00:56:30 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 00:56:30 INFO - Using the following test package requirements: 00:56:30 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 00:56:30 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:56:30 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:56:30 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:30 INFO - u'jsshell-linux-x86_64.zip'], 00:56:30 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:56:30 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 00:56:30 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:56:30 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:56:30 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:56:30 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:56:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:56: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')]} 00:56:30 INFO - https://queue.taskcluster.net/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:56:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:56:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:56:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:56:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:56:32 INFO - Downloaded 23779819 bytes. 00:56:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:56:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:56:33 INFO - Return code: 0 00:56:33 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:56:33 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')]} 00:56:33 INFO - https://queue.taskcluster.net/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:56:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:56:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:56:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:56:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:56:35 INFO - Downloaded 23779819 bytes. 00:56:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:56:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:56:36 INFO - Return code: 0 00:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:36 INFO - https://queue.taskcluster.net/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:56:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 00:56:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 00:56:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 00:56:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:56:37 INFO - Downloaded 10841076 bytes. 00:56:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:56:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 00:56:37 INFO - Return code: 0 00:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:37 INFO - https://queue.taskcluster.net/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:56:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:56:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:56:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:56:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:56:41 INFO - Downloaded 58200318 bytes. 00:56:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:56:41 INFO - mkdir: /builds/slave/test/properties 00:56:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:56:41 INFO - Writing to file /builds/slave/test/properties/build_url 00:56:41 INFO - Contents: 00:56:41 INFO - build_url:https://queue.taskcluster.net/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:56:41 INFO - Running post-action listener: _resource_record_post_action 00:56:41 INFO - Running post-action listener: set_extra_try_arguments 00:56:41 INFO - ##### 00:56:41 INFO - ##### Running populate-webroot step. 00:56:41 INFO - ##### 00:56:41 INFO - Running pre-action listener: _resource_record_pre_action 00:56:41 INFO - Running main action method: populate_webroot 00:56:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:56:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:56:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:56:41 INFO - '--tppagecycles', 00:56:41 INFO - '7'], 00:56:41 INFO - 'tests': ['tsvgm']}}, 00:56:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:56:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:56:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:56:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:56:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:56:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:56:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:41 INFO - 'talos_options': ['--disable-e10s'], 00:56:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:56:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:56:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:41 INFO - 'talos_options': ['--disable-e10s'], 00:56:41 INFO - 'tests': ['damp', 'tps']}, 00:56:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:41 INFO - 'tests': ['damp', 'tps']}, 00:56:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:56:41 INFO - 'tests': ['dromaeo_dom']}, 00:56:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:56:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:56:41 INFO - 'tests': ['a11yr', 00:56:41 INFO - 'ts_paint', 00:56:41 INFO - 'tpaint', 00:56:41 INFO - 'sessionrestore', 00:56:41 INFO - 'sessionrestore_no_auto_restore', 00:56:41 INFO - 'tabpaint']}, 00:56:41 INFO - 'other-e10s': {'tests': ['a11yr', 00:56:41 INFO - 'ts_paint', 00:56:41 INFO - 'tpaint', 00:56:41 INFO - 'sessionrestore', 00:56:41 INFO - 'sessionrestore_no_auto_restore', 00:56:41 INFO - 'tabpaint']}, 00:56:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:56:41 INFO - 'ts_paint', 00:56:41 INFO - 'tpaint', 00:56:41 INFO - 'sessionrestore', 00:56:41 INFO - 'sessionrestore_no_auto_restore', 00:56:41 INFO - 'tabpaint']}, 00:56:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:56:41 INFO - 'ts_paint', 00:56:41 INFO - 'tpaint', 00:56:41 INFO - 'sessionrestore', 00:56:41 INFO - 'sessionrestore_no_auto_restore', 00:56:41 INFO - 'tabpaint']}, 00:56:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:56:41 INFO - 'tests': ['a11yr', 00:56:41 INFO - 'ts_paint', 00:56:41 INFO - 'tpaint', 00:56:41 INFO - 'sessionrestore', 00:56:41 INFO - 'sessionrestore_no_auto_restore', 00:56:41 INFO - 'tabpaint']}, 00:56:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:56:41 INFO - 'tests': ['a11yr', 00:56:41 INFO - 'ts_paint', 00:56:41 INFO - 'tpaint', 00:56:41 INFO - 'sessionrestore', 00:56:41 INFO - 'sessionrestore_no_auto_restore', 00:56:41 INFO - 'tabpaint']}, 00:56:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:56:41 INFO - 'tests': ['tsvgx', 00:56:41 INFO - 'tsvgr_opacity', 00:56:41 INFO - 'tart', 00:56:41 INFO - 'tscrollx', 00:56:41 INFO - 'cart']}, 00:56:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:56:41 INFO - 'tsvgr_opacity', 00:56:41 INFO - 'tart', 00:56:41 INFO - 'tscrollx', 00:56:41 INFO - 'cart']}, 00:56:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:41 INFO - 'talos_options': ['--disable-e10s'], 00:56:41 INFO - 'tests': ['tp5o']}, 00:56:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:41 INFO - 'tests': ['tp5o']}, 00:56:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:41 INFO - 'talos_options': ['--disable-e10s', 00:56:41 INFO - '--xperf_path', 00:56:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:56:41 INFO - 'tests': ['tp5n']}, 00:56:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:41 INFO - 'talos_options': ['--xperf_path', 00:56:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:56:41 INFO - 'tests': ['tp5n']}}, 00:56:41 INFO - 'talos.zip': {'path': '', 00:56:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:56:41 INFO - Running post-action listener: _resource_record_post_action 00:56:41 INFO - ##### 00:56:41 INFO - ##### Running create-virtualenv step. 00:56:41 INFO - ##### 00:56:41 INFO - Running pre-action listener: _resource_record_pre_action 00:56:41 INFO - Running main action method: create_virtualenv 00:56:41 INFO - Creating virtualenv /builds/slave/test/build/venv 00:56:41 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 00:56:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:56:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:56:41 INFO - Using real prefix '/usr' 00:56:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:56:42 INFO - Installing distribute.............................................................................................................................................................................................done. 00:56:44 INFO - Installing pip.................done. 00:56:44 INFO - Return code: 0 00:56:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:44 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 0x7f3f147e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f1410>, '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 0x16f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f27a0>, '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': '62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749', '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 00:56:44 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 00:56:44 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 00:56:44 INFO - Using env: {'DISPLAY': ':0', 00:56:44 INFO - 'HOME': '/home/cltbld', 00:56:44 INFO - 'LANG': 'en_US.UTF-8', 00:56:44 INFO - 'LANGUAGE': 'en_US:en', 00:56:44 INFO - 'LOGNAME': 'cltbld', 00:56:44 INFO - 'MAIL': '/var/mail/cltbld', 00:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:44 INFO - 'MOZ_NO_REMOTE': '1', 00:56:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:44 INFO - 'NO_EM_RESTART': '1', 00:56:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:44 INFO - 'PWD': '/builds/slave/test', 00:56:44 INFO - 'SHELL': '/bin/bash', 00:56:44 INFO - 'SHLVL': '1', 00:56:44 INFO - 'TERM': 'linux', 00:56:44 INFO - 'TMOUT': '86400', 00:56:44 INFO - 'USER': 'cltbld', 00:56:44 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749', 00:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:44 INFO - '_': '/tools/buildbot/bin/python'} 00:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:44 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 00:56:44 INFO - Cleaning up... 00:56:44 INFO - Return code: 0 00:56:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:44 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 0x7f3f147e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f1410>, '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 0x16f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f27a0>, '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': '62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749', '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 00:56:44 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 00:56:44 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 00:56:44 INFO - Using env: {'DISPLAY': ':0', 00:56:44 INFO - 'HOME': '/home/cltbld', 00:56:44 INFO - 'LANG': 'en_US.UTF-8', 00:56:44 INFO - 'LANGUAGE': 'en_US:en', 00:56:44 INFO - 'LOGNAME': 'cltbld', 00:56:44 INFO - 'MAIL': '/var/mail/cltbld', 00:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:44 INFO - 'MOZ_NO_REMOTE': '1', 00:56:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:44 INFO - 'NO_EM_RESTART': '1', 00:56:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:44 INFO - 'PWD': '/builds/slave/test', 00:56:44 INFO - 'SHELL': '/bin/bash', 00:56:44 INFO - 'SHLVL': '1', 00:56:44 INFO - 'TERM': 'linux', 00:56:44 INFO - 'TMOUT': '86400', 00:56:44 INFO - 'USER': 'cltbld', 00:56:44 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749', 00:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:44 INFO - '_': '/tools/buildbot/bin/python'} 00:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:44 INFO - Downloading/unpacking psutil>=0.7.1 00:56:44 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 00:56:44 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 00:56:44 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 00:56:44 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 00:56:44 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 00:56:44 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 00:56:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:56:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:56:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:56:46 INFO - Installing collected packages: psutil 00:56:46 INFO - Running setup.py install for psutil 00:56:46 INFO - building 'psutil._psutil_linux' extension 00:56:46 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 00:56:47 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 00:56:47 INFO - building 'psutil._psutil_posix' extension 00:56:47 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 00:56:47 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 00:56:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:56:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:56:47 INFO - Successfully installed psutil 00:56:47 INFO - Cleaning up... 00:56:47 INFO - Return code: 0 00:56:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3f147e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f1410>, '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 0x16f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f27a0>, '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': '62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749', '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 00:56:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 00:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 00:56:47 INFO - Using env: {'DISPLAY': ':0', 00:56:47 INFO - 'HOME': '/home/cltbld', 00:56:47 INFO - 'LANG': 'en_US.UTF-8', 00:56:47 INFO - 'LANGUAGE': 'en_US:en', 00:56:47 INFO - 'LOGNAME': 'cltbld', 00:56:47 INFO - 'MAIL': '/var/mail/cltbld', 00:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:47 INFO - 'MOZ_NO_REMOTE': '1', 00:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:47 INFO - 'NO_EM_RESTART': '1', 00:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:47 INFO - 'PWD': '/builds/slave/test', 00:56:47 INFO - 'SHELL': '/bin/bash', 00:56:47 INFO - 'SHLVL': '1', 00:56:47 INFO - 'TERM': 'linux', 00:56:47 INFO - 'TMOUT': '86400', 00:56:47 INFO - 'USER': 'cltbld', 00:56:47 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749', 00:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:47 INFO - '_': '/tools/buildbot/bin/python'} 00:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:56:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:56:49 INFO - Installing collected packages: mozsystemmonitor 00:56:49 INFO - Running setup.py install for mozsystemmonitor 00:56:49 INFO - Successfully installed mozsystemmonitor 00:56:49 INFO - Cleaning up... 00:56:49 INFO - Return code: 0 00:56:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3f147e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f1410>, '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 0x16f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f27a0>, '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': '62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749', '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 00:56:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:56:49 INFO - Using env: {'DISPLAY': ':0', 00:56:49 INFO - 'HOME': '/home/cltbld', 00:56:49 INFO - 'LANG': 'en_US.UTF-8', 00:56:49 INFO - 'LANGUAGE': 'en_US:en', 00:56:49 INFO - 'LOGNAME': 'cltbld', 00:56:49 INFO - 'MAIL': '/var/mail/cltbld', 00:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:49 INFO - 'MOZ_NO_REMOTE': '1', 00:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:49 INFO - 'NO_EM_RESTART': '1', 00:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:49 INFO - 'PWD': '/builds/slave/test', 00:56:49 INFO - 'SHELL': '/bin/bash', 00:56:49 INFO - 'SHLVL': '1', 00:56:49 INFO - 'TERM': 'linux', 00:56:49 INFO - 'TMOUT': '86400', 00:56:49 INFO - 'USER': 'cltbld', 00:56:49 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749', 00:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:49 INFO - '_': '/tools/buildbot/bin/python'} 00:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:49 INFO - Downloading/unpacking blobuploader==1.2.4 00:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:51 INFO - Downloading blobuploader-1.2.4.tar.gz 00:56:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:56:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:56:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:52 INFO - Downloading docopt-0.6.1.tar.gz 00:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:56:52 INFO - Installing collected packages: blobuploader, requests, docopt 00:56:52 INFO - Running setup.py install for blobuploader 00:56:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:56:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:56:52 INFO - Running setup.py install for requests 00:56:52 INFO - Running setup.py install for docopt 00:56:53 INFO - Successfully installed blobuploader requests docopt 00:56:53 INFO - Cleaning up... 00:56:53 INFO - Return code: 0 00:56:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:56:53 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')]} 00:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:53 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')]} 00:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:53 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 0x7f3f147e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f1410>, '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 0x16f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f27a0>, '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': '62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749', '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 00:56:53 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 00:56:53 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 00:56:53 INFO - Using env: {'DISPLAY': ':0', 00:56:53 INFO - 'HOME': '/home/cltbld', 00:56:53 INFO - 'LANG': 'en_US.UTF-8', 00:56:53 INFO - 'LANGUAGE': 'en_US:en', 00:56:53 INFO - 'LOGNAME': 'cltbld', 00:56:53 INFO - 'MAIL': '/var/mail/cltbld', 00:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:53 INFO - 'MOZ_NO_REMOTE': '1', 00:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:53 INFO - 'NO_EM_RESTART': '1', 00:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:53 INFO - 'PWD': '/builds/slave/test', 00:56:53 INFO - 'SHELL': '/bin/bash', 00:56:53 INFO - 'SHLVL': '1', 00:56:53 INFO - 'TERM': 'linux', 00:56:53 INFO - 'TMOUT': '86400', 00:56:53 INFO - 'USER': 'cltbld', 00:56:53 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749', 00:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:53 INFO - '_': '/tools/buildbot/bin/python'} 00:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:56:53 INFO - Running setup.py (path:/tmp/pip-ImnpMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:56:53 INFO - Running setup.py (path:/tmp/pip-MM9R_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:56:53 INFO - Running setup.py (path:/tmp/pip-27T87I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:56:53 INFO - Running setup.py (path:/tmp/pip-ocqmJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:56:53 INFO - Running setup.py (path:/tmp/pip-Qg5cfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:56:53 INFO - Running setup.py (path:/tmp/pip-shQY5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:56:53 INFO - Running setup.py (path:/tmp/pip-wAkiTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:56:53 INFO - Running setup.py (path:/tmp/pip-ugUOpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:56:53 INFO - Running setup.py (path:/tmp/pip-bc5PpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:56:53 INFO - Running setup.py (path:/tmp/pip-64xtEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:56:54 INFO - Running setup.py (path:/tmp/pip-qtP_nL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:56:54 INFO - Running setup.py (path:/tmp/pip-agUSJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:56:54 INFO - Running setup.py (path:/tmp/pip-t3d3sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:56:54 INFO - Running setup.py (path:/tmp/pip-CfDaar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:56:54 INFO - Running setup.py (path:/tmp/pip-4kuMNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:56:54 INFO - Running setup.py (path:/tmp/pip-UVXFzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:56:54 INFO - Running setup.py (path:/tmp/pip-U3OrEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:56:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:56:54 INFO - Running setup.py install for manifestparser 00:56:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:56:54 INFO - Running setup.py install for mozcrash 00:56:54 INFO - Running setup.py install for mozdebug 00:56:54 INFO - Running setup.py install for mozdevice 00:56:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:56:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:56:54 INFO - Running setup.py install for mozfile 00:56:55 INFO - Running setup.py install for mozhttpd 00:56:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:56:55 INFO - Running setup.py install for mozinfo 00:56:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:56:55 INFO - Running setup.py install for mozInstall 00:56:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:56:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:56:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:56:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:56:55 INFO - Running setup.py install for mozleak 00:56:55 INFO - Running setup.py install for mozlog 00:56:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:56:55 INFO - Running setup.py install for moznetwork 00:56:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:56:55 INFO - Running setup.py install for mozprocess 00:56:55 INFO - Running setup.py install for mozprofile 00:56:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:56:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:56:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:56:55 INFO - Running setup.py install for mozrunner 00:56:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:56:55 INFO - Running setup.py install for mozscreenshot 00:56:56 INFO - Running setup.py install for moztest 00:56:56 INFO - Running setup.py install for mozversion 00:56:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:56:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:56:56 INFO - Cleaning up... 00:56:56 INFO - Return code: 0 00:56:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:56:56 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')]} 00:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:56 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')]} 00:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:56 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 0x7f3f147e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f1410>, '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 0x16f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f27a0>, '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': '62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749', '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 00:56:56 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 00:56:56 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 00:56:56 INFO - Using env: {'DISPLAY': ':0', 00:56:56 INFO - 'HOME': '/home/cltbld', 00:56:56 INFO - 'LANG': 'en_US.UTF-8', 00:56:56 INFO - 'LANGUAGE': 'en_US:en', 00:56:56 INFO - 'LOGNAME': 'cltbld', 00:56:56 INFO - 'MAIL': '/var/mail/cltbld', 00:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:56 INFO - 'MOZ_NO_REMOTE': '1', 00:56:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:56 INFO - 'NO_EM_RESTART': '1', 00:56:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:56 INFO - 'PWD': '/builds/slave/test', 00:56:56 INFO - 'SHELL': '/bin/bash', 00:56:56 INFO - 'SHLVL': '1', 00:56:56 INFO - 'TERM': 'linux', 00:56:56 INFO - 'TMOUT': '86400', 00:56:56 INFO - 'USER': 'cltbld', 00:56:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749', 00:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:56 INFO - '_': '/tools/buildbot/bin/python'} 00:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:56:56 INFO - Running setup.py (path:/tmp/pip-A4JXf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:56:56 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)) 00:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:56:56 INFO - Running setup.py (path:/tmp/pip-Apts9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:56:56 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)) 00:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:56:56 INFO - Running setup.py (path:/tmp/pip-F7Xxu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:56:56 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)) 00:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:56:56 INFO - Running setup.py (path:/tmp/pip-1xuVgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:56:56 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)) 00:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:56:56 INFO - Running setup.py (path:/tmp/pip-9NG5Ad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:56:56 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)) 00:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:56:56 INFO - Running setup.py (path:/tmp/pip-cZS5zB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:56:56 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)) 00:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:56:56 INFO - Running setup.py (path:/tmp/pip-gsszq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:56:57 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)) 00:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:56:57 INFO - Running setup.py (path:/tmp/pip-WDa56P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:56:57 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)) 00:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:56:57 INFO - Running setup.py (path:/tmp/pip-vCgoP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:56:57 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)) 00:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:56:57 INFO - Running setup.py (path:/tmp/pip-lsP15H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:56:57 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)) 00:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:56:57 INFO - Running setup.py (path:/tmp/pip-P8HiDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:56:57 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)) 00:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:56:57 INFO - Running setup.py (path:/tmp/pip-yxV2in-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:56:57 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)) 00:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:56:57 INFO - Running setup.py (path:/tmp/pip-7hv7sT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:56:57 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)) 00:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:56:57 INFO - Running setup.py (path:/tmp/pip-nsYhDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:56:57 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)) 00:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:56:57 INFO - Running setup.py (path:/tmp/pip-TVWZmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:56:57 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)) 00:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:56:57 INFO - Running setup.py (path:/tmp/pip-A3bzTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:56:57 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)) 00:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:56:57 INFO - Running setup.py (path:/tmp/pip-xdOA9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:56:57 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)) 00:56:57 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)) 00:56:57 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)) 00:56:57 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)) 00:56:57 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)) 00:56:57 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)) 00:56:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:59 INFO - Downloading blessings-1.6.tar.gz 00:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:56:59 INFO - Installing collected packages: blessings 00:56:59 INFO - Running setup.py install for blessings 00:56:59 INFO - Successfully installed blessings 00:56:59 INFO - Cleaning up... 00:56:59 INFO - Return code: 0 00:56:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:56:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:56:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:57:00 INFO - Reading from file tmpfile_stdout 00:57:00 INFO - Current package versions: 00:57:00 INFO - argparse == 1.2.1 00:57:00 INFO - blessings == 1.6 00:57:00 INFO - blobuploader == 1.2.4 00:57:00 INFO - docopt == 0.6.1 00:57:00 INFO - manifestparser == 1.1 00:57:00 INFO - mozInstall == 1.12 00:57:00 INFO - mozcrash == 0.17 00:57:00 INFO - mozdebug == 0.1 00:57:00 INFO - mozdevice == 0.48 00:57:00 INFO - mozfile == 1.2 00:57:00 INFO - mozhttpd == 0.7 00:57:00 INFO - mozinfo == 0.9 00:57:00 INFO - mozleak == 0.1 00:57:00 INFO - mozlog == 3.1 00:57:00 INFO - moznetwork == 0.27 00:57:00 INFO - mozprocess == 0.22 00:57:00 INFO - mozprofile == 0.28 00:57:00 INFO - mozrunner == 6.11 00:57:00 INFO - mozscreenshot == 0.1 00:57:00 INFO - mozsystemmonitor == 0.0 00:57:00 INFO - moztest == 0.7 00:57:00 INFO - mozversion == 1.4 00:57:00 INFO - psutil == 3.1.1 00:57:00 INFO - requests == 1.2.3 00:57:00 INFO - wsgiref == 0.1.2 00:57:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:00 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 0x7f3f147e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f1410>, '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 0x16f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f27a0>, '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': '62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749', '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 00:57:00 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 00:57:00 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 00:57:00 INFO - Using env: {'DISPLAY': ':0', 00:57:00 INFO - 'HOME': '/home/cltbld', 00:57:00 INFO - 'LANG': 'en_US.UTF-8', 00:57:00 INFO - 'LANGUAGE': 'en_US:en', 00:57:00 INFO - 'LOGNAME': 'cltbld', 00:57:00 INFO - 'MAIL': '/var/mail/cltbld', 00:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:00 INFO - 'MOZ_NO_REMOTE': '1', 00:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:00 INFO - 'NO_EM_RESTART': '1', 00:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:00 INFO - 'PWD': '/builds/slave/test', 00:57:00 INFO - 'SHELL': '/bin/bash', 00:57:00 INFO - 'SHLVL': '1', 00:57:00 INFO - 'TERM': 'linux', 00:57:00 INFO - 'TMOUT': '86400', 00:57:00 INFO - 'USER': 'cltbld', 00:57:00 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749', 00:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:00 INFO - '_': '/tools/buildbot/bin/python'} 00:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:57:00 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)) 00:57:00 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)) 00:57:00 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)) 00:57:00 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)) 00:57:00 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)) 00:57:00 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)) 00:57:00 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)) 00:57:00 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)) 00:57:00 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)) 00:57:00 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)) 00:57:00 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)) 00:57:00 INFO - Cleaning up... 00:57:00 INFO - Return code: 0 00:57:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f147e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f1410>, '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 0x16f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f27a0>, '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': '62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749', '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 00:57:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:57:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:57:00 INFO - Using env: {'DISPLAY': ':0', 00:57:00 INFO - 'HOME': '/home/cltbld', 00:57:00 INFO - 'LANG': 'en_US.UTF-8', 00:57:00 INFO - 'LANGUAGE': 'en_US:en', 00:57:00 INFO - 'LOGNAME': 'cltbld', 00:57:00 INFO - 'MAIL': '/var/mail/cltbld', 00:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:00 INFO - 'MOZ_NO_REMOTE': '1', 00:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:00 INFO - 'NO_EM_RESTART': '1', 00:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:00 INFO - 'PWD': '/builds/slave/test', 00:57:00 INFO - 'SHELL': '/bin/bash', 00:57:00 INFO - 'SHLVL': '1', 00:57:00 INFO - 'TERM': 'linux', 00:57:00 INFO - 'TMOUT': '86400', 00:57:00 INFO - 'USER': 'cltbld', 00:57:00 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749', 00:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:00 INFO - '_': '/tools/buildbot/bin/python'} 00:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:57:00 INFO - Downloading/unpacking jsonschema 00:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:57:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:57:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:57:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:57:02 INFO - Downloading/unpacking functools32 (from jsonschema) 00:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:57:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:57:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:57:02 INFO - Downloading functools32-3.2.3-2.tar.gz 00:57:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:57:02 INFO - warning: no files found matching '*.txt' 00:57:02 INFO - no previously-included directories found matching 'build' 00:57:02 INFO - no previously-included directories found matching 'dist' 00:57:02 INFO - no previously-included directories found matching '.git*' 00:57:02 INFO - Installing collected packages: jsonschema, functools32 00:57:02 INFO - Running setup.py install for functools32 00:57:02 INFO - warning: no files found matching '*.txt' 00:57:02 INFO - no previously-included directories found matching 'build' 00:57:02 INFO - no previously-included directories found matching 'dist' 00:57:02 INFO - no previously-included directories found matching '.git*' 00:57:02 INFO - Successfully installed jsonschema functools32 00:57:02 INFO - Cleaning up... 00:57:02 INFO - Return code: 0 00:57:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f147e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f1410>, '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 0x16f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f27a0>, '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': '62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749', '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 00:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 00:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 00:57:02 INFO - Using env: {'DISPLAY': ':0', 00:57:02 INFO - 'HOME': '/home/cltbld', 00:57:02 INFO - 'LANG': 'en_US.UTF-8', 00:57:02 INFO - 'LANGUAGE': 'en_US:en', 00:57:02 INFO - 'LOGNAME': 'cltbld', 00:57:02 INFO - 'MAIL': '/var/mail/cltbld', 00:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:02 INFO - 'MOZ_NO_REMOTE': '1', 00:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:02 INFO - 'NO_EM_RESTART': '1', 00:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:02 INFO - 'PWD': '/builds/slave/test', 00:57:02 INFO - 'SHELL': '/bin/bash', 00:57:02 INFO - 'SHLVL': '1', 00:57:02 INFO - 'TERM': 'linux', 00:57:02 INFO - 'TMOUT': '86400', 00:57:02 INFO - 'USER': 'cltbld', 00:57:02 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749', 00:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:02 INFO - '_': '/tools/buildbot/bin/python'} 00:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:57:03 INFO - Downloading/unpacking flake8 00:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:57:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:57:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:57:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:57:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:57:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:57:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:57:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:57:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:57:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:57:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:57:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:57:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:57:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:57:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:57:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:57:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:57:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:57:05 INFO - no previously-included directories found matching 'docs/_build' 00:57:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:57:05 INFO - Running setup.py install for pep8 00:57:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:57:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:57:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:57:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:57:05 INFO - no previously-included directories found matching 'docs/_build' 00:57:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:57:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:57:05 INFO - Cleaning up... 00:57:05 INFO - Return code: 0 00:57:05 INFO - Running post-action listener: _resource_record_post_action 00:57:05 INFO - Running post-action listener: _start_resource_monitoring 00:57:05 INFO - Starting resource monitoring. 00:57:05 INFO - ##### 00:57:05 INFO - ##### Running install step. 00:57:05 INFO - ##### 00:57:05 INFO - Running pre-action listener: _resource_record_pre_action 00:57:05 INFO - Running main action method: install 00:57:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:57:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:57:06 INFO - Reading from file tmpfile_stdout 00:57:06 INFO - Detecting whether we're running mozinstall >=1.0... 00:57:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:57:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:57:06 INFO - Reading from file tmpfile_stdout 00:57:06 INFO - Output received: 00:57:06 INFO - Usage: mozinstall [options] installer 00:57:06 INFO - Options: 00:57:06 INFO - -h, --help show this help message and exit 00:57:06 INFO - -d DEST, --destination=DEST 00:57:06 INFO - Directory to install application into. [default: 00:57:06 INFO - "/builds/slave/test"] 00:57:06 INFO - --app=APP Application being installed. [default: firefox] 00:57:06 INFO - mkdir: /builds/slave/test/build/application 00:57:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:57:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:57:22 INFO - Reading from file tmpfile_stdout 00:57:22 INFO - Output received: 00:57:22 INFO - /builds/slave/test/build/application/firefox/firefox 00:57:22 INFO - Running post-action listener: _resource_record_post_action 00:57:22 INFO - ##### 00:57:22 INFO - ##### Running run-tests step. 00:57:22 INFO - ##### 00:57:22 INFO - Running pre-action listener: _resource_record_pre_action 00:57:22 INFO - Running main action method: run_tests 00:57:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:57:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:57:22 INFO - Python 2.7.3 00:57:22 INFO - Return code: 0 00:57:22 INFO - grabbing minidump binary from tooltool 00:57:22 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')]} 00:57:22 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 0x16f1410>, '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 0x16f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f27a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:57:22 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 00:57:22 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 00:57:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:57:22 INFO - Return code: 0 00:57:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:57:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:57:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:57:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:57:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:57:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:57:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:57:23 INFO - Return code: 0 00:57:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 00:57:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 00:57:23 INFO - Using env: {'DISPLAY': ':0', 00:57:23 INFO - 'HOME': '/home/cltbld', 00:57:23 INFO - 'LANG': 'en_US.UTF-8', 00:57:23 INFO - 'LANGUAGE': 'en_US:en', 00:57:23 INFO - 'LOGNAME': 'cltbld', 00:57:23 INFO - 'MAIL': '/var/mail/cltbld', 00:57:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:57:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:23 INFO - 'MOZ_NO_REMOTE': '1', 00:57:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:57:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:23 INFO - 'NO_EM_RESTART': '1', 00:57:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:23 INFO - 'PWD': '/builds/slave/test', 00:57:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:57:23 INFO - 'SHELL': '/bin/bash', 00:57:23 INFO - 'SHLVL': '1', 00:57:23 INFO - 'TERM': 'linux', 00:57:23 INFO - 'TMOUT': '86400', 00:57:23 INFO - 'USER': 'cltbld', 00:57:23 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749', 00:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:23 INFO - '_': '/tools/buildbot/bin/python'} 00:57:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:57:23 INFO - mozversion application_buildid: 20160414223109 00:57:23 INFO - mozversion application_changeset: 15a4d633bd2d983566e22a7989af17ed55fd9f21 00:57:23 INFO - mozversion application_display_name: Nightly 00:57:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:57:23 INFO - mozversion application_name: Firefox 00:57:23 INFO - mozversion application_remotingname: firefox 00:57:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:57:23 INFO - mozversion application_vendor: Mozilla 00:57:23 INFO - mozversion application_version: 48.0a1 00:57:23 INFO - mozversion platform_buildid: 20160414223109 00:57:23 INFO - mozversion platform_changeset: 15a4d633bd2d983566e22a7989af17ed55fd9f21 00:57:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:57:23 INFO - mozversion platform_version: 48.0a1 00:57:23 INFO - using testdate: 1460707043 00:57:23 INFO - actual date: 1460707043 00:57:23 INFO - starting webserver on 'localhost:49897' 00:57:23 INFO - SUITE-START | Running 2 tests 00:57:23 INFO - TEST-START | dromaeo_css 00:57:23 INFO - operating with platform_type : linux_ 00:57:23 INFO - Initialising browser for dromaeo_css test... 00:57:23 INFO - TEST-INFO | started process 5749 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVXWRNl/profile http://localhost:49897/getInfo.html) 00:57:28 INFO - PROCESS | 5749 | __metrics Screen width/height:1600/1200 00:57:28 INFO - PROCESS | 5749 | colorDepth:24 00:57:28 INFO - PROCESS | 5749 | Browser inner width/height: 1024/697 00:57:28 INFO - PROCESS | 5749 | __metrics 00:57:29 ERROR - PROCESS | 5749 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:57:29 INFO - TEST-INFO | 5749: exit 0 00:57:29 INFO - Browser initialized. 00:57:29 INFO - Running cycle 1/1 for dromaeo_css test... 00:57:29 INFO - TEST-INFO | started process 5828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVXWRNl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:57:41 INFO - PROCESS | 5828 | RSS: Main: 153550848 00:57:41 INFO - PROCESS | 5828 | 00:58:32 INFO - PROCESS | 5828 | 1460707112421 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] 01:00:39 INFO - PROCESS | 5828 | Cycle 1(1): loaded http://localhost:49897/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49897/tests/dromaeo/cssquery-ext.html) 01:00:40 INFO - PROCESS | 5828 | RSS: Main: 258084864 01:00:40 INFO - PROCESS | 5828 | 01:03:43 INFO - PROCESS | 5828 | Cycle 1(1): loaded http://localhost:49897/tests/dromaeo/cssquery-ext.html (next: http://localhost:49897/tests/dromaeo/cssquery-jquery.html) 01:03:43 INFO - PROCESS | 5828 | RSS: Main: 229928960 01:03:43 INFO - PROCESS | 5828 | 01:06:45 INFO - PROCESS | 5828 | Cycle 1(1): loaded http://localhost:49897/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49897/tests/dromaeo/cssquery-mootools.html) 01:06:46 INFO - PROCESS | 5828 | RSS: Main: 233762816 01:06:46 INFO - PROCESS | 5828 | 01:09:48 INFO - PROCESS | 5828 | Cycle 1(1): loaded http://localhost:49897/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49897/tests/dromaeo/cssquery-prototype.html) 01:09:48 INFO - PROCESS | 5828 | RSS: Main: 234463232 01:09:48 INFO - PROCESS | 5828 | 01:12:51 INFO - PROCESS | 5828 | Cycle 1(1): loaded http://localhost:49897/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49897/tests/dromaeo/cssquery-yui.html) 01:12:51 INFO - PROCESS | 5828 | RSS: Main: 224268288 01:12:51 INFO - PROCESS | 5828 | 01:15:54 INFO - PROCESS | 5828 | Cycle 1(1): loaded http://localhost:49897/tests/dromaeo/cssquery-yui.html (next: http://localhost:49897/tests/dromaeo/cssquery-dojo.html) 01:15:54 INFO - PROCESS | 5828 | RSS: Main: 264646656 01:15:54 INFO - PROCESS | 5828 | 01:15:54 INFO - PROCESS | 5828 | __start_tp_report 01:15:54 INFO - PROCESS | 5828 | _x_x_mozilla_page_load 01:15:54 INFO - PROCESS | 5828 | _x_x_mozilla_page_load_details 01:15:54 INFO - PROCESS | 5828 | |i|pagename|runs| 01:15:54 INFO - PROCESS | 5828 | |0;dojo.html;3030.696930306969;3114.05021468452;3150.60617422822;3151.606049243846;3177.682231776822;5277.788888444467;5328.840134795957;5341.706206158665;5363;5365.543928766055;5274.103402421588;5321.627486075976;5351.143816989283;5365.275687782148;5390.218418329349;4753.16819556578;4787.760611969405;4910.312556242129;4934.753262336887;4959.60323174147;4867.853964381075;4932.235503496964;4939.160342741725;4940.08608407444;4962.206047032458;4700.224462963607;4783.832565860195;4817.879553011167;4841.15279826029;4905.975470122645;4808.663393562452;4810.735409552473;4811.711297322172;4834.009028149221;4860.3195552622665;4592.908141837144;4693.155232058228;4780.737059461728;4784.0192760484015;4810.06203790261;5230.34620672416;5231.110711179109;5240.423553409122;5248.5538729208065;5256.92114618281;5602.831915042555;5627.493525582676;5628.746706398222;5629.127485239795;5638.464345887134;5526.917096243519;5640.407757185478;5657.2928383952;5668.631538949955;5736.56975726818;5274.894502109974;5289.86775330616;5291.444398338158;5297.470252974749;5309.150535914274;5770.971145144247;5792.0732682771395;5794.246747922743;5794.362620111784;5795.391483894215;5410.756515956791;5462.481064298885;5515.145152501369;5517.337919449611;5559.082751345983;5582.190582365534;5629;5639.182318563785;5641.069223578145;5642.774289028475;5594.608377413542;5601.327840659147;5614.073677843192;5617.9438205618235;5619.550435965113;5468.56251499887;5477.370102438191;5527.115661494142;5544.306961629796;5568.972155139199;4245.893852653709;4254.170436764801;4257.808398622069;4258.233517966733;4301.505326887385;3797.050737315671;3833.1183827719224;3839.865604703878;3860.285847118292;3896.7661940283674;5189.948100519022;5231.058409486329;5238.73806309683;5280.419153893069;5287.68273903567;5681.318241810926;5695.971520142372;5723.914141287884;5725.198472213893;5729.140628905698;5240.842774716764;5326.44072372403;5456.945430545644;5466.753996070186;5525.392206857243;4870.391201099863;4878;4892.559669629751;4910.680805747615;4935.407751069894;5861.032929566573;5865.794697185578;5867.559933005042;5870.0607902735355;5913.46778789911;5445.809396671098;5646.096624540054;5657.717114144359;5705.429457054262;5788.768449261982;5729.054705973635;5745.1956726059225;5750.108733146369;5752.13717942312;5768.625039372428;5425.484578964992;5446;5447.346318441812;5451.454854514517;5457.454254574511;5526.668399896019;5595.832125036092;5652.123920792284;5718.714064296852;5757.625754325955;5377.542908852792;5397.082495975772;5403.324584426947;5407.486288802557;5430.049741295336;5384.703841288767;5384.9192262116885;5388.137897936312;5408.296921400193;5441.319835020622;5218.295530103387;5362.115250983544;5378.40837507866;5397.78408863641;5438.8640283991635;5542.7782888684005;5577.6653400796085;5582.218489411567;5587.1339942309005;5588.217649529151;5351.839444816662;5481.424450432806;5483.314585676791;5490.91763623538;5538.0585300499815 01:15:54 INFO - PROCESS | 5828 | |1;ext.html;600.5885968111844;642.7943058221365;643.9760780359229;653.2650767886128;663.4460225711528;28949.855250723744;36540;37505.624943750554;37575.24849503015;37621.62378376215;38431.231375372474;39035.219295614144;39064.41403378944;39129.60870391302;39168.41247381292;8393.16068393162;8584.613692383826;8590.527520986343;8591.44155629882;8592;8393.118722534138;8561.1866872647;8583.484990900535;8591.570421478933;8793.296536277114;8807.64769409223;8874.20132188103;8888.511131887744;8889.733308000737;8891.599878005472;8757.255633271148;8803.823923521557;8807;8808.691695790649;8811.162939520735;8754.255888249507;8851.557422128868;8861.335399844973;8863.689770857989;8866.689665861664;40138.39792403116;40722.79638601818;40781;40781.38827917584;40804.183916321505;3509.210427653783;3545.131442796506;3629.2922880038404;3703.851845926187;4036.354183330682;30611;31072;31231.84384078088;31308.373832523448;32610.347793044242;4035.8385664573384;4128.710990230685;4154.50145982481;4186;4229.217594744982;299848;300931;302222;302593.48703256564;302814;50620.240696389585;55157.724211378685;55652;55973;58182.7090864543;53082;53083.73458132762;53182.20226696603;53295;53400;16543.255553500123;16767.496975090766;16770.832291677172;16770.832291677172;16776;11190.552377904793;11549.36478493674;12695.746085078246;12961.481540738454;12963.092583519063;16088.436904708513;16330;16396.75404868928;16403.5899102521;16431.424900128437;6545.672716364258;6796.694148763318;6814.182298124257;6865.691043902936;6882.965585172042;1051.4374809476892;1085.5766251162054;1097.9780404391868;1137.5734099712608;1236.190295356543;31686.683133168834;31692.841535792635;31999.520007199444;32495.350092998007;32506.674933250364;1169.6374124021581;1189;1212.2060050666828;1278.2713853103642;1292.6445227562494;16311.184440777914;16998.660026799396;17106.743398849027;17127;17354.479365619052;446415;453173;453680;455712;458443;55149;55625.721871390386;55638.16542751862;55671.721641392345;55718.44281557214;1266.7909794883926;1363.9113457625222;1395.0583356234501;1431.3201229415945;1498.1760031982367;28285.43429131447;28980.275493111996;29771.85114074416;29977.700222998363;31486.37027259488;45452.31821522746;45457.318140228585;45961;46029;46094;282384;283584;284478;284602;284741;35577;40241.39637905375;41362.58637413708;41425.585744143376;43352.34971475368;44073.55926440695;44451.33323000093;44639;44955;45563.54436455593;39367.80316098401;40334.1933161341;41167.1766564661;42212.577874222094;43153.784231078644;34751.304973900886;34891;35533.466997995565;35550.288994220486;35710.8214458926;35477.82261088678;36216.81891590525;36696.81651591832;37023.629763703095;37081.81459092795;33545.83227083946;34812.47781283232;35182;35237.82381088078;35506.46740298846;27298.181054568395;27659.60637675634;30222.244443889078;32049.679503205603;32572.837135815116 01:15:54 INFO - PROCESS | 5828 | |2;jquery.html;379.4197168791982;380.6459992207248;383.5397522972432;392.2547160395249;396.3658146964855;14964.925175374136;16824;17427.825721742778;18828.52928676782;18863.245470181195;17040;17399.3040278389;17821.82178178218;17875;18463.16915738795;5448.128299472075;5573.888522229553;5601.719914004283;5623.240862483553;5637.633553818989;5484.232207490954;5712.485876271135;5714.628549144313;5714.885702285952;5717.399673034334;5389.595780316472;5613.550915926716;5615.185798059279;5616.466435688603;5619.438056194389;5507.5593952483705;5555.30558680165;5594.720263986785;5597.384287728347;5599.608027438081;4607.401037865089;4919.581835543983;4923.409190897115;4923.729194894279;4924.556789888891;21914.561708765734;22096.226632067963;22255.666165007537;22395.776042239533;22589.887050564805;2370.928872133839;2439.6706444629926;2539.860307683095;2616.8355081988525;2829.995351650155;13903.443862245498;13929.721405571832;13931;14195.716085678228;14245.358958846877;1906.9904650476797;1914.8563857710587;1955.9902200489048;1972.142118178597;2008.1866843928233;73308.6334568329;76302.61848690777;78208.21791782066;78744;79417;9489.572969216402;9638.180754635794;10195.042504170906;10204.23468239885;10260.846087308697;13910.930445347709;13955.58133256004;13972.650683732785;14000.159990400405;14019.088759230617;7658.770236892902;7778.8833167502535;7803.648835802403;7825.060992680801;7843.56860372685;7465.552066875896;7524.9247507525315;7586.696532138763;7600.087989441192;7612.2387761224545;6167.167432396569;6287.96856015717;6331.366863313724;6376.585521941059;6393.004372267333;1752.772139621841;1756.6925787987307;1774.325756212631;1786.6873297172942;1857.526330785641;1023.8482951631058;1045.7072019834307;1053.3258714422775;1066.8346406307035;1071.385818602607;18544.629107418044;18719.157637906326;18880.527986800163;19061.332853350064;19589.118489668;1066.0405634928472;1081.1837063017372;1082.7401423658423;1089.5641743302583;1103.7020004598874;10716.249862509549;10983;11054.668359949215;11081.833772493419;11115.277506962022;459331;462851;485380.58477661206;485735;486418;77182.22817771751;78661;78720;78830;79424;1011.6964910526813;1022.3610243597751;1024.533837104116;1045.0907710292095;1055.4353420919772;16371.42700005494;16812.394078917787;16870.831291686925;16892.493225203263;17107.7433838495;34506.309873802886;35539.82230088833;36119.27761444809;36989.815050924575;37025.25949480941;46718.76640616775;50006;50098.49901500938;50248;50291;8313.168683131638;8419.789505262172;8458.619362128597;8534.78663033429;8559.186877246651;12799.360031998549;12961.870381296067;13067.477300907858;13180.670483237996;13350.465981360638;11665.300081995107;11782.410879455821;11869.940650296694;12032.458539365925;12175.452104655134;11387.259828111146;11486.597969071043;11622.256661500842;11699.473523691284;11724.296542207494;11614.825777613174;11799.764004719686;12017.4592143352;12079;12270.141090123605;6991.300869912968;8196.67213311461;8324.791880203044;8482.406231563731;8652.82694346097;9226.874488099133;10952.835707464235;11334.829977550507;11405.714857128638;11533.769324613293 01:15:54 INFO - PROCESS | 5828 | |3;mootools.html;1354.383755391297;1364.7884577890427;1450.3690894460908;1453.8328092269392;1613.943511977081;7993.1607181246;8324.209200125986;8337.499750015004;8346.16538346165;8349.165083491647;8125.0656174539945;8279.130691277405;8281.83436331273;8284.91715082849;8291.585420728954;2058.7014882841977;2275.8293128015384;2289.2331069091833;2324.976750232501;2367.041348253951;2363.409147713072;2395.089865850974;2396.628522579003;2397.0531640002187;2398.112698301622;2272.0570963050395;2323.453988312745;2333.9533209335805;2334.26470661741;2339.4268404240984;2041.1835265893687;2234.955300893973;2293.575688497633;2294.288770481156;2295.231097582312;2229.041512149775;2245.8764767937755;2250.5723912456583;2260.3106052653934;2261.276391554703;8202.630881610341;8248.505089694578;8270.669173233064;8273.627686754111;8274.627641756135;4985.52637499437;5127.9230811537855;5129.487051294878;5133.666311689728;5207;3150.3699260148064;3182.474891642876;3182.6105197964093;3235.8058516489086;3244.902652920416;1024.4212020208558;1049.7847941172042;1053.8577292065627;1063.6064656077224;1074.6399956014745;11406.657800266004;11610.535578576932;11638.476268567934;11642.185047046625;11646.301221926627;4366.6506679465565;4407.757573333433;4516.841910533181;4558.726476411426;4583.472900616405;9885.950570247247;9936.80126397468;9942.105210531086;9946.552405141785;9952.80094398108;4509.526499717548;5173.456787037382;5178.042062218502;5181.715005674649;5205.27126202332;4633.119707255611;4728.0543891221205;4735.029318989599;4743.976280118646;4768.642351823627;3865.9806700966315;3927.8821635350987;3988.202359528106;4003.53959294679;4048.0487085534874;1271.2690203133236;1290.6321698315935;1299.5191779041816;1300.8634093420244;1301.2777908261005;922.3174850610634;951.3530799056708;960.2941837749248;974.7124598243536;983.7208144571059;5523.143912693539;5733.77064917407;5743.8851222976145;5800.0429929062075;5879.20630714848;373.8691457989682;379.2888334373051;383.75854111947825;387.24100762505805;392.6113147983533;3924.6860251179837;3926.7251292409255;3970.463987361727;3987.940180897289;4042.6967977401814;10014.39913605186;10323.84514232287;10404.427756473468;10427.165826733843;10469.31949423285;10308;10316.329438586468;10433.5826566938;10605.893941060645;10606.681799545871;7832.921670783333;7852.568108754073;7906.327962123284;7909.841803163905;7927.246911543394;5542.11326187808;5562.110062389998;5574.832755017356;5608.495235428668;5773.653580785166;9473.100055494717;9500.572474238537;9617.855732163884;9703.12671859536;9728.9027109728;9712.951435243061;9880.209583233467;9892.752681183028;10052.396856188652;10088.747781305527;6679.332066793282;7147.46394020461;7305.1233851938105;7355.5954422507275;7398.704051837866;7938.880916786137;7959.442839001214;8017.879731804144;8019.799505012421;8020.438569300093;6791.083203767428;6989.825254368478;7033.156021277479;7088.681009354488;7122.074130363019;6884.277150899284;6927.7228910845015;6983.301669832976;6999.930000699927;7019.613921234177;6774.593524388552;6799.5920244785475;6891.586504809728;6910.136232970879;6943.722251110101;4833.250846118857;4838.879028024327;4860.902781944412;4893.314935908905;4943.8629115302965;5012.423571289202;5029.823956161516;5030.773615187399;5047.167217409086;5134.12719837621 01:15:54 INFO - PROCESS | 5828 | |4;prototype.html;294.30984341718676;304.8567173428488;307.35455543358944;307.6907707753707;309.8528199105425;5290.444503327143;5436.782528698847;5603.523700485459;5654.632448890819;5681.23303354047;5526.281583394163;5541.861453463665;5546.278983732119;5580.079286917654;5604.85987850304;4249.1714115747445;4250.234957707611;4254.851409956641;4262.445882035347;4262.53112157664;4011.3581826907703;4118.341065429532;4213.389058586503;4230.873073807791;4269.573042695737;4237.258479766044;4237.639800616951;4242.469691288589;4251.681123915703;4251.8724438266745;4230.407742915994;4241.1941731071;4248.511421186572;4249.46881639795;4250.766207858566;3676.9080772980888;3700.85196592136;3724.1248306647917;3732.42147467143;3734.906627334311;5322.1484562470205;5351.464853514656;5353.732313384316;5368.194770784375;5391.137418013099;4846.248831431134;4855.150348689001;4861.805527778884;4870.4171144378215;4879.780409881529;5601.859953501154;5776.393478684719;5780.9710951445395;5783.363829978699;5790.189373487715;4045.939310910339;4069.2471892699946;4072.9389059164137;4073.246449406869;4078.3066878630702;5716.599838011341;5835.270591176103;6076.964216987314;6083.665398403086;6083.726232319556;4123.628873401408;4131.834726610902;4138.52406973196;4143.854965076268;4158.251514727318;4175.97912010438;4186.937195942063;4187.895302617459;4198;4199.517055538652;4708.317293992421;4845.830395936126;4852.951470485321;4853.514648535118;4854.368932038883;5773.1051686988585;5837.124431335334;5843.357230704619;5853.268341457318;5857.736401861926;1412.5338638249352;1429.4425174182077;1431.7065001674632;1432.9140251584938;1445.9349329280208;958.1759686669459;971.4074414607226;991.1872264742985;991.7966816802539;996.8088134679134;5610.915836262459;5676;5694.430556944272;5702.0591602385975;5716.256886604715;5906.409359064145;5982.162497250389;5985.102234664748;5985.551083668655;5990.7004649768205;5513.696746678891;5650.530861975916;5676.318841739017;5694.715264236855;5727.112297593796;3207.7273431758094;3207.8716851326153;3216.758743094277;3229.4348489014797;3233.692799184074;6027.9095813562835;6211.192544969125;6217.191765070603;6280.995040793451;6304.747810087545;6070.939290607126;6128.724207410677;6131.785387511416;6139.508839292846;6151.938480615226;6196.783112591038;6202.883480973378;6215.9378406216265;6219.657918814509;6262.906056409158;5822.534197264294;5950.2264705587995;5968.403159683997;5995.88008239824;5999.550033747573;5898.764049437975;5936.495397891227;5940.821775346746;5956.255468066492;5958.523318134626;6032.306284777132;6128.540359473147;6325.335839736946;6330.556861019684;6336.524760642878;4149.605787450188;4175.5824417558;4180.1848639515;4189.2459357315975;4197.433346498184;5927.288725352985;6085.60031192837;6092.45167934888;6097.603655762361;6106.542009349228;5893.528517718658;5898.705064746831;5926.081457374114;5935.881282374242;5950.940490595039;5858.765649373977;5883.411658834082;5895.115732640138;5913.940860591339;5932.347441781487;5657.858553536194;5805.883882322414;5813;5814.418558144321;5828.825135245949;5903.2325797646035;5906.464319277105;5932.851678708067;5950.3454619992635;5969.4627483524955;5674.7017457929605;5828.883422331614;5844.26946631671;5845.503132233808;5881.382454842351 01:15:54 INFO - PROCESS | 5828 | |5;yui.html;775.1860546426254;779.1429427629612;818.7420962396849;839.345310657687;864.0883867519766;14767.409303627855;15167.241637918087;15192.620184495394;15266;15277.236138193088;12362.690932726664;12612.747745045093;12630.115891887548;13784.655383615389;13809.792853107212;675.4765057080778;791.2720297326473;791.7901756034655;809.2069771623812;811.2333844516934;806.9556174410405;811.4401063266357;811.5374236685092;813.60540138033;814.8411059843332;849.558229720545;849.7195925344653;850.553459433796;851.1658574596898;851.5657014922373;708.1855865754372;821.8274162425897;844.9493030418164;847.8770578266178;850.9021462531795;617.3178637605471;618.8019833653233;619.0837560410617;620.1968450856152;621.4562258024229;14440.205788681618;14582.416703331854;14602.26988650574;14615.70768584633;14625.92687036558;14114.153150810882;14479.203643799692;14493;14556.344964476624;14653.12081275127;11407.372594507298;11632.825507617392;11665.066794656492;11865.288082715064;12000.039996800235;3820;3843.404272337792;3848.7146108057964;3879.650831425157;3916.8629097981434;55050.44949550533;58410.123848142735;58470;58524.707376462844;58703.41296587022;11074.667759967213;11201.60794372193;11332.773344533063;11354.205205635526;11626;19192.424227273204;20247.797522024885;20363.389098327072;20390.69413958792;20424.59150817005;8341.082480927093;8398.580070996426;8457.365697572706;8557.871631925525;8682.131786821394;4693.718376897397;4734.147853386424;4845.63657725665;4865.440474345495;4867.542751410075;3367.292868497594;3520.859165633346;3520.9613164116645;3524.3479956208184;3528.8764893228613;588.9705514724333;591.5681552466723;593.2762030322999;594.2334388638608;608.3308360803081;713.5789883968483;730.18219594055;751.4439314907039;752.2665401233753;792.5442870349572;8940;9036.051214622501;9121.950975637754;9163.358564900393;9226.49254291007;638.5402510192654;681.8294928582133;691.5574032619128;722.7903907866765;742.6732237815344;4437.866863994085;4451.6883818133065;4464.374987501752;4483.21543729846;4571.725696458223;59728.70135649381;59757.103643445385;61213.38786612166;61304.69347653233;61308;54128;54181.72909135429;54506;54649.72675136599;54798.178027329624;48607.51392486101;48943.510564894605;49007.13900053924;49791.50208497941;50124.74937625288;8486.321094312563;8614.569271536524;8634;8754.956225219088;8793.252573531066;32271.70913163447;32767;33475.330493389505;33547.83226083854;33671.66328336783;42609.460770099686;44262.114757704025;44582.8791984558;44762;45367.31949020701;10518.105960993402;10885.945570272099;11003;11872.703182420508;11993;12645.620631381073;12838.935805320914;12933.22400655926;13299.667508311983;13586.796198057235;11944.581939632071;12576.993840492922;12640.810387844005;12654.936725316315;13077.476900924237;12669.176503527242;12696.74606507883;12825.358732063547;12899.419526121535;13440.327983600977;12072.577459788865;12260.754784904073;12316.753664926471;12372.13395062337;12380.876191237972;10575.259731819007;10641;10677.412742299248;10717.410542420243;11080;10303.124234439856;10634.468276586294;10703.143748500257;10704.571817127227;10713.303635263683 01:15:54 INFO - PROCESS | 5828 | __end_tp_report 01:15:54 INFO - PROCESS | 5828 | __start_cc_report 01:15:54 INFO - PROCESS | 5828 | _x_x_mozilla_cycle_collect,838 01:15:54 INFO - PROCESS | 5828 | __end_cc_report 01:15:54 INFO - PROCESS | 5828 | __startTimestamp1460708154565__endTimestamp 01:15:54 INFO - PROCESS | 5828 | 01:15:54 INFO - PROCESS | 5828 | ------- Summary: start ------- 01:15:54 INFO - PROCESS | 5828 | Number of tests: 6 01:15:54 INFO - PROCESS | 5828 | 01:15:54 INFO - PROCESS | 5828 | [#0] dojo.html Cycles:165 Average:5234.86 Median:5403.32 stddev:579.19 (10.7%) stddev-sans-first:554.56 01:15:54 INFO - PROCESS | 5828 | Values: 3030.7 3114.1 3150.6 3151.6 3177.7 5277.8 5328.8 5341.7 5363.0 5365.5 5274.1 5321.6 5351.1 5365.3 5390.2 4753.2 4787.8 4910.3 4934.8 4959.6 4867.9 4932.2 4939.2 4940.1 4962.2 4700.2 4783.8 4817.9 4841.2 4906.0 4808.7 4810.7 4811.7 4834.0 4860.3 4592.9 4693.2 4780.7 4784.0 4810.1 5230.3 5231.1 5240.4 5248.6 5256.9 5602.8 5627.5 5628.7 5629.1 5638.5 5526.9 5640.4 5657.3 5668.6 5736.6 5274.9 5289.9 5291.4 5297.5 5309.2 5771.0 5792.1 5794.2 5794.4 5795.4 5410.8 5462.5 5515.1 5517.3 5559.1 5582.2 5629.0 5639.2 5641.1 5642.8 5594.6 5601.3 5614.1 5617.9 5619.6 5468.6 5477.4 5527.1 5544.3 5569.0 4245.9 4254.2 4257.8 4258.2 4301.5 3797.1 3833.1 3839.9 3860.3 3896.8 5189.9 5231.1 5238.7 5280.4 5287.7 5681.3 5696.0 5723.9 5725.2 5729.1 5240.8 5326.4 5456.9 5466.8 5525.4 4870.4 4878.0 4892.6 4910.7 4935.4 5861.0 5865.8 5867.6 5870.1 5913.5 5445.8 5646.1 5657.7 5705.4 5788.8 5729.1 5745.2 5750.1 5752.1 5768.6 5425.5 5446.0 5447.3 5451.5 5457.5 5526.7 5595.8 5652.1 5718.7 5757.6 5377.5 5397.1 5403.3 5407.5 5430.0 5384.7 5384.9 5388.1 5408.3 5441.3 5218.3 5362.1 5378.4 5397.8 5438.9 5542.8 5577.7 5582.2 5587.1 5588.2 5351.8 5481.4 5483.3 5490.9 5538.1 01:15:54 INFO - PROCESS | 5828 | 01:15:54 INFO - PROCESS | 5828 | [#1] ext.html Cycles:180 Average:51253.50 Median:38733.23 stddev:93449.89 (241.3%) stddev-sans-first:93634.65 01:15:54 INFO - PROCESS | 5828 | Values: 600.6 642.8 644.0 653.3 663.4 28949.9 36540.0 37505.6 37575.2 37621.6 38431.2 39035.2 39064.4 39129.6 39168.4 8393.2 8584.6 8590.5 8591.4 8592.0 8393.1 8561.2 8583.5 8591.6 8793.3 8807.6 8874.2 8888.5 8889.7 8891.6 8757.3 8803.8 8807.0 8808.7 8811.2 8754.3 8851.6 8861.3 8863.7 8866.7 40138.4 40722.8 40781.0 40781.4 40804.2 3509.2 3545.1 3629.3 3703.9 4036.4 30611.0 31072.0 31231.8 31308.4 32610.3 4035.8 4128.7 4154.5 4186.0 4229.2 299848.0 300931.0 302222.0 302593.5 302814.0 50620.2 55157.7 55652.0 55973.0 58182.7 53082.0 53083.7 53182.2 53295.0 53400.0 16543.3 16767.5 16770.8 16770.8 16776.0 11190.6 11549.4 12695.7 12961.5 12963.1 16088.4 16330.0 16396.8 16403.6 16431.4 6545.7 6796.7 6814.2 6865.7 6883.0 1051.4 1085.6 1098.0 1137.6 1236.2 31686.7 31692.8 31999.5 32495.4 32506.7 1169.6 1189.0 1212.2 1278.3 1292.6 16311.2 16998.7 17106.7 17127.0 17354.5 446415.0 453173.0 453680.0 455712.0 458443.0 55149.0 55625.7 55638.2 55671.7 55718.4 1266.8 1363.9 1395.1 1431.3 1498.2 28285.4 28980.3 29771.9 29977.7 31486.4 45452.3 45457.3 45961.0 46029.0 46094.0 282384.0 283584.0 284478.0 284602.0 284741.0 35577.0 40241.4 41362.6 41425.6 43352.3 44073.6 44451.3 44639.0 44955.0 45563.5 39367.8 40334.2 41167.2 42212.6 43153.8 34751.3 34891.0 35533.5 35550.3 35710.8 35477.8 36216.8 36696.8 37023.6 37081.8 33545.8 34812.5 35182.0 35237.8 35506.5 27298.2 27659.6 30222.2 32049.7 32572.8 01:15:54 INFO - PROCESS | 5828 | 01:15:54 INFO - PROCESS | 5828 | [#2] jquery.html Cycles:180 Average:27612.18 Median:22492.83 stddev:78150.31 (347.4%) stddev-sans-first:78342.79 01:15:54 INFO - PROCESS | 5828 | Values: 379.4 380.6 383.5 392.3 396.4 14964.9 16824.0 17427.8 18828.5 18863.2 17040.0 17399.3 17821.8 17875.0 18463.2 5448.1 5573.9 5601.7 5623.2 5637.6 5484.2 5712.5 5714.6 5714.9 5717.4 5389.6 5613.6 5615.2 5616.5 5619.4 5507.6 5555.3 5594.7 5597.4 5599.6 4607.4 4919.6 4923.4 4923.7 4924.6 21914.6 22096.2 22255.7 22395.8 22589.9 2370.9 2439.7 2539.9 2616.8 2830.0 13903.4 13929.7 13931.0 14195.7 14245.4 1907.0 1914.9 1956.0 1972.1 2008.2 73308.6 76302.6 78208.2 78744.0 79417.0 9489.6 9638.2 10195.0 10204.2 10260.8 13910.9 13955.6 13972.7 14000.2 14019.1 7658.8 7778.9 7803.6 7825.1 7843.6 7465.6 7524.9 7586.7 7600.1 7612.2 6167.2 6288.0 6331.4 6376.6 6393.0 1752.8 1756.7 1774.3 1786.7 1857.5 1023.8 1045.7 1053.3 1066.8 1071.4 18544.6 18719.2 18880.5 19061.3 19589.1 1066.0 1081.2 1082.7 1089.6 1103.7 10716.2 10983.0 11054.7 11081.8 11115.3 459331.0 462851.0 485380.6 485735.0 486418.0 77182.2 78661.0 78720.0 78830.0 79424.0 1011.7 1022.4 1024.5 1045.1 1055.4 16371.4 16812.4 16870.8 16892.5 17107.7 34506.3 35539.8 36119.3 36989.8 37025.3 46718.8 50006.0 50098.5 50248.0 50291.0 8313.2 8419.8 8458.6 8534.8 8559.2 12799.4 12961.9 13067.5 13180.7 13350.5 11665.3 11782.4 11869.9 12032.5 12175.5 11387.3 11486.6 11622.3 11699.5 11724.3 11614.8 11799.8 12017.5 12079.0 12270.1 6991.3 8196.7 8324.8 8482.4 8652.8 9226.9 10952.8 11334.8 11405.7 11533.8 01:15:54 INFO - PROCESS | 5828 | 01:15:54 INFO - PROCESS | 5828 | [#3] mootools.html Cycles:180 Average:5524.20 Median:4877.11 stddev:3126.67 (64.1%) stddev-sans-first:3119.73 01:15:54 INFO - PROCESS | 5828 | Values: 1354.4 1364.8 1450.4 1453.8 1613.9 7993.2 8324.2 8337.5 8346.2 8349.2 8125.1 8279.1 8281.8 8284.9 8291.6 2058.7 2275.8 2289.2 2325.0 2367.0 2363.4 2395.1 2396.6 2397.1 2398.1 2272.1 2323.5 2334.0 2334.3 2339.4 2041.2 2235.0 2293.6 2294.3 2295.2 2229.0 2245.9 2250.6 2260.3 2261.3 8202.6 8248.5 8270.7 8273.6 8274.6 4985.5 5127.9 5129.5 5133.7 5207.0 3150.4 3182.5 3182.6 3235.8 3244.9 1024.4 1049.8 1053.9 1063.6 1074.6 11406.7 11610.5 11638.5 11642.2 11646.3 4366.7 4407.8 4516.8 4558.7 4583.5 9886.0 9936.8 9942.1 9946.6 9952.8 4509.5 5173.5 5178.0 5181.7 5205.3 4633.1 4728.1 4735.0 4744.0 4768.6 3866.0 3927.9 3988.2 4003.5 4048.0 1271.3 1290.6 1299.5 1300.9 1301.3 922.3 951.4 960.3 974.7 983.7 5523.1 5733.8 5743.9 5800.0 5879.2 373.9 379.3 383.8 387.2 392.6 3924.7 3926.7 3970.5 3987.9 4042.7 10014.4 10323.8 10404.4 10427.2 10469.3 10308.0 10316.3 10433.6 10605.9 10606.7 7832.9 7852.6 7906.3 7909.8 7927.2 5542.1 5562.1 5574.8 5608.5 5773.7 9473.1 9500.6 9617.9 9703.1 9728.9 9713.0 9880.2 9892.8 10052.4 10088.7 6679.3 7147.5 7305.1 7355.6 7398.7 7938.9 7959.4 8017.9 8019.8 8020.4 6791.1 6989.8 7033.2 7088.7 7122.1 6884.3 6927.7 6983.3 6999.9 7019.6 6774.6 6799.6 6891.6 6910.1 6943.7 4833.3 4838.9 4860.9 4893.3 4943.9 5012.4 5029.8 5030.8 5047.2 5134.1 01:15:54 INFO - PROCESS | 5828 | 01:15:54 INFO - PROCESS | 5828 | [#4] prototype.html Cycles:180 Average:4894.31 Median:5676.16 stddev:1476.20 (26.0%) stddev-sans-first:1439.40 01:15:54 INFO - PROCESS | 5828 | Values: 294.3 304.9 307.4 307.7 309.9 5290.4 5436.8 5603.5 5654.6 5681.2 5526.3 5541.9 5546.3 5580.1 5604.9 4249.2 4250.2 4254.9 4262.4 4262.5 4011.4 4118.3 4213.4 4230.9 4269.6 4237.3 4237.6 4242.5 4251.7 4251.9 4230.4 4241.2 4248.5 4249.5 4250.8 3676.9 3700.9 3724.1 3732.4 3734.9 5322.1 5351.5 5353.7 5368.2 5391.1 4846.2 4855.2 4861.8 4870.4 4879.8 5601.9 5776.4 5781.0 5783.4 5790.2 4045.9 4069.2 4072.9 4073.2 4078.3 5716.6 5835.3 6077.0 6083.7 6083.7 4123.6 4131.8 4138.5 4143.9 4158.3 4176.0 4186.9 4187.9 4198.0 4199.5 4708.3 4845.8 4853.0 4853.5 4854.4 5773.1 5837.1 5843.4 5853.3 5857.7 1412.5 1429.4 1431.7 1432.9 1445.9 958.2 971.4 991.2 991.8 996.8 5610.9 5676.0 5694.4 5702.1 5716.3 5906.4 5982.2 5985.1 5985.6 5990.7 5513.7 5650.5 5676.3 5694.7 5727.1 3207.7 3207.9 3216.8 3229.4 3233.7 6027.9 6211.2 6217.2 6281.0 6304.7 6070.9 6128.7 6131.8 6139.5 6151.9 6196.8 6202.9 6215.9 6219.7 6262.9 5822.5 5950.2 5968.4 5995.9 5999.6 5898.8 5936.5 5940.8 5956.3 5958.5 6032.3 6128.5 6325.3 6330.6 6336.5 4149.6 4175.6 4180.2 4189.2 4197.4 5927.3 6085.6 6092.5 6097.6 6106.5 5893.5 5898.7 5926.1 5935.9 5950.9 5858.8 5883.4 5895.1 5913.9 5932.3 5657.9 5805.9 5813.0 5814.4 5828.8 5903.2 5906.5 5932.9 5950.3 5969.5 5674.7 5828.9 5844.3 5845.5 5881.4 01:15:54 INFO - PROCESS | 5828 | 01:15:54 INFO - PROCESS | 5828 | [#5] yui.html Cycles:180 Average:14808.43 Median:24613.19 stddev:17035.98 (69.2%) stddev-sans-first:17051.17 01:15:54 INFO - PROCESS | 5828 | Values: 775.2 779.1 818.7 839.3 864.1 14767.4 15167.2 15192.6 15266.0 15277.2 12362.7 12612.7 12630.1 13784.7 13809.8 675.5 791.3 791.8 809.2 811.2 807.0 811.4 811.5 813.6 814.8 849.6 849.7 850.6 851.2 851.6 708.2 821.8 844.9 847.9 850.9 617.3 618.8 619.1 620.2 621.5 14440.2 14582.4 14602.3 14615.7 14625.9 14114.2 14479.2 14493.0 14556.3 14653.1 11407.4 11632.8 11665.1 11865.3 12000.0 3820.0 3843.4 3848.7 3879.7 3916.9 55050.4 58410.1 58470.0 58524.7 58703.4 11074.7 11201.6 11332.8 11354.2 11626.0 19192.4 20247.8 20363.4 20390.7 20424.6 8341.1 8398.6 8457.4 8557.9 8682.1 4693.7 4734.1 4845.6 4865.4 4867.5 3367.3 3520.9 3521.0 3524.3 3528.9 589.0 591.6 593.3 594.2 608.3 713.6 730.2 751.4 752.3 792.5 8940.0 9036.1 9122.0 9163.4 9226.5 638.5 681.8 691.6 722.8 742.7 4437.9 4451.7 4464.4 4483.2 4571.7 59728.7 59757.1 61213.4 61304.7 61308.0 54128.0 54181.7 54506.0 54649.7 54798.2 48607.5 48943.5 49007.1 49791.5 50124.7 8486.3 8614.6 8634.0 8755.0 8793.3 32271.7 32767.0 33475.3 33547.8 33671.7 42609.5 44262.1 44582.9 44762.0 45367.3 10518.1 10885.9 11003.0 11872.7 11993.0 12645.6 12838.9 12933.2 13299.7 13586.8 11944.6 12577.0 12640.8 12654.9 13077.5 12669.2 12696.7 12825.4 12899.4 13440.3 12072.6 12260.8 12316.8 12372.1 12380.9 10575.3 10641.0 10677.4 10717.4 11080.0 10303.1 10634.5 10703.1 10704.6 10713.3 01:15:54 INFO - PROCESS | 5828 | -------- Summary: end -------- 01:15:54 INFO - PROCESS | 5828 | 01:15:55 INFO - TEST-INFO | 5828: exit 0 01:15:55 INFO - TEST-OK | dromaeo_css | took 1111328ms 01:15:55 INFO - TEST-START | kraken 01:15:55 INFO - operating with platform_type : linux_ 01:15:55 INFO - Initialising browser for kraken test... 01:15:55 INFO - TEST-INFO | started process 6010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXwToqJ/profile http://localhost:49897/getInfo.html) 01:15:58 INFO - PROCESS | 6010 | __metrics Screen width/height:1600/1200 01:15:58 INFO - PROCESS | 6010 | colorDepth:24 01:15:58 INFO - PROCESS | 6010 | Browser inner width/height: 1024/697 01:15:58 INFO - PROCESS | 6010 | __metrics 01:15:59 ERROR - PROCESS | 6010 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:16:00 INFO - TEST-INFO | 6010: exit 0 01:16:00 INFO - Browser initialized. 01:16:00 INFO - Running cycle 1/1 for kraken test... 01:16:00 INFO - TEST-INFO | started process 6097 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXwToqJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:16:12 INFO - PROCESS | 6097 | RSS: Main: 153292800 01:16:12 INFO - PROCESS | 6097 | 01:16:15 INFO - PROCESS | 6097 | Cycle 1(1): loaded http://localhost:49897/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49897/tests/kraken/driver.html?testName=audio-beat-detection) 01:16:15 INFO - PROCESS | 6097 | RSS: Main: 209154048 01:16:15 INFO - PROCESS | 6097 | 01:16:18 INFO - PROCESS | 6097 | Cycle 1(1): loaded http://localhost:49897/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49897/tests/kraken/driver.html?testName=audio-dft) 01:16:19 INFO - PROCESS | 6097 | RSS: Main: 194420736 01:16:19 INFO - PROCESS | 6097 | 01:16:22 INFO - PROCESS | 6097 | Cycle 1(1): loaded http://localhost:49897/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49897/tests/kraken/driver.html?testName=audio-fft) 01:16:22 INFO - PROCESS | 6097 | RSS: Main: 265641984 01:16:22 INFO - PROCESS | 6097 | 01:16:24 INFO - PROCESS | 6097 | Cycle 1(1): loaded http://localhost:49897/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49897/tests/kraken/driver.html?testName=audio-oscillator) 01:16:25 INFO - PROCESS | 6097 | RSS: Main: 173785088 01:16:25 INFO - PROCESS | 6097 | 01:16:27 INFO - PROCESS | 6097 | Cycle 1(1): loaded http://localhost:49897/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49897/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:16:28 INFO - PROCESS | 6097 | RSS: Main: 177864704 01:16:28 INFO - PROCESS | 6097 | 01:16:31 INFO - PROCESS | 6097 | Cycle 1(1): loaded http://localhost:49897/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49897/tests/kraken/driver.html?testName=imaging-darkroom) 01:16:31 INFO - PROCESS | 6097 | RSS: Main: 213991424 01:16:31 INFO - PROCESS | 6097 | 01:16:35 INFO - PROCESS | 6097 | Cycle 1(1): loaded http://localhost:49897/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49897/tests/kraken/driver.html?testName=imaging-desaturate) 01:16:35 INFO - PROCESS | 6097 | RSS: Main: 214437888 01:16:35 INFO - PROCESS | 6097 | 01:16:38 INFO - PROCESS | 6097 | Cycle 1(1): loaded http://localhost:49897/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49897/tests/kraken/driver.html?testName=json-parse-financial) 01:16:39 INFO - PROCESS | 6097 | RSS: Main: 213811200 01:16:39 INFO - PROCESS | 6097 | 01:16:40 INFO - PROCESS | 6097 | Cycle 1(1): loaded http://localhost:49897/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49897/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:16:41 INFO - PROCESS | 6097 | RSS: Main: 201842688 01:16:41 INFO - PROCESS | 6097 | 01:16:43 INFO - PROCESS | 6097 | Cycle 1(1): loaded http://localhost:49897/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49897/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:16:43 INFO - PROCESS | 6097 | RSS: Main: 205893632 01:16:43 INFO - PROCESS | 6097 | 01:16:45 INFO - PROCESS | 6097 | Cycle 1(1): loaded http://localhost:49897/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49897/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:16:46 INFO - PROCESS | 6097 | RSS: Main: 215293952 01:16:46 INFO - PROCESS | 6097 | 01:16:48 INFO - PROCESS | 6097 | Cycle 1(1): loaded http://localhost:49897/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49897/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:16:49 INFO - PROCESS | 6097 | RSS: Main: 223563776 01:16:49 INFO - PROCESS | 6097 | 01:16:52 INFO - PROCESS | 6097 | Cycle 1(1): loaded http://localhost:49897/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49897/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:16:52 INFO - PROCESS | 6097 | RSS: Main: 217489408 01:16:52 INFO - PROCESS | 6097 | 01:16:54 INFO - PROCESS | 6097 | Cycle 1(1): loaded http://localhost:49897/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49897/tests/kraken/driver.html?testName=ai-astar) 01:16:54 INFO - PROCESS | 6097 | RSS: Main: 281182208 01:16:54 INFO - PROCESS | 6097 | 01:16:54 INFO - PROCESS | 6097 | __start_tp_report 01:16:54 INFO - PROCESS | 6097 | _x_x_mozilla_page_load 01:16:54 INFO - PROCESS | 6097 | _x_x_mozilla_page_load_details 01:16:54 INFO - PROCESS | 6097 | |i|pagename|runs| 01:16:54 INFO - PROCESS | 6097 | |0;ai-astar;113;113;108;111;112;111;100;110;110;110 01:16:54 INFO - PROCESS | 6097 | |1;audio-beat-detection;165;131;155;187;136;166;161;129;187;134 01:16:54 INFO - PROCESS | 6097 | |2;audio-dft;162;163;159;162;163;160;160;160;161;161 01:16:54 INFO - PROCESS | 6097 | |3;audio-fft;75;72;107;105;72;76;76;112;99;77 01:16:54 INFO - PROCESS | 6097 | |4;audio-oscillator;93;93;154;92;92;93;150;92;92;145 01:16:54 INFO - PROCESS | 6097 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;116;117 01:16:54 INFO - PROCESS | 6097 | |6;imaging-darkroom;146;147;146;146;146;147;146;145;145;145 01:16:54 INFO - PROCESS | 6097 | |7;imaging-desaturate;95;96;95;94;94;95;95;95;95;94 01:16:54 INFO - PROCESS | 6097 | |8;json-parse-financial;57;57;57;58;57;57;58;74;57;56 01:16:54 INFO - PROCESS | 6097 | |9;json-stringify-tinderbox;60;61;61;61;61;60;60;61;62;60 01:16:54 INFO - PROCESS | 6097 | |10;stanford-crypto-aes;75;83;75;75;78;85;76;77;77;85 01:16:54 INFO - PROCESS | 6097 | |11;stanford-crypto-ccm;125;124;124;130;119;119;124;124;169;128 01:16:54 INFO - PROCESS | 6097 | |12;stanford-crypto-pbkdf2;164;164;167;167;164;166;164;171;164;169 01:16:54 INFO - PROCESS | 6097 | |13;stanford-crypto-sha256-iterative;67;69;69;67;66;68;68;67;67;66 01:16:54 INFO - PROCESS | 6097 | __end_tp_report 01:16:54 INFO - PROCESS | 6097 | __start_cc_report 01:16:54 INFO - PROCESS | 6097 | _x_x_mozilla_cycle_collect,1632 01:16:54 INFO - PROCESS | 6097 | __end_cc_report 01:16:54 INFO - PROCESS | 6097 | __startTimestamp1460708214750__endTimestamp 01:16:54 INFO - PROCESS | 6097 | 01:16:54 INFO - PROCESS | 6097 | ------- Summary: start ------- 01:16:54 INFO - PROCESS | 6097 | Number of tests: 14 01:16:54 INFO - PROCESS | 6097 | 01:16:54 INFO - PROCESS | 6097 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.77 (3.4%) stddev-sans-first:3.81 01:16:54 INFO - PROCESS | 6097 | Values: 113.0 113.0 108.0 111.0 112.0 111.0 100.0 110.0 110.0 110.0 01:16:54 INFO - PROCESS | 6097 | 01:16:54 INFO - PROCESS | 6097 | [#1] audio-beat-detection Cycles:10 Average:155.10 Median:163.00 stddev:22.01 (13.5%) stddev-sans-first:23.05 01:16:54 INFO - PROCESS | 6097 | Values: 165.0 131.0 155.0 187.0 136.0 166.0 161.0 129.0 187.0 134.0 01:16:54 INFO - PROCESS | 6097 | 01:16:54 INFO - PROCESS | 6097 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.37 (0.8%) stddev-sans-first:1.41 01:16:54 INFO - PROCESS | 6097 | Values: 162.0 163.0 159.0 162.0 163.0 160.0 160.0 160.0 161.0 161.0 01:16:54 INFO - PROCESS | 6097 | 01:16:54 INFO - PROCESS | 6097 | [#3] audio-fft Cycles:10 Average:87.10 Median:75.50 stddev:16.43 (21.8%) stddev-sans-first:16.83 01:16:54 INFO - PROCESS | 6097 | Values: 75.0 72.0 107.0 105.0 72.0 76.0 76.0 112.0 99.0 77.0 01:16:54 INFO - PROCESS | 6097 | 01:16:54 INFO - PROCESS | 6097 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:92.00 stddev:27.73 (30.1%) stddev-sans-first:28.76 01:16:54 INFO - PROCESS | 6097 | Values: 93.0 93.0 154.0 92.0 92.0 93.0 150.0 92.0 92.0 145.0 01:16:54 INFO - PROCESS | 6097 | 01:16:54 INFO - PROCESS | 6097 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 01:16:54 INFO - PROCESS | 6097 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 01:16:54 INFO - PROCESS | 6097 | 01:16:54 INFO - PROCESS | 6097 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 01:16:54 INFO - PROCESS | 6097 | Values: 146.0 147.0 146.0 146.0 146.0 147.0 146.0 145.0 145.0 145.0 01:16:54 INFO - PROCESS | 6097 | 01:16:54 INFO - PROCESS | 6097 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 01:16:54 INFO - PROCESS | 6097 | Values: 95.0 96.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 94.0 01:16:54 INFO - PROCESS | 6097 | 01:16:54 INFO - PROCESS | 6097 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:57.00 stddev:5.37 (9.4%) stddev-sans-first:5.66 01:16:54 INFO - PROCESS | 6097 | Values: 57.0 57.0 57.0 58.0 57.0 57.0 58.0 74.0 57.0 56.0 01:16:54 INFO - PROCESS | 6097 | 01:16:54 INFO - PROCESS | 6097 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 01:16:54 INFO - PROCESS | 6097 | Values: 60.0 61.0 61.0 61.0 61.0 60.0 60.0 61.0 62.0 60.0 01:16:54 INFO - PROCESS | 6097 | 01:16:54 INFO - PROCESS | 6097 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:77.50 stddev:4.12 (5.3%) stddev-sans-first:4.15 01:16:54 INFO - PROCESS | 6097 | Values: 75.0 83.0 75.0 75.0 78.0 85.0 76.0 77.0 77.0 85.0 01:16:54 INFO - PROCESS | 6097 | 01:16:54 INFO - PROCESS | 6097 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:124.50 stddev:14.59 (11.7%) stddev-sans-first:15.42 01:16:54 INFO - PROCESS | 6097 | Values: 125.0 124.0 124.0 130.0 119.0 119.0 124.0 124.0 169.0 128.0 01:16:54 INFO - PROCESS | 6097 | 01:16:54 INFO - PROCESS | 6097 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.00 Median:166.50 stddev:2.49 (1.5%) stddev-sans-first:2.54 01:16:54 INFO - PROCESS | 6097 | Values: 164.0 164.0 167.0 167.0 164.0 166.0 164.0 171.0 164.0 169.0 01:16:54 INFO - PROCESS | 6097 | 01:16:54 INFO - PROCESS | 6097 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:1.07 (1.6%) stddev-sans-first:1.13 01:16:54 INFO - PROCESS | 6097 | Values: 67.0 69.0 69.0 67.0 66.0 68.0 68.0 67.0 67.0 66.0 01:16:54 INFO - PROCESS | 6097 | -------- Summary: end -------- 01:16:54 INFO - PROCESS | 6097 | 01:16:55 INFO - TEST-INFO | 6097: exit 0 01:16:55 INFO - TEST-OK | kraken | took 60382ms 01:16:55 INFO - SUITE-END | took 1171s 01:16:55 INFO - Completed test suite (00:19:31) 01:16:55 INFO - javascript benchmark 01:16:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3030.696930306969, 3114.05021468452, 3150.60617422822, 3151.606049243846, 3177.682231776822, 5277.788888444467, 5328.840134795957, 5341.706206158665, 5363.0, 5365.543928766055, 5274.103402421588, 5321.627486075976, 5351.143816989283, 5365.275687782148, 5390.218418329349, 4753.16819556578, 4787.760611969405, 4910.312556242129, 4934.753262336887, 4959.60323174147, 4867.853964381075, 4932.235503496964, 4939.160342741725, 4940.08608407444, 4962.206047032458, 4700.224462963607, 4783.832565860195, 4817.879553011167, 4841.15279826029, 4905.975470122645, 4808.663393562452, 4810.735409552473, 4811.711297322172, 4834.009028149221, 4860.3195552622665, 4592.908141837144, 4693.155232058228, 4780.737059461728, 4784.0192760484015, 4810.06203790261, 5230.34620672416, 5231.110711179109, 5240.423553409122, 5248.5538729208065, 5256.92114618281, 5602.831915042555, 5627.493525582676, 5628.746706398222, 5629.127485239795, 5638.464345887134, 5526.917096243519, 5640.407757185478, 5657.2928383952, 5668.631538949955, 5736.56975726818, 5274.894502109974, 5289.86775330616, 5291.444398338158, 5297.470252974749, 5309.150535914274, 5770.971145144247, 5792.0732682771395, 5794.246747922743, 5794.362620111784, 5795.391483894215, 5410.756515956791, 5462.481064298885, 5515.145152501369, 5517.337919449611, 5559.082751345983, 5582.190582365534, 5629.0, 5639.182318563785, 5641.069223578145, 5642.774289028475, 5594.608377413542, 5601.327840659147, 5614.073677843192, 5617.9438205618235, 5619.550435965113, 5468.56251499887, 5477.370102438191, 5527.115661494142, 5544.306961629796, 5568.972155139199, 4245.893852653709, 4254.170436764801, 4257.808398622069, 4258.233517966733, 4301.505326887385, 3797.050737315671, 3833.1183827719224, 3839.865604703878, 3860.285847118292, 3896.7661940283674, 5189.948100519022, 5231.058409486329, 5238.73806309683, 5280.419153893069, 5287.68273903567, 5681.318241810926, 5695.971520142372, 5723.914141287884, 5725.198472213893, 5729.140628905698, 5240.842774716764, 5326.44072372403, 5456.945430545644, 5466.753996070186, 5525.392206857243, 4870.391201099863, 4878.0, 4892.559669629751, 4910.680805747615, 4935.407751069894, 5861.032929566573, 5865.794697185578, 5867.559933005042, 5870.0607902735355, 5913.46778789911, 5445.809396671098, 5646.096624540054, 5657.717114144359, 5705.429457054262, 5788.768449261982, 5729.054705973635, 5745.1956726059225, 5750.108733146369, 5752.13717942312, 5768.625039372428, 5425.484578964992, 5446.0, 5447.346318441812, 5451.454854514517, 5457.454254574511, 5526.668399896019, 5595.832125036092, 5652.123920792284, 5718.714064296852, 5757.625754325955, 5377.542908852792, 5397.082495975772, 5403.324584426947, 5407.486288802557, 5430.049741295336, 5384.703841288767, 5384.9192262116885, 5388.137897936312, 5408.296921400193, 5441.319835020622, 5218.295530103387, 5362.115250983544, 5378.40837507866, 5397.78408863641, 5438.8640283991635, 5542.7782888684005, 5577.6653400796085, 5582.218489411567, 5587.1339942309005, 5588.217649529151, 5351.839444816662, 5481.424450432806, 5483.314585676791, 5490.91763623538, 5538.0585300499815], "value": 5196.992298583423, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.5885968111844, 642.7943058221365, 643.9760780359229, 653.2650767886128, 663.4460225711528, 28949.855250723744, 36540.0, 37505.624943750554, 37575.24849503015, 37621.62378376215, 38431.231375372474, 39035.219295614144, 39064.41403378944, 39129.60870391302, 39168.41247381292, 8393.16068393162, 8584.613692383826, 8590.527520986343, 8591.44155629882, 8592.0, 8393.118722534138, 8561.1866872647, 8583.484990900535, 8591.570421478933, 8793.296536277114, 8807.64769409223, 8874.20132188103, 8888.511131887744, 8889.733308000737, 8891.599878005472, 8757.255633271148, 8803.823923521557, 8807.0, 8808.691695790649, 8811.162939520735, 8754.255888249507, 8851.557422128868, 8861.335399844973, 8863.689770857989, 8866.689665861664, 40138.39792403116, 40722.79638601818, 40781.0, 40781.38827917584, 40804.183916321505, 3509.210427653783, 3545.131442796506, 3629.2922880038404, 3703.851845926187, 4036.354183330682, 30611.0, 31072.0, 31231.84384078088, 31308.373832523448, 32610.347793044242, 4035.8385664573384, 4128.710990230685, 4154.50145982481, 4186.0, 4229.217594744982, 299848.0, 300931.0, 302222.0, 302593.48703256564, 302814.0, 50620.240696389585, 55157.724211378685, 55652.0, 55973.0, 58182.7090864543, 53082.0, 53083.73458132762, 53182.20226696603, 53295.0, 53400.0, 16543.255553500123, 16767.496975090766, 16770.832291677172, 16770.832291677172, 16776.0, 11190.552377904793, 11549.36478493674, 12695.746085078246, 12961.481540738454, 12963.092583519063, 16088.436904708513, 16330.0, 16396.75404868928, 16403.5899102521, 16431.424900128437, 6545.672716364258, 6796.694148763318, 6814.182298124257, 6865.691043902936, 6882.965585172042, 1051.4374809476892, 1085.5766251162054, 1097.9780404391868, 1137.5734099712608, 1236.190295356543, 31686.683133168834, 31692.841535792635, 31999.520007199444, 32495.350092998007, 32506.674933250364, 1169.6374124021581, 1189.0, 1212.2060050666828, 1278.2713853103642, 1292.6445227562494, 16311.184440777914, 16998.660026799396, 17106.743398849027, 17127.0, 17354.479365619052, 446415.0, 453173.0, 453680.0, 455712.0, 458443.0, 55149.0, 55625.721871390386, 55638.16542751862, 55671.721641392345, 55718.44281557214, 1266.7909794883926, 1363.9113457625222, 1395.0583356234501, 1431.3201229415945, 1498.1760031982367, 28285.43429131447, 28980.275493111996, 29771.85114074416, 29977.700222998363, 31486.37027259488, 45452.31821522746, 45457.318140228585, 45961.0, 46029.0, 46094.0, 282384.0, 283584.0, 284478.0, 284602.0, 284741.0, 35577.0, 40241.39637905375, 41362.58637413708, 41425.585744143376, 43352.34971475368, 44073.55926440695, 44451.33323000093, 44639.0, 44955.0, 45563.54436455593, 39367.80316098401, 40334.1933161341, 41167.1766564661, 42212.577874222094, 43153.784231078644, 34751.304973900886, 34891.0, 35533.466997995565, 35550.288994220486, 35710.8214458926, 35477.82261088678, 36216.81891590525, 36696.81651591832, 37023.629763703095, 37081.81459092795, 33545.83227083946, 34812.47781283232, 35182.0, 35237.82381088078, 35506.46740298846, 27298.181054568395, 27659.60637675634, 30222.244443889078, 32049.679503205603, 32572.837135815116], "value": 19270.940793316367, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.4197168791982, 380.6459992207248, 383.5397522972432, 392.2547160395249, 396.3658146964855, 14964.925175374136, 16824.0, 17427.825721742778, 18828.52928676782, 18863.245470181195, 17040.0, 17399.3040278389, 17821.82178178218, 17875.0, 18463.16915738795, 5448.128299472075, 5573.888522229553, 5601.719914004283, 5623.240862483553, 5637.633553818989, 5484.232207490954, 5712.485876271135, 5714.628549144313, 5714.885702285952, 5717.399673034334, 5389.595780316472, 5613.550915926716, 5615.185798059279, 5616.466435688603, 5619.438056194389, 5507.5593952483705, 5555.30558680165, 5594.720263986785, 5597.384287728347, 5599.608027438081, 4607.401037865089, 4919.581835543983, 4923.409190897115, 4923.729194894279, 4924.556789888891, 21914.561708765734, 22096.226632067963, 22255.666165007537, 22395.776042239533, 22589.887050564805, 2370.928872133839, 2439.6706444629926, 2539.860307683095, 2616.8355081988525, 2829.995351650155, 13903.443862245498, 13929.721405571832, 13931.0, 14195.716085678228, 14245.358958846877, 1906.9904650476797, 1914.8563857710587, 1955.9902200489048, 1972.142118178597, 2008.1866843928233, 73308.6334568329, 76302.61848690777, 78208.21791782066, 78744.0, 79417.0, 9489.572969216402, 9638.180754635794, 10195.042504170906, 10204.23468239885, 10260.846087308697, 13910.930445347709, 13955.58133256004, 13972.650683732785, 14000.159990400405, 14019.088759230617, 7658.770236892902, 7778.8833167502535, 7803.648835802403, 7825.060992680801, 7843.56860372685, 7465.552066875896, 7524.9247507525315, 7586.696532138763, 7600.087989441192, 7612.2387761224545, 6167.167432396569, 6287.96856015717, 6331.366863313724, 6376.585521941059, 6393.004372267333, 1752.772139621841, 1756.6925787987307, 1774.325756212631, 1786.6873297172942, 1857.526330785641, 1023.8482951631058, 1045.7072019834307, 1053.3258714422775, 1066.8346406307035, 1071.385818602607, 18544.629107418044, 18719.157637906326, 18880.527986800163, 19061.332853350064, 19589.118489668, 1066.0405634928472, 1081.1837063017372, 1082.7401423658423, 1089.5641743302583, 1103.7020004598874, 10716.249862509549, 10983.0, 11054.668359949215, 11081.833772493419, 11115.277506962022, 459331.0, 462851.0, 485380.58477661206, 485735.0, 486418.0, 77182.22817771751, 78661.0, 78720.0, 78830.0, 79424.0, 1011.6964910526813, 1022.3610243597751, 1024.533837104116, 1045.0907710292095, 1055.4353420919772, 16371.42700005494, 16812.394078917787, 16870.831291686925, 16892.493225203263, 17107.7433838495, 34506.309873802886, 35539.82230088833, 36119.27761444809, 36989.815050924575, 37025.25949480941, 46718.76640616775, 50006.0, 50098.49901500938, 50248.0, 50291.0, 8313.168683131638, 8419.789505262172, 8458.619362128597, 8534.78663033429, 8559.186877246651, 12799.360031998549, 12961.870381296067, 13067.477300907858, 13180.670483237996, 13350.465981360638, 11665.300081995107, 11782.410879455821, 11869.940650296694, 12032.458539365925, 12175.452104655134, 11387.259828111146, 11486.597969071043, 11622.256661500842, 11699.473523691284, 11724.296542207494, 11614.825777613174, 11799.764004719686, 12017.4592143352, 12079.0, 12270.141090123605, 6991.300869912968, 8196.67213311461, 8324.791880203044, 8482.406231563731, 8652.82694346097, 9226.874488099133, 10952.835707464235, 11334.829977550507, 11405.714857128638, 11533.769324613293], "value": 9055.733272747239, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1354.383755391297, 1364.7884577890427, 1450.3690894460908, 1453.8328092269392, 1613.943511977081, 7993.1607181246, 8324.209200125986, 8337.499750015004, 8346.16538346165, 8349.165083491647, 8125.0656174539945, 8279.130691277405, 8281.83436331273, 8284.91715082849, 8291.585420728954, 2058.7014882841977, 2275.8293128015384, 2289.2331069091833, 2324.976750232501, 2367.041348253951, 2363.409147713072, 2395.089865850974, 2396.628522579003, 2397.0531640002187, 2398.112698301622, 2272.0570963050395, 2323.453988312745, 2333.9533209335805, 2334.26470661741, 2339.4268404240984, 2041.1835265893687, 2234.955300893973, 2293.575688497633, 2294.288770481156, 2295.231097582312, 2229.041512149775, 2245.8764767937755, 2250.5723912456583, 2260.3106052653934, 2261.276391554703, 8202.630881610341, 8248.505089694578, 8270.669173233064, 8273.627686754111, 8274.627641756135, 4985.52637499437, 5127.9230811537855, 5129.487051294878, 5133.666311689728, 5207.0, 3150.3699260148064, 3182.474891642876, 3182.6105197964093, 3235.8058516489086, 3244.902652920416, 1024.4212020208558, 1049.7847941172042, 1053.8577292065627, 1063.6064656077224, 1074.6399956014745, 11406.657800266004, 11610.535578576932, 11638.476268567934, 11642.185047046625, 11646.301221926627, 4366.6506679465565, 4407.757573333433, 4516.841910533181, 4558.726476411426, 4583.472900616405, 9885.950570247247, 9936.80126397468, 9942.105210531086, 9946.552405141785, 9952.80094398108, 4509.526499717548, 5173.456787037382, 5178.042062218502, 5181.715005674649, 5205.27126202332, 4633.119707255611, 4728.0543891221205, 4735.029318989599, 4743.976280118646, 4768.642351823627, 3865.9806700966315, 3927.8821635350987, 3988.202359528106, 4003.53959294679, 4048.0487085534874, 1271.2690203133236, 1290.6321698315935, 1299.5191779041816, 1300.8634093420244, 1301.2777908261005, 922.3174850610634, 951.3530799056708, 960.2941837749248, 974.7124598243536, 983.7208144571059, 5523.143912693539, 5733.77064917407, 5743.8851222976145, 5800.0429929062075, 5879.20630714848, 373.8691457989682, 379.2888334373051, 383.75854111947825, 387.24100762505805, 392.6113147983533, 3924.6860251179837, 3926.7251292409255, 3970.463987361727, 3987.940180897289, 4042.6967977401814, 10014.39913605186, 10323.84514232287, 10404.427756473468, 10427.165826733843, 10469.31949423285, 10308.0, 10316.329438586468, 10433.5826566938, 10605.893941060645, 10606.681799545871, 7832.921670783333, 7852.568108754073, 7906.327962123284, 7909.841803163905, 7927.246911543394, 5542.11326187808, 5562.110062389998, 5574.832755017356, 5608.495235428668, 5773.653580785166, 9473.100055494717, 9500.572474238537, 9617.855732163884, 9703.12671859536, 9728.9027109728, 9712.951435243061, 9880.209583233467, 9892.752681183028, 10052.396856188652, 10088.747781305527, 6679.332066793282, 7147.46394020461, 7305.1233851938105, 7355.5954422507275, 7398.704051837866, 7938.880916786137, 7959.442839001214, 8017.879731804144, 8019.799505012421, 8020.438569300093, 6791.083203767428, 6989.825254368478, 7033.156021277479, 7088.681009354488, 7122.074130363019, 6884.277150899284, 6927.7228910845015, 6983.301669832976, 6999.930000699927, 7019.613921234177, 6774.593524388552, 6799.5920244785475, 6891.586504809728, 6910.136232970879, 6943.722251110101, 4833.250846118857, 4838.879028024327, 4860.902781944412, 4893.314935908905, 4943.8629115302965, 5012.423571289202, 5029.823956161516, 5030.773615187399, 5047.167217409086, 5134.12719837621], "value": 4355.47844265974, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.30984341718676, 304.8567173428488, 307.35455543358944, 307.6907707753707, 309.8528199105425, 5290.444503327143, 5436.782528698847, 5603.523700485459, 5654.632448890819, 5681.23303354047, 5526.281583394163, 5541.861453463665, 5546.278983732119, 5580.079286917654, 5604.85987850304, 4249.1714115747445, 4250.234957707611, 4254.851409956641, 4262.445882035347, 4262.53112157664, 4011.3581826907703, 4118.341065429532, 4213.389058586503, 4230.873073807791, 4269.573042695737, 4237.258479766044, 4237.639800616951, 4242.469691288589, 4251.681123915703, 4251.8724438266745, 4230.407742915994, 4241.1941731071, 4248.511421186572, 4249.46881639795, 4250.766207858566, 3676.9080772980888, 3700.85196592136, 3724.1248306647917, 3732.42147467143, 3734.906627334311, 5322.1484562470205, 5351.464853514656, 5353.732313384316, 5368.194770784375, 5391.137418013099, 4846.248831431134, 4855.150348689001, 4861.805527778884, 4870.4171144378215, 4879.780409881529, 5601.859953501154, 5776.393478684719, 5780.9710951445395, 5783.363829978699, 5790.189373487715, 4045.939310910339, 4069.2471892699946, 4072.9389059164137, 4073.246449406869, 4078.3066878630702, 5716.599838011341, 5835.270591176103, 6076.964216987314, 6083.665398403086, 6083.726232319556, 4123.628873401408, 4131.834726610902, 4138.52406973196, 4143.854965076268, 4158.251514727318, 4175.97912010438, 4186.937195942063, 4187.895302617459, 4198.0, 4199.517055538652, 4708.317293992421, 4845.830395936126, 4852.951470485321, 4853.514648535118, 4854.368932038883, 5773.1051686988585, 5837.124431335334, 5843.357230704619, 5853.268341457318, 5857.736401861926, 1412.5338638249352, 1429.4425174182077, 1431.7065001674632, 1432.9140251584938, 1445.9349329280208, 958.1759686669459, 971.4074414607226, 991.1872264742985, 991.7966816802539, 996.8088134679134, 5610.915836262459, 5676.0, 5694.430556944272, 5702.0591602385975, 5716.256886604715, 5906.409359064145, 5982.162497250389, 5985.102234664748, 5985.551083668655, 5990.7004649768205, 5513.696746678891, 5650.530861975916, 5676.318841739017, 5694.715264236855, 5727.112297593796, 3207.7273431758094, 3207.8716851326153, 3216.758743094277, 3229.4348489014797, 3233.692799184074, 6027.9095813562835, 6211.192544969125, 6217.191765070603, 6280.995040793451, 6304.747810087545, 6070.939290607126, 6128.724207410677, 6131.785387511416, 6139.508839292846, 6151.938480615226, 6196.783112591038, 6202.883480973378, 6215.9378406216265, 6219.657918814509, 6262.906056409158, 5822.534197264294, 5950.2264705587995, 5968.403159683997, 5995.88008239824, 5999.550033747573, 5898.764049437975, 5936.495397891227, 5940.821775346746, 5956.255468066492, 5958.523318134626, 6032.306284777132, 6128.540359473147, 6325.335839736946, 6330.556861019684, 6336.524760642878, 4149.605787450188, 4175.5824417558, 4180.1848639515, 4189.2459357315975, 4197.433346498184, 5927.288725352985, 6085.60031192837, 6092.45167934888, 6097.603655762361, 6106.542009349228, 5893.528517718658, 5898.705064746831, 5926.081457374114, 5935.881282374242, 5950.940490595039, 5858.765649373977, 5883.411658834082, 5895.115732640138, 5913.940860591339, 5932.347441781487, 5657.858553536194, 5805.883882322414, 5813.0, 5814.418558144321, 5828.825135245949, 5903.2325797646035, 5906.464319277105, 5932.851678708067, 5950.3454619992635, 5969.4627483524955, 5674.7017457929605, 5828.883422331614, 5844.26946631671, 5845.503132233808, 5881.382454842351], "value": 4409.15944056227, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.1860546426254, 779.1429427629612, 818.7420962396849, 839.345310657687, 864.0883867519766, 14767.409303627855, 15167.241637918087, 15192.620184495394, 15266.0, 15277.236138193088, 12362.690932726664, 12612.747745045093, 12630.115891887548, 13784.655383615389, 13809.792853107212, 675.4765057080778, 791.2720297326473, 791.7901756034655, 809.2069771623812, 811.2333844516934, 806.9556174410405, 811.4401063266357, 811.5374236685092, 813.60540138033, 814.8411059843332, 849.558229720545, 849.7195925344653, 850.553459433796, 851.1658574596898, 851.5657014922373, 708.1855865754372, 821.8274162425897, 844.9493030418164, 847.8770578266178, 850.9021462531795, 617.3178637605471, 618.8019833653233, 619.0837560410617, 620.1968450856152, 621.4562258024229, 14440.205788681618, 14582.416703331854, 14602.26988650574, 14615.70768584633, 14625.92687036558, 14114.153150810882, 14479.203643799692, 14493.0, 14556.344964476624, 14653.12081275127, 11407.372594507298, 11632.825507617392, 11665.066794656492, 11865.288082715064, 12000.039996800235, 3820.0, 3843.404272337792, 3848.7146108057964, 3879.650831425157, 3916.8629097981434, 55050.44949550533, 58410.123848142735, 58470.0, 58524.707376462844, 58703.41296587022, 11074.667759967213, 11201.60794372193, 11332.773344533063, 11354.205205635526, 11626.0, 19192.424227273204, 20247.797522024885, 20363.389098327072, 20390.69413958792, 20424.59150817005, 8341.082480927093, 8398.580070996426, 8457.365697572706, 8557.871631925525, 8682.131786821394, 4693.718376897397, 4734.147853386424, 4845.63657725665, 4865.440474345495, 4867.542751410075, 3367.292868497594, 3520.859165633346, 3520.9613164116645, 3524.3479956208184, 3528.8764893228613, 588.9705514724333, 591.5681552466723, 593.2762030322999, 594.2334388638608, 608.3308360803081, 713.5789883968483, 730.18219594055, 751.4439314907039, 752.2665401233753, 792.5442870349572, 8940.0, 9036.051214622501, 9121.950975637754, 9163.358564900393, 9226.49254291007, 638.5402510192654, 681.8294928582133, 691.5574032619128, 722.7903907866765, 742.6732237815344, 4437.866863994085, 4451.6883818133065, 4464.374987501752, 4483.21543729846, 4571.725696458223, 59728.70135649381, 59757.103643445385, 61213.38786612166, 61304.69347653233, 61308.0, 54128.0, 54181.72909135429, 54506.0, 54649.72675136599, 54798.178027329624, 48607.51392486101, 48943.510564894605, 49007.13900053924, 49791.50208497941, 50124.74937625288, 8486.321094312563, 8614.569271536524, 8634.0, 8754.956225219088, 8793.252573531066, 32271.70913163447, 32767.0, 33475.330493389505, 33547.83226083854, 33671.66328336783, 42609.460770099686, 44262.114757704025, 44582.8791984558, 44762.0, 45367.31949020701, 10518.105960993402, 10885.945570272099, 11003.0, 11872.703182420508, 11993.0, 12645.620631381073, 12838.935805320914, 12933.22400655926, 13299.667508311983, 13586.796198057235, 11944.581939632071, 12576.993840492922, 12640.810387844005, 12654.936725316315, 13077.476900924237, 12669.176503527242, 12696.74606507883, 12825.358732063547, 12899.419526121535, 13440.327983600977, 12072.577459788865, 12260.754784904073, 12316.753664926471, 12372.13395062337, 12380.876191237972, 10575.259731819007, 10641.0, 10677.412742299248, 10717.410542420243, 11080.0, 10303.124234439856, 10634.468276586294, 10703.143748500257, 10704.571817127227, 10713.303635263683], "value": 6741.6497523283815, "unit": "score"}], "name": "dromaeo_css", "value": 6997.831221271704, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 108.0, 111.0, 112.0, 111.0, 100.0, 110.0, 110.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 131.0, 155.0, 187.0, 136.0, 166.0, 161.0, 129.0, 187.0, 134.0], "value": 155.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 159.0, 162.0, 163.0, 160.0, 160.0, 160.0, 161.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 107.0, 105.0, 72.0, 76.0, 76.0, 112.0, 99.0, 77.0], "value": 87.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 154.0, 92.0, 92.0, 93.0, 150.0, 92.0, 92.0, 145.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 145.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 58.0, 57.0, 57.0, 58.0, 74.0, 57.0, 56.0], "value": 58.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 61.0, 60.0, 60.0, 61.0, 62.0, 60.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 83.0, 75.0, 75.0, 78.0, 85.0, 76.0, 77.0, 77.0, 85.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 124.0, 124.0, 130.0, 119.0, 119.0, 124.0, 124.0, 169.0, 128.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 167.0, 167.0, 164.0, 166.0, 164.0, 171.0, 164.0, 169.0], "value": 166.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 69.0, 67.0, 66.0, 68.0, 68.0, 67.0, 67.0, 66.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1540.2, "alertThreshold": 2.0}]} 01:16:55 INFO - Return code: 0 01:16:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:16:56 ERROR - # TBPL SUCCESS # 01:16:56 INFO - Running post-action listener: _resource_record_post_action 01:16:56 INFO - Running post-run listener: _resource_record_post_run 01:16:57 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538738688; Read time: 16; Write time: 620324 01:16:57 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244355072; Read time: 0; Write time: 355160 01:16:57 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294383616; Read time: 16; Write time: 265164 01:16:57 INFO - Running post-run listener: _upload_blobber_files 01:16:57 INFO - Blob upload gear active. 01:16:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:16:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:16:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:16:57 INFO - (blobuploader) - INFO - Open directory for files ... 01:16:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:16:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:16:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:16:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:16:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:16:58 INFO - (blobuploader) - INFO - Done attempting. 01:16:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:16:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:16:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:16:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:16:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:16:59 INFO - (blobuploader) - INFO - Done attempting. 01:16:59 INFO - (blobuploader) - INFO - Iteration through files over. 01:16:59 INFO - Return code: 0 01:16:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:16:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:16:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/af2ceeb037ef3a2eb449a829764a1d75f897b278fa4a9e296060924de811510270652a4b41872f704112c4609f28463e30ed2067d6b78fa31f5c1cce64348659", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9b056ef9538cfdf638f31c322b90beca8033da56ec9b251865bacf4a0d9eb11ce25156417ae6912c50d6b5196fd2c8893329a2e2b77fa3551c9aaf49de409e2b"} 01:16:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:16:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:16:59 INFO - Contents: 01:16:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/af2ceeb037ef3a2eb449a829764a1d75f897b278fa4a9e296060924de811510270652a4b41872f704112c4609f28463e30ed2067d6b78fa31f5c1cce64348659", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9b056ef9538cfdf638f31c322b90beca8033da56ec9b251865bacf4a0d9eb11ce25156417ae6912c50d6b5196fd2c8893329a2e2b77fa3551c9aaf49de409e2b"} 01:16:59 INFO - Running post-run listener: copy_logs_to_upload_dir 01:16:59 INFO - Copying logs to upload dir... 01:16:59 INFO - mkdir: /builds/slave/test/build/upload/logs 01:16:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.869750 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-15 01:16:59.190761) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 01:16:59.194408) ========= 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=62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/af2ceeb037ef3a2eb449a829764a1d75f897b278fa4a9e296060924de811510270652a4b41872f704112c4609f28463e30ed2067d6b78fa31f5c1cce64348659", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9b056ef9538cfdf638f31c322b90beca8033da56ec9b251865bacf4a0d9eb11ce25156417ae6912c50d6b5196fd2c8893329a2e2b77fa3551c9aaf49de409e2b"} build_url:https://queue.taskcluster.net/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011289 build_url: 'https://queue.taskcluster.net/v1/task/UCQLV2-FTtWLns6HiQEn8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/af2ceeb037ef3a2eb449a829764a1d75f897b278fa4a9e296060924de811510270652a4b41872f704112c4609f28463e30ed2067d6b78fa31f5c1cce64348659", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9b056ef9538cfdf638f31c322b90beca8033da56ec9b251865bacf4a0d9eb11ce25156417ae6912c50d6b5196fd2c8893329a2e2b77fa3551c9aaf49de409e2b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 01:16:59.221626) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 01:16:59.221933) ========= 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=62c568580acbfdaac3eec7be000001dc-1460700528.888113-2064815749 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 01:16:59.307817) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 01:16:59.308328) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 01:16:59.308605) ========= ========= Total master_lag: 0.18 =========