builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-032 starttime: 1460712137.82 results: success (0) buildid: 20160415014444 builduid: 53cbf33aba3b4b43a8b31ea0e7abbaf5 revision: d0c2f09a6285ad7a9f25fcb704de38c9c5168369 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:17.815984) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:17.816441) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:17.816729) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:17.833116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:17.833379) ========= 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=745a4373a2a16df560f216e000000264-1460711228.396779-400857299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 02:22:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-04-15 02:22:18 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.341345 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:18.187627) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:18.187944) ========= 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=745a4373a2a16df560f216e000000264-1460711228.396779-400857299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014127 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:18.301071) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 02:22:18.301417) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d0c2f09a6285ad7a9f25fcb704de38c9c5168369 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d0c2f09a6285ad7a9f25fcb704de38c9c5168369 --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=745a4373a2a16df560f216e000000264-1460711228.396779-400857299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 02:22:18,461 truncating revision to first 12 chars 2016-04-15 02:22:18,461 Setting DEBUG logging. 2016-04-15 02:22:18,461 attempt 1/10 2016-04-15 02:22:18,461 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d0c2f09a6285?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 02:22:19,534 unpacking tar archive at: fx-team-d0c2f09a6285/testing/mozharness/ program finished with exit code 0 elapsedTime=1.342901 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 02:22:19.657225) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:19.657533) ========= script_repo_revision: d0c2f09a6285ad7a9f25fcb704de38c9c5168369 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:19.657919) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:19.658206) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:19.666810) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-04-15 02:22:19.667102) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1460711228.396779-400857299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:22:19 INFO - MultiFileLogger online at 20160415 02:22:19 in /builds/slave/test 02:22:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:22:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:22:19 INFO - {'append_to_log': False, 02:22:19 INFO - 'base_work_dir': '/builds/slave/test', 02:22:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:22:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:22:19 INFO - 'branch': 'Fx-Team-Non-PGO', 02:22:19 INFO - 'buildbot_json_path': 'buildprops.json', 02:22:19 INFO - 'config_files': ('talos/linux_config.py',), 02:22:19 INFO - 'default_actions': ('clobber', 02:22:19 INFO - 'read-buildbot-config', 02:22:19 INFO - 'download-and-extract', 02:22:19 INFO - 'populate-webroot', 02:22:19 INFO - 'create-virtualenv', 02:22:19 INFO - 'install', 02:22:19 INFO - 'run-tests'), 02:22:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:22:19 INFO - 'download_minidump_stackwalk': True, 02:22:19 INFO - 'download_symbols': 'ondemand', 02:22:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:22:19 INFO - 'tooltool.py': '/tools/tooltool.py', 02:22:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:22:19 INFO - '/tools/misc-python/virtualenv.py')}, 02:22:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:22:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:22:19 INFO - 'installer_path': 'installer.exe', 02:22:19 INFO - 'log_level': 'info', 02:22:19 INFO - 'log_name': 'talos', 02:22:19 INFO - 'log_to_console': True, 02:22:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:22:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:22:19 INFO - 'opt_config_files': (), 02:22:19 INFO - 'pip_index': False, 02:22:19 INFO - 'sps_profile': False, 02:22:19 INFO - 'sps_profile_interval': 0, 02:22:19 INFO - 'suite': 'dromaeojs', 02:22:19 INFO - 'system_bits': '32', 02:22:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:22:19 INFO - 'title': 'talos-linux64-ix-032', 02:22:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:22:19 INFO - 'use_talos_json': True, 02:22:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:22:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:22:19 INFO - 'work_dir': 'build'} 02:22:19 INFO - ##### 02:22:19 INFO - ##### Running clobber step. 02:22:19 INFO - ##### 02:22:19 INFO - Running pre-action listener: _resource_record_pre_action 02:22:19 INFO - Running main action method: clobber 02:22:19 INFO - rmtree: /builds/slave/test/build 02:22:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:22:20 INFO - Running post-action listener: _resource_record_post_action 02:22:20 INFO - ##### 02:22:20 INFO - ##### Running read-buildbot-config step. 02:22:20 INFO - ##### 02:22:20 INFO - Running pre-action listener: _resource_record_pre_action 02:22:20 INFO - Running main action method: read_buildbot_config 02:22:20 INFO - Using buildbot properties: 02:22:20 INFO - { 02:22:20 INFO - "project": "", 02:22:20 INFO - "product": "firefox", 02:22:20 INFO - "script_repo_revision": "production", 02:22:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:22:20 INFO - "repository": "", 02:22:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:22:20 INFO - "buildid": "20160415014444", 02:22:20 INFO - "pgo_build": "False", 02:22:20 INFO - "basedir": "/builds/slave/test", 02:22:20 INFO - "buildnumber": 2842, 02:22:20 INFO - "slavename": "talos-linux64-ix-032", 02:22:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:22:20 INFO - "platform": "ubuntu64_hw", 02:22:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:22:20 INFO - "branch": "fx-team", 02:22:20 INFO - "repo_path": "integration/fx-team", 02:22:20 INFO - "revision": "d0c2f09a6285ad7a9f25fcb704de38c9c5168369", 02:22:20 INFO - "stage_platform": "linux64", 02:22:20 INFO - "builduid": "53cbf33aba3b4b43a8b31ea0e7abbaf5", 02:22:20 INFO - "slavebuilddir": "test" 02:22:20 INFO - } 02:22:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 02:22:20 INFO - Running post-action listener: _resource_record_post_action 02:22:20 INFO - ##### 02:22:20 INFO - ##### Running download-and-extract step. 02:22:20 INFO - ##### 02:22:20 INFO - Running pre-action listener: _resource_record_pre_action 02:22:20 INFO - Running main action method: download_and_extract 02:22:20 INFO - mkdir: /builds/slave/test/build/tests 02:22:20 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')]} 02:22:20 INFO - https://queue.taskcluster.net/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:22:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:22:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:22:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/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 02:22:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/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 02:22:27 INFO - Downloaded 1361 bytes. 02:22:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:22:27 INFO - Using the following test package requirements: 02:22:27 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:22:27 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:22:27 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:22:27 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:27 INFO - u'jsshell-linux-x86_64.zip'], 02:22:27 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:22:27 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:22:27 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:22:27 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:22:27 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:22:27 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:22:27 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:22:27 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')]} 02:22:27 INFO - https://queue.taskcluster.net/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:22:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:22:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:22:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/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 02:22:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/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 02:22:39 INFO - Downloaded 22202881 bytes. 02:22:39 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'] 02:22:39 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 02:22:40 INFO - Return code: 0 02:22:40 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 02:22:40 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')]} 02:22:40 INFO - https://queue.taskcluster.net/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:22:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:22:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:22:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/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 02:22:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/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 02:22:43 INFO - Downloaded 22202881 bytes. 02:22:43 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'] 02:22:43 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 02:22:44 INFO - Return code: 0 02:22: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')]} 02:22:44 INFO - https://queue.taskcluster.net/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:22:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:22:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:22:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/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 02:22:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/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 02:22:46 INFO - Downloaded 10841076 bytes. 02:22:46 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'] 02:22:46 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 02:22:46 INFO - Return code: 0 02:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:46 INFO - https://queue.taskcluster.net/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:22:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:22:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:22:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/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 02:22:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/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 02:22:47 INFO - Downloaded 54445783 bytes. 02:22:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:22:47 INFO - mkdir: /builds/slave/test/properties 02:22:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:22:47 INFO - Writing to file /builds/slave/test/properties/build_url 02:22:47 INFO - Contents: 02:22:47 INFO - build_url:https://queue.taskcluster.net/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:22:48 INFO - Running post-action listener: _resource_record_post_action 02:22:48 INFO - Running post-action listener: set_extra_try_arguments 02:22:48 INFO - ##### 02:22:48 INFO - ##### Running populate-webroot step. 02:22:48 INFO - ##### 02:22:48 INFO - Running pre-action listener: _resource_record_pre_action 02:22:48 INFO - Running main action method: populate_webroot 02:22:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:22:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:22:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:22:48 INFO - '--tppagecycles', 02:22:48 INFO - '7'], 02:22:48 INFO - 'tests': ['tsvgm']}}, 02:22:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:22:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:22:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:22:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:22:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:22:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:22:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:48 INFO - 'talos_options': ['--disable-e10s'], 02:22:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:22:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:22:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:48 INFO - 'talos_options': ['--disable-e10s'], 02:22:48 INFO - 'tests': ['damp', 'tps']}, 02:22:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:48 INFO - 'tests': ['damp', 'tps']}, 02:22:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:22:48 INFO - 'tests': ['dromaeo_dom']}, 02:22:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:22:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:22:48 INFO - 'tests': ['a11yr', 02:22:48 INFO - 'ts_paint', 02:22:48 INFO - 'tpaint', 02:22:48 INFO - 'sessionrestore', 02:22:48 INFO - 'sessionrestore_no_auto_restore', 02:22:48 INFO - 'tabpaint']}, 02:22:48 INFO - 'other-e10s': {'tests': ['a11yr', 02:22:48 INFO - 'ts_paint', 02:22:48 INFO - 'tpaint', 02:22:48 INFO - 'sessionrestore', 02:22:48 INFO - 'sessionrestore_no_auto_restore', 02:22:48 INFO - 'tabpaint']}, 02:22:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:22:48 INFO - 'ts_paint', 02:22:48 INFO - 'tpaint', 02:22:48 INFO - 'sessionrestore', 02:22:48 INFO - 'sessionrestore_no_auto_restore', 02:22:48 INFO - 'tabpaint']}, 02:22:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:22:48 INFO - 'ts_paint', 02:22:48 INFO - 'tpaint', 02:22:48 INFO - 'sessionrestore', 02:22:48 INFO - 'sessionrestore_no_auto_restore', 02:22:48 INFO - 'tabpaint']}, 02:22:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:22:48 INFO - 'tests': ['a11yr', 02:22:48 INFO - 'ts_paint', 02:22:48 INFO - 'tpaint', 02:22:48 INFO - 'sessionrestore', 02:22:48 INFO - 'sessionrestore_no_auto_restore', 02:22:48 INFO - 'tabpaint']}, 02:22:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:22:48 INFO - 'tests': ['a11yr', 02:22:48 INFO - 'ts_paint', 02:22:48 INFO - 'tpaint', 02:22:48 INFO - 'sessionrestore', 02:22:48 INFO - 'sessionrestore_no_auto_restore', 02:22:48 INFO - 'tabpaint']}, 02:22:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:22:48 INFO - 'tests': ['tsvgx', 02:22:48 INFO - 'tsvgr_opacity', 02:22:48 INFO - 'tart', 02:22:48 INFO - 'tscrollx', 02:22:48 INFO - 'cart']}, 02:22:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:22:48 INFO - 'tsvgr_opacity', 02:22:48 INFO - 'tart', 02:22:48 INFO - 'tscrollx', 02:22:48 INFO - 'cart']}, 02:22:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:48 INFO - 'talos_options': ['--disable-e10s'], 02:22:48 INFO - 'tests': ['tp5o']}, 02:22:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:48 INFO - 'tests': ['tp5o']}, 02:22:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:48 INFO - 'talos_options': ['--disable-e10s', 02:22:48 INFO - '--xperf_path', 02:22:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:22:48 INFO - 'tests': ['tp5n']}, 02:22:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:48 INFO - 'talos_options': ['--xperf_path', 02:22:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:22:48 INFO - 'tests': ['tp5n']}}, 02:22:48 INFO - 'talos.zip': {'path': '', 02:22:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:22:48 INFO - Running post-action listener: _resource_record_post_action 02:22:48 INFO - ##### 02:22:48 INFO - ##### Running create-virtualenv step. 02:22:48 INFO - ##### 02:22:48 INFO - Running pre-action listener: _resource_record_pre_action 02:22:48 INFO - Running main action method: create_virtualenv 02:22:48 INFO - Creating virtualenv /builds/slave/test/build/venv 02:22:48 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 02:22:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:22:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:22:48 INFO - Using real prefix '/usr' 02:22:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:22:49 INFO - Installing distribute.............................................................................................................................................................................................done. 02:22:51 INFO - Installing pip.................done. 02:22:51 INFO - Return code: 0 02:22:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4e008c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12785a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307410>, '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 0x1308310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13087a0>, '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': '745a4373a2a16df560f216e000000264-1460711228.396779-400857299', '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 02:22:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:22:51 INFO - Using env: {'DISPLAY': ':0', 02:22:51 INFO - 'HOME': '/home/cltbld', 02:22:51 INFO - 'LANG': 'en_US.UTF-8', 02:22:51 INFO - 'LANGUAGE': 'en_US:en', 02:22:51 INFO - 'LOGNAME': 'cltbld', 02:22:51 INFO - 'MAIL': '/var/mail/cltbld', 02:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:51 INFO - 'MOZ_NO_REMOTE': '1', 02:22:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:51 INFO - 'NO_EM_RESTART': '1', 02:22:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:51 INFO - 'PWD': '/builds/slave/test', 02:22:51 INFO - 'SHELL': '/bin/bash', 02:22:51 INFO - 'SHLVL': '1', 02:22:51 INFO - 'TERM': 'linux', 02:22:51 INFO - 'TMOUT': '86400', 02:22:51 INFO - 'USER': 'cltbld', 02:22:51 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460711228.396779-400857299', 02:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:51 INFO - '_': '/tools/buildbot/bin/python'} 02:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:51 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 02:22:51 INFO - Cleaning up... 02:22:51 INFO - Return code: 0 02:22:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4e008c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12785a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307410>, '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 0x1308310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13087a0>, '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': '745a4373a2a16df560f216e000000264-1460711228.396779-400857299', '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 02:22:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:22:51 INFO - Using env: {'DISPLAY': ':0', 02:22:51 INFO - 'HOME': '/home/cltbld', 02:22:51 INFO - 'LANG': 'en_US.UTF-8', 02:22:51 INFO - 'LANGUAGE': 'en_US:en', 02:22:51 INFO - 'LOGNAME': 'cltbld', 02:22:51 INFO - 'MAIL': '/var/mail/cltbld', 02:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:51 INFO - 'MOZ_NO_REMOTE': '1', 02:22:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:51 INFO - 'NO_EM_RESTART': '1', 02:22:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:51 INFO - 'PWD': '/builds/slave/test', 02:22:51 INFO - 'SHELL': '/bin/bash', 02:22:51 INFO - 'SHLVL': '1', 02:22:51 INFO - 'TERM': 'linux', 02:22:51 INFO - 'TMOUT': '86400', 02:22:51 INFO - 'USER': 'cltbld', 02:22:51 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460711228.396779-400857299', 02:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:51 INFO - '_': '/tools/buildbot/bin/python'} 02:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:51 INFO - Downloading/unpacking psutil>=0.7.1 02:22: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 02:22: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 02:22: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 02:22: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 02:22: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 02:22: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 02:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:22:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:22:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:22:53 INFO - Installing collected packages: psutil 02:22:53 INFO - Running setup.py install for psutil 02:22:53 INFO - building 'psutil._psutil_linux' extension 02:22:53 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 02:22:53 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 02:22:54 INFO - building 'psutil._psutil_posix' extension 02:22:54 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 02:22:54 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 02:22:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:22:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:22:54 INFO - Successfully installed psutil 02:22:54 INFO - Cleaning up... 02:22:54 INFO - Return code: 0 02:22:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4e008c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12785a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307410>, '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 0x1308310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13087a0>, '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': '745a4373a2a16df560f216e000000264-1460711228.396779-400857299', '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 02:22:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:22:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:22:54 INFO - Using env: {'DISPLAY': ':0', 02:22:54 INFO - 'HOME': '/home/cltbld', 02:22:54 INFO - 'LANG': 'en_US.UTF-8', 02:22:54 INFO - 'LANGUAGE': 'en_US:en', 02:22:54 INFO - 'LOGNAME': 'cltbld', 02:22:54 INFO - 'MAIL': '/var/mail/cltbld', 02:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:54 INFO - 'MOZ_NO_REMOTE': '1', 02:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:54 INFO - 'NO_EM_RESTART': '1', 02:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:54 INFO - 'PWD': '/builds/slave/test', 02:22:54 INFO - 'SHELL': '/bin/bash', 02:22:54 INFO - 'SHLVL': '1', 02:22:54 INFO - 'TERM': 'linux', 02:22:54 INFO - 'TMOUT': '86400', 02:22:54 INFO - 'USER': 'cltbld', 02:22:54 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460711228.396779-400857299', 02:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:54 INFO - '_': '/tools/buildbot/bin/python'} 02:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:22:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:22:56 INFO - Installing collected packages: mozsystemmonitor 02:22:56 INFO - Running setup.py install for mozsystemmonitor 02:22:56 INFO - Successfully installed mozsystemmonitor 02:22:56 INFO - Cleaning up... 02:22:56 INFO - Return code: 0 02:22:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:22: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')]} 02:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22: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')]} 02:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:56 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 0x7f4e008c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12785a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307410>, '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 0x1308310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13087a0>, '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': '745a4373a2a16df560f216e000000264-1460711228.396779-400857299', '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 02:22:56 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 02:22:56 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 02:22:56 INFO - Using env: {'DISPLAY': ':0', 02:22:56 INFO - 'HOME': '/home/cltbld', 02:22:56 INFO - 'LANG': 'en_US.UTF-8', 02:22:56 INFO - 'LANGUAGE': 'en_US:en', 02:22:56 INFO - 'LOGNAME': 'cltbld', 02:22:56 INFO - 'MAIL': '/var/mail/cltbld', 02:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:56 INFO - 'MOZ_NO_REMOTE': '1', 02:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:56 INFO - 'NO_EM_RESTART': '1', 02:22:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:56 INFO - 'PWD': '/builds/slave/test', 02:22:56 INFO - 'SHELL': '/bin/bash', 02:22:56 INFO - 'SHLVL': '1', 02:22:56 INFO - 'TERM': 'linux', 02:22:56 INFO - 'TMOUT': '86400', 02:22:56 INFO - 'USER': 'cltbld', 02:22:56 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460711228.396779-400857299', 02:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:56 INFO - '_': '/tools/buildbot/bin/python'} 02:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:56 INFO - Downloading/unpacking blobuploader==1.2.4 02:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:58 INFO - Downloading blobuploader-1.2.4.tar.gz 02:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:22:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:22:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:22:59 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 02:22:59 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 02:22:59 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 02:22:59 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 02:22:59 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 02:22:59 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 02:22:59 INFO - Downloading docopt-0.6.1.tar.gz 02:22:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:22:59 INFO - Installing collected packages: blobuploader, requests, docopt 02:22:59 INFO - Running setup.py install for blobuploader 02:22:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:22:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:22:59 INFO - Running setup.py install for requests 02:22:59 INFO - Running setup.py install for docopt 02:22:59 INFO - Successfully installed blobuploader requests docopt 02:22:59 INFO - Cleaning up... 02:23:00 INFO - Return code: 0 02:23:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:23: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')]} 02:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23: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')]} 02:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:00 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 0x7f4e008c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12785a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307410>, '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 0x1308310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13087a0>, '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': '745a4373a2a16df560f216e000000264-1460711228.396779-400857299', '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 02:23:00 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 02:23:00 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 02:23:00 INFO - Using env: {'DISPLAY': ':0', 02:23:00 INFO - 'HOME': '/home/cltbld', 02:23:00 INFO - 'LANG': 'en_US.UTF-8', 02:23:00 INFO - 'LANGUAGE': 'en_US:en', 02:23:00 INFO - 'LOGNAME': 'cltbld', 02:23:00 INFO - 'MAIL': '/var/mail/cltbld', 02:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:00 INFO - 'MOZ_NO_REMOTE': '1', 02:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:00 INFO - 'NO_EM_RESTART': '1', 02:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:00 INFO - 'PWD': '/builds/slave/test', 02:23:00 INFO - 'SHELL': '/bin/bash', 02:23:00 INFO - 'SHLVL': '1', 02:23:00 INFO - 'TERM': 'linux', 02:23:00 INFO - 'TMOUT': '86400', 02:23:00 INFO - 'USER': 'cltbld', 02:23:00 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460711228.396779-400857299', 02:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:00 INFO - '_': '/tools/buildbot/bin/python'} 02:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:23:00 INFO - Running setup.py (path:/tmp/pip-YLRWfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:23:00 INFO - Running setup.py (path:/tmp/pip-vU6739-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:23:00 INFO - Running setup.py (path:/tmp/pip-9QKV_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:23:00 INFO - Running setup.py (path:/tmp/pip-gwJ7J6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:23:00 INFO - Running setup.py (path:/tmp/pip-6GtKaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:23:00 INFO - Running setup.py (path:/tmp/pip-YkRSBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:23:00 INFO - Running setup.py (path:/tmp/pip-4nF6lZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:23:00 INFO - Running setup.py (path:/tmp/pip-tfOodG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:23:00 INFO - Running setup.py (path:/tmp/pip-dZELPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:23:00 INFO - Running setup.py (path:/tmp/pip-uU9XVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:23:00 INFO - Running setup.py (path:/tmp/pip-eYNpmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:23:01 INFO - Running setup.py (path:/tmp/pip-uH55Ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:23:01 INFO - Running setup.py (path:/tmp/pip-BvhU4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:23:01 INFO - Running setup.py (path:/tmp/pip-04bjcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:23:01 INFO - Running setup.py (path:/tmp/pip-kcDx2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:23:01 INFO - Running setup.py (path:/tmp/pip-nZ_HW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:23:01 INFO - Running setup.py (path:/tmp/pip-SyLogP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:23:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:23:01 INFO - Running setup.py install for manifestparser 02:23:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:23:01 INFO - Running setup.py install for mozcrash 02:23:01 INFO - Running setup.py install for mozdebug 02:23:01 INFO - Running setup.py install for mozdevice 02:23:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:23:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:23:01 INFO - Running setup.py install for mozfile 02:23:01 INFO - Running setup.py install for mozhttpd 02:23:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:23:02 INFO - Running setup.py install for mozinfo 02:23:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:23:02 INFO - Running setup.py install for mozInstall 02:23:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:23:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:23:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:23:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:23:02 INFO - Running setup.py install for mozleak 02:23:02 INFO - Running setup.py install for mozlog 02:23:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:23:02 INFO - Running setup.py install for moznetwork 02:23:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:23:02 INFO - Running setup.py install for mozprocess 02:23:02 INFO - Running setup.py install for mozprofile 02:23:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:23:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:23:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:23:02 INFO - Running setup.py install for mozrunner 02:23:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:23:02 INFO - Running setup.py install for mozscreenshot 02:23:03 INFO - Running setup.py install for moztest 02:23:03 INFO - Running setup.py install for mozversion 02:23:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:23:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:23:03 INFO - Cleaning up... 02:23:03 INFO - Return code: 0 02:23:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:23:03 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')]} 02:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:03 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')]} 02:23:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:03 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 0x7f4e008c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12785a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307410>, '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 0x1308310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13087a0>, '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': '745a4373a2a16df560f216e000000264-1460711228.396779-400857299', '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 02:23:03 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 02:23:03 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 02:23:03 INFO - Using env: {'DISPLAY': ':0', 02:23:03 INFO - 'HOME': '/home/cltbld', 02:23:03 INFO - 'LANG': 'en_US.UTF-8', 02:23:03 INFO - 'LANGUAGE': 'en_US:en', 02:23:03 INFO - 'LOGNAME': 'cltbld', 02:23:03 INFO - 'MAIL': '/var/mail/cltbld', 02:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:03 INFO - 'MOZ_NO_REMOTE': '1', 02:23:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:03 INFO - 'NO_EM_RESTART': '1', 02:23:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:03 INFO - 'PWD': '/builds/slave/test', 02:23:03 INFO - 'SHELL': '/bin/bash', 02:23:03 INFO - 'SHLVL': '1', 02:23:03 INFO - 'TERM': 'linux', 02:23:03 INFO - 'TMOUT': '86400', 02:23:03 INFO - 'USER': 'cltbld', 02:23:03 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460711228.396779-400857299', 02:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:03 INFO - '_': '/tools/buildbot/bin/python'} 02:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:23:03 INFO - Running setup.py (path:/tmp/pip-p5yXPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:23:03 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)) 02:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:23:03 INFO - Running setup.py (path:/tmp/pip-vCQcbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:23:03 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)) 02:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:23:03 INFO - Running setup.py (path:/tmp/pip-NvRZnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:23:03 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)) 02:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:23:03 INFO - Running setup.py (path:/tmp/pip-MRPLjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:23:03 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)) 02:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:23:03 INFO - Running setup.py (path:/tmp/pip-yXQNHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:23:03 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)) 02:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:23:03 INFO - Running setup.py (path:/tmp/pip-gQse7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:23:03 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)) 02:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:23:03 INFO - Running setup.py (path:/tmp/pip-Tf_LL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:23:03 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)) 02:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:23:03 INFO - Running setup.py (path:/tmp/pip-cvs616-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:23:04 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)) 02:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:23:04 INFO - Running setup.py (path:/tmp/pip-G3v0Jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:23:04 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)) 02:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:23:04 INFO - Running setup.py (path:/tmp/pip-lm55MV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:23:04 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)) 02:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:23:04 INFO - Running setup.py (path:/tmp/pip-m0Y3JH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:23:04 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)) 02:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:23:04 INFO - Running setup.py (path:/tmp/pip-F41vZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:23:04 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)) 02:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:23:04 INFO - Running setup.py (path:/tmp/pip-j6AJhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:23:04 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)) 02:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:23:04 INFO - Running setup.py (path:/tmp/pip-Pd9xFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:23:04 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)) 02:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:23:04 INFO - Running setup.py (path:/tmp/pip-v8GEQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:23:04 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)) 02:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:23:04 INFO - Running setup.py (path:/tmp/pip-ROOyFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:23:04 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)) 02:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:23:04 INFO - Running setup.py (path:/tmp/pip-iLJmjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:23:04 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)) 02:23:04 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)) 02:23:04 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)) 02:23:04 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)) 02:23:04 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)) 02:23:04 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)) 02:23:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:23: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 02:23: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 02:23: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 02:23: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 02:23: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 02:23: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 02:23:06 INFO - Downloading blessings-1.6.tar.gz 02:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:23:06 INFO - Installing collected packages: blessings 02:23:06 INFO - Running setup.py install for blessings 02:23:06 INFO - Successfully installed blessings 02:23:06 INFO - Cleaning up... 02:23:06 INFO - Return code: 0 02:23:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:23:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:23:07 INFO - Reading from file tmpfile_stdout 02:23:07 INFO - Current package versions: 02:23:07 INFO - argparse == 1.2.1 02:23:07 INFO - blessings == 1.6 02:23:07 INFO - blobuploader == 1.2.4 02:23:07 INFO - docopt == 0.6.1 02:23:07 INFO - manifestparser == 1.1 02:23:07 INFO - mozInstall == 1.12 02:23:07 INFO - mozcrash == 0.17 02:23:07 INFO - mozdebug == 0.1 02:23:07 INFO - mozdevice == 0.48 02:23:07 INFO - mozfile == 1.2 02:23:07 INFO - mozhttpd == 0.7 02:23:07 INFO - mozinfo == 0.9 02:23:07 INFO - mozleak == 0.1 02:23:07 INFO - mozlog == 3.1 02:23:07 INFO - moznetwork == 0.27 02:23:07 INFO - mozprocess == 0.22 02:23:07 INFO - mozprofile == 0.28 02:23:07 INFO - mozrunner == 6.11 02:23:07 INFO - mozscreenshot == 0.1 02:23:07 INFO - mozsystemmonitor == 0.0 02:23:07 INFO - moztest == 0.7 02:23:07 INFO - mozversion == 1.4 02:23:07 INFO - psutil == 3.1.1 02:23:07 INFO - requests == 1.2.3 02:23:07 INFO - wsgiref == 0.1.2 02:23:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:07 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 0x7f4e008c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12785a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307410>, '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 0x1308310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13087a0>, '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': '745a4373a2a16df560f216e000000264-1460711228.396779-400857299', '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 02:23:07 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 02:23:07 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 02:23:07 INFO - Using env: {'DISPLAY': ':0', 02:23:07 INFO - 'HOME': '/home/cltbld', 02:23:07 INFO - 'LANG': 'en_US.UTF-8', 02:23:07 INFO - 'LANGUAGE': 'en_US:en', 02:23:07 INFO - 'LOGNAME': 'cltbld', 02:23:07 INFO - 'MAIL': '/var/mail/cltbld', 02:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:07 INFO - 'MOZ_NO_REMOTE': '1', 02:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:07 INFO - 'NO_EM_RESTART': '1', 02:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:07 INFO - 'PWD': '/builds/slave/test', 02:23:07 INFO - 'SHELL': '/bin/bash', 02:23:07 INFO - 'SHLVL': '1', 02:23:07 INFO - 'TERM': 'linux', 02:23:07 INFO - 'TMOUT': '86400', 02:23:07 INFO - 'USER': 'cltbld', 02:23:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460711228.396779-400857299', 02:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:07 INFO - '_': '/tools/buildbot/bin/python'} 02:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:07 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)) 02:23:07 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)) 02:23:07 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)) 02:23:07 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)) 02:23:07 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)) 02:23:07 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)) 02:23:07 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)) 02:23:07 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)) 02:23:07 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)) 02:23:07 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)) 02:23:07 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)) 02:23:07 INFO - Cleaning up... 02:23:07 INFO - Return code: 0 02:23:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4e008c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12785a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307410>, '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 0x1308310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13087a0>, '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': '745a4373a2a16df560f216e000000264-1460711228.396779-400857299', '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 02:23:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:23:07 INFO - Using env: {'DISPLAY': ':0', 02:23:07 INFO - 'HOME': '/home/cltbld', 02:23:07 INFO - 'LANG': 'en_US.UTF-8', 02:23:07 INFO - 'LANGUAGE': 'en_US:en', 02:23:07 INFO - 'LOGNAME': 'cltbld', 02:23:07 INFO - 'MAIL': '/var/mail/cltbld', 02:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:07 INFO - 'MOZ_NO_REMOTE': '1', 02:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:07 INFO - 'NO_EM_RESTART': '1', 02:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:07 INFO - 'PWD': '/builds/slave/test', 02:23:07 INFO - 'SHELL': '/bin/bash', 02:23:07 INFO - 'SHLVL': '1', 02:23:07 INFO - 'TERM': 'linux', 02:23:07 INFO - 'TMOUT': '86400', 02:23:07 INFO - 'USER': 'cltbld', 02:23:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460711228.396779-400857299', 02:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:07 INFO - '_': '/tools/buildbot/bin/python'} 02:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:07 INFO - Downloading/unpacking jsonschema 02:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:23:09 INFO - Downloading/unpacking functools32 (from jsonschema) 02:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:09 INFO - Downloading functools32-3.2.3-2.tar.gz 02:23:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:23:09 INFO - warning: no files found matching '*.txt' 02:23:09 INFO - no previously-included directories found matching 'build' 02:23:09 INFO - no previously-included directories found matching 'dist' 02:23:09 INFO - no previously-included directories found matching '.git*' 02:23:09 INFO - Installing collected packages: jsonschema, functools32 02:23:09 INFO - Running setup.py install for functools32 02:23:09 INFO - warning: no files found matching '*.txt' 02:23:09 INFO - no previously-included directories found matching 'build' 02:23:09 INFO - no previously-included directories found matching 'dist' 02:23:09 INFO - no previously-included directories found matching '.git*' 02:23:09 INFO - Successfully installed jsonschema functools32 02:23:09 INFO - Cleaning up... 02:23:09 INFO - Return code: 0 02:23:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:09 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 0x7f4e008c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12785a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1307410>, '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 0x1308310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13087a0>, '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': '745a4373a2a16df560f216e000000264-1460711228.396779-400857299', '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 02:23:09 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 02:23:09 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 02:23:09 INFO - Using env: {'DISPLAY': ':0', 02:23:09 INFO - 'HOME': '/home/cltbld', 02:23:09 INFO - 'LANG': 'en_US.UTF-8', 02:23:09 INFO - 'LANGUAGE': 'en_US:en', 02:23:09 INFO - 'LOGNAME': 'cltbld', 02:23:09 INFO - 'MAIL': '/var/mail/cltbld', 02:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:09 INFO - 'MOZ_NO_REMOTE': '1', 02:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:09 INFO - 'NO_EM_RESTART': '1', 02:23:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:09 INFO - 'PWD': '/builds/slave/test', 02:23:09 INFO - 'SHELL': '/bin/bash', 02:23:09 INFO - 'SHLVL': '1', 02:23:09 INFO - 'TERM': 'linux', 02:23:09 INFO - 'TMOUT': '86400', 02:23:09 INFO - 'USER': 'cltbld', 02:23:09 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460711228.396779-400857299', 02:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:09 INFO - '_': '/tools/buildbot/bin/python'} 02:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:10 INFO - Downloading/unpacking flake8 02:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:23:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:23:11 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 02:23:11 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 02:23:11 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 02:23:11 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 02:23:11 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 02:23:11 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 02:23:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:23:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:23:12 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 02:23:12 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 02:23:12 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 02:23:12 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 02:23:12 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 02:23:12 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 02:23:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:23:12 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 02:23:12 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 02:23:12 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 02:23:12 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 02:23:12 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 02:23:12 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 02:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:23:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:23:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:23:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:23:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:23:12 INFO - no previously-included directories found matching 'docs/_build' 02:23:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:23:12 INFO - Running setup.py install for pep8 02:23:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:23:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:23:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:23:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:23:12 INFO - no previously-included directories found matching 'docs/_build' 02:23:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:23:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:23:12 INFO - Cleaning up... 02:23:12 INFO - Return code: 0 02:23:12 INFO - Running post-action listener: _resource_record_post_action 02:23:12 INFO - Running post-action listener: _start_resource_monitoring 02:23:12 INFO - Starting resource monitoring. 02:23:12 INFO - ##### 02:23:12 INFO - ##### Running install step. 02:23:12 INFO - ##### 02:23:12 INFO - Running pre-action listener: _resource_record_pre_action 02:23:12 INFO - Running main action method: install 02:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:23:13 INFO - Reading from file tmpfile_stdout 02:23:13 INFO - Detecting whether we're running mozinstall >=1.0... 02:23:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:23:13 INFO - Reading from file tmpfile_stdout 02:23:13 INFO - Output received: 02:23:13 INFO - Usage: mozinstall [options] installer 02:23:13 INFO - Options: 02:23:13 INFO - -h, --help show this help message and exit 02:23:13 INFO - -d DEST, --destination=DEST 02:23:13 INFO - Directory to install application into. [default: 02:23:13 INFO - "/builds/slave/test"] 02:23:13 INFO - --app=APP Application being installed. [default: firefox] 02:23:13 INFO - mkdir: /builds/slave/test/build/application 02:23:13 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'] 02:23:13 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 02:23:28 INFO - Reading from file tmpfile_stdout 02:23:28 INFO - Output received: 02:23:28 INFO - /builds/slave/test/build/application/firefox/firefox 02:23:28 INFO - Running post-action listener: _resource_record_post_action 02:23:28 INFO - ##### 02:23:28 INFO - ##### Running run-tests step. 02:23:28 INFO - ##### 02:23:28 INFO - Running pre-action listener: _resource_record_pre_action 02:23:28 INFO - Running main action method: run_tests 02:23:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:23:28 INFO - Python 2.7.3 02:23:28 INFO - Return code: 0 02:23:28 INFO - grabbing minidump binary from tooltool 02:23:28 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')]} 02:23:28 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 0x1307410>, '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 0x1308310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13087a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:23:28 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 02:23:28 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 02:23:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:23:28 INFO - Return code: 0 02:23:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:23:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:23:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:23:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:23:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:23:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:23:29 INFO - Return code: 0 02:23:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 02:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 02:23:29 INFO - Using env: {'DISPLAY': ':0', 02:23:29 INFO - 'HOME': '/home/cltbld', 02:23:29 INFO - 'LANG': 'en_US.UTF-8', 02:23:29 INFO - 'LANGUAGE': 'en_US:en', 02:23:29 INFO - 'LOGNAME': 'cltbld', 02:23:29 INFO - 'MAIL': '/var/mail/cltbld', 02:23:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:23:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:29 INFO - 'MOZ_NO_REMOTE': '1', 02:23:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:29 INFO - 'NO_EM_RESTART': '1', 02:23:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:29 INFO - 'PWD': '/builds/slave/test', 02:23:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:23:29 INFO - 'SHELL': '/bin/bash', 02:23:29 INFO - 'SHLVL': '1', 02:23:29 INFO - 'TERM': 'linux', 02:23:29 INFO - 'TMOUT': '86400', 02:23:29 INFO - 'USER': 'cltbld', 02:23:29 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460711228.396779-400857299', 02:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:29 INFO - '_': '/tools/buildbot/bin/python'} 02:23:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 02:23:30 INFO - mozversion application_buildid: 20160415014444 02:23:30 INFO - mozversion application_changeset: d0c2f09a6285ad7a9f25fcb704de38c9c5168369 02:23:30 INFO - mozversion application_display_name: Nightly 02:23:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:23:30 INFO - mozversion application_name: Firefox 02:23:30 INFO - mozversion application_remotingname: firefox 02:23:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:23:30 INFO - mozversion application_vendor: Mozilla 02:23:30 INFO - mozversion application_version: 48.0a1 02:23:30 INFO - mozversion platform_buildid: 20160415014444 02:23:30 INFO - mozversion platform_changeset: d0c2f09a6285ad7a9f25fcb704de38c9c5168369 02:23:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:23:30 INFO - mozversion platform_version: 48.0a1 02:23:30 INFO - using testdate: 1460712210 02:23:30 INFO - actual date: 1460712210 02:23:30 INFO - starting webserver on 'localhost:39364' 02:23:30 INFO - SUITE-START | Running 2 tests 02:23:30 INFO - TEST-START | dromaeo_css 02:23:30 INFO - operating with platform_type : linux_ 02:23:30 INFO - Initialising browser for dromaeo_css test... 02:23:30 INFO - TEST-INFO | started process 5085 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV4U6Al/profile http://localhost:39364/getInfo.html) 02:23:35 INFO - PROCESS | 5085 | __metrics Screen width/height:1600/1200 02:23:35 INFO - PROCESS | 5085 | colorDepth:24 02:23:35 INFO - PROCESS | 5085 | Browser inner width/height: 1024/697 02:23:35 INFO - PROCESS | 5085 | __metrics 02:23:37 ERROR - PROCESS | 5085 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:23:38 INFO - TEST-INFO | 5085: exit 0 02:23:38 INFO - Browser initialized. 02:23:38 INFO - Running cycle 1/1 for dromaeo_css test... 02:23:38 INFO - TEST-INFO | started process 5165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV4U6Al/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:23:50 INFO - PROCESS | 5165 | RSS: Main: 154947584 02:23:50 INFO - PROCESS | 5165 | 02:24:41 INFO - PROCESS | 5165 | 1460712281943 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] 02:26:53 INFO - PROCESS | 5165 | Cycle 1(1): loaded http://localhost:39364/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39364/tests/dromaeo/cssquery-ext.html) 02:26:54 INFO - PROCESS | 5165 | RSS: Main: 263680000 02:26:54 INFO - PROCESS | 5165 | 02:29:57 INFO - PROCESS | 5165 | Cycle 1(1): loaded http://localhost:39364/tests/dromaeo/cssquery-ext.html (next: http://localhost:39364/tests/dromaeo/cssquery-jquery.html) 02:29:57 INFO - PROCESS | 5165 | RSS: Main: 238133248 02:29:57 INFO - PROCESS | 5165 | 02:32:59 INFO - PROCESS | 5165 | Cycle 1(1): loaded http://localhost:39364/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39364/tests/dromaeo/cssquery-mootools.html) 02:33:00 INFO - PROCESS | 5165 | RSS: Main: 240517120 02:33:00 INFO - PROCESS | 5165 | 02:36:02 INFO - PROCESS | 5165 | Cycle 1(1): loaded http://localhost:39364/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39364/tests/dromaeo/cssquery-prototype.html) 02:36:03 INFO - PROCESS | 5165 | RSS: Main: 237101056 02:36:03 INFO - PROCESS | 5165 | 02:39:06 INFO - PROCESS | 5165 | Cycle 1(1): loaded http://localhost:39364/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39364/tests/dromaeo/cssquery-yui.html) 02:39:06 INFO - PROCESS | 5165 | RSS: Main: 214286336 02:39:06 INFO - PROCESS | 5165 | 02:42:09 INFO - PROCESS | 5165 | Cycle 1(1): loaded http://localhost:39364/tests/dromaeo/cssquery-yui.html (next: http://localhost:39364/tests/dromaeo/cssquery-dojo.html) 02:42:09 INFO - PROCESS | 5165 | RSS: Main: 282062848 02:42:09 INFO - PROCESS | 5165 | 02:42:09 INFO - PROCESS | 5165 | __start_tp_report 02:42:09 INFO - PROCESS | 5165 | _x_x_mozilla_page_load 02:42:09 INFO - PROCESS | 5165 | _x_x_mozilla_page_load_details 02:42:09 INFO - PROCESS | 5165 | |i|pagename|runs| 02:42:09 INFO - PROCESS | 5165 | |0;dojo.html;2601.778848797852;2667.799915006375;2679.5846643770224;2684.9463010739773;2704.756571908528;4588;4598.70108442951;4604.815807367705;4615.446146462429;4637.791299391527;4685.7188568685815;4740.881477963044;4749.145153872301;4787.6169906407495;4788.425388953322;4274.893127671818;4284.250256205167;4285.571442855705;4341.565843415665;4462.085272519142;4392.560743925614;4415.381846541487;4429.800658970354;4448.822047118111;4457.910841783162;4282.336237883133;4305.913881722379;4351.042770590465;4361;4392.165488557196;4320.654347652212;4340.175366680321;4347.413099231595;4352.455943007124;4394.2529769938865;4239.618434340893;4252;4261.786910654486;4265.97867010663;4298.398224248576;4475.977620111911;4556.430446194226;4567.474740404863;4632.328312394718;4658.813647454098;4999.3000979862845;5012.77442515084;5017.49825017499;5019.64862459628;5051.671641343338;4995.475475075101;5030.597552195815;5034.773435195425;5036.622253331015;5076.213186956028;4540.84107056258;4639.930401043987;4669.603083737887;4718.386609740781;4725.432948046257;5098.668586541863;5125.109745390658;5126.79492820283;5126.794928202905;5181;4913.263010548446;4916.70499770015;4916.70499770015;4920.778564964585;4966.503349665005;4817.710937343771;4922;4925.679830810986;4926.236433352836;4989.80040798364;4980.90038199234;5024.0956627807345;5033.47148549397;5034.723090229999;5082.339295891585;5011.4236862761245;5022.2466630005065;5023.120953833138;5023.196288593807;5085.110105731482;4187.036981494273;4190.266703326905;4238.470191226097;4255.361695745601;4258.382534532476;3692.7045836333027;3705.5182826232417;3707.925841483155;3737.831797569116;3741.663250307431;4381.123775244963;4386.583274588909;4389.231884420214;4416.889577760582;4432.911341773147;4928;5029.06962211992;5030.522100400456;5046.924296135561;5114.897702045938;4359.433273674402;4376.234159022159;4386.890327741832;4387.473503179575;4427.535108813592;4496.168208881368;4508.909821803545;4509.030558429953;4530.22986092365;4557.977210113928;4636.9536304637195;4730.503297153749;4741.928871066937;4811.7834697438;4814.6870453420415;5020.523050310361;5023.397192336943;5046.268291097844;5048.091343558195;5143.7428128594165;4773.09311230865;4791.137595232892;4802.807887684454;4810.783514741775;4856.320115183948;4802.255650374198;4919.975400122977;4981.551660350586;4996.875078123076;5028.1954887219335;5034.924476132935;5040.974795126001;5060;5060.114479966065;5109.8722531937;4773.785179666993;4906.901861962812;4920.8769780755765;4925.236588328815;4969.155243608668;4848.927266090941;4883.316335712932;4902.289168070681;4935.777889994887;4953.628477864247;4834.758262086952;4835.178019736723;4845.152098382699;4846.200376937766;4890.804367825247;4718.103560323528;4882.194437917704;4928.186849169847;4944.678595891256;4993.151164302005;4785.114753770564;4796.992631547414;4811.230203167476;4833.540813622701;4862.440819305825 02:42:09 INFO - PROCESS | 5165 | |1;ext.html;564.3566334378809;597.2057163971916;605.1920685884342;615.9476444502219;617.7312868902026;26125.346866328327;26657.200283991464;26746.465070698574;26846.32884177894;33230.8338458308;33737;34664.480032799525;34730.13174670634;34735.13162170947;36751.4487282691;7678.539287642745;7883.526988380687;7887.645055972466;7895.131535531115;7910.169432209622;7364.33720965113;7700.11448683403;7856.9607151964165;9874;10258.384496930208;9819.607215711363;9934.056264654846;9934.155596774282;9938;9945.453000084992;9723.659671911484;9848.950755246215;9850.064243896819;9860.408375497493;9861.211103111735;9732.90267097334;9847.704568862946;9848.35985660937;9850.310478266525;9865.654702085392;36970.260594788226;37503.624963750284;37511;37544.81227593844;37552.81223593865;3024.259056531164;3036.878524859003;3042.9391412171854;3043.269615292336;3134.514150306706;25773.35566610831;28611.42777144466;28795.28011799701;29027.274318142005;29920.102396928127;3293.143782616513;3410.183713432942;3482.7387945903906;3487.930241395183;3577.6422357764277;167599;169077;169181;169352;169432;47469.28796068062;47684.7615761919;47792.522074778804;48010.75994620074;48012.279815802794;49744.25383619249;50123.49876501261;50161.74919125381;50166;50274.74862625664;13670.794938075936;14456.20490873012;14462;14463.85536144625;14483.203423811581;9942;11388.601398950997;11499.885001149882;11511.884881151249;11543.653690389301;17834.37579684705;18214.27142914295;18327.633447331245;18375;18433.26266949334;6571.967140164268;6688.197416309977;6694.564853284521;6936.930630693629;7015.543989640657;887.494128346849;977.9902200977899;981.8723565936525;996.8604395384652;998.1565577087349;25162;26876.59685104725;27031.594526082125;28154;28665;1007.2495990487134;1059.9629012984662;1076.2143635146388;1104.9447527623747;1130.1806190511813;14482.565523034325;14677.633059173606;14753.483628072965;14895.329710163069;15086.773698394532;323591;328656;329595;329659;331285;47519.76240118777;48354.75822620864;48413.75793121082;48419.27371089436;48517.75741121272;1115.3140818396628;1260.6344160193626;1261.0857128581704;1287;1315.5066849931275;24301.878490607432;25092;26169.869150654125;26226.344341390854;26638.7336126644;38618;38959.6104038956;38990.4151437723;39184.608153918096;39202.2159556813;219726;220560;220735;221323;221403;22100;24485.51028979446;25339.6199057018;25460;25568.23295301144;38336.42495362627;38638.80680596579;38966.80516597399;39189.41215881821;39649;33005;33435.16412089717;33487.49768753422;33603.32793344168;33881;33431.66568334286;33617;33620;33767.83116084404;33843.830780845936;32676.34647307088;33560;33671.663283366855;33954.49068263928;33977;29438.11685649434;29754.55368169436;29887.55168672515;30227.697723022487;30366;23388.877337847924;23721.762782372647;23852.761472385748;23859.403514911573;23883.761162388153 02:42:09 INFO - PROCESS | 5165 | |2;jquery.html;372.6348178784791;374.1656106881654;395.47796908081347;395.7803419102397;410.0323237160299;15328.61678458039;16176.514704558853;16884.32462701492;16906.915465422688;16918.5770355741;16740.748888766677;16801;17015.234314455847;17216.741748873777;17315.826841731578;5159.22611608258;5292.655977361478;5330.680159190461;5340.25236466895;5346.198070289449;3638.108663377476;5683.772649094031;6031.215941927543;6037.7584896604085;6046.54650901182;4848.296996935443;5965.135055416962;5969.22400087988;5995.370486098962;5999.6700181490005;5084.51697088776;5135.563477104451;5150.510701483353;5163.328767260251;5165.4834516548235;3393.8303084845907;3568.375534281516;3658.743887927846;5248.921266181011;5253.842384728426;11965.760684786343;12113.39433028345;12222.938885305517;14361.856381436157;20522.692159617618;1811.7101263797729;1946.4939115829845;1962.4014675523958;1969.7734760502583;2249.5275992041693;8560.785980350478;8883;9296.209822165125;9307.06929307064;9319.673811416636;1647.785787847584;1732.1512458895177;1734.384293575775;1739.6868563658536;1749.4751574527718;68176.31823681798;72062.27937720608;73019.63490182569;74840;81615;15422.768658470131;15816.52550423489;15839.604009899615;16065.277062532214;16220.513384598245;29756.702432975395;29832.552511712343;30005.24986875302;30135.69864301373;30138.095857123884;8703.521306328214;8761.386702930733;8812.603432845537;8829.823403531893;8903.465792052497;6984.79045628632;7244.203137654854;7310.853782924311;7453.590052547053;7516.586587737617;8367.163283671583;8373.790655233668;8378.287845533076;8392;8476.533790641573;2840.815347002438;3346.6987971082717;3429.6548506536715;3444.9655503445147;3495.528103706018;813.6094674556247;898.1871406377239;937.2736129499692;943.1370296178919;976.7558110472382;16123.193840308173;16469.505914822574;16954.576135596708;17035.659286814196;17206.483805485856;844.1221130024828;846.3060290561804;878.2754227762122;890.2521881619471;923.5890028937193;8966.910330896739;9433.292503062297;9441.433513989183;9459.432434053979;9551.90448095524;245944;370732;373307;374794;378090;78691.21308786953;78760;79542.6022869882;79652;79850.20149798544;900.8063266397756;903;916.1937495004487;924.4499522783933;932.4032619123631;14862.331195096463;14906.403743850558;14965.476208332657;14965.625859353604;15156.924215378853;34135.82932085423;34240.315193696486;34629.30741385108;35232.11919702028;35892;44707.776461117486;49916.75041624768;50076.499235007184;50202;50421.74789126031;7492.550446973199;7543.698252069856;7553.584552849646;7671;7906.486078404885;10163.644272450429;11228.831567526331;11243.369711391966;11274.549018039515;11471.426428678365;9905.55425005862;10108.595656173964;10150.340227885164;10170.338927969658;10222.13111885498;9898.158656514277;9903.108720214927;9956.20350371954;10040.315127414588;10222;9964.950175249078;10076.24428167905;10133.391996480235;10455.059044686015;10508.316959397614;7409.37020353276;7440.813979650552;7478.5138965967035;7543.886841697269;7735.342495887688;9436.764080898032;9902.603895844086;10034.799304014025;10080.344777589433;10136.898631013595 02:42:09 INFO - PROCESS | 5165 | |3;mootools.html;1282.2178471132602;1443.1557538839782;1463.2098666719971;1604.727196376616;1780.0565700178909;6841.486888483365;7630.084389873216;7815.726449574259;7829.725959591416;7833.80415489613;7540.81147971301;7696.538207707527;7707.22927707229;7716.459847810642;7725.420593455485;1894.5074280686983;1957.2464601128597;1958.5103724068983;2236.798688118065;2265.9660105098437;2203.449137715571;2290.290010096867;2291.9083236670513;2293.8967746451367;2295.2196253273883;2175.641019231825;2197.154095673169;2202.273249827553;2204.6031714291503;2211.5466329402434;1881.539022939375;2093.822025127866;2210.5799898019404;2221.366910430536;2221.4557433428754;2224.3882932193615;2242.372135801978;2242.495438526335;2244.618414869476;2247.213475283654;7629.80925476862;7684.846303073963;7689.269519395649;7690.5385676859005;7700.4609677322605;4474;4598.701084429535;4600.6549508786975;4614.861554153381;4638.095571363586;2902.3759891623404;3057.2662560985427;3082.3835232953497;3092.8608212630484;3094.6286445626442;999.9850002249972;1036.3471013261596;1040.3445829127677;1060.750723579958;1061.7770268243678;10723.946380268128;10731.785364292671;10758.193135514868;10761.408122553257;10767.300125491818;4059.7970101494807;4167.6874234432535;4333.696641235083;4360.561014865087;4365.890852728708;9216.63133474667;9258.95370523143;9266.21237194846;9274;9278.907210927939;4694.108119457293;4708.882277943078;4712.458067322234;4719.646026548023;4745.477997420281;3686.6129056448685;4208.389783481378;4310.8706738797255;4318.093200427946;4350.782460877007;3616.764910280823;3644.1436262478296;3660.432632941898;3697.2235830475365;3721.6650501455;1199.220506670671;1231.9651492746136;1234.2039384596885;1238.9566365177357;1239.3493415956696;879.678917195232;884.7036242858586;897.3539051882634;898.85168947123;904.1862323908535;5315.229291752674;5392.838214853561;5424.321959755031;5587.441255874462;5596.720163991866;426.100927043937;427.26510402108323;442.126799570845;442.59281461055906;445.49658885459223;3736;3786.6024067473068;3797.2974999625158;3808.1050953026015;3865.632764887331;9240.722778316662;9553.283503737248;9669.081437263449;9732.805343893082;9746.463944483121;9411.764705882271;9587.712368628952;9612;9625.374350667184;9657.565409556586;7302.488825782144;7395.371393431618;7454.40364770817;7461.589612571361;7493.363064139609;5286.682799032071;5328.920066198933;5417.106177480671;5469.3983661797965;5481.479259470344;8588.613512391832;8672.176143266379;8754.606042727964;8754.737357879274;8877.689280875138;8676.349273804364;8843.823123537364;8869.06874778139;9053.321000925089;9064.365494415328;6200.3179650239335;6579.736810527525;6840.281770414035;6845.349691779472;7002.8949565757575;7459.291367320096;7481.989931359197;7500.212477689982;7520.736774212876;7563.243675632612;6672.332766723289;6809.114815074008;6880.174379074543;6941.375276225164;6966.825829354307;6772.051912732123;6793;6854.074699915447;6881.208661004049;6944.895826562707;6410.102585637921;6428.742850285937;6482.546221764431;6528.869422611616;6573.5398522103;4652.930206046844;4657.301404789308;4670.953290467188;4734.33719279308;4763.333133361401;4714.9292760609305;4751.596114330182;4791.688540244873;4814.975925120352;4825.4933232010135 02:42:09 INFO - PROCESS | 5165 | |4;prototype.html;316.63428739805533;317.0520144767147;317.16110886704666;323.23877269031414;328.5203602739999;5092.77082531286;5092.974535127324;5155.226715992593;5162.586993040552;5172.6379153459275;5081.491850814926;5081.79672813087;5082.796688132479;5096.566791822699;5119.641625086246;3794.5256842894637;3848.9807550962205;3996.5403978542404;4009.67922566194;4074.6740260779216;4007.6994225433064;4013.8795836124964;4024.7182697211206;4042.73722208057;4045.0696339841707;3775.6790672792845;3970.4044393341087;3973.8013099344917;3990.4413382126527;3993.460882780831;3875.1280961783655;3944.073142811437;3986.760794352348;3997.8200980955635;4012.2376748417705;3506.211102501942;3518.5953615334306;3532.993096967378;3535.9292814143573;3540.76984995977;4829.806807727687;4883.804647814083;4896.540357501361;4914.975425122887;4938.530839570235;4306.837153968442;4541.704789188725;4556.270996640522;4564.680472366936;4635.5364463553715;5350.35795704514;5388.622796404254;5394.973025134849;5398.78404863805;5401.378841433207;3800.4869342638667;3815.236952609489;3815.8855234342736;3817;3820.407836785275;5503.944960550383;5629.127485239795;5639.097744360924;5656.4060773618585;5665.971670141623;3862.0537968197973;3887.494625698641;3891.922161556753;3894.3768996960916;3895.0651843557907;3948.072203032285;3948.506436695413;3949.38784488399;3950.6641935435237;3960.5841386653988;4419.845305414359;4525.705829121097;4539.6368290536675;4542.386777784956;4562.749048802348;5396.3524377075;5419.810306639249;5425.131978883439;5425.321834770653;5439.456054394529;1359.3882752761297;1377.4490203918513;1382.4470211915313;1384.0865029080758;1387.2162228340956;875.4854102402878;901.6213190460022;921.5760750054916;924.6856068936594;937.3438592984937;4740.454847692559;4754.809807607726;4779.402574678165;4787.593054590398;4792.640551958617;5521.8310175817005;5565.30433695788;5571.60998730085;5572.721363931787;5583.888322233533;4670.136024835417;4738.431388233434;4749.976250118796;4768.356271903318;4796.232602783608;2924.239697678619;2962.5408061750463;2963.170312312556;2964.125582953034;2972.985135074354;5206;5217.2434996925995;5224.686518808883;5230.084735171406;5231.738413079407;5476.342838859283;5666.603337766399;5766.192733017381;5777.220075289866;5788.392218817048;5270;5289.127293996525;5290.095565596383;5319.281896943863;5326.307580014651;5333.839984800462;5623.156526521055;5630.943690563206;5632.690202038927;5655.208270842003;5525.751341189736;5530.889382212253;5532.751026203911;5533.5849811263515;5540.22436858832;5315.335583052119;5324.201369794562;5331.813386531453;5338;5341.252224688469;3706.5552133744122;3923;3929.0766669831996;3941.3890846918775;3964.940525892056;5584.46947539983;5592.328920529562;5602.159676048625;5606.467385598362;5609.1305847593685;5408.296921400193;5408.945910540844;5421.295231619864;5431.158170483582;5432.158015507603;5239.633225674166;5416.918746218731;5418.913718218593;5437.510624043855;5444.673319600836;5077.593792496666;5300.681959082467;5310.654807437504;5358.249845021622;5361.329833770778;5194.7922083116255;5398.64908780928;5435.673859568438;5445.1832225166545;5453.672779633234;5291.576673866159;5296.655717378358;5300.284461597789;5308.867278318073;5324.201369794562 02:42:09 INFO - PROCESS | 5165 | |5;yui.html;650.3593959949449;657.8190997475693;662.5759513911095;719.7660760252919;763.0576238345644;11896.7620647587;12061.155719099666;12065.698357541043;12071.698207544816;12118.636440906776;10299.27905046647;11050.723731906706;11059.834102488448;11063.391513466777;11074.557017719282;803.1968031968032;815.9428839981204;817.239966830847;817.7342363731781;818.7543736878943;798.6046906781152;807.6365635464035;808.745245247748;809.4050872608628;809.4212637963855;841.7600983719641;842.3261390887296;842.4524059361403;843.7426584891606;844.2275318083946;829.995850020749;830.5349004557468;832.076395201326;832.271762208071;832.4089896173693;610.4780412747082;610.8320211941707;611.065070442224;611.7522403426619;611.8500967263004;10816.513256903458;10839.241253112285;10860.945695271474;10881.23831331807;10884.673459796219;10089.899101009043;10107.545160467796;10215.948920255425;10329.535170917326;10486.161107111413;8837.38138330317;8919.509426981513;9205.849268841395;9265.212456941168;9357.532123393803;3232.450483417801;3311.205310725433;3314.751393645486;3375.8312084395684;3387;37319.81340093309;37561.81219093914;38946.61053389458;40178.19643607111;45164.322535162;9899.356541824758;9905.950470247602;10080.495975201211;10187.439690816927;10361.481925903825;16445.83554164467;16869.072201028815;16874.578135546464;17233;17237.56906077358;6635.668216589152;6696.7656132035145;6746.696398662072;6862.9313706863295;6930;3551.5738111426795;3589.730770192246;3683.5763887152784;3723.4414837774007;3821.3694740368082;2991.267139550824;3099.4575949208797;3102.751779857606;3105.2392163919985;3106.9067927962196;537.7203853995978;548.1749966300692;551.5697755750521;554.7808615596816;558.6033915919661;511.9820806271763;535.9758810853521;582.2954225387244;614.4899733221415;640.0495264532166;7529.397648188132;7961.0040654061695;7998.560079195584;8017.358611311081;8031.879521807177;465.6088885336334;541.983740487786;614.7043222636951;626.4643729611208;647.795944277551;3746.269477451871;3835.76985380878;3843.1936989615397;3900.8829735107993;3921.0785465415606;52958.47041529613;53041;53513;53790.73104634452;54344.184837227476;44734.55265447304;44809.32786008212;45460.54539454563;45579.544204558195;46804.5319546807;35082.64917350845;42228.57771422308;42506.14987700291;43988.78005610016;44650.3302450457;7516.285952834472;7708.845823083395;7849.17583653731;7856.175101614248;8079.151689072798;27086;27121.1863644091;27766.44467110606;27793.305167370978;27823.582646259918;35476.290474190886;35688.286234275685;36114.638853611126;36266;36563.26873462569;10672.359658420519;10727.141828653845;10803.243772936134;10907.672769816601;11115.555377784798;11995.820062698893;12064.939675301568;12309.93845030769;12400.689982750504;13069;11241.66275011751;11292.322460652387;11432.314061156358;11489.885101149215;11565;10871.510782014986;11288.830667539829;11347.432628368713;11349.602763903555;11350.54597816078;9989.650362237287;10337.17302615804;10369.585216591553;10678.62624808128;10687.786244275227;9034.819303614022;9361.531923403667;9368.578413971523;9462.668806591737;9978.301518893608;8849.823003540021;8932.598033088396;8956.507392093497;9123.224525915106;9141.131592498701 02:42:09 INFO - PROCESS | 5165 | __end_tp_report 02:42:09 INFO - PROCESS | 5165 | __start_cc_report 02:42:09 INFO - PROCESS | 5165 | _x_x_mozilla_cycle_collect,1071 02:42:09 INFO - PROCESS | 5165 | __end_cc_report 02:42:09 INFO - PROCESS | 5165 | __startTimestamp1460713329846__endTimestamp 02:42:09 INFO - PROCESS | 5165 | 02:42:09 INFO - PROCESS | 5165 | ------- Summary: start ------- 02:42:09 INFO - PROCESS | 5165 | Number of tests: 6 02:42:09 INFO - PROCESS | 5165 | 02:42:09 INFO - PROCESS | 5165 | [#0] dojo.html Cycles:165 Average:4646.50 Median:4791.14 stddev:478.33 (10.0%) stddev-sans-first:452.10 02:42:09 INFO - PROCESS | 5165 | Values: 2601.8 2667.8 2679.6 2684.9 2704.8 4588.0 4598.7 4604.8 4615.4 4637.8 4685.7 4740.9 4749.1 4787.6 4788.4 4274.9 4284.3 4285.6 4341.6 4462.1 4392.6 4415.4 4429.8 4448.8 4457.9 4282.3 4305.9 4351.0 4361.0 4392.2 4320.7 4340.2 4347.4 4352.5 4394.3 4239.6 4252.0 4261.8 4266.0 4298.4 4476.0 4556.4 4567.5 4632.3 4658.8 4999.3 5012.8 5017.5 5019.6 5051.7 4995.5 5030.6 5034.8 5036.6 5076.2 4540.8 4639.9 4669.6 4718.4 4725.4 5098.7 5125.1 5126.8 5126.8 5181.0 4913.3 4916.7 4916.7 4920.8 4966.5 4817.7 4922.0 4925.7 4926.2 4989.8 4980.9 5024.1 5033.5 5034.7 5082.3 5011.4 5022.2 5023.1 5023.2 5085.1 4187.0 4190.3 4238.5 4255.4 4258.4 3692.7 3705.5 3707.9 3737.8 3741.7 4381.1 4386.6 4389.2 4416.9 4432.9 4928.0 5029.1 5030.5 5046.9 5114.9 4359.4 4376.2 4386.9 4387.5 4427.5 4496.2 4508.9 4509.0 4530.2 4558.0 4637.0 4730.5 4741.9 4811.8 4814.7 5020.5 5023.4 5046.3 5048.1 5143.7 4773.1 4791.1 4802.8 4810.8 4856.3 4802.3 4920.0 4981.6 4996.9 5028.2 5034.9 5041.0 5060.0 5060.1 5109.9 4773.8 4906.9 4920.9 4925.2 4969.2 4848.9 4883.3 4902.3 4935.8 4953.6 4834.8 4835.2 4845.2 4846.2 4890.8 4718.1 4882.2 4928.2 4944.7 4993.2 4785.1 4797.0 4811.2 4833.5 4862.4 02:42:09 INFO - PROCESS | 5165 | 02:42:09 INFO - PROCESS | 5165 | [#1] ext.html Cycles:180 Average:39570.92 Median:33523.75 stddev:65043.97 (194.0%) stddev-sans-first:65160.50 02:42:09 INFO - PROCESS | 5165 | Values: 564.4 597.2 605.2 615.9 617.7 26125.3 26657.2 26746.5 26846.3 33230.8 33737.0 34664.5 34730.1 34735.1 36751.4 7678.5 7883.5 7887.6 7895.1 7910.2 7364.3 7700.1 7857.0 9874.0 10258.4 9819.6 9934.1 9934.2 9938.0 9945.5 9723.7 9849.0 9850.1 9860.4 9861.2 9732.9 9847.7 9848.4 9850.3 9865.7 36970.3 37503.6 37511.0 37544.8 37552.8 3024.3 3036.9 3042.9 3043.3 3134.5 25773.4 28611.4 28795.3 29027.3 29920.1 3293.1 3410.2 3482.7 3487.9 3577.6 167599.0 169077.0 169181.0 169352.0 169432.0 47469.3 47684.8 47792.5 48010.8 48012.3 49744.3 50123.5 50161.7 50166.0 50274.7 13670.8 14456.2 14462.0 14463.9 14483.2 9942.0 11388.6 11499.9 11511.9 11543.7 17834.4 18214.3 18327.6 18375.0 18433.3 6572.0 6688.2 6694.6 6936.9 7015.5 887.5 978.0 981.9 996.9 998.2 25162.0 26876.6 27031.6 28154.0 28665.0 1007.2 1060.0 1076.2 1104.9 1130.2 14482.6 14677.6 14753.5 14895.3 15086.8 323591.0 328656.0 329595.0 329659.0 331285.0 47519.8 48354.8 48413.8 48419.3 48517.8 1115.3 1260.6 1261.1 1287.0 1315.5 24301.9 25092.0 26169.9 26226.3 26638.7 38618.0 38959.6 38990.4 39184.6 39202.2 219726.0 220560.0 220735.0 221323.0 221403.0 22100.0 24485.5 25339.6 25460.0 25568.2 38336.4 38638.8 38966.8 39189.4 39649.0 33005.0 33435.2 33487.5 33603.3 33881.0 33431.7 33617.0 33620.0 33767.8 33843.8 32676.3 33560.0 33671.7 33954.5 33977.0 29438.1 29754.6 29887.6 30227.7 30366.0 23388.9 23721.8 23852.8 23859.4 23883.8 02:42:09 INFO - PROCESS | 5165 | 02:42:09 INFO - PROCESS | 5165 | [#2] jquery.html Cycles:180 Average:23789.87 Median:50139.25 stddev:58560.69 (116.8%) stddev-sans-first:58698.57 02:42:09 INFO - PROCESS | 5165 | Values: 372.6 374.2 395.5 395.8 410.0 15328.6 16176.5 16884.3 16906.9 16918.6 16740.7 16801.0 17015.2 17216.7 17315.8 5159.2 5292.7 5330.7 5340.3 5346.2 3638.1 5683.8 6031.2 6037.8 6046.5 4848.3 5965.1 5969.2 5995.4 5999.7 5084.5 5135.6 5150.5 5163.3 5165.5 3393.8 3568.4 3658.7 5248.9 5253.8 11965.8 12113.4 12222.9 14361.9 20522.7 1811.7 1946.5 1962.4 1969.8 2249.5 8560.8 8883.0 9296.2 9307.1 9319.7 1647.8 1732.2 1734.4 1739.7 1749.5 68176.3 72062.3 73019.6 74840.0 81615.0 15422.8 15816.5 15839.6 16065.3 16220.5 29756.7 29832.6 30005.2 30135.7 30138.1 8703.5 8761.4 8812.6 8829.8 8903.5 6984.8 7244.2 7310.9 7453.6 7516.6 8367.2 8373.8 8378.3 8392.0 8476.5 2840.8 3346.7 3429.7 3445.0 3495.5 813.6 898.2 937.3 943.1 976.8 16123.2 16469.5 16954.6 17035.7 17206.5 844.1 846.3 878.3 890.3 923.6 8966.9 9433.3 9441.4 9459.4 9551.9 245944.0 370732.0 373307.0 374794.0 378090.0 78691.2 78760.0 79542.6 79652.0 79850.2 900.8 903.0 916.2 924.4 932.4 14862.3 14906.4 14965.5 14965.6 15156.9 34135.8 34240.3 34629.3 35232.1 35892.0 44707.8 49916.8 50076.5 50202.0 50421.7 7492.6 7543.7 7553.6 7671.0 7906.5 10163.6 11228.8 11243.4 11274.5 11471.4 9905.6 10108.6 10150.3 10170.3 10222.1 9898.2 9903.1 9956.2 10040.3 10222.0 9965.0 10076.2 10133.4 10455.1 10508.3 7409.4 7440.8 7478.5 7543.9 7735.3 9436.8 9902.6 10034.8 10080.3 10136.9 02:42:09 INFO - PROCESS | 5165 | 02:42:09 INFO - PROCESS | 5165 | [#3] mootools.html Cycles:180 Average:5171.03 Median:4777.51 stddev:2872.89 (60.1%) stddev-sans-first:2866.08 02:42:09 INFO - PROCESS | 5165 | Values: 1282.2 1443.2 1463.2 1604.7 1780.1 6841.5 7630.1 7815.7 7829.7 7833.8 7540.8 7696.5 7707.2 7716.5 7725.4 1894.5 1957.2 1958.5 2236.8 2266.0 2203.4 2290.3 2291.9 2293.9 2295.2 2175.6 2197.2 2202.3 2204.6 2211.5 1881.5 2093.8 2210.6 2221.4 2221.5 2224.4 2242.4 2242.5 2244.6 2247.2 7629.8 7684.8 7689.3 7690.5 7700.5 4474.0 4598.7 4600.7 4614.9 4638.1 2902.4 3057.3 3082.4 3092.9 3094.6 1000.0 1036.3 1040.3 1060.8 1061.8 10723.9 10731.8 10758.2 10761.4 10767.3 4059.8 4167.7 4333.7 4360.6 4365.9 9216.6 9259.0 9266.2 9274.0 9278.9 4694.1 4708.9 4712.5 4719.6 4745.5 3686.6 4208.4 4310.9 4318.1 4350.8 3616.8 3644.1 3660.4 3697.2 3721.7 1199.2 1232.0 1234.2 1239.0 1239.3 879.7 884.7 897.4 898.9 904.2 5315.2 5392.8 5424.3 5587.4 5596.7 426.1 427.3 442.1 442.6 445.5 3736.0 3786.6 3797.3 3808.1 3865.6 9240.7 9553.3 9669.1 9732.8 9746.5 9411.8 9587.7 9612.0 9625.4 9657.6 7302.5 7395.4 7454.4 7461.6 7493.4 5286.7 5328.9 5417.1 5469.4 5481.5 8588.6 8672.2 8754.6 8754.7 8877.7 8676.3 8843.8 8869.1 9053.3 9064.4 6200.3 6579.7 6840.3 6845.3 7002.9 7459.3 7482.0 7500.2 7520.7 7563.2 6672.3 6809.1 6880.2 6941.4 6966.8 6772.1 6793.0 6854.1 6881.2 6944.9 6410.1 6428.7 6482.5 6528.9 6573.5 4652.9 4657.3 4671.0 4734.3 4763.3 4714.9 4751.6 4791.7 4815.0 4825.5 02:42:09 INFO - PROCESS | 5165 | 02:42:09 INFO - PROCESS | 5165 | [#4] prototype.html Cycles:180 Average:4478.24 Median:5094.77 stddev:1311.83 (25.7%) stddev-sans-first:1277.78 02:42:09 INFO - PROCESS | 5165 | Values: 316.6 317.1 317.2 323.2 328.5 5092.8 5093.0 5155.2 5162.6 5172.6 5081.5 5081.8 5082.8 5096.6 5119.6 3794.5 3849.0 3996.5 4009.7 4074.7 4007.7 4013.9 4024.7 4042.7 4045.1 3775.7 3970.4 3973.8 3990.4 3993.5 3875.1 3944.1 3986.8 3997.8 4012.2 3506.2 3518.6 3533.0 3535.9 3540.8 4829.8 4883.8 4896.5 4915.0 4938.5 4306.8 4541.7 4556.3 4564.7 4635.5 5350.4 5388.6 5395.0 5398.8 5401.4 3800.5 3815.2 3815.9 3817.0 3820.4 5503.9 5629.1 5639.1 5656.4 5666.0 3862.1 3887.5 3891.9 3894.4 3895.1 3948.1 3948.5 3949.4 3950.7 3960.6 4419.8 4525.7 4539.6 4542.4 4562.7 5396.4 5419.8 5425.1 5425.3 5439.5 1359.4 1377.4 1382.4 1384.1 1387.2 875.5 901.6 921.6 924.7 937.3 4740.5 4754.8 4779.4 4787.6 4792.6 5521.8 5565.3 5571.6 5572.7 5583.9 4670.1 4738.4 4750.0 4768.4 4796.2 2924.2 2962.5 2963.2 2964.1 2973.0 5206.0 5217.2 5224.7 5230.1 5231.7 5476.3 5666.6 5766.2 5777.2 5788.4 5270.0 5289.1 5290.1 5319.3 5326.3 5333.8 5623.2 5630.9 5632.7 5655.2 5525.8 5530.9 5532.8 5533.6 5540.2 5315.3 5324.2 5331.8 5338.0 5341.3 3706.6 3923.0 3929.1 3941.4 3964.9 5584.5 5592.3 5602.2 5606.5 5609.1 5408.3 5408.9 5421.3 5431.2 5432.2 5239.6 5416.9 5418.9 5437.5 5444.7 5077.6 5300.7 5310.7 5358.2 5361.3 5194.8 5398.6 5435.7 5445.2 5453.7 5291.6 5296.7 5300.3 5308.9 5324.2 02:42:09 INFO - PROCESS | 5165 | 02:42:09 INFO - PROCESS | 5165 | [#5] yui.html Cycles:180 Average:12269.26 Median:44692.44 stddev:13885.59 (31.1%) stddev-sans-first:13897.13 02:42:09 INFO - PROCESS | 5165 | Values: 650.4 657.8 662.6 719.8 763.1 11896.8 12061.2 12065.7 12071.7 12118.6 10299.3 11050.7 11059.8 11063.4 11074.6 803.2 815.9 817.2 817.7 818.8 798.6 807.6 808.7 809.4 809.4 841.8 842.3 842.5 843.7 844.2 830.0 830.5 832.1 832.3 832.4 610.5 610.8 611.1 611.8 611.9 10816.5 10839.2 10860.9 10881.2 10884.7 10089.9 10107.5 10215.9 10329.5 10486.2 8837.4 8919.5 9205.8 9265.2 9357.5 3232.5 3311.2 3314.8 3375.8 3387.0 37319.8 37561.8 38946.6 40178.2 45164.3 9899.4 9906.0 10080.5 10187.4 10361.5 16445.8 16869.1 16874.6 17233.0 17237.6 6635.7 6696.8 6746.7 6862.9 6930.0 3551.6 3589.7 3683.6 3723.4 3821.4 2991.3 3099.5 3102.8 3105.2 3106.9 537.7 548.2 551.6 554.8 558.6 512.0 536.0 582.3 614.5 640.0 7529.4 7961.0 7998.6 8017.4 8031.9 465.6 542.0 614.7 626.5 647.8 3746.3 3835.8 3843.2 3900.9 3921.1 52958.5 53041.0 53513.0 53790.7 54344.2 44734.6 44809.3 45460.5 45579.5 46804.5 35082.6 42228.6 42506.1 43988.8 44650.3 7516.3 7708.8 7849.2 7856.2 8079.2 27086.0 27121.2 27766.4 27793.3 27823.6 35476.3 35688.3 36114.6 36266.0 36563.3 10672.4 10727.1 10803.2 10907.7 11115.6 11995.8 12064.9 12309.9 12400.7 13069.0 11241.7 11292.3 11432.3 11489.9 11565.0 10871.5 11288.8 11347.4 11349.6 11350.5 9989.7 10337.2 10369.6 10678.6 10687.8 9034.8 9361.5 9368.6 9462.7 9978.3 8849.8 8932.6 8956.5 9123.2 9141.1 02:42:09 INFO - PROCESS | 5165 | -------- Summary: end -------- 02:42:09 INFO - PROCESS | 5165 | 02:42:10 INFO - TEST-INFO | 5165: exit 0 02:42:10 INFO - TEST-OK | dromaeo_css | took 1120494ms 02:42:10 INFO - TEST-START | kraken 02:42:10 INFO - operating with platform_type : linux_ 02:42:10 INFO - Initialising browser for kraken test... 02:42:10 INFO - TEST-INFO | started process 5347 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw15LQZ/profile http://localhost:39364/getInfo.html) 02:42:15 INFO - PROCESS | 5347 | __metrics Screen width/height:1600/1200 02:42:15 INFO - PROCESS | 5347 | colorDepth:24 02:42:15 INFO - PROCESS | 5347 | Browser inner width/height: 1024/697 02:42:15 INFO - PROCESS | 5347 | __metrics 02:42:16 ERROR - PROCESS | 5347 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:42:17 INFO - TEST-INFO | 5347: exit 0 02:42:17 INFO - Browser initialized. 02:42:17 INFO - Running cycle 1/1 for kraken test... 02:42:17 INFO - TEST-INFO | started process 5428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw15LQZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:42:29 INFO - PROCESS | 5428 | RSS: Main: 155058176 02:42:29 INFO - PROCESS | 5428 | 02:42:32 INFO - PROCESS | 5428 | Cycle 1(1): loaded http://localhost:39364/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39364/tests/kraken/driver.html?testName=audio-beat-detection) 02:42:33 INFO - PROCESS | 5428 | RSS: Main: 209309696 02:42:33 INFO - PROCESS | 5428 | 02:42:35 INFO - PROCESS | 5428 | Cycle 1(1): loaded http://localhost:39364/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39364/tests/kraken/driver.html?testName=audio-dft) 02:42:36 INFO - PROCESS | 5428 | RSS: Main: 194473984 02:42:36 INFO - PROCESS | 5428 | 02:42:39 INFO - PROCESS | 5428 | Cycle 1(1): loaded http://localhost:39364/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39364/tests/kraken/driver.html?testName=audio-fft) 02:42:40 INFO - PROCESS | 5428 | RSS: Main: 265617408 02:42:40 INFO - PROCESS | 5428 | 02:42:42 INFO - PROCESS | 5428 | Cycle 1(1): loaded http://localhost:39364/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39364/tests/kraken/driver.html?testName=audio-oscillator) 02:42:43 INFO - PROCESS | 5428 | RSS: Main: 174129152 02:42:43 INFO - PROCESS | 5428 | 02:42:45 INFO - PROCESS | 5428 | Cycle 1(1): loaded http://localhost:39364/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39364/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:42:45 INFO - PROCESS | 5428 | RSS: Main: 178544640 02:42:45 INFO - PROCESS | 5428 | 02:42:49 INFO - PROCESS | 5428 | Cycle 1(1): loaded http://localhost:39364/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39364/tests/kraken/driver.html?testName=imaging-darkroom) 02:42:49 INFO - PROCESS | 5428 | RSS: Main: 214437888 02:42:49 INFO - PROCESS | 5428 | 02:42:53 INFO - PROCESS | 5428 | Cycle 1(1): loaded http://localhost:39364/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39364/tests/kraken/driver.html?testName=imaging-desaturate) 02:42:53 INFO - PROCESS | 5428 | RSS: Main: 212275200 02:42:53 INFO - PROCESS | 5428 | 02:42:56 INFO - PROCESS | 5428 | Cycle 1(1): loaded http://localhost:39364/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39364/tests/kraken/driver.html?testName=json-parse-financial) 02:42:57 INFO - PROCESS | 5428 | RSS: Main: 213475328 02:42:57 INFO - PROCESS | 5428 | 02:42:58 INFO - PROCESS | 5428 | Cycle 1(1): loaded http://localhost:39364/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39364/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:42:59 INFO - PROCESS | 5428 | RSS: Main: 201015296 02:42:59 INFO - PROCESS | 5428 | 02:43:01 INFO - PROCESS | 5428 | Cycle 1(1): loaded http://localhost:39364/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39364/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:43:02 INFO - PROCESS | 5428 | RSS: Main: 202551296 02:43:02 INFO - PROCESS | 5428 | 02:43:04 INFO - PROCESS | 5428 | Cycle 1(1): loaded http://localhost:39364/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39364/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:43:04 INFO - PROCESS | 5428 | RSS: Main: 218959872 02:43:04 INFO - PROCESS | 5428 | 02:43:07 INFO - PROCESS | 5428 | Cycle 1(1): loaded http://localhost:39364/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39364/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:43:08 INFO - PROCESS | 5428 | RSS: Main: 223318016 02:43:08 INFO - PROCESS | 5428 | 02:43:11 INFO - PROCESS | 5428 | Cycle 1(1): loaded http://localhost:39364/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39364/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:43:11 INFO - PROCESS | 5428 | RSS: Main: 220631040 02:43:11 INFO - PROCESS | 5428 | 02:43:13 INFO - PROCESS | 5428 | Cycle 1(1): loaded http://localhost:39364/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39364/tests/kraken/driver.html?testName=ai-astar) 02:43:13 INFO - PROCESS | 5428 | RSS: Main: 282673152 02:43:13 INFO - PROCESS | 5428 | 02:43:13 INFO - PROCESS | 5428 | __start_tp_report 02:43:13 INFO - PROCESS | 5428 | _x_x_mozilla_page_load 02:43:13 INFO - PROCESS | 5428 | _x_x_mozilla_page_load_details 02:43:13 INFO - PROCESS | 5428 | |i|pagename|runs| 02:43:13 INFO - PROCESS | 5428 | |0;ai-astar;110;113;106;111;112;112;100;111;112;111 02:43:13 INFO - PROCESS | 5428 | |1;audio-beat-detection;154;150;161;174;138;154;154;140;191;138 02:43:13 INFO - PROCESS | 5428 | |2;audio-dft;161;163;162;161;164;161;163;163;161;167 02:43:13 INFO - PROCESS | 5428 | |3;audio-fft;78;73;98;112;74;75;77;114;102;74 02:43:13 INFO - PROCESS | 5428 | |4;audio-oscillator;95;94;149;94;94;94;146;94;94;149 02:43:13 INFO - PROCESS | 5428 | |5;imaging-gaussian-blur;117;117;117;116;116;118;117;117;116;117 02:43:13 INFO - PROCESS | 5428 | |6;imaging-darkroom;146;146;146;146;146;147;146;146;146;146 02:43:13 INFO - PROCESS | 5428 | |7;imaging-desaturate;95;95;95;96;95;95;96;96;95;96 02:43:13 INFO - PROCESS | 5428 | |8;json-parse-financial;65;65;65;65;64;64;65;83;65;61 02:43:13 INFO - PROCESS | 5428 | |9;json-stringify-tinderbox;65;65;64;65;65;64;65;65;64;65 02:43:13 INFO - PROCESS | 5428 | |10;stanford-crypto-aes;84;83;82;92;84;84;84;85;87;85 02:43:13 INFO - PROCESS | 5428 | |11;stanford-crypto-ccm;141;139;145;136;135;134;137;137;177;138 02:43:13 INFO - PROCESS | 5428 | |12;stanford-crypto-pbkdf2;171;171;172;171;171;171;169;173;170;171 02:43:13 INFO - PROCESS | 5428 | |13;stanford-crypto-sha256-iterative;73;71;71;71;72;70;71;72;70;71 02:43:13 INFO - PROCESS | 5428 | __end_tp_report 02:43:13 INFO - PROCESS | 5428 | __start_cc_report 02:43:13 INFO - PROCESS | 5428 | _x_x_mozilla_cycle_collect,1896 02:43:13 INFO - PROCESS | 5428 | __end_cc_report 02:43:13 INFO - PROCESS | 5428 | __startTimestamp1460713393969__endTimestamp 02:43:13 INFO - PROCESS | 5428 | 02:43:13 INFO - PROCESS | 5428 | ------- Summary: start ------- 02:43:13 INFO - PROCESS | 5428 | Number of tests: 14 02:43:13 INFO - PROCESS | 5428 | 02:43:13 INFO - PROCESS | 5428 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.50 stddev:3.94 (3.5%) stddev-sans-first:4.18 02:43:13 INFO - PROCESS | 5428 | Values: 110.0 113.0 106.0 111.0 112.0 112.0 100.0 111.0 112.0 111.0 02:43:13 INFO - PROCESS | 5428 | 02:43:13 INFO - PROCESS | 5428 | [#1] audio-beat-detection Cycles:10 Average:155.40 Median:154.00 stddev:16.74 (10.9%) stddev-sans-first:17.75 02:43:13 INFO - PROCESS | 5428 | Values: 154.0 150.0 161.0 174.0 138.0 154.0 154.0 140.0 191.0 138.0 02:43:13 INFO - PROCESS | 5428 | 02:43:13 INFO - PROCESS | 5428 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:1.90 (1.2%) stddev-sans-first:1.92 02:43:13 INFO - PROCESS | 5428 | Values: 161.0 163.0 162.0 161.0 164.0 161.0 163.0 163.0 161.0 167.0 02:43:13 INFO - PROCESS | 5428 | 02:43:13 INFO - PROCESS | 5428 | [#3] audio-fft Cycles:10 Average:87.70 Median:74.50 stddev:16.85 (22.6%) stddev-sans-first:17.50 02:43:13 INFO - PROCESS | 5428 | Values: 78.0 73.0 98.0 112.0 74.0 75.0 77.0 114.0 102.0 74.0 02:43:13 INFO - PROCESS | 5428 | 02:43:13 INFO - PROCESS | 5428 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:94.00 stddev:26.03 (27.7%) stddev-sans-first:27.01 02:43:13 INFO - PROCESS | 5428 | Values: 95.0 94.0 149.0 94.0 94.0 94.0 146.0 94.0 94.0 149.0 02:43:13 INFO - PROCESS | 5428 | 02:43:13 INFO - PROCESS | 5428 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 02:43:13 INFO - PROCESS | 5428 | Values: 117.0 117.0 117.0 116.0 116.0 118.0 117.0 117.0 116.0 117.0 02:43:13 INFO - PROCESS | 5428 | 02:43:13 INFO - PROCESS | 5428 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 02:43:13 INFO - PROCESS | 5428 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 02:43:13 INFO - PROCESS | 5428 | 02:43:13 INFO - PROCESS | 5428 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:43:13 INFO - PROCESS | 5428 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 96.0 02:43:13 INFO - PROCESS | 5428 | 02:43:13 INFO - PROCESS | 5428 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:65.00 stddev:6.03 (9.3%) stddev-sans-first:6.38 02:43:13 INFO - PROCESS | 5428 | Values: 65.0 65.0 65.0 65.0 64.0 64.0 65.0 83.0 65.0 61.0 02:43:13 INFO - PROCESS | 5428 | 02:43:13 INFO - PROCESS | 5428 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 02:43:13 INFO - PROCESS | 5428 | Values: 65.0 65.0 64.0 65.0 65.0 64.0 65.0 65.0 64.0 65.0 02:43:13 INFO - PROCESS | 5428 | 02:43:13 INFO - PROCESS | 5428 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.50 stddev:2.79 (3.3%) stddev-sans-first:2.93 02:43:13 INFO - PROCESS | 5428 | Values: 84.0 83.0 82.0 92.0 84.0 84.0 84.0 85.0 87.0 85.0 02:43:13 INFO - PROCESS | 5428 | 02:43:13 INFO - PROCESS | 5428 | [#11] stanford-crypto-ccm Cycles:10 Average:141.90 Median:138.50 stddev:12.73 (9.2%) stddev-sans-first:13.50 02:43:13 INFO - PROCESS | 5428 | Values: 141.0 139.0 145.0 136.0 135.0 134.0 137.0 137.0 177.0 138.0 02:43:13 INFO - PROCESS | 5428 | 02:43:13 INFO - PROCESS | 5428 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.00 Median:171.00 stddev:1.05 (0.6%) stddev-sans-first:1.12 02:43:13 INFO - PROCESS | 5428 | Values: 171.0 171.0 172.0 171.0 171.0 171.0 169.0 173.0 170.0 171.0 02:43:13 INFO - PROCESS | 5428 | 02:43:13 INFO - PROCESS | 5428 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:71.00 stddev:0.92 (1.3%) stddev-sans-first:0.71 02:43:13 INFO - PROCESS | 5428 | Values: 73.0 71.0 71.0 71.0 72.0 70.0 71.0 72.0 70.0 71.0 02:43:13 INFO - PROCESS | 5428 | -------- Summary: end -------- 02:43:13 INFO - PROCESS | 5428 | 02:43:14 INFO - TEST-INFO | 5428: exit 0 02:43:15 INFO - TEST-OK | kraken | took 64378ms 02:43:15 INFO - SUITE-END | took 1184s 02:43:15 INFO - Completed test suite (00:19:44) 02:43:15 INFO - javascript benchmark 02:43:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2601.778848797852, 2667.799915006375, 2679.5846643770224, 2684.9463010739773, 2704.756571908528, 4588.0, 4598.70108442951, 4604.815807367705, 4615.446146462429, 4637.791299391527, 4685.7188568685815, 4740.881477963044, 4749.145153872301, 4787.6169906407495, 4788.425388953322, 4274.893127671818, 4284.250256205167, 4285.571442855705, 4341.565843415665, 4462.085272519142, 4392.560743925614, 4415.381846541487, 4429.800658970354, 4448.822047118111, 4457.910841783162, 4282.336237883133, 4305.913881722379, 4351.042770590465, 4361.0, 4392.165488557196, 4320.654347652212, 4340.175366680321, 4347.413099231595, 4352.455943007124, 4394.2529769938865, 4239.618434340893, 4252.0, 4261.786910654486, 4265.97867010663, 4298.398224248576, 4475.977620111911, 4556.430446194226, 4567.474740404863, 4632.328312394718, 4658.813647454098, 4999.3000979862845, 5012.77442515084, 5017.49825017499, 5019.64862459628, 5051.671641343338, 4995.475475075101, 5030.597552195815, 5034.773435195425, 5036.622253331015, 5076.213186956028, 4540.84107056258, 4639.930401043987, 4669.603083737887, 4718.386609740781, 4725.432948046257, 5098.668586541863, 5125.109745390658, 5126.79492820283, 5126.794928202905, 5181.0, 4913.263010548446, 4916.70499770015, 4916.70499770015, 4920.778564964585, 4966.503349665005, 4817.710937343771, 4922.0, 4925.679830810986, 4926.236433352836, 4989.80040798364, 4980.90038199234, 5024.0956627807345, 5033.47148549397, 5034.723090229999, 5082.339295891585, 5011.4236862761245, 5022.2466630005065, 5023.120953833138, 5023.196288593807, 5085.110105731482, 4187.036981494273, 4190.266703326905, 4238.470191226097, 4255.361695745601, 4258.382534532476, 3692.7045836333027, 3705.5182826232417, 3707.925841483155, 3737.831797569116, 3741.663250307431, 4381.123775244963, 4386.583274588909, 4389.231884420214, 4416.889577760582, 4432.911341773147, 4928.0, 5029.06962211992, 5030.522100400456, 5046.924296135561, 5114.897702045938, 4359.433273674402, 4376.234159022159, 4386.890327741832, 4387.473503179575, 4427.535108813592, 4496.168208881368, 4508.909821803545, 4509.030558429953, 4530.22986092365, 4557.977210113928, 4636.9536304637195, 4730.503297153749, 4741.928871066937, 4811.7834697438, 4814.6870453420415, 5020.523050310361, 5023.397192336943, 5046.268291097844, 5048.091343558195, 5143.7428128594165, 4773.09311230865, 4791.137595232892, 4802.807887684454, 4810.783514741775, 4856.320115183948, 4802.255650374198, 4919.975400122977, 4981.551660350586, 4996.875078123076, 5028.1954887219335, 5034.924476132935, 5040.974795126001, 5060.0, 5060.114479966065, 5109.8722531937, 4773.785179666993, 4906.901861962812, 4920.8769780755765, 4925.236588328815, 4969.155243608668, 4848.927266090941, 4883.316335712932, 4902.289168070681, 4935.777889994887, 4953.628477864247, 4834.758262086952, 4835.178019736723, 4845.152098382699, 4846.200376937766, 4890.804367825247, 4718.103560323528, 4882.194437917704, 4928.186849169847, 4944.678595891256, 4993.151164302005, 4785.114753770564, 4796.992631547414, 4811.230203167476, 4833.540813622701, 4862.440819305825], "value": 4616.667352720924, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.3566334378809, 597.2057163971916, 605.1920685884342, 615.9476444502219, 617.7312868902026, 26125.346866328327, 26657.200283991464, 26746.465070698574, 26846.32884177894, 33230.8338458308, 33737.0, 34664.480032799525, 34730.13174670634, 34735.13162170947, 36751.4487282691, 7678.539287642745, 7883.526988380687, 7887.645055972466, 7895.131535531115, 7910.169432209622, 7364.33720965113, 7700.11448683403, 7856.9607151964165, 9874.0, 10258.384496930208, 9819.607215711363, 9934.056264654846, 9934.155596774282, 9938.0, 9945.453000084992, 9723.659671911484, 9848.950755246215, 9850.064243896819, 9860.408375497493, 9861.211103111735, 9732.90267097334, 9847.704568862946, 9848.35985660937, 9850.310478266525, 9865.654702085392, 36970.260594788226, 37503.624963750284, 37511.0, 37544.81227593844, 37552.81223593865, 3024.259056531164, 3036.878524859003, 3042.9391412171854, 3043.269615292336, 3134.514150306706, 25773.35566610831, 28611.42777144466, 28795.28011799701, 29027.274318142005, 29920.102396928127, 3293.143782616513, 3410.183713432942, 3482.7387945903906, 3487.930241395183, 3577.6422357764277, 167599.0, 169077.0, 169181.0, 169352.0, 169432.0, 47469.28796068062, 47684.7615761919, 47792.522074778804, 48010.75994620074, 48012.279815802794, 49744.25383619249, 50123.49876501261, 50161.74919125381, 50166.0, 50274.74862625664, 13670.794938075936, 14456.20490873012, 14462.0, 14463.85536144625, 14483.203423811581, 9942.0, 11388.601398950997, 11499.885001149882, 11511.884881151249, 11543.653690389301, 17834.37579684705, 18214.27142914295, 18327.633447331245, 18375.0, 18433.26266949334, 6571.967140164268, 6688.197416309977, 6694.564853284521, 6936.930630693629, 7015.543989640657, 887.494128346849, 977.9902200977899, 981.8723565936525, 996.8604395384652, 998.1565577087349, 25162.0, 26876.59685104725, 27031.594526082125, 28154.0, 28665.0, 1007.2495990487134, 1059.9629012984662, 1076.2143635146388, 1104.9447527623747, 1130.1806190511813, 14482.565523034325, 14677.633059173606, 14753.483628072965, 14895.329710163069, 15086.773698394532, 323591.0, 328656.0, 329595.0, 329659.0, 331285.0, 47519.76240118777, 48354.75822620864, 48413.75793121082, 48419.27371089436, 48517.75741121272, 1115.3140818396628, 1260.6344160193626, 1261.0857128581704, 1287.0, 1315.5066849931275, 24301.878490607432, 25092.0, 26169.869150654125, 26226.344341390854, 26638.7336126644, 38618.0, 38959.6104038956, 38990.4151437723, 39184.608153918096, 39202.2159556813, 219726.0, 220560.0, 220735.0, 221323.0, 221403.0, 22100.0, 24485.51028979446, 25339.6199057018, 25460.0, 25568.23295301144, 38336.42495362627, 38638.80680596579, 38966.80516597399, 39189.41215881821, 39649.0, 33005.0, 33435.16412089717, 33487.49768753422, 33603.32793344168, 33881.0, 33431.66568334286, 33617.0, 33620.0, 33767.83116084404, 33843.830780845936, 32676.34647307088, 33560.0, 33671.663283366855, 33954.49068263928, 33977.0, 29438.11685649434, 29754.55368169436, 29887.55168672515, 30227.697723022487, 30366.0, 23388.877337847924, 23721.762782372647, 23852.761472385748, 23859.403514911573, 23883.761162388153], "value": 16902.863439649278, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.6348178784791, 374.1656106881654, 395.47796908081347, 395.7803419102397, 410.0323237160299, 15328.61678458039, 16176.514704558853, 16884.32462701492, 16906.915465422688, 16918.5770355741, 16740.748888766677, 16801.0, 17015.234314455847, 17216.741748873777, 17315.826841731578, 5159.22611608258, 5292.655977361478, 5330.680159190461, 5340.25236466895, 5346.198070289449, 3638.108663377476, 5683.772649094031, 6031.215941927543, 6037.7584896604085, 6046.54650901182, 4848.296996935443, 5965.135055416962, 5969.22400087988, 5995.370486098962, 5999.6700181490005, 5084.51697088776, 5135.563477104451, 5150.510701483353, 5163.328767260251, 5165.4834516548235, 3393.8303084845907, 3568.375534281516, 3658.743887927846, 5248.921266181011, 5253.842384728426, 11965.760684786343, 12113.39433028345, 12222.938885305517, 14361.856381436157, 20522.692159617618, 1811.7101263797729, 1946.4939115829845, 1962.4014675523958, 1969.7734760502583, 2249.5275992041693, 8560.785980350478, 8883.0, 9296.209822165125, 9307.06929307064, 9319.673811416636, 1647.785787847584, 1732.1512458895177, 1734.384293575775, 1739.6868563658536, 1749.4751574527718, 68176.31823681798, 72062.27937720608, 73019.63490182569, 74840.0, 81615.0, 15422.768658470131, 15816.52550423489, 15839.604009899615, 16065.277062532214, 16220.513384598245, 29756.702432975395, 29832.552511712343, 30005.24986875302, 30135.69864301373, 30138.095857123884, 8703.521306328214, 8761.386702930733, 8812.603432845537, 8829.823403531893, 8903.465792052497, 6984.79045628632, 7244.203137654854, 7310.853782924311, 7453.590052547053, 7516.586587737617, 8367.163283671583, 8373.790655233668, 8378.287845533076, 8392.0, 8476.533790641573, 2840.815347002438, 3346.6987971082717, 3429.6548506536715, 3444.9655503445147, 3495.528103706018, 813.6094674556247, 898.1871406377239, 937.2736129499692, 943.1370296178919, 976.7558110472382, 16123.193840308173, 16469.505914822574, 16954.576135596708, 17035.659286814196, 17206.483805485856, 844.1221130024828, 846.3060290561804, 878.2754227762122, 890.2521881619471, 923.5890028937193, 8966.910330896739, 9433.292503062297, 9441.433513989183, 9459.432434053979, 9551.90448095524, 245944.0, 370732.0, 373307.0, 374794.0, 378090.0, 78691.21308786953, 78760.0, 79542.6022869882, 79652.0, 79850.20149798544, 900.8063266397756, 903.0, 916.1937495004487, 924.4499522783933, 932.4032619123631, 14862.331195096463, 14906.403743850558, 14965.476208332657, 14965.625859353604, 15156.924215378853, 34135.82932085423, 34240.315193696486, 34629.30741385108, 35232.11919702028, 35892.0, 44707.776461117486, 49916.75041624768, 50076.499235007184, 50202.0, 50421.74789126031, 7492.550446973199, 7543.698252069856, 7553.584552849646, 7671.0, 7906.486078404885, 10163.644272450429, 11228.831567526331, 11243.369711391966, 11274.549018039515, 11471.426428678365, 9905.55425005862, 10108.595656173964, 10150.340227885164, 10170.338927969658, 10222.13111885498, 9898.158656514277, 9903.108720214927, 9956.20350371954, 10040.315127414588, 10222.0, 9964.950175249078, 10076.24428167905, 10133.391996480235, 10455.059044686015, 10508.316959397614, 7409.37020353276, 7440.813979650552, 7478.5138965967035, 7543.886841697269, 7735.342495887688, 9436.764080898032, 9902.603895844086, 10034.799304014025, 10080.344777589433, 10136.898631013595], "value": 8670.287044004986, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1282.2178471132602, 1443.1557538839782, 1463.2098666719971, 1604.727196376616, 1780.0565700178909, 6841.486888483365, 7630.084389873216, 7815.726449574259, 7829.725959591416, 7833.80415489613, 7540.81147971301, 7696.538207707527, 7707.22927707229, 7716.459847810642, 7725.420593455485, 1894.5074280686983, 1957.2464601128597, 1958.5103724068983, 2236.798688118065, 2265.9660105098437, 2203.449137715571, 2290.290010096867, 2291.9083236670513, 2293.8967746451367, 2295.2196253273883, 2175.641019231825, 2197.154095673169, 2202.273249827553, 2204.6031714291503, 2211.5466329402434, 1881.539022939375, 2093.822025127866, 2210.5799898019404, 2221.366910430536, 2221.4557433428754, 2224.3882932193615, 2242.372135801978, 2242.495438526335, 2244.618414869476, 2247.213475283654, 7629.80925476862, 7684.846303073963, 7689.269519395649, 7690.5385676859005, 7700.4609677322605, 4474.0, 4598.701084429535, 4600.6549508786975, 4614.861554153381, 4638.095571363586, 2902.3759891623404, 3057.2662560985427, 3082.3835232953497, 3092.8608212630484, 3094.6286445626442, 999.9850002249972, 1036.3471013261596, 1040.3445829127677, 1060.750723579958, 1061.7770268243678, 10723.946380268128, 10731.785364292671, 10758.193135514868, 10761.408122553257, 10767.300125491818, 4059.7970101494807, 4167.6874234432535, 4333.696641235083, 4360.561014865087, 4365.890852728708, 9216.63133474667, 9258.95370523143, 9266.21237194846, 9274.0, 9278.907210927939, 4694.108119457293, 4708.882277943078, 4712.458067322234, 4719.646026548023, 4745.477997420281, 3686.6129056448685, 4208.389783481378, 4310.8706738797255, 4318.093200427946, 4350.782460877007, 3616.764910280823, 3644.1436262478296, 3660.432632941898, 3697.2235830475365, 3721.6650501455, 1199.220506670671, 1231.9651492746136, 1234.2039384596885, 1238.9566365177357, 1239.3493415956696, 879.678917195232, 884.7036242858586, 897.3539051882634, 898.85168947123, 904.1862323908535, 5315.229291752674, 5392.838214853561, 5424.321959755031, 5587.441255874462, 5596.720163991866, 426.100927043937, 427.26510402108323, 442.126799570845, 442.59281461055906, 445.49658885459223, 3736.0, 3786.6024067473068, 3797.2974999625158, 3808.1050953026015, 3865.632764887331, 9240.722778316662, 9553.283503737248, 9669.081437263449, 9732.805343893082, 9746.463944483121, 9411.764705882271, 9587.712368628952, 9612.0, 9625.374350667184, 9657.565409556586, 7302.488825782144, 7395.371393431618, 7454.40364770817, 7461.589612571361, 7493.363064139609, 5286.682799032071, 5328.920066198933, 5417.106177480671, 5469.3983661797965, 5481.479259470344, 8588.613512391832, 8672.176143266379, 8754.606042727964, 8754.737357879274, 8877.689280875138, 8676.349273804364, 8843.823123537364, 8869.06874778139, 9053.321000925089, 9064.365494415328, 6200.3179650239335, 6579.736810527525, 6840.281770414035, 6845.349691779472, 7002.8949565757575, 7459.291367320096, 7481.989931359197, 7500.212477689982, 7520.736774212876, 7563.243675632612, 6672.332766723289, 6809.114815074008, 6880.174379074543, 6941.375276225164, 6966.825829354307, 6772.051912732123, 6793.0, 6854.074699915447, 6881.208661004049, 6944.895826562707, 6410.102585637921, 6428.742850285937, 6482.546221764431, 6528.869422611616, 6573.5398522103, 4652.930206046844, 4657.301404789308, 4670.953290467188, 4734.33719279308, 4763.333133361401, 4714.9292760609305, 4751.596114330182, 4791.688540244873, 4814.975925120352, 4825.4933232010135], "value": 4126.5480660963685, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.63428739805533, 317.0520144767147, 317.16110886704666, 323.23877269031414, 328.5203602739999, 5092.77082531286, 5092.974535127324, 5155.226715992593, 5162.586993040552, 5172.6379153459275, 5081.491850814926, 5081.79672813087, 5082.796688132479, 5096.566791822699, 5119.641625086246, 3794.5256842894637, 3848.9807550962205, 3996.5403978542404, 4009.67922566194, 4074.6740260779216, 4007.6994225433064, 4013.8795836124964, 4024.7182697211206, 4042.73722208057, 4045.0696339841707, 3775.6790672792845, 3970.4044393341087, 3973.8013099344917, 3990.4413382126527, 3993.460882780831, 3875.1280961783655, 3944.073142811437, 3986.760794352348, 3997.8200980955635, 4012.2376748417705, 3506.211102501942, 3518.5953615334306, 3532.993096967378, 3535.9292814143573, 3540.76984995977, 4829.806807727687, 4883.804647814083, 4896.540357501361, 4914.975425122887, 4938.530839570235, 4306.837153968442, 4541.704789188725, 4556.270996640522, 4564.680472366936, 4635.5364463553715, 5350.35795704514, 5388.622796404254, 5394.973025134849, 5398.78404863805, 5401.378841433207, 3800.4869342638667, 3815.236952609489, 3815.8855234342736, 3817.0, 3820.407836785275, 5503.944960550383, 5629.127485239795, 5639.097744360924, 5656.4060773618585, 5665.971670141623, 3862.0537968197973, 3887.494625698641, 3891.922161556753, 3894.3768996960916, 3895.0651843557907, 3948.072203032285, 3948.506436695413, 3949.38784488399, 3950.6641935435237, 3960.5841386653988, 4419.845305414359, 4525.705829121097, 4539.6368290536675, 4542.386777784956, 4562.749048802348, 5396.3524377075, 5419.810306639249, 5425.131978883439, 5425.321834770653, 5439.456054394529, 1359.3882752761297, 1377.4490203918513, 1382.4470211915313, 1384.0865029080758, 1387.2162228340956, 875.4854102402878, 901.6213190460022, 921.5760750054916, 924.6856068936594, 937.3438592984937, 4740.454847692559, 4754.809807607726, 4779.402574678165, 4787.593054590398, 4792.640551958617, 5521.8310175817005, 5565.30433695788, 5571.60998730085, 5572.721363931787, 5583.888322233533, 4670.136024835417, 4738.431388233434, 4749.976250118796, 4768.356271903318, 4796.232602783608, 2924.239697678619, 2962.5408061750463, 2963.170312312556, 2964.125582953034, 2972.985135074354, 5206.0, 5217.2434996925995, 5224.686518808883, 5230.084735171406, 5231.738413079407, 5476.342838859283, 5666.603337766399, 5766.192733017381, 5777.220075289866, 5788.392218817048, 5270.0, 5289.127293996525, 5290.095565596383, 5319.281896943863, 5326.307580014651, 5333.839984800462, 5623.156526521055, 5630.943690563206, 5632.690202038927, 5655.208270842003, 5525.751341189736, 5530.889382212253, 5532.751026203911, 5533.5849811263515, 5540.22436858832, 5315.335583052119, 5324.201369794562, 5331.813386531453, 5338.0, 5341.252224688469, 3706.5552133744122, 3923.0, 3929.0766669831996, 3941.3890846918775, 3964.940525892056, 5584.46947539983, 5592.328920529562, 5602.159676048625, 5606.467385598362, 5609.1305847593685, 5408.296921400193, 5408.945910540844, 5421.295231619864, 5431.158170483582, 5432.158015507603, 5239.633225674166, 5416.918746218731, 5418.913718218593, 5437.510624043855, 5444.673319600836, 5077.593792496666, 5300.681959082467, 5310.654807437504, 5358.249845021622, 5361.329833770778, 5194.7922083116255, 5398.64908780928, 5435.673859568438, 5445.1832225166545, 5453.672779633234, 5291.576673866159, 5296.655717378358, 5300.284461597789, 5308.867278318073, 5324.201369794562], "value": 4062.2945450539537, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.3593959949449, 657.8190997475693, 662.5759513911095, 719.7660760252919, 763.0576238345644, 11896.7620647587, 12061.155719099666, 12065.698357541043, 12071.698207544816, 12118.636440906776, 10299.27905046647, 11050.723731906706, 11059.834102488448, 11063.391513466777, 11074.557017719282, 803.1968031968032, 815.9428839981204, 817.239966830847, 817.7342363731781, 818.7543736878943, 798.6046906781152, 807.6365635464035, 808.745245247748, 809.4050872608628, 809.4212637963855, 841.7600983719641, 842.3261390887296, 842.4524059361403, 843.7426584891606, 844.2275318083946, 829.995850020749, 830.5349004557468, 832.076395201326, 832.271762208071, 832.4089896173693, 610.4780412747082, 610.8320211941707, 611.065070442224, 611.7522403426619, 611.8500967263004, 10816.513256903458, 10839.241253112285, 10860.945695271474, 10881.23831331807, 10884.673459796219, 10089.899101009043, 10107.545160467796, 10215.948920255425, 10329.535170917326, 10486.161107111413, 8837.38138330317, 8919.509426981513, 9205.849268841395, 9265.212456941168, 9357.532123393803, 3232.450483417801, 3311.205310725433, 3314.751393645486, 3375.8312084395684, 3387.0, 37319.81340093309, 37561.81219093914, 38946.61053389458, 40178.19643607111, 45164.322535162, 9899.356541824758, 9905.950470247602, 10080.495975201211, 10187.439690816927, 10361.481925903825, 16445.83554164467, 16869.072201028815, 16874.578135546464, 17233.0, 17237.56906077358, 6635.668216589152, 6696.7656132035145, 6746.696398662072, 6862.9313706863295, 6930.0, 3551.5738111426795, 3589.730770192246, 3683.5763887152784, 3723.4414837774007, 3821.3694740368082, 2991.267139550824, 3099.4575949208797, 3102.751779857606, 3105.2392163919985, 3106.9067927962196, 537.7203853995978, 548.1749966300692, 551.5697755750521, 554.7808615596816, 558.6033915919661, 511.9820806271763, 535.9758810853521, 582.2954225387244, 614.4899733221415, 640.0495264532166, 7529.397648188132, 7961.0040654061695, 7998.560079195584, 8017.358611311081, 8031.879521807177, 465.6088885336334, 541.983740487786, 614.7043222636951, 626.4643729611208, 647.795944277551, 3746.269477451871, 3835.76985380878, 3843.1936989615397, 3900.8829735107993, 3921.0785465415606, 52958.47041529613, 53041.0, 53513.0, 53790.73104634452, 54344.184837227476, 44734.55265447304, 44809.32786008212, 45460.54539454563, 45579.544204558195, 46804.5319546807, 35082.64917350845, 42228.57771422308, 42506.14987700291, 43988.78005610016, 44650.3302450457, 7516.285952834472, 7708.845823083395, 7849.17583653731, 7856.175101614248, 8079.151689072798, 27086.0, 27121.1863644091, 27766.44467110606, 27793.305167370978, 27823.582646259918, 35476.290474190886, 35688.286234275685, 36114.638853611126, 36266.0, 36563.26873462569, 10672.359658420519, 10727.141828653845, 10803.243772936134, 10907.672769816601, 11115.555377784798, 11995.820062698893, 12064.939675301568, 12309.93845030769, 12400.689982750504, 13069.0, 11241.66275011751, 11292.322460652387, 11432.314061156358, 11489.885101149215, 11565.0, 10871.510782014986, 11288.830667539829, 11347.432628368713, 11349.602763903555, 11350.54597816078, 9989.650362237287, 10337.17302615804, 10369.585216591553, 10678.62624808128, 10687.786244275227, 9034.819303614022, 9361.531923403667, 9368.578413971523, 9462.668806591737, 9978.301518893608, 8849.823003540021, 8932.598033088396, 8956.507392093497, 9123.224525915106, 9141.131592498701], "value": 5799.473375086829, "unit": "score"}], "name": "dromaeo_css", "value": 6353.592084297486, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 106.0, 111.0, 112.0, 112.0, 100.0, 111.0, 112.0, 111.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 150.0, 161.0, 174.0, 138.0, 154.0, 154.0, 140.0, 191.0, 138.0], "value": 155.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 161.0, 164.0, 161.0, 163.0, 163.0, 161.0, 167.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 73.0, 98.0, 112.0, 74.0, 75.0, 77.0, 114.0, 102.0, 74.0], "value": 87.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 149.0, 94.0, 94.0, 94.0, 146.0, 94.0, 94.0, 149.0], "value": 110.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 118.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 83.0, 65.0, 61.0], "value": 66.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 82.0, 92.0, 84.0, 84.0, 84.0, 85.0, 87.0, 85.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 139.0, 145.0, 136.0, 135.0, 134.0, 137.0, 137.0, 177.0, 138.0], "value": 141.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 172.0, 171.0, 171.0, 171.0, 169.0, 173.0, 170.0, 171.0], "value": 171.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 71.0, 71.0, 72.0, 70.0, 71.0, 72.0, 70.0, 71.0], "value": 71.2, "unit": "score"}], "name": "kraken", "value": 1584.1000000000001, "alertThreshold": 2.0}]} 02:43:15 INFO - Return code: 0 02:43:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:43:15 ERROR - # TBPL SUCCESS # 02:43:15 INFO - Running post-action listener: _resource_record_post_action 02:43:15 INFO - Running post-run listener: _resource_record_post_run 02:43:16 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 526630912; Read time: 8; Write time: 1283956 02:43:16 INFO - install - Wall time: 16s; CPU: 19.0%; Read bytes: 0; Write bytes: 234110976; Read time: 0; Write time: 748692 02:43:16 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292458496; Read time: 8; Write time: 535240 02:43:16 INFO - Running post-run listener: _upload_blobber_files 02:43:16 INFO - Blob upload gear active. 02:43:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:43:16 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 02:43:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:43:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:43:16 INFO - (blobuploader) - INFO - Open directory for files ... 02:43:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:43:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:43:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:43:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:43:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:43:17 INFO - (blobuploader) - INFO - Done attempting. 02:43:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:43:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:43:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:43:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:43:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:43:18 INFO - (blobuploader) - INFO - Done attempting. 02:43:18 INFO - (blobuploader) - INFO - Iteration through files over. 02:43:18 INFO - Return code: 0 02:43:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:43:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:43:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a636c003c3b1e2b9f0ef8668481bd52fc5e7aa10c5e166150af071eed9e49a46da6b4be8e3515e4021179763fba722139cd7eb24e46fe32f02501dab980da92d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/273e1d12a1780b5386975f5df89ea1cb5cc977e51f97daab920189fe1b3780e52977d2fe7a08140498d62c6ba0eb86c215b90d0a3af2a464c2576d84a9c02cf2"} 02:43:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:43:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:43:18 INFO - Contents: 02:43:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a636c003c3b1e2b9f0ef8668481bd52fc5e7aa10c5e166150af071eed9e49a46da6b4be8e3515e4021179763fba722139cd7eb24e46fe32f02501dab980da92d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/273e1d12a1780b5386975f5df89ea1cb5cc977e51f97daab920189fe1b3780e52977d2fe7a08140498d62c6ba0eb86c215b90d0a3af2a464c2576d84a9c02cf2"} 02:43:18 INFO - Running post-run listener: copy_logs_to_upload_dir 02:43:18 INFO - Copying logs to upload dir... 02:43:18 INFO - mkdir: /builds/slave/test/build/upload/logs 02:43:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.662517 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-04-15 02:43:18.347923) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 02:43:18.351438) ========= 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=745a4373a2a16df560f216e000000264-1460711228.396779-400857299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a636c003c3b1e2b9f0ef8668481bd52fc5e7aa10c5e166150af071eed9e49a46da6b4be8e3515e4021179763fba722139cd7eb24e46fe32f02501dab980da92d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/273e1d12a1780b5386975f5df89ea1cb5cc977e51f97daab920189fe1b3780e52977d2fe7a08140498d62c6ba0eb86c215b90d0a3af2a464c2576d84a9c02cf2"} build_url:https://queue.taskcluster.net/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011300 build_url: 'https://queue.taskcluster.net/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a636c003c3b1e2b9f0ef8668481bd52fc5e7aa10c5e166150af071eed9e49a46da6b4be8e3515e4021179763fba722139cd7eb24e46fe32f02501dab980da92d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/273e1d12a1780b5386975f5df89ea1cb5cc977e51f97daab920189fe1b3780e52977d2fe7a08140498d62c6ba0eb86c215b90d0a3af2a464c2576d84a9c02cf2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 02:43:18.376140) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:43:18.376456) ========= 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=745a4373a2a16df560f216e000000264-1460711228.396779-400857299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004412 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:43:18.459582) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 02:43:18.459986) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 02:43:18.460412) ========= ========= Total master_lag: 0.24 =========