builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-058 starttime: 1461839142.94 results: success (0) buildid: 20160428030702 builduid: 07d7f3686f2a487cb1b5ac98c5ea4e48 revision: 315ad011b1fd6fbda1f8938c28145e9a28e1b460 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 03:25:42.942034) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 03:25:42.942907) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 03:25:42.943701) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 03:25:42.957044) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 03:25:42.957305) ========= 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=0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 03:25:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-04-28 03:25:43 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087171 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 03:25:43.055197) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 03:25:43.055502) ========= 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=0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016132 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 03:25:43.105650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 03:25:43.106008) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 315ad011b1fd6fbda1f8938c28145e9a28e1b460 --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 315ad011b1fd6fbda1f8938c28145e9a28e1b460 --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=0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 03:25:43,876 truncating revision to first 12 chars 2016-04-28 03:25:43,876 Setting DEBUG logging. 2016-04-28 03:25:43,876 attempt 1/10 2016-04-28 03:25:43,876 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/315ad011b1fd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 03:25:44,207 unpacking tar archive at: fx-team-315ad011b1fd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631173 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 03:25:43.750203) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 03:25:43.750522) ========= script_repo_revision: 315ad011b1fd6fbda1f8938c28145e9a28e1b460 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 03:25:43.750911) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 03:25:43.751186) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 03:25:43.759467) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-28 03:25:43.759754) ========= /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=0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:25:44 INFO - MultiFileLogger online at 20160428 03:25:44 in /builds/slave/test 03:25:44 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 03:25:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:25:44 INFO - {'append_to_log': False, 03:25:44 INFO - 'base_work_dir': '/builds/slave/test', 03:25:44 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:25:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:25:44 INFO - 'branch': 'Fx-Team-Non-PGO', 03:25:44 INFO - 'buildbot_json_path': 'buildprops.json', 03:25:44 INFO - 'config_files': ('talos/linux_config.py',), 03:25:44 INFO - 'default_actions': ('clobber', 03:25:44 INFO - 'read-buildbot-config', 03:25:44 INFO - 'download-and-extract', 03:25:44 INFO - 'populate-webroot', 03:25:44 INFO - 'create-virtualenv', 03:25:44 INFO - 'install', 03:25:44 INFO - 'run-tests'), 03:25:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:25:44 INFO - 'download_minidump_stackwalk': True, 03:25:44 INFO - 'download_symbols': 'ondemand', 03:25:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:25:44 INFO - 'tooltool.py': '/tools/tooltool.py', 03:25:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:25:44 INFO - '/tools/misc-python/virtualenv.py')}, 03:25:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:25:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:25:44 INFO - 'installer_path': 'installer.exe', 03:25:44 INFO - 'log_level': 'info', 03:25:44 INFO - 'log_name': 'talos', 03:25:44 INFO - 'log_to_console': True, 03:25:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:25:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:25:44 INFO - 'opt_config_files': (), 03:25:44 INFO - 'pip_index': False, 03:25:44 INFO - 'sps_profile': False, 03:25:44 INFO - 'sps_profile_interval': 0, 03:25:44 INFO - 'suite': 'dromaeojs', 03:25:44 INFO - 'system_bits': '32', 03:25:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:25:44 INFO - 'title': 'talos-linux64-ix-058', 03:25:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:25:44 INFO - 'use_talos_json': True, 03:25:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:25:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:25:44 INFO - 'work_dir': 'build'} 03:25:44 INFO - ##### 03:25:44 INFO - ##### Running clobber step. 03:25:44 INFO - ##### 03:25:44 INFO - Running pre-action listener: _resource_record_pre_action 03:25:44 INFO - Running main action method: clobber 03:25:44 INFO - rmtree: /builds/slave/test/build 03:25:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:25:45 INFO - Running post-action listener: _resource_record_post_action 03:25:45 INFO - ##### 03:25:45 INFO - ##### Running read-buildbot-config step. 03:25:45 INFO - ##### 03:25:45 INFO - Running pre-action listener: _resource_record_pre_action 03:25:45 INFO - Running main action method: read_buildbot_config 03:25:45 INFO - Using buildbot properties: 03:25:45 INFO - { 03:25:45 INFO - "project": "", 03:25:45 INFO - "product": "firefox", 03:25:45 INFO - "script_repo_revision": "production", 03:25:45 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:25:45 INFO - "repository": "", 03:25:45 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:25:45 INFO - "buildid": "20160428030702", 03:25:45 INFO - "pgo_build": "False", 03:25:45 INFO - "basedir": "/builds/slave/test", 03:25:45 INFO - "buildnumber": 1615, 03:25:45 INFO - "slavename": "talos-linux64-ix-058", 03:25:45 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:25:45 INFO - "platform": "ubuntu64_hw", 03:25:45 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:25:45 INFO - "branch": "fx-team", 03:25:45 INFO - "repo_path": "integration/fx-team", 03:25:45 INFO - "revision": "315ad011b1fd6fbda1f8938c28145e9a28e1b460", 03:25:45 INFO - "stage_platform": "linux64", 03:25:45 INFO - "builduid": "07d7f3686f2a487cb1b5ac98c5ea4e48", 03:25:45 INFO - "slavebuilddir": "test" 03:25:45 INFO - } 03:25:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 03:25:45 INFO - Running post-action listener: _resource_record_post_action 03:25:45 INFO - ##### 03:25:45 INFO - ##### Running download-and-extract step. 03:25:45 INFO - ##### 03:25:45 INFO - Running pre-action listener: _resource_record_pre_action 03:25:45 INFO - Running main action method: download_and_extract 03:25:45 INFO - mkdir: /builds/slave/test/build/tests 03:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:45 INFO - https://queue.taskcluster.net/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:25:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:25:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:25:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:25:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:25:45 INFO - Downloaded 1361 bytes. 03:25:45 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:25:45 INFO - Using the following test package requirements: 03:25:45 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:25:45 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:25:45 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:25:45 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:45 INFO - u'jsshell-linux-x86_64.zip'], 03:25:45 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:25:45 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:25:45 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:25:45 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:25:45 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:25:45 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:25:45 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:45 INFO - https://queue.taskcluster.net/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:25:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:25:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:25:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:25:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:25:47 INFO - Downloaded 22293734 bytes. 03:25:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:25:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:25:48 INFO - Return code: 0 03:25:48 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:48 INFO - https://queue.taskcluster.net/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:25:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:25:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:25:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:25:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:25:49 INFO - Downloaded 22293734 bytes. 03:25:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:25:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:25:50 INFO - Return code: 0 03:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:50 INFO - https://queue.taskcluster.net/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:25:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:25:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:25:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:25:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:25:51 INFO - Downloaded 10840145 bytes. 03:25:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:25:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:25:51 INFO - Return code: 0 03:25: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')]} 03:25:51 INFO - https://queue.taskcluster.net/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:25:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:25:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:25:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:25:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:25:53 INFO - Downloaded 54841807 bytes. 03:25:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:25:53 INFO - mkdir: /builds/slave/test/properties 03:25:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:25:53 INFO - Writing to file /builds/slave/test/properties/build_url 03:25:53 INFO - Contents: 03:25:53 INFO - build_url:https://queue.taskcluster.net/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:25:53 INFO - Running post-action listener: _resource_record_post_action 03:25:53 INFO - Running post-action listener: set_extra_try_arguments 03:25:53 INFO - ##### 03:25:53 INFO - ##### Running populate-webroot step. 03:25:53 INFO - ##### 03:25:53 INFO - Running pre-action listener: _resource_record_pre_action 03:25:53 INFO - Running main action method: populate_webroot 03:25:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:25:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:25:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:25:54 INFO - '--tppagecycles', 03:25:54 INFO - '7'], 03:25:54 INFO - 'tests': ['tsvgm']}}, 03:25:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:25:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:25:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:25:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:25:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:25:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:25:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:54 INFO - 'talos_options': ['--disable-e10s'], 03:25:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:54 INFO - 'talos_options': ['--disable-e10s'], 03:25:54 INFO - 'tests': ['damp', 'tps']}, 03:25:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:54 INFO - 'tests': ['damp', 'tps']}, 03:25:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:25:54 INFO - 'tests': ['dromaeo_dom']}, 03:25:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:25:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:25:54 INFO - 'tests': ['a11yr', 03:25:54 INFO - 'ts_paint', 03:25:54 INFO - 'tpaint', 03:25:54 INFO - 'sessionrestore', 03:25:54 INFO - 'sessionrestore_no_auto_restore', 03:25:54 INFO - 'tabpaint']}, 03:25:54 INFO - 'other-e10s': {'tests': ['a11yr', 03:25:54 INFO - 'ts_paint', 03:25:54 INFO - 'tpaint', 03:25:54 INFO - 'sessionrestore', 03:25:54 INFO - 'sessionrestore_no_auto_restore', 03:25:54 INFO - 'tabpaint']}, 03:25:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:25:54 INFO - 'ts_paint', 03:25:54 INFO - 'tpaint', 03:25:54 INFO - 'sessionrestore', 03:25:54 INFO - 'sessionrestore_no_auto_restore', 03:25:54 INFO - 'tabpaint']}, 03:25:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:25:54 INFO - 'ts_paint', 03:25:54 INFO - 'tpaint', 03:25:54 INFO - 'sessionrestore', 03:25:54 INFO - 'sessionrestore_no_auto_restore', 03:25:54 INFO - 'tabpaint']}, 03:25:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:25:54 INFO - 'tests': ['a11yr', 03:25:54 INFO - 'ts_paint', 03:25:54 INFO - 'tpaint', 03:25:54 INFO - 'sessionrestore', 03:25:54 INFO - 'sessionrestore_no_auto_restore', 03:25:54 INFO - 'tabpaint']}, 03:25:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:25:54 INFO - 'tests': ['a11yr', 03:25:54 INFO - 'ts_paint', 03:25:54 INFO - 'tpaint', 03:25:54 INFO - 'sessionrestore', 03:25:54 INFO - 'sessionrestore_no_auto_restore', 03:25:54 INFO - 'tabpaint']}, 03:25:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:25:54 INFO - 'tests': ['tsvgx', 03:25:54 INFO - 'tsvgr_opacity', 03:25:54 INFO - 'tart', 03:25:54 INFO - 'tscrollx', 03:25:54 INFO - 'cart']}, 03:25:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:25:54 INFO - 'tsvgr_opacity', 03:25:54 INFO - 'tart', 03:25:54 INFO - 'tscrollx', 03:25:54 INFO - 'cart']}, 03:25:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:54 INFO - 'talos_options': ['--disable-e10s'], 03:25:54 INFO - 'tests': ['tp5o']}, 03:25:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:54 INFO - 'tests': ['tp5o']}, 03:25:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:54 INFO - 'talos_options': ['--disable-e10s', 03:25:54 INFO - '--xperf_path', 03:25:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:54 INFO - 'tests': ['tp5n']}, 03:25:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:54 INFO - 'talos_options': ['--xperf_path', 03:25:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:54 INFO - 'tests': ['tp5n']}}, 03:25:54 INFO - 'talos.zip': {'path': '', 03:25:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:25:54 INFO - Running post-action listener: _resource_record_post_action 03:25:54 INFO - ##### 03:25:54 INFO - ##### Running create-virtualenv step. 03:25:54 INFO - ##### 03:25:54 INFO - Running pre-action listener: _resource_record_pre_action 03:25:54 INFO - Running main action method: create_virtualenv 03:25:54 INFO - Creating virtualenv /builds/slave/test/build/venv 03:25:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:25:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:25:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:25:54 INFO - Using real prefix '/usr' 03:25:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:25:54 INFO - Installing distribute.............................................................................................................................................................................................done. 03:25:56 INFO - Installing pip.................done. 03:25:56 INFO - Return code: 0 03:25:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:25: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')]} 03:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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')]} 03:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29946af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f185a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7410>, '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 0x1fa8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa87a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25: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', 'pip>=1.5'] in /builds/slave/test/build 03:25: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 pip>=1.5 03:25:56 INFO - Using env: {'DISPLAY': ':0', 03:25:56 INFO - 'HOME': '/home/cltbld', 03:25:56 INFO - 'LANG': 'en_US.UTF-8', 03:25:56 INFO - 'LANGUAGE': 'en_US:en', 03:25:56 INFO - 'LOGNAME': 'cltbld', 03:25:56 INFO - 'MAIL': '/var/mail/cltbld', 03:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:56 INFO - 'MOZ_NO_REMOTE': '1', 03:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:56 INFO - 'NO_EM_RESTART': '1', 03:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:56 INFO - 'PWD': '/builds/slave/test', 03:25:56 INFO - 'SHELL': '/bin/bash', 03:25:56 INFO - 'SHLVL': '1', 03:25:56 INFO - 'TERM': 'linux', 03:25:56 INFO - 'TMOUT': '86400', 03:25:56 INFO - 'USER': 'cltbld', 03:25:56 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981', 03:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:56 INFO - '_': '/tools/buildbot/bin/python'} 03:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:25:56 INFO - Cleaning up... 03:25:56 INFO - Return code: 0 03:25:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:25: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')]} 03:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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')]} 03:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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', '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 0x7fe29946af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f185a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7410>, '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 0x1fa8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa87a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25: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', 'psutil>=0.7.1'] in /builds/slave/test/build 03:25: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 psutil>=0.7.1 03:25:56 INFO - Using env: {'DISPLAY': ':0', 03:25:56 INFO - 'HOME': '/home/cltbld', 03:25:56 INFO - 'LANG': 'en_US.UTF-8', 03:25:56 INFO - 'LANGUAGE': 'en_US:en', 03:25:56 INFO - 'LOGNAME': 'cltbld', 03:25:56 INFO - 'MAIL': '/var/mail/cltbld', 03:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:56 INFO - 'MOZ_NO_REMOTE': '1', 03:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:56 INFO - 'NO_EM_RESTART': '1', 03:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:56 INFO - 'PWD': '/builds/slave/test', 03:25:56 INFO - 'SHELL': '/bin/bash', 03:25:56 INFO - 'SHLVL': '1', 03:25:56 INFO - 'TERM': 'linux', 03:25:56 INFO - 'TMOUT': '86400', 03:25:56 INFO - 'USER': 'cltbld', 03:25:56 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981', 03:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:56 INFO - '_': '/tools/buildbot/bin/python'} 03:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:57 INFO - Downloading/unpacking psutil>=0.7.1 03:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:25:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:59 INFO - Installing collected packages: psutil 03:25:59 INFO - Running setup.py install for psutil 03:25:59 INFO - building 'psutil._psutil_linux' extension 03:25:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:25:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:25:59 INFO - building 'psutil._psutil_posix' extension 03:25:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:25:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:25:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:59 INFO - Successfully installed psutil 03:25:59 INFO - Cleaning up... 03:25:59 INFO - Return code: 0 03:25:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:59 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 0x7fe29946af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f185a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7410>, '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 0x1fa8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa87a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:25:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:25:59 INFO - Using env: {'DISPLAY': ':0', 03:25:59 INFO - 'HOME': '/home/cltbld', 03:25:59 INFO - 'LANG': 'en_US.UTF-8', 03:25:59 INFO - 'LANGUAGE': 'en_US:en', 03:25:59 INFO - 'LOGNAME': 'cltbld', 03:25:59 INFO - 'MAIL': '/var/mail/cltbld', 03:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:59 INFO - 'MOZ_NO_REMOTE': '1', 03:25:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:59 INFO - 'NO_EM_RESTART': '1', 03:25:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:59 INFO - 'PWD': '/builds/slave/test', 03:25:59 INFO - 'SHELL': '/bin/bash', 03:25:59 INFO - 'SHLVL': '1', 03:25:59 INFO - 'TERM': 'linux', 03:25:59 INFO - 'TMOUT': '86400', 03:25:59 INFO - 'USER': 'cltbld', 03:25:59 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981', 03:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:59 INFO - '_': '/tools/buildbot/bin/python'} 03:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:26:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:26:01 INFO - Installing collected packages: mozsystemmonitor 03:26:01 INFO - Running setup.py install for mozsystemmonitor 03:26:01 INFO - Successfully installed mozsystemmonitor 03:26:01 INFO - Cleaning up... 03:26:01 INFO - Return code: 0 03:26:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:01 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 0x7fe29946af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f185a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7410>, '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 0x1fa8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa87a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:26:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:26:01 INFO - Using env: {'DISPLAY': ':0', 03:26:01 INFO - 'HOME': '/home/cltbld', 03:26:01 INFO - 'LANG': 'en_US.UTF-8', 03:26:01 INFO - 'LANGUAGE': 'en_US:en', 03:26:01 INFO - 'LOGNAME': 'cltbld', 03:26:01 INFO - 'MAIL': '/var/mail/cltbld', 03:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:01 INFO - 'MOZ_NO_REMOTE': '1', 03:26:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:01 INFO - 'NO_EM_RESTART': '1', 03:26:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:01 INFO - 'PWD': '/builds/slave/test', 03:26:01 INFO - 'SHELL': '/bin/bash', 03:26:01 INFO - 'SHLVL': '1', 03:26:01 INFO - 'TERM': 'linux', 03:26:01 INFO - 'TMOUT': '86400', 03:26:01 INFO - 'USER': 'cltbld', 03:26:01 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981', 03:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:01 INFO - '_': '/tools/buildbot/bin/python'} 03:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:02 INFO - Downloading/unpacking blobuploader==1.2.4 03:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:04 INFO - Downloading blobuploader-1.2.4.tar.gz 03:26:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:26:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:26: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 03:26: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 03:26: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 03:26: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 03:26: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 03:26: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 03:26:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:26:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:26: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 03:26: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 03:26: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 03:26: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 03:26: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 03:26: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 03:26:04 INFO - Downloading docopt-0.6.1.tar.gz 03:26:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:26:04 INFO - Installing collected packages: blobuploader, requests, docopt 03:26:04 INFO - Running setup.py install for blobuploader 03:26:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:26:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:26:04 INFO - Running setup.py install for requests 03:26:05 INFO - Running setup.py install for docopt 03:26:05 INFO - Successfully installed blobuploader requests docopt 03:26:05 INFO - Cleaning up... 03:26:05 INFO - Return code: 0 03:26:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:05 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 0x7fe29946af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f185a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7410>, '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 0x1fa8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa87a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:26:05 INFO - Using env: {'DISPLAY': ':0', 03:26:05 INFO - 'HOME': '/home/cltbld', 03:26:05 INFO - 'LANG': 'en_US.UTF-8', 03:26:05 INFO - 'LANGUAGE': 'en_US:en', 03:26:05 INFO - 'LOGNAME': 'cltbld', 03:26:05 INFO - 'MAIL': '/var/mail/cltbld', 03:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:05 INFO - 'MOZ_NO_REMOTE': '1', 03:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:05 INFO - 'NO_EM_RESTART': '1', 03:26:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:05 INFO - 'PWD': '/builds/slave/test', 03:26:05 INFO - 'SHELL': '/bin/bash', 03:26:05 INFO - 'SHLVL': '1', 03:26:05 INFO - 'TERM': 'linux', 03:26:05 INFO - 'TMOUT': '86400', 03:26:05 INFO - 'USER': 'cltbld', 03:26:05 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981', 03:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:05 INFO - '_': '/tools/buildbot/bin/python'} 03:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:05 INFO - Running setup.py (path:/tmp/pip-G8DeJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:06 INFO - Running setup.py (path:/tmp/pip-ab4nPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:06 INFO - Running setup.py (path:/tmp/pip-6MxnGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:06 INFO - Running setup.py (path:/tmp/pip-1E71XS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:06 INFO - Running setup.py (path:/tmp/pip-iXoZZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:06 INFO - Running setup.py (path:/tmp/pip-0aTkKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:06 INFO - Running setup.py (path:/tmp/pip-Podk9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:06 INFO - Running setup.py (path:/tmp/pip-9gdxA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:06 INFO - Running setup.py (path:/tmp/pip-375drH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:06 INFO - Running setup.py (path:/tmp/pip-Hp8Lj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:06 INFO - Running setup.py (path:/tmp/pip-QDt7mF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:06 INFO - Running setup.py (path:/tmp/pip-Vd7aQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:06 INFO - Running setup.py (path:/tmp/pip-wjXYsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:06 INFO - Running setup.py (path:/tmp/pip-3BG0vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:06 INFO - Running setup.py (path:/tmp/pip-YsWbGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:07 INFO - Running setup.py (path:/tmp/pip-jLI4zs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:07 INFO - Running setup.py (path:/tmp/pip-Dpznmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:26:07 INFO - Running setup.py install for manifestparser 03:26:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:26:07 INFO - Running setup.py install for mozcrash 03:26:07 INFO - Running setup.py install for mozdebug 03:26:07 INFO - Running setup.py install for mozdevice 03:26:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:26:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:26:07 INFO - Running setup.py install for mozfile 03:26:07 INFO - Running setup.py install for mozhttpd 03:26:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:26:07 INFO - Running setup.py install for mozinfo 03:26:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:26:07 INFO - Running setup.py install for mozInstall 03:26:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:26:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:26:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:26:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:26:07 INFO - Running setup.py install for mozleak 03:26:08 INFO - Running setup.py install for mozlog 03:26:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:26:08 INFO - Running setup.py install for moznetwork 03:26:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:26:08 INFO - Running setup.py install for mozprocess 03:26:08 INFO - Running setup.py install for mozprofile 03:26:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:26:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:26:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:26:08 INFO - Running setup.py install for mozrunner 03:26:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:26:08 INFO - Running setup.py install for mozscreenshot 03:26:08 INFO - Running setup.py install for moztest 03:26:08 INFO - Running setup.py install for mozversion 03:26:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:26:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:26:08 INFO - Cleaning up... 03:26:08 INFO - Return code: 0 03:26:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:08 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 0x7fe29946af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f185a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7410>, '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 0x1fa8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa87a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:26:08 INFO - Using env: {'DISPLAY': ':0', 03:26:08 INFO - 'HOME': '/home/cltbld', 03:26:08 INFO - 'LANG': 'en_US.UTF-8', 03:26:08 INFO - 'LANGUAGE': 'en_US:en', 03:26:08 INFO - 'LOGNAME': 'cltbld', 03:26:08 INFO - 'MAIL': '/var/mail/cltbld', 03:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:08 INFO - 'MOZ_NO_REMOTE': '1', 03:26:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:08 INFO - 'NO_EM_RESTART': '1', 03:26:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:08 INFO - 'PWD': '/builds/slave/test', 03:26:08 INFO - 'SHELL': '/bin/bash', 03:26:08 INFO - 'SHLVL': '1', 03:26:08 INFO - 'TERM': 'linux', 03:26:08 INFO - 'TMOUT': '86400', 03:26:08 INFO - 'USER': 'cltbld', 03:26:08 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981', 03:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:08 INFO - '_': '/tools/buildbot/bin/python'} 03:26:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:09 INFO - Running setup.py (path:/tmp/pip-0sRGiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:09 INFO - Running setup.py (path:/tmp/pip-OXodpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:09 INFO - Running setup.py (path:/tmp/pip-zTll_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:09 INFO - Running setup.py (path:/tmp/pip-hWe39c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:09 INFO - Running setup.py (path:/tmp/pip-JI6r98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:09 INFO - Running setup.py (path:/tmp/pip-snwgVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:09 INFO - Running setup.py (path:/tmp/pip-_7C_dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:09 INFO - Running setup.py (path:/tmp/pip-F0v6a4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:09 INFO - Running setup.py (path:/tmp/pip-Z1VMPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:09 INFO - Running setup.py (path:/tmp/pip-GK2BNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:09 INFO - Running setup.py (path:/tmp/pip-6zmLgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:09 INFO - Running setup.py (path:/tmp/pip-KiR4Jx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:10 INFO - Running setup.py (path:/tmp/pip-QmgKH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:10 INFO - Running setup.py (path:/tmp/pip-2C2R9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:10 INFO - Running setup.py (path:/tmp/pip-exWoDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:10 INFO - Running setup.py (path:/tmp/pip-RqMW4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:10 INFO - Running setup.py (path:/tmp/pip-Ick3dH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:26:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26: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 03:26: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 03:26: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 03:26: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 03:26: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 03:26: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 03:26:12 INFO - Downloading blessings-1.6.tar.gz 03:26:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:26:12 INFO - Installing collected packages: blessings 03:26:12 INFO - Running setup.py install for blessings 03:26:12 INFO - Successfully installed blessings 03:26:12 INFO - Cleaning up... 03:26:12 INFO - Return code: 0 03:26:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:26:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:12 INFO - Reading from file tmpfile_stdout 03:26:12 INFO - Current package versions: 03:26:12 INFO - argparse == 1.2.1 03:26:12 INFO - blessings == 1.6 03:26:12 INFO - blobuploader == 1.2.4 03:26:12 INFO - docopt == 0.6.1 03:26:12 INFO - manifestparser == 1.1 03:26:12 INFO - mozInstall == 1.12 03:26:12 INFO - mozcrash == 0.17 03:26:12 INFO - mozdebug == 0.1 03:26:12 INFO - mozdevice == 0.48 03:26:12 INFO - mozfile == 1.2 03:26:12 INFO - mozhttpd == 0.7 03:26:12 INFO - mozinfo == 0.9 03:26:12 INFO - mozleak == 0.1 03:26:12 INFO - mozlog == 3.1 03:26:12 INFO - moznetwork == 0.27 03:26:12 INFO - mozprocess == 0.22 03:26:12 INFO - mozprofile == 0.28 03:26:12 INFO - mozrunner == 6.11 03:26:12 INFO - mozscreenshot == 0.1 03:26:12 INFO - mozsystemmonitor == 0.0 03:26:12 INFO - moztest == 0.7 03:26:12 INFO - mozversion == 1.4 03:26:12 INFO - psutil == 3.1.1 03:26:12 INFO - requests == 1.2.3 03:26:12 INFO - wsgiref == 0.1.2 03:26:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:12 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 0x7fe29946af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f185a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7410>, '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 0x1fa8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa87a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:26:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:26:12 INFO - Using env: {'DISPLAY': ':0', 03:26:12 INFO - 'HOME': '/home/cltbld', 03:26:12 INFO - 'LANG': 'en_US.UTF-8', 03:26:12 INFO - 'LANGUAGE': 'en_US:en', 03:26:12 INFO - 'LOGNAME': 'cltbld', 03:26:12 INFO - 'MAIL': '/var/mail/cltbld', 03:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:12 INFO - 'MOZ_NO_REMOTE': '1', 03:26:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:12 INFO - 'NO_EM_RESTART': '1', 03:26:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:12 INFO - 'PWD': '/builds/slave/test', 03:26:12 INFO - 'SHELL': '/bin/bash', 03:26:12 INFO - 'SHLVL': '1', 03:26:12 INFO - 'TERM': 'linux', 03:26:12 INFO - 'TMOUT': '86400', 03:26:12 INFO - 'USER': 'cltbld', 03:26:12 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981', 03:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:12 INFO - '_': '/tools/buildbot/bin/python'} 03:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:26:12 INFO - Cleaning up... 03:26:12 INFO - Return code: 0 03:26:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:12 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 0x7fe29946af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f185a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7410>, '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 0x1fa8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa87a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:26:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:26:12 INFO - Using env: {'DISPLAY': ':0', 03:26:12 INFO - 'HOME': '/home/cltbld', 03:26:12 INFO - 'LANG': 'en_US.UTF-8', 03:26:12 INFO - 'LANGUAGE': 'en_US:en', 03:26:12 INFO - 'LOGNAME': 'cltbld', 03:26:12 INFO - 'MAIL': '/var/mail/cltbld', 03:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:12 INFO - 'MOZ_NO_REMOTE': '1', 03:26:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:12 INFO - 'NO_EM_RESTART': '1', 03:26:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:12 INFO - 'PWD': '/builds/slave/test', 03:26:12 INFO - 'SHELL': '/bin/bash', 03:26:12 INFO - 'SHLVL': '1', 03:26:12 INFO - 'TERM': 'linux', 03:26:12 INFO - 'TMOUT': '86400', 03:26:12 INFO - 'USER': 'cltbld', 03:26:12 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981', 03:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:12 INFO - '_': '/tools/buildbot/bin/python'} 03:26:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:13 INFO - Downloading/unpacking jsonschema 03:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:26:15 INFO - Downloading/unpacking functools32 (from jsonschema) 03:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:15 INFO - Downloading functools32-3.2.3-2.tar.gz 03:26:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:26:15 INFO - warning: no files found matching '*.txt' 03:26:15 INFO - no previously-included directories found matching 'build' 03:26:15 INFO - no previously-included directories found matching 'dist' 03:26:15 INFO - no previously-included directories found matching '.git*' 03:26:15 INFO - Installing collected packages: jsonschema, functools32 03:26:15 INFO - Running setup.py install for functools32 03:26:15 INFO - warning: no files found matching '*.txt' 03:26:15 INFO - no previously-included directories found matching 'build' 03:26:15 INFO - no previously-included directories found matching 'dist' 03:26:15 INFO - no previously-included directories found matching '.git*' 03:26:15 INFO - Successfully installed jsonschema functools32 03:26:15 INFO - Cleaning up... 03:26:15 INFO - Return code: 0 03:26:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29946af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f185a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7410>, '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 0x1fa8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa87a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:26:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:26:15 INFO - Using env: {'DISPLAY': ':0', 03:26:15 INFO - 'HOME': '/home/cltbld', 03:26:15 INFO - 'LANG': 'en_US.UTF-8', 03:26:15 INFO - 'LANGUAGE': 'en_US:en', 03:26:15 INFO - 'LOGNAME': 'cltbld', 03:26:15 INFO - 'MAIL': '/var/mail/cltbld', 03:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:15 INFO - 'MOZ_NO_REMOTE': '1', 03:26:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:15 INFO - 'NO_EM_RESTART': '1', 03:26:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:15 INFO - 'PWD': '/builds/slave/test', 03:26:15 INFO - 'SHELL': '/bin/bash', 03:26:15 INFO - 'SHLVL': '1', 03:26:15 INFO - 'TERM': 'linux', 03:26:15 INFO - 'TMOUT': '86400', 03:26:15 INFO - 'USER': 'cltbld', 03:26:15 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981', 03:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:15 INFO - '_': '/tools/buildbot/bin/python'} 03:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:15 INFO - Downloading/unpacking flake8 03:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:26:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:26:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:26:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:26:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:26:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:26:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:26:18 INFO - no previously-included directories found matching 'docs/_build' 03:26:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:26:18 INFO - Running setup.py install for pep8 03:26:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:26:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:26:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:26:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:26:18 INFO - no previously-included directories found matching 'docs/_build' 03:26:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:26:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:26:18 INFO - Cleaning up... 03:26:18 INFO - Return code: 0 03:26:18 INFO - Running post-action listener: _resource_record_post_action 03:26:18 INFO - Running post-action listener: _start_resource_monitoring 03:26:18 INFO - Starting resource monitoring. 03:26:18 INFO - ##### 03:26:18 INFO - ##### Running install step. 03:26:18 INFO - ##### 03:26:18 INFO - Running pre-action listener: _resource_record_pre_action 03:26:18 INFO - Running main action method: install 03:26:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:18 INFO - Reading from file tmpfile_stdout 03:26:18 INFO - Detecting whether we're running mozinstall >=1.0... 03:26:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:26:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:26:18 INFO - Reading from file tmpfile_stdout 03:26:18 INFO - Output received: 03:26:18 INFO - Usage: mozinstall [options] installer 03:26:18 INFO - Options: 03:26:18 INFO - -h, --help show this help message and exit 03:26:18 INFO - -d DEST, --destination=DEST 03:26:18 INFO - Directory to install application into. [default: 03:26:18 INFO - "/builds/slave/test"] 03:26:18 INFO - --app=APP Application being installed. [default: firefox] 03:26:18 INFO - mkdir: /builds/slave/test/build/application 03:26:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:26:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:26:34 INFO - Reading from file tmpfile_stdout 03:26:34 INFO - Output received: 03:26:34 INFO - /builds/slave/test/build/application/firefox/firefox 03:26:34 INFO - Running post-action listener: _resource_record_post_action 03:26:34 INFO - ##### 03:26:34 INFO - ##### Running run-tests step. 03:26:34 INFO - ##### 03:26:34 INFO - Running pre-action listener: _resource_record_pre_action 03:26:34 INFO - Running main action method: run_tests 03:26:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:26:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:26:34 INFO - Python 2.7.3 03:26:34 INFO - Return code: 0 03:26:34 INFO - grabbing minidump binary from tooltool 03:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa7410>, '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 0x1fa8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa87a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:26:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:26:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:26:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:26:34 INFO - Return code: 0 03:26:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:26:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:26:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:26:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:26:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:26:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:26:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:26:35 INFO - Return code: 0 03:26:35 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/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 03:26:35 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/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 03:26:35 INFO - Using env: {'DISPLAY': ':0', 03:26:35 INFO - 'HOME': '/home/cltbld', 03:26:35 INFO - 'LANG': 'en_US.UTF-8', 03:26:35 INFO - 'LANGUAGE': 'en_US:en', 03:26:35 INFO - 'LOGNAME': 'cltbld', 03:26:35 INFO - 'MAIL': '/var/mail/cltbld', 03:26:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:26:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:26:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:35 INFO - 'MOZ_NO_REMOTE': '1', 03:26:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:26:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:35 INFO - 'NO_EM_RESTART': '1', 03:26:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:35 INFO - 'PWD': '/builds/slave/test', 03:26:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:26:35 INFO - 'SHELL': '/bin/bash', 03:26:35 INFO - 'SHLVL': '1', 03:26:35 INFO - 'TERM': 'linux', 03:26:35 INFO - 'TMOUT': '86400', 03:26:35 INFO - 'USER': 'cltbld', 03:26:35 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981', 03:26:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:35 INFO - '_': '/tools/buildbot/bin/python'} 03:26:35 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/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 03:26:35 INFO - mozversion application_buildid: 20160428030702 03:26:35 INFO - mozversion application_changeset: 315ad011b1fd6fbda1f8938c28145e9a28e1b460 03:26:35 INFO - mozversion application_display_name: Nightly 03:26:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:26:35 INFO - mozversion application_name: Firefox 03:26:35 INFO - mozversion application_remotingname: firefox 03:26:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:26:35 INFO - mozversion application_vendor: Mozilla 03:26:35 INFO - mozversion application_version: 49.0a1 03:26:35 INFO - mozversion platform_buildid: 20160428030702 03:26:35 INFO - mozversion platform_changeset: 315ad011b1fd6fbda1f8938c28145e9a28e1b460 03:26:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:26:35 INFO - mozversion platform_version: 49.0a1 03:26:35 INFO - using testdate: 1461839195 03:26:35 INFO - actual date: 1461839195 03:26:35 INFO - starting webserver on 'localhost:32924' 03:26:35 INFO - SUITE-START | Running 2 tests 03:26:35 INFO - TEST-START | dromaeo_css 03:26:35 INFO - operating with platform_type : linux_ 03:26:35 INFO - Initialising browser for dromaeo_css test... 03:26:35 INFO - TEST-INFO | started process 27972 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_JSGcN/profile http://localhost:32924/getInfo.html) 03:26:40 INFO - PROCESS | 27972 | __metrics Screen width/height:1600/1200 03:26:40 INFO - PROCESS | 27972 | colorDepth:24 03:26:40 INFO - PROCESS | 27972 | Browser inner width/height: 1024/697 03:26:40 INFO - PROCESS | 27972 | __metrics 03:26:41 ERROR - PROCESS | 27972 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:26:42 INFO - TEST-INFO | 27972: exit 0 03:26:42 INFO - Browser initialized. 03:26:42 INFO - Running cycle 1/1 for dromaeo_css test... 03:26:42 INFO - TEST-INFO | started process 28052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_JSGcN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:53 INFO - PROCESS | 28052 | RSS: Main: 156954624 03:26:53 INFO - PROCESS | 28052 | 03:27:45 INFO - PROCESS | 28052 | 1461839265600 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:29:56 INFO - PROCESS | 28052 | Cycle 1(1): loaded http://localhost:32924/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32924/tests/dromaeo/cssquery-ext.html) 03:29:57 INFO - PROCESS | 28052 | RSS: Main: 232030208 03:29:57 INFO - PROCESS | 28052 | 03:33:00 INFO - PROCESS | 28052 | Cycle 1(1): loaded http://localhost:32924/tests/dromaeo/cssquery-ext.html (next: http://localhost:32924/tests/dromaeo/cssquery-jquery.html) 03:33:00 INFO - PROCESS | 28052 | RSS: Main: 234254336 03:33:00 INFO - PROCESS | 28052 | 03:36:03 INFO - PROCESS | 28052 | Cycle 1(1): loaded http://localhost:32924/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32924/tests/dromaeo/cssquery-mootools.html) 03:36:03 INFO - PROCESS | 28052 | RSS: Main: 234541056 03:36:03 INFO - PROCESS | 28052 | 03:39:05 INFO - PROCESS | 28052 | Cycle 1(1): loaded http://localhost:32924/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32924/tests/dromaeo/cssquery-prototype.html) 03:39:06 INFO - PROCESS | 28052 | RSS: Main: 226770944 03:39:06 INFO - PROCESS | 28052 | 03:42:09 INFO - PROCESS | 28052 | Cycle 1(1): loaded http://localhost:32924/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32924/tests/dromaeo/cssquery-yui.html) 03:42:09 INFO - PROCESS | 28052 | RSS: Main: 212983808 03:42:09 INFO - PROCESS | 28052 | 03:45:12 INFO - PROCESS | 28052 | Cycle 1(1): loaded http://localhost:32924/tests/dromaeo/cssquery-yui.html (next: http://localhost:32924/tests/dromaeo/cssquery-dojo.html) 03:45:12 INFO - PROCESS | 28052 | RSS: Main: 292048896 03:45:12 INFO - PROCESS | 28052 | 03:45:12 INFO - PROCESS | 28052 | __start_tp_report 03:45:12 INFO - PROCESS | 28052 | _x_x_mozilla_page_load 03:45:12 INFO - PROCESS | 28052 | _x_x_mozilla_page_load_details 03:45:12 INFO - PROCESS | 28052 | |i|pagename|runs| 03:45:12 INFO - PROCESS | 28052 | |0;dojo.html;2631.052820984445;2705.7023727389997;2706.3098909778005;2724.346156922338;2739.411026629275;4579.244424669925;4656.092062047902;4676.205045142326;4676.298555216719;4680.625549956004;4636.605888499473;4696.319033740106;4779.402574678165;4781.7130972141695;4791.640626952975;4263.658907287409;4277.294246449332;4320.956790432103;4373.081652852905;4457.910841783162;4368.432103826498;4404.317330813729;4419.845305414311;4423.159599676067;4462.776861156945;4201.621854033121;4262.275413179736;4292.527821939584;4293.742375457483;4340.414044104053;4281.678874084425;4308.719933204332;4313.137372525507;4323.589259020388;4371.14762621289;4284.935725964113;4291.313389857608;4301.698881078326;4305;4333.848315308981;4455.4876189238;4589.655775816827;4627.167109920213;4662.603678687316;4665.650076244261;5010.599152067863;5031.773570189313;5031.798728050873;5037.949620503785;5099.515546023122;5058.671186372911;5062.924056139161;5064.5441910228255;5074.3657042869645;5083.669561478529;4539.931901021454;4702.435707715096;4751.786169622375;4775.498572649891;4802.495737947535;5074.441811400743;5077.847664570068;5080.949190508121;5081.898362032739;5132.769025393866;4804.06320767454;4869.074875773592;4875.95124048762;4880.731559764176;4898.779554920037;5028.069807085701;5061.670991385548;5082.695038297714;5095.490450954949;5122.718250496184;4934.284528743312;4958.256261560723;4972.055309491185;4976.800927962841;5016.774245158977;4836.46798852126;4916.459189489154;4957.454679985199;4958.826441074545;5009.24861270805;3903.726739128291;3920.627540383659;3945.388464787905;3958.5843486434087;3958.663513601376;3485.2680937003515;3493.7379696522353;3502.0369398415132;3524.9118772030392;3535.752497325214;4200.348945913388;4269.935950960738;4278.871633850989;4298.2263192625005;4347.456567929009;5046.949530504721;5051.520105589963;5054.267131265946;5071.619628527801;5098.209777484496;4298.656107511391;4312.870613881589;4317.676174286941;4320.4599425071865;4352.564743525685;4436.201483732959;4503.121891231179;4554.4990051094355;4566.45202575693;4573.885652858705;4792.113459010095;4810.63920205979;4814.253790662453;4845.75771211438;4858.7570621469495;5030.6730062547285;5034.942662041012;5036.244563315532;5037.319961805256;5075.568576671024;4693.55411235932;4782.641301902441;4815.3499277597075;4841.298011788342;4885.8045678172475;4934.9753251233515;4959.429665588504;4968.3292755479;4968.801247950186;5006.924896126634;5026.924596131134;5027.74861256943;5028.949710502994;5033;5072.670276432168;4758.976205118952;4865.318855360181;4935.580475659465;4962.602991760578;4975.626827987988;4829.082474329866;4844.4186697595105;4857.53853383928;4858.052679727561;4897.314375987294;4766.189747742961;4810.350602668595;4814.229723244264;4814.855554333376;4840.975795121002;4769.070031343994;4884.511548845229;4890.24201248807;4980.701157930535;4985.8005679772405;4734.905301894012;4746.715197088186;4753.310769938271;4763.285507173951;4815.542523460265 03:45:12 INFO - PROCESS | 28052 | |1;ext.html;573.8479302984707;590.8257064166072;599.5503372470646;607.4532920371662;609.6799180430273;32005;33206.33587328255;33213.33573328532;33348.66651333486;33394.49908251378;33865.32269354618;34385.65614343856;34444.31111377771;34447.65552344476;34509.65490345096;7608.543487390747;7830.099538553054;7831.530108193499;7838.176991415905;7845.960770196141;7723.459357844953;7835.294823465887;7836.608169591526;7839.960800195991;7842.647080881374;7747.806304842396;7802;7804.414668899827;7805.882911756328;7806.063272407319;7792.415568832332;7846.803829904241;7853.057633084038;7855.371570274393;7856.803579910491;7746.573938433384;7838.7256446024685;7867.331276841475;7875.330596899271;7878.4485086044;35524.28951420957;35977;36011.4598281026;36025.279494409966;36106;3001.504751715964;3069.8618562164756;3084.2597776533694;3132.79636823608;3196.121066706651;26775.732242677517;27023.189304320902;27101.72898271012;27228.72771272282;27519.724802752116;3087.6757940416383;3110.1758034120976;3112.393083348748;3163.4147682678777;3183.697548732867;186212;190469;190794;190837;196680;49833.75083124561;50122.24816627753;50553;50857.74571127195;50895.49104508982;42291.36562951558;48282.758586206844;48952.75523622359;53572.464275357524;54026.72986635042;13883.097598656055;14032.438702451787;14037.227952462508;14042.36809343582;14058.367373468218;10703.518341674644;10757.354558726502;10763.677089687322;10769.353838769543;10772;13914.721705565831;14031.859681403259;14064.789028164585;14162;15945.202739863193;6249.968790104694;6430.485561155097;6654.3142670215975;6683.565568238049;6794.728210871609;933.6638810028385;936.817320622472;939.1266122506134;999.4453078541334;1013.1995723378449;24545.50908981846;27059.864700676764;27253;27271.72728272692;27821;1013.9493025348703;1017.5065093429681;1018.2821111116644;1050.4747626186906;1059.0944742245424;13827.308634568231;14296.926945592832;14373.360182122213;14629.414823406945;14762.778558321634;267973;272288;272966;273099;273877;44601.55398445974;45416.09167816625;45531;45621.771891140335;45632;1254.6988722706485;1259.9181053231512;1266.1453518874907;1269.7397033608272;1274.20362273579;25034.74965250324;26245.868770656023;26282.531969564836;26660.60009099826;26667.06665266784;40372.596274036885;40492.595074048884;40566.79716601398;40773.59226407698;40777.592224078566;243577;244862;244962;245822;247216;20091.59816803685;22783.038205033903;23248;24011.27966161018;24385.19570249373;35011.17058761826;35433.82283088568;35699.64300357067;39171.2165756689;39711.20577588374;32534.34931301408;32783.50824737583;32911.506327404626;33074;33500.32999340048;32350.514742278414;33193.17017074592;33238;33270;33806.154846129044;29187.85406072956;29246.853765731033;29462.705372945995;29545;33260.33479330448;28667.28331791722;30322.545161823033;30327.24181895382;30386.39227215399;30500;22995.77004230003;23447.648285275394;24112.397190069685;24136.396590085387;24222.394440138432 03:45:12 INFO - PROCESS | 28052 | |2;jquery.html;384.6518900395142;386.67712460095834;386.81432912202143;392.7486408698432;397.5170168245581;15067.623309417257;15315.693686126271;15767.763483547742;15870.285837137328;15895.04629722216;15511.612209694735;16418.917905410457;16645.33418663252;16661.250243739032;16675.41636042739;4832.395950506187;5087.033463641897;5120.667156634807;5123.308353372303;5124.743762811863;3645.726570507209;3865.7873816940055;5571.916421253664;5849.561282903799;5856.795012174553;5734.168545560891;5804.390538993408;5805.042168042289;5824.767009319622;5832.387599302076;5620.831375058734;5746.770129194827;5758.712064396764;5779.190913272167;5784.4504772046585;3350.9329813403597;3506.3863823830984;3510.894673159784;3512.7189824813954;4907.773056735816;19537.511562211057;19615.411537653894;19781.307654232176;19815;19824.90087549553;1840.7607011088608;1914.3873960332699;1921.2315073970524;1970.6255811395788;2141.5288636499945;12536.81194782079;12632.557860474839;12721.55474558386;12743.681407964783;13255.668608284774;1759.5689056181318;1814.963700725978;1822.7812662480455;1851.1762265791729;1852.4257480181186;55025.72487137579;55041.72479137579;55301;56379.71810140964;58321.41678583244;9042.095790420904;9394.718158455258;9502.244349138673;9662.227021838236;10031.197504199647;13142.145760525535;13152.934235328763;13215.867841321657;13225.206487610774;13256.734865302833;7348.706051757977;7401;7519.924800752032;7539.359154471822;7575.545467271982;7126.322999315057;7142.392896603743;7176.892346614805;7250.259937614935;7291.927080729125;5915.290165180119;6074.574779765374;6161.322254551996;6220.377962203834;6220.688965551704;1597.2988766963379;1737.3832289537286;1796.3263776083968;1809.76494029873;1822.0980614595594;815.6981916690744;858.914108589136;876.6975393489236;890.2699786175274;954.0173621170205;15314.693706125816;15589.766153507706;16071.678566428605;16439.342426302814;16861.325546978227;913.9862902056342;926.9675561355455;942.4769253064615;944.7317051364248;946.536197263336;9446;9840.3603765755;9851.113399794052;9873.80252394948;9892.851607225897;285826;291073;291541;292592;294679;64651;67585.98621020689;68273.3172668277;69324.6533767338;69791;930.874331965176;933.5192375926404;953.9856902146335;956.636478138303;973.9707808765748;14764.115620787521;14814.40742370293;15009.98003992016;15241.901807552365;15345;32155.35689286248;32308;32321.51517727189;32534.18664533311;33209;42654.36018459788;43482;43884.78057609691;44147.558524414344;44538.3319250218;7380.77857664271;7451.850962980819;7472.589007604634;7513.098428188652;7516.661750221362;9984.60061597528;11456.82814757796;11463.885361146282;11488.94255528717;11761.411929403324;9342.626294948126;9817.558209880715;10076.546555404877;10160.136388407069;10241.897581024392;9743.9025609743;9902;10079.395236285847;10087.899121008695;10224.591016359262;6360.840978975378;9613.423194608065;9682.75793105178;9740.318177727491;9993;7217.566945983258;7730.458867879194;7870.921290787019;7966;8027.357811375193;9717.757056073655;9953.073228751815;10065.295429319878;10112.949435252776;10246.948765256126 03:45:12 INFO - PROCESS | 28052 | |3;mootools.html;1203.7773011992788;1378.2144177818643;1434.361709039477;1534.5856618712949;1785.8839175453586;7143.678534465948;7385.778426647195;7386.4460165487535;7395.889061664073;7407.370373518257;7186.604736739478;7327.816804579888;7328.780136595898;7335.706571737138;7352.48532602718;2281.7261928568555;2292.0946226240626;2299.0803678528637;2300.700908881843;2301.5857145713767;2233.798958093771;2264.1848934383693;2279.168103642175;2311.075569772088;2317.6755254264417;2255.954880902381;2266.2068276103314;2270.7048083749173;2306.1121468234765;2313.086330899302;2179.2808373236953;2209.5801797658473;2218.8557743746605;2220.678001689754;2221.9777802222015;2218.4564781628605;2231.4644485323406;2232.5200081982453;2234.229190929127;2234.3632064861436;7337.523061001018;7457.85084298311;7625.351845093173;7683.961580192119;7689.038870141232;4622.653301002405;4743.075100355432;4762.952370476286;4767.904641907143;4771.8091276348905;2922.8100173488656;2938.735513803768;2955.3498230389496;3086.8302243376606;3106.3942531206426;896.6906417286026;926.305271046715;962.9470379129145;968.3947532792005;986.4426598971559;9626.75933101671;10370.792584148276;10381.740456488573;10407;10418;4168.3955826405;4214.609178970933;4294.656427485794;4299.118680670455;4328.826846926151;8197.344212463107;8232.876506852403;8233.8353232935;8248.298894594027;8330.708425205088;4595.425571803525;4795.544423279783;4796.496367881392;4797.232442809134;4798.424189097331;3768.3593789055926;4219.683523735732;4324.632406245441;4330.501992270929;4332.306830907103;3420.9828950855585;3470.392681280766;3513.718902487795;3531.6998055165086;3565.322588708189;1105.4748994227677;1117.9888201117885;1129.2377645089532;1132.5073592986912;1140.5722853929776;670.6143967218869;687.4706476013541;761.3756719489965;828.1511450762896;894.579547612621;4929.802807887644;5131.794728210904;5166.405863325691;5186.377634683862;5230.476952304739;429.9914001720011;437.8489421149762;443.20666007845597;467.1031619290969;611.9755209791648;3510.57873055235;3581.1405262737276;3617.981910090485;3631.2374401375478;3708.9443658345144;8693.956530217309;8993.325500587482;9119.270458363315;9139.862902056475;9174.495402752913;8939.776505587282;8997.235235004968;9037.231835294073;9049.592768325441;9055.501947392824;6863.759768408082;6881.13985751781;7061.540999835097;7072.1513418389095;7080.681369338392;4864.27035944597;4919.901601967869;5002.724850133278;5028.924566131438;5042.0168067228005;7497.850042999;7552.697892084255;7762.805929851573;7781.182975787688;7807.882881756892;7715.768526944201;7807.141214466291;7940.16628254025;7944.523328600302;7967.2431119043595;6639.933600663931;6906.963955406528;6910.82515972296;6918.06606108189;6919.550229235084;7243.7464688735645;7328.1938986712485;7346.485745997729;7346.595937223504;7347.55914645123;5395.24466574672;6626.370494802986;6638.236602790547;6653;6817.625030623165;6298.496120310272;6436;6529.5102867284195;6702.229243637044;6785.864282714417;5921.822345329647;5959.463648271676;5964.761409543569;5994.430529099903;6086.878262434638;4507.076049409798;4579.221532339444;4668.159731248408;4716.929246061243;4721.055788842314;4441.244988351923;4471.351654010085;4543.7955292011275;4588.311753237042;4620.907581848277 03:45:12 INFO - PROCESS | 28052 | |4;prototype.html;305.6988865967022;313.87758774078105;319.6372117646471;322.47597653812556;323.32263907114617;4646.907061858761;4688.460827004891;4699.694519856207;4718.127146477904;4727.1727447696685;4399.5160532341415;4500.5949464548185;4578.404807375045;4628.375169352136;4664.2537194048955;3707.110293529547;3714.2014466889614;3723.3111874303204;3738.4205448155444;3753.4745135681096;3731.3097077040698;3732.5894151643297;3755.967109045007;3757.6054514276016;3760.097576581628;3537.2571759930315;3610.2418492116685;3701.130234394915;3713.220223753015;3721.2371463849845;3703.7222208334347;3704.944425833615;3707.8516859325596;3712.684421824148;3727.850885964558;3310.4372256716415;3340.9810007947567;3342.5265303675346;3347.2636020075543;3359.3617212729505;4309.461317335333;4437.356583295436;4508.368828364031;4528.9547104528865;4535.63714902807;4170.270202714543;4200.831966721327;4214.4099826024385;4227.7463352198965;4235.618794308496;4842;4842.394700662418;4855.135470072674;4861.927071093901;4874.439439464471;3591.4612808078737;3599.1721903961975;3601.459781032866;3617.801020943847;3649.1059690375764;4951.504849515056;5056.266841308026;5066.847994560169;5129.820456284012;5133.153029750087;3693.649103335179;3694.5591219424446;3695.4456831474954;3708.0915175781565;3712;3762.8494860205833;3766.8493260269283;3776.811159442017;3782.413725872494;3788.0340513168967;4026.456428382131;4201.634468797653;4220;4244.535635205849;4254.978725106416;4852.2479015752615;4883.633727470454;4888.780004899717;4917.704937703749;4930.334404855299;1290.9677258068436;1314.7173357727943;1364.5087768403366;1380.323641415719;1380.496118916588;934.1872570863393;953.3040880157524;953.3326671330096;959.3045042344384;960.2845879819579;4530.252508336153;4533.841315554006;4542.613877820356;4545.045540436479;4549.727016379028;5318.73406329682;5324.361076670747;5329.733513324319;5335.466453354711;5336.733163341817;4453.377160848347;4546.158960592301;4568.931466028012;4570.405847239904;4571.657125715585;2717.972820271772;2830.249983754307;2830.830150190995;2836.3618185908003;2838.9006384776435;5082.923756143661;5086.847394578169;5095;5096.770645320969;5097.796088156507;5264.710440925785;5384.5692344612335;5427.83716488506;5428.131498960148;5445.264889239981;5101.69389836611;5101.795928162906;5104.9744751276;5106.591472682251;5119.10415677255;5249.921251181312;5276.182191760283;5289.814856480005;5306.071437498499;5307.840764777063;4916.606671466346;5173.974130129325;5174.197999310113;5198.844034678966;5215.478452154906;4994.1509943309;5051.62112841531;5066.797328106834;5076.7207803571155;5078.162103252922;3895.006773272797;3907.3162196614912;3915.47141135943;3925.5289365275207;3944.2703099926607;4690.179218636793;5131.449178629434;5286.312779338661;5328.6802791832615;5339.626226164131;4694.507076756891;4789.664723469463;4852.369192005017;4889.437714662717;4924.384451943507;4854.80580776765;4862.902741945212;4881.585065269492;4889.9486610378935;4891.633127515522;4625;4834.347363106076;4838.903221935612;4839.274108883696;4859.2954021667365;4926.852194434173;4981.576565991932;4983.9501604984935;4988.376452943382;4994.9750251248515;4819.156647586588;4839.540243676845;4841.474935395339;4852.296417019583;4860.17377045896 03:45:12 INFO - PROCESS | 28052 | |5;yui.html;589.0418417704915;605.4308949587389;645.6997496164282;766.5247546521158;776.0803447914226;11920.105992050598;12135.029197664187;12251.14242003059;12291.815622765644;12300.753984920297;11715.648530544076;11768.941155294211;11771.352575608338;11772.646820595375;11781.7643647127;632.4813652804702;678.4707927816287;707.6497133918717;799.9960000200006;811.2860682599304;801.8877357169972;805.0942689474341;806.8870358149863;807.096052421289;808.2119933065244;849.5412477262271;851.6550796927223;860.1656393298522;860.4020205956863;861.2636196052379;668.7559040950067;829.6473998550653;849.817289282804;854.1245223645751;856.4005196362509;622.919020527333;622.9314775374705;622.937706229378;623.1369553168848;623.4451338308909;12778.74442511154;12815.423305951255;12831.101822872402;12846.871531284662;12865.742685146244;11465.426728663533;12114.152009359348;12615.495380184782;12655.050871184698;12908;9890.851637225376;9937.205023598095;9966.20270378368;10007.49962501872;10084.495775211284;4050.9797451012555;4062.5328087270045;4149.97925010376;4158.4178215049915;4235.385869048971;44574.10851782979;45714.31428528575;45817;45978;46251.5374846254;9658.227341812639;9681.322307438553;9748.415095094317;9878.814542254975;9880.851787223197;16977.405790797264;16982.490525284262;16993.320267189174;17035.744463833053;17048.318067277418;6764.729410823512;6827.146606674166;6941.028256044158;6950.6177160256675;7012.474064445187;3556.928861422757;3625.637436256406;3650.8722194723587;3861.189150278417;3894.7273690841935;2849.9430011399654;2947.852607369623;2952.616159899242;2956.305268261957;2956.438276727415;536.696766327024;541.1882176734898;545.5662748115258;545.7816873250731;559.1110134885552;615.7813976038532;618.6257314324769;641.9261784894703;643.3855667837204;648.8961766117493;7345.816354591071;7763.146053934062;7843.294103530596;7936.523808571505;8035.598220088972;508.496588377511;588.4791959116213;601.4586871815313;607.2409488139825;615.1203778596649;3762.3227818992846;3777.9244415111543;3884.514435695538;3976.701747368901;4041.4341992121126;50341.24488132681;52656.21015684768;53565.46434535605;53823.46176538263;54486.727566361915;47354.5264547357;47734.522654773704;48893.266601001014;49256.261156082684;49509.75245123752;43968.78015609965;44711.55288447139;45050.868220682816;45241.09517809626;46658;7633.503822251758;7783.571903545359;7804.8829267559895;8003.719869804529;8046.833209184519;29146;29602.407951841273;30082.09753707392;30217.546736798526;30383.392332153675;35884;37908.43137352997;38181.80909095548;38296.42555361616;40034.39948400718;10234.385936843813;10278.897211028094;10332.380057196593;10357.9482102589;10537.683869483928;10821.18841086906;11122.221444498808;11392.601258955896;11953.940230298793;12185.14703970749;11897.286162829912;11924.523019079139;12004.899959167049;12025.579104731292;12026.639200823989;11410.771784564427;11448.313101213955;11841.171118021655;11911.523539058688;12192.329421881881;11450.427478626201;11537.241844056118;11770.705732356759;11807.17349785541;12054;9699.321047526606;9708.805823883342;10053.597856085675;10208.642697505551;10363.170946324426;9024.826772519531;9317.16145546904;9769.755756106155;9805.36265142792;9877.703668889944 03:45:12 INFO - PROCESS | 28052 | __end_tp_report 03:45:12 INFO - PROCESS | 28052 | __start_cc_report 03:45:12 INFO - PROCESS | 28052 | _x_x_mozilla_cycle_collect,1010 03:45:12 INFO - PROCESS | 28052 | __end_cc_report 03:45:12 INFO - PROCESS | 28052 | __startTimestamp1461840312734__endTimestamp 03:45:12 INFO - PROCESS | 28052 | 03:45:12 INFO - PROCESS | 28052 | ------- Summary: start ------- 03:45:12 INFO - PROCESS | 28052 | Number of tests: 6 03:45:12 INFO - PROCESS | 28052 | 03:45:12 INFO - PROCESS | 28052 | [#0] dojo.html Cycles:165 Average:4626.00 Median:4791.64 stddev:500.77 (10.5%) stddev-sans-first:477.23 03:45:12 INFO - PROCESS | 28052 | Values: 2631.1 2705.7 2706.3 2724.3 2739.4 4579.2 4656.1 4676.2 4676.3 4680.6 4636.6 4696.3 4779.4 4781.7 4791.6 4263.7 4277.3 4321.0 4373.1 4457.9 4368.4 4404.3 4419.8 4423.2 4462.8 4201.6 4262.3 4292.5 4293.7 4340.4 4281.7 4308.7 4313.1 4323.6 4371.1 4284.9 4291.3 4301.7 4305.0 4333.8 4455.5 4589.7 4627.2 4662.6 4665.7 5010.6 5031.8 5031.8 5037.9 5099.5 5058.7 5062.9 5064.5 5074.4 5083.7 4539.9 4702.4 4751.8 4775.5 4802.5 5074.4 5077.8 5080.9 5081.9 5132.8 4804.1 4869.1 4876.0 4880.7 4898.8 5028.1 5061.7 5082.7 5095.5 5122.7 4934.3 4958.3 4972.1 4976.8 5016.8 4836.5 4916.5 4957.5 4958.8 5009.2 3903.7 3920.6 3945.4 3958.6 3958.7 3485.3 3493.7 3502.0 3524.9 3535.8 4200.3 4269.9 4278.9 4298.2 4347.5 5046.9 5051.5 5054.3 5071.6 5098.2 4298.7 4312.9 4317.7 4320.5 4352.6 4436.2 4503.1 4554.5 4566.5 4573.9 4792.1 4810.6 4814.3 4845.8 4858.8 5030.7 5034.9 5036.2 5037.3 5075.6 4693.6 4782.6 4815.3 4841.3 4885.8 4935.0 4959.4 4968.3 4968.8 5006.9 5026.9 5027.7 5028.9 5033.0 5072.7 4759.0 4865.3 4935.6 4962.6 4975.6 4829.1 4844.4 4857.5 4858.1 4897.3 4766.2 4810.4 4814.2 4814.9 4841.0 4769.1 4884.5 4890.2 4980.7 4985.8 4734.9 4746.7 4753.3 4763.3 4815.5 03:45:12 INFO - PROCESS | 28052 | 03:45:12 INFO - PROCESS | 28052 | [#1] ext.html Cycles:180 Average:38801.51 Median:32177.76 stddev:62187.81 (193.3%) stddev-sans-first:62296.02 03:45:12 INFO - PROCESS | 28052 | Values: 573.8 590.8 599.6 607.5 609.7 32005.0 33206.3 33213.3 33348.7 33394.5 33865.3 34385.7 34444.3 34447.7 34509.7 7608.5 7830.1 7831.5 7838.2 7846.0 7723.5 7835.3 7836.6 7840.0 7842.6 7747.8 7802.0 7804.4 7805.9 7806.1 7792.4 7846.8 7853.1 7855.4 7856.8 7746.6 7838.7 7867.3 7875.3 7878.4 35524.3 35977.0 36011.5 36025.3 36106.0 3001.5 3069.9 3084.3 3132.8 3196.1 26775.7 27023.2 27101.7 27228.7 27519.7 3087.7 3110.2 3112.4 3163.4 3183.7 186212.0 190469.0 190794.0 190837.0 196680.0 49833.8 50122.2 50553.0 50857.7 50895.5 42291.4 48282.8 48952.8 53572.5 54026.7 13883.1 14032.4 14037.2 14042.4 14058.4 10703.5 10757.4 10763.7 10769.4 10772.0 13914.7 14031.9 14064.8 14162.0 15945.2 6250.0 6430.5 6654.3 6683.6 6794.7 933.7 936.8 939.1 999.4 1013.2 24545.5 27059.9 27253.0 27271.7 27821.0 1013.9 1017.5 1018.3 1050.5 1059.1 13827.3 14296.9 14373.4 14629.4 14762.8 267973.0 272288.0 272966.0 273099.0 273877.0 44601.6 45416.1 45531.0 45621.8 45632.0 1254.7 1259.9 1266.1 1269.7 1274.2 25034.7 26245.9 26282.5 26660.6 26667.1 40372.6 40492.6 40566.8 40773.6 40777.6 243577.0 244862.0 244962.0 245822.0 247216.0 20091.6 22783.0 23248.0 24011.3 24385.2 35011.2 35433.8 35699.6 39171.2 39711.2 32534.3 32783.5 32911.5 33074.0 33500.3 32350.5 33193.2 33238.0 33270.0 33806.2 29187.9 29246.9 29462.7 29545.0 33260.3 28667.3 30322.5 30327.2 30386.4 30500.0 22995.8 23447.6 24112.4 24136.4 24222.4 03:45:12 INFO - PROCESS | 28052 | 03:45:12 INFO - PROCESS | 28052 | [#2] jquery.html Cycles:180 Average:20546.25 Median:4870.08 stddev:48186.89 (989.4%) stddev-sans-first:48298.29 03:45:12 INFO - PROCESS | 28052 | Values: 384.7 386.7 386.8 392.7 397.5 15067.6 15315.7 15767.8 15870.3 15895.0 15511.6 16418.9 16645.3 16661.3 16675.4 4832.4 5087.0 5120.7 5123.3 5124.7 3645.7 3865.8 5571.9 5849.6 5856.8 5734.2 5804.4 5805.0 5824.8 5832.4 5620.8 5746.8 5758.7 5779.2 5784.5 3350.9 3506.4 3510.9 3512.7 4907.8 19537.5 19615.4 19781.3 19815.0 19824.9 1840.8 1914.4 1921.2 1970.6 2141.5 12536.8 12632.6 12721.6 12743.7 13255.7 1759.6 1815.0 1822.8 1851.2 1852.4 55025.7 55041.7 55301.0 56379.7 58321.4 9042.1 9394.7 9502.2 9662.2 10031.2 13142.1 13152.9 13215.9 13225.2 13256.7 7348.7 7401.0 7519.9 7539.4 7575.5 7126.3 7142.4 7176.9 7250.3 7291.9 5915.3 6074.6 6161.3 6220.4 6220.7 1597.3 1737.4 1796.3 1809.8 1822.1 815.7 858.9 876.7 890.3 954.0 15314.7 15589.8 16071.7 16439.3 16861.3 914.0 927.0 942.5 944.7 946.5 9446.0 9840.4 9851.1 9873.8 9892.9 285826.0 291073.0 291541.0 292592.0 294679.0 64651.0 67586.0 68273.3 69324.7 69791.0 930.9 933.5 954.0 956.6 974.0 14764.1 14814.4 15010.0 15241.9 15345.0 32155.4 32308.0 32321.5 32534.2 33209.0 42654.4 43482.0 43884.8 44147.6 44538.3 7380.8 7451.9 7472.6 7513.1 7516.7 9984.6 11456.8 11463.9 11488.9 11761.4 9342.6 9817.6 10076.5 10160.1 10241.9 9743.9 9902.0 10079.4 10087.9 10224.6 6360.8 9613.4 9682.8 9740.3 9993.0 7217.6 7730.5 7870.9 7966.0 8027.4 9717.8 9953.1 10065.3 10112.9 10246.9 03:45:12 INFO - PROCESS | 28052 | 03:45:12 INFO - PROCESS | 28052 | [#3] mootools.html Cycles:180 Average:4940.18 Median:4966.26 stddev:2651.00 (53.4%) stddev-sans-first:2643.56 03:45:12 INFO - PROCESS | 28052 | Values: 1203.8 1378.2 1434.4 1534.6 1785.9 7143.7 7385.8 7386.4 7395.9 7407.4 7186.6 7327.8 7328.8 7335.7 7352.5 2281.7 2292.1 2299.1 2300.7 2301.6 2233.8 2264.2 2279.2 2311.1 2317.7 2256.0 2266.2 2270.7 2306.1 2313.1 2179.3 2209.6 2218.9 2220.7 2222.0 2218.5 2231.5 2232.5 2234.2 2234.4 7337.5 7457.9 7625.4 7684.0 7689.0 4622.7 4743.1 4763.0 4767.9 4771.8 2922.8 2938.7 2955.3 3086.8 3106.4 896.7 926.3 962.9 968.4 986.4 9626.8 10370.8 10381.7 10407.0 10418.0 4168.4 4214.6 4294.7 4299.1 4328.8 8197.3 8232.9 8233.8 8248.3 8330.7 4595.4 4795.5 4796.5 4797.2 4798.4 3768.4 4219.7 4324.6 4330.5 4332.3 3421.0 3470.4 3513.7 3531.7 3565.3 1105.5 1118.0 1129.2 1132.5 1140.6 670.6 687.5 761.4 828.2 894.6 4929.8 5131.8 5166.4 5186.4 5230.5 430.0 437.8 443.2 467.1 612.0 3510.6 3581.1 3618.0 3631.2 3708.9 8694.0 8993.3 9119.3 9139.9 9174.5 8939.8 8997.2 9037.2 9049.6 9055.5 6863.8 6881.1 7061.5 7072.2 7080.7 4864.3 4919.9 5002.7 5028.9 5042.0 7497.9 7552.7 7762.8 7781.2 7807.9 7715.8 7807.1 7940.2 7944.5 7967.2 6639.9 6907.0 6910.8 6918.1 6919.6 7243.7 7328.2 7346.5 7346.6 7347.6 5395.2 6626.4 6638.2 6653.0 6817.6 6298.5 6436.0 6529.5 6702.2 6785.9 5921.8 5959.5 5964.8 5994.4 6086.9 4507.1 4579.2 4668.2 4716.9 4721.1 4441.2 4471.4 4543.8 4588.3 4620.9 03:45:12 INFO - PROCESS | 28052 | 03:45:12 INFO - PROCESS | 28052 | [#4] prototype.html Cycles:180 Average:4180.54 Median:4655.58 stddev:1192.97 (25.6%) stddev-sans-first:1160.32 03:45:12 INFO - PROCESS | 28052 | Values: 305.7 313.9 319.6 322.5 323.3 4646.9 4688.5 4699.7 4718.1 4727.2 4399.5 4500.6 4578.4 4628.4 4664.3 3707.1 3714.2 3723.3 3738.4 3753.5 3731.3 3732.6 3756.0 3757.6 3760.1 3537.3 3610.2 3701.1 3713.2 3721.2 3703.7 3704.9 3707.9 3712.7 3727.9 3310.4 3341.0 3342.5 3347.3 3359.4 4309.5 4437.4 4508.4 4529.0 4535.6 4170.3 4200.8 4214.4 4227.7 4235.6 4842.0 4842.4 4855.1 4861.9 4874.4 3591.5 3599.2 3601.5 3617.8 3649.1 4951.5 5056.3 5066.8 5129.8 5133.2 3693.6 3694.6 3695.4 3708.1 3712.0 3762.8 3766.8 3776.8 3782.4 3788.0 4026.5 4201.6 4220.0 4244.5 4255.0 4852.2 4883.6 4888.8 4917.7 4930.3 1291.0 1314.7 1364.5 1380.3 1380.5 934.2 953.3 953.3 959.3 960.3 4530.3 4533.8 4542.6 4545.0 4549.7 5318.7 5324.4 5329.7 5335.5 5336.7 4453.4 4546.2 4568.9 4570.4 4571.7 2718.0 2830.2 2830.8 2836.4 2838.9 5082.9 5086.8 5095.0 5096.8 5097.8 5264.7 5384.6 5427.8 5428.1 5445.3 5101.7 5101.8 5105.0 5106.6 5119.1 5249.9 5276.2 5289.8 5306.1 5307.8 4916.6 5174.0 5174.2 5198.8 5215.5 4994.2 5051.6 5066.8 5076.7 5078.2 3895.0 3907.3 3915.5 3925.5 3944.3 4690.2 5131.4 5286.3 5328.7 5339.6 4694.5 4789.7 4852.4 4889.4 4924.4 4854.8 4862.9 4881.6 4889.9 4891.6 4625.0 4834.3 4838.9 4839.3 4859.3 4926.9 4981.6 4984.0 4988.4 4995.0 4819.2 4839.5 4841.5 4852.3 4860.2 03:45:12 INFO - PROCESS | 28052 | 03:45:12 INFO - PROCESS | 28052 | [#5] yui.html Cycles:180 Average:12957.83 Median:45765.66 stddev:14719.22 (32.2%) stddev-sans-first:14731.21 03:45:12 INFO - PROCESS | 28052 | Values: 589.0 605.4 645.7 766.5 776.1 11920.1 12135.0 12251.1 12291.8 12300.8 11715.6 11768.9 11771.4 11772.6 11781.8 632.5 678.5 707.6 800.0 811.3 801.9 805.1 806.9 807.1 808.2 849.5 851.7 860.2 860.4 861.3 668.8 829.6 849.8 854.1 856.4 622.9 622.9 622.9 623.1 623.4 12778.7 12815.4 12831.1 12846.9 12865.7 11465.4 12114.2 12615.5 12655.1 12908.0 9890.9 9937.2 9966.2 10007.5 10084.5 4051.0 4062.5 4150.0 4158.4 4235.4 44574.1 45714.3 45817.0 45978.0 46251.5 9658.2 9681.3 9748.4 9878.8 9880.9 16977.4 16982.5 16993.3 17035.7 17048.3 6764.7 6827.1 6941.0 6950.6 7012.5 3556.9 3625.6 3650.9 3861.2 3894.7 2849.9 2947.9 2952.6 2956.3 2956.4 536.7 541.2 545.6 545.8 559.1 615.8 618.6 641.9 643.4 648.9 7345.8 7763.1 7843.3 7936.5 8035.6 508.5 588.5 601.5 607.2 615.1 3762.3 3777.9 3884.5 3976.7 4041.4 50341.2 52656.2 53565.5 53823.5 54486.7 47354.5 47734.5 48893.3 49256.3 49509.8 43968.8 44711.6 45050.9 45241.1 46658.0 7633.5 7783.6 7804.9 8003.7 8046.8 29146.0 29602.4 30082.1 30217.5 30383.4 35884.0 37908.4 38181.8 38296.4 40034.4 10234.4 10278.9 10332.4 10357.9 10537.7 10821.2 11122.2 11392.6 11953.9 12185.1 11897.3 11924.5 12004.9 12025.6 12026.6 11410.8 11448.3 11841.2 11911.5 12192.3 11450.4 11537.2 11770.7 11807.2 12054.0 9699.3 9708.8 10053.6 10208.6 10363.2 9024.8 9317.2 9769.8 9805.4 9877.7 03:45:12 INFO - PROCESS | 28052 | -------- Summary: end -------- 03:45:12 INFO - PROCESS | 28052 | 03:45:13 INFO - TEST-INFO | 28052: exit 0 03:45:13 INFO - TEST-OK | dromaeo_css | took 1117627ms 03:45:13 INFO - TEST-START | kraken 03:45:13 INFO - operating with platform_type : linux_ 03:45:13 INFO - Initialising browser for kraken test... 03:45:13 INFO - TEST-INFO | started process 28230 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqy7ScR/profile http://localhost:32924/getInfo.html) 03:45:17 INFO - PROCESS | 28230 | __metrics Screen width/height:1600/1200 03:45:17 INFO - PROCESS | 28230 | colorDepth:24 03:45:17 INFO - PROCESS | 28230 | Browser inner width/height: 1024/697 03:45:17 INFO - PROCESS | 28230 | __metrics 03:45:18 ERROR - PROCESS | 28230 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:45:19 INFO - TEST-INFO | 28230: exit 0 03:45:19 INFO - Browser initialized. 03:45:19 INFO - Running cycle 1/1 for kraken test... 03:45:19 INFO - TEST-INFO | started process 28311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqy7ScR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:31 INFO - PROCESS | 28311 | RSS: Main: 156438528 03:45:31 INFO - PROCESS | 28311 | 03:45:34 INFO - PROCESS | 28311 | Cycle 1(1): loaded http://localhost:32924/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32924/tests/kraken/driver.html?testName=audio-beat-detection) 03:45:35 INFO - PROCESS | 28311 | RSS: Main: 210870272 03:45:35 INFO - PROCESS | 28311 | 03:45:37 INFO - PROCESS | 28311 | Cycle 1(1): loaded http://localhost:32924/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32924/tests/kraken/driver.html?testName=audio-dft) 03:45:38 INFO - PROCESS | 28311 | RSS: Main: 196608000 03:45:38 INFO - PROCESS | 28311 | 03:45:41 INFO - PROCESS | 28311 | Cycle 1(1): loaded http://localhost:32924/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32924/tests/kraken/driver.html?testName=audio-fft) 03:45:42 INFO - PROCESS | 28311 | RSS: Main: 267866112 03:45:42 INFO - PROCESS | 28311 | 03:45:44 INFO - PROCESS | 28311 | Cycle 1(1): loaded http://localhost:32924/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32924/tests/kraken/driver.html?testName=audio-oscillator) 03:45:45 INFO - PROCESS | 28311 | RSS: Main: 175386624 03:45:45 INFO - PROCESS | 28311 | 03:45:47 INFO - PROCESS | 28311 | Cycle 1(1): loaded http://localhost:32924/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32924/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:45:48 INFO - PROCESS | 28311 | RSS: Main: 180023296 03:45:48 INFO - PROCESS | 28311 | 03:45:51 INFO - PROCESS | 28311 | Cycle 1(1): loaded http://localhost:32924/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32924/tests/kraken/driver.html?testName=imaging-darkroom) 03:45:51 INFO - PROCESS | 28311 | RSS: Main: 215900160 03:45:51 INFO - PROCESS | 28311 | 03:45:55 INFO - PROCESS | 28311 | Cycle 1(1): loaded http://localhost:32924/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32924/tests/kraken/driver.html?testName=imaging-desaturate) 03:45:55 INFO - PROCESS | 28311 | RSS: Main: 216952832 03:45:55 INFO - PROCESS | 28311 | 03:45:58 INFO - PROCESS | 28311 | Cycle 1(1): loaded http://localhost:32924/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32924/tests/kraken/driver.html?testName=json-parse-financial) 03:45:59 INFO - PROCESS | 28311 | RSS: Main: 216793088 03:45:59 INFO - PROCESS | 28311 | 03:46:00 INFO - PROCESS | 28311 | Cycle 1(1): loaded http://localhost:32924/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32924/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:46:01 INFO - PROCESS | 28311 | RSS: Main: 202539008 03:46:01 INFO - PROCESS | 28311 | 03:46:03 INFO - PROCESS | 28311 | Cycle 1(1): loaded http://localhost:32924/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32924/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:46:04 INFO - PROCESS | 28311 | RSS: Main: 206802944 03:46:04 INFO - PROCESS | 28311 | 03:46:06 INFO - PROCESS | 28311 | Cycle 1(1): loaded http://localhost:32924/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32924/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:46:06 INFO - PROCESS | 28311 | RSS: Main: 217522176 03:46:06 INFO - PROCESS | 28311 | 03:46:09 INFO - PROCESS | 28311 | Cycle 1(1): loaded http://localhost:32924/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32924/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:46:10 INFO - PROCESS | 28311 | RSS: Main: 225734656 03:46:10 INFO - PROCESS | 28311 | 03:46:13 INFO - PROCESS | 28311 | Cycle 1(1): loaded http://localhost:32924/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32924/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:46:14 INFO - PROCESS | 28311 | RSS: Main: 222564352 03:46:14 INFO - PROCESS | 28311 | 03:46:16 INFO - PROCESS | 28311 | Cycle 1(1): loaded http://localhost:32924/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32924/tests/kraken/driver.html?testName=ai-astar) 03:46:16 INFO - PROCESS | 28311 | RSS: Main: 286375936 03:46:16 INFO - PROCESS | 28311 | 03:46:16 INFO - PROCESS | 28311 | __start_tp_report 03:46:16 INFO - PROCESS | 28311 | _x_x_mozilla_page_load 03:46:16 INFO - PROCESS | 28311 | _x_x_mozilla_page_load_details 03:46:16 INFO - PROCESS | 28311 | |i|pagename|runs| 03:46:16 INFO - PROCESS | 28311 | |0;ai-astar;111;113;110;115;112;113;100;110;113;112 03:46:16 INFO - PROCESS | 28311 | |1;audio-beat-detection;165;134;169;192;140;167;165;134;203;133 03:46:16 INFO - PROCESS | 28311 | |2;audio-dft;160;161;162;160;161;164;162;163;163;162 03:46:16 INFO - PROCESS | 28311 | |3;audio-fft;76;74;97;122;75;74;76;109;102;74 03:46:16 INFO - PROCESS | 28311 | |4;audio-oscillator;101;94;145;95;96;96;141;96;96;145 03:46:16 INFO - PROCESS | 28311 | |5;imaging-gaussian-blur;117;116;117;117;116;116;117;117;117;117 03:46:16 INFO - PROCESS | 28311 | |6;imaging-darkroom;146;146;147;146;146;146;146;145;146;146 03:46:16 INFO - PROCESS | 28311 | |7;imaging-desaturate;95;95;94;94;95;95;94;95;94;95 03:46:16 INFO - PROCESS | 28311 | |8;json-parse-financial;65;65;63;64;64;64;68;82;64;62 03:46:16 INFO - PROCESS | 28311 | |9;json-stringify-tinderbox;65;66;65;65;65;63;64;65;65;65 03:46:16 INFO - PROCESS | 28311 | |10;stanford-crypto-aes;79;80;78;79;78;78;80;80;80;79 03:46:16 INFO - PROCESS | 28311 | |11;stanford-crypto-ccm;134;134;143;133;132;136;140;145;168;134 03:46:16 INFO - PROCESS | 28311 | |12;stanford-crypto-pbkdf2;215;213;218;212;218;219;212;214;212;214 03:46:16 INFO - PROCESS | 28311 | |13;stanford-crypto-sha256-iterative;76;78;75;74;76;74;74;82;73;76 03:46:16 INFO - PROCESS | 28311 | __end_tp_report 03:46:16 INFO - PROCESS | 28311 | __start_cc_report 03:46:16 INFO - PROCESS | 28311 | _x_x_mozilla_cycle_collect,1887 03:46:16 INFO - PROCESS | 28311 | __end_cc_report 03:46:16 INFO - PROCESS | 28311 | __startTimestamp1461840376381__endTimestamp 03:46:16 INFO - PROCESS | 28311 | 03:46:16 INFO - PROCESS | 28311 | ------- Summary: start ------- 03:46:16 INFO - PROCESS | 28311 | Number of tests: 14 03:46:16 INFO - PROCESS | 28311 | 03:46:16 INFO - PROCESS | 28311 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.50 stddev:4.12 (3.7%) stddev-sans-first:4.37 03:46:16 INFO - PROCESS | 28311 | Values: 111.0 113.0 110.0 115.0 112.0 113.0 100.0 110.0 113.0 112.0 03:46:16 INFO - PROCESS | 28311 | 03:46:16 INFO - PROCESS | 28311 | [#1] audio-beat-detection Cycles:10 Average:160.20 Median:166.00 stddev:24.80 (14.9%) stddev-sans-first:26.24 03:46:16 INFO - PROCESS | 28311 | Values: 165.0 134.0 169.0 192.0 140.0 167.0 165.0 134.0 203.0 133.0 03:46:16 INFO - PROCESS | 28311 | 03:46:16 INFO - PROCESS | 28311 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.32 (0.8%) stddev-sans-first:1.22 03:46:16 INFO - PROCESS | 28311 | Values: 160.0 161.0 162.0 160.0 161.0 164.0 162.0 163.0 163.0 162.0 03:46:16 INFO - PROCESS | 28311 | 03:46:16 INFO - PROCESS | 28311 | [#3] audio-fft Cycles:10 Average:87.90 Median:74.50 stddev:18.01 (24.2%) stddev-sans-first:18.58 03:46:16 INFO - PROCESS | 28311 | Values: 76.0 74.0 97.0 122.0 75.0 74.0 76.0 109.0 102.0 74.0 03:46:16 INFO - PROCESS | 28311 | 03:46:16 INFO - PROCESS | 28311 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:95.50 stddev:22.98 (24.1%) stddev-sans-first:24.12 03:46:16 INFO - PROCESS | 28311 | Values: 101.0 94.0 145.0 95.0 96.0 96.0 141.0 96.0 96.0 145.0 03:46:16 INFO - PROCESS | 28311 | 03:46:16 INFO - PROCESS | 28311 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:46:16 INFO - PROCESS | 28311 | Values: 117.0 116.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 03:46:16 INFO - PROCESS | 28311 | 03:46:16 INFO - PROCESS | 28311 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 03:46:16 INFO - PROCESS | 28311 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 03:46:16 INFO - PROCESS | 28311 | 03:46:16 INFO - PROCESS | 28311 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 03:46:16 INFO - PROCESS | 28311 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 94.0 95.0 94.0 95.0 03:46:16 INFO - PROCESS | 28311 | 03:46:16 INFO - PROCESS | 28311 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:64.50 stddev:5.80 (9.0%) stddev-sans-first:6.14 03:46:16 INFO - PROCESS | 28311 | Values: 65.0 65.0 63.0 64.0 64.0 64.0 68.0 82.0 64.0 62.0 03:46:16 INFO - PROCESS | 28311 | 03:46:16 INFO - PROCESS | 28311 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 03:46:16 INFO - PROCESS | 28311 | Values: 65.0 66.0 65.0 65.0 65.0 63.0 64.0 65.0 65.0 65.0 03:46:16 INFO - PROCESS | 28311 | 03:46:16 INFO - PROCESS | 28311 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.50 stddev:0.88 (1.1%) stddev-sans-first:0.93 03:46:16 INFO - PROCESS | 28311 | Values: 79.0 80.0 78.0 79.0 78.0 78.0 80.0 80.0 80.0 79.0 03:46:16 INFO - PROCESS | 28311 | 03:46:16 INFO - PROCESS | 28311 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:138.00 stddev:10.83 (7.8%) stddev-sans-first:11.27 03:46:16 INFO - PROCESS | 28311 | Values: 134.0 134.0 143.0 133.0 132.0 136.0 140.0 145.0 168.0 134.0 03:46:16 INFO - PROCESS | 28311 | 03:46:16 INFO - PROCESS | 28311 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:214.70 Median:214.50 stddev:2.71 (1.3%) stddev-sans-first:2.87 03:46:16 INFO - PROCESS | 28311 | Values: 215.0 213.0 218.0 212.0 218.0 219.0 212.0 214.0 212.0 214.0 03:46:16 INFO - PROCESS | 28311 | 03:46:16 INFO - PROCESS | 28311 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.80 Median:76.00 stddev:2.62 (3.4%) stddev-sans-first:2.77 03:46:16 INFO - PROCESS | 28311 | Values: 76.0 78.0 75.0 74.0 76.0 74.0 74.0 82.0 73.0 76.0 03:46:16 INFO - PROCESS | 28311 | -------- Summary: end -------- 03:46:16 INFO - PROCESS | 28311 | 03:46:17 INFO - TEST-INFO | 28311: exit 0 03:46:17 INFO - TEST-OK | kraken | took 63868ms 03:46:17 INFO - SUITE-END | took 1181s 03:46:17 INFO - Completed test suite (00:19:41) 03:46:17 INFO - javascript benchmark 03:46:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2631.052820984445, 2705.7023727389997, 2706.3098909778005, 2724.346156922338, 2739.411026629275, 4579.244424669925, 4656.092062047902, 4676.205045142326, 4676.298555216719, 4680.625549956004, 4636.605888499473, 4696.319033740106, 4779.402574678165, 4781.7130972141695, 4791.640626952975, 4263.658907287409, 4277.294246449332, 4320.956790432103, 4373.081652852905, 4457.910841783162, 4368.432103826498, 4404.317330813729, 4419.845305414311, 4423.159599676067, 4462.776861156945, 4201.621854033121, 4262.275413179736, 4292.527821939584, 4293.742375457483, 4340.414044104053, 4281.678874084425, 4308.719933204332, 4313.137372525507, 4323.589259020388, 4371.14762621289, 4284.935725964113, 4291.313389857608, 4301.698881078326, 4305.0, 4333.848315308981, 4455.4876189238, 4589.655775816827, 4627.167109920213, 4662.603678687316, 4665.650076244261, 5010.599152067863, 5031.773570189313, 5031.798728050873, 5037.949620503785, 5099.515546023122, 5058.671186372911, 5062.924056139161, 5064.5441910228255, 5074.3657042869645, 5083.669561478529, 4539.931901021454, 4702.435707715096, 4751.786169622375, 4775.498572649891, 4802.495737947535, 5074.441811400743, 5077.847664570068, 5080.949190508121, 5081.898362032739, 5132.769025393866, 4804.06320767454, 4869.074875773592, 4875.95124048762, 4880.731559764176, 4898.779554920037, 5028.069807085701, 5061.670991385548, 5082.695038297714, 5095.490450954949, 5122.718250496184, 4934.284528743312, 4958.256261560723, 4972.055309491185, 4976.800927962841, 5016.774245158977, 4836.46798852126, 4916.459189489154, 4957.454679985199, 4958.826441074545, 5009.24861270805, 3903.726739128291, 3920.627540383659, 3945.388464787905, 3958.5843486434087, 3958.663513601376, 3485.2680937003515, 3493.7379696522353, 3502.0369398415132, 3524.9118772030392, 3535.752497325214, 4200.348945913388, 4269.935950960738, 4278.871633850989, 4298.2263192625005, 4347.456567929009, 5046.949530504721, 5051.520105589963, 5054.267131265946, 5071.619628527801, 5098.209777484496, 4298.656107511391, 4312.870613881589, 4317.676174286941, 4320.4599425071865, 4352.564743525685, 4436.201483732959, 4503.121891231179, 4554.4990051094355, 4566.45202575693, 4573.885652858705, 4792.113459010095, 4810.63920205979, 4814.253790662453, 4845.75771211438, 4858.7570621469495, 5030.6730062547285, 5034.942662041012, 5036.244563315532, 5037.319961805256, 5075.568576671024, 4693.55411235932, 4782.641301902441, 4815.3499277597075, 4841.298011788342, 4885.8045678172475, 4934.9753251233515, 4959.429665588504, 4968.3292755479, 4968.801247950186, 5006.924896126634, 5026.924596131134, 5027.74861256943, 5028.949710502994, 5033.0, 5072.670276432168, 4758.976205118952, 4865.318855360181, 4935.580475659465, 4962.602991760578, 4975.626827987988, 4829.082474329866, 4844.4186697595105, 4857.53853383928, 4858.052679727561, 4897.314375987294, 4766.189747742961, 4810.350602668595, 4814.229723244264, 4814.855554333376, 4840.975795121002, 4769.070031343994, 4884.511548845229, 4890.24201248807, 4980.701157930535, 4985.8005679772405, 4734.905301894012, 4746.715197088186, 4753.310769938271, 4763.285507173951, 4815.542523460265], "value": 4593.7054575230995, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.8479302984707, 590.8257064166072, 599.5503372470646, 607.4532920371662, 609.6799180430273, 32005.0, 33206.33587328255, 33213.33573328532, 33348.66651333486, 33394.49908251378, 33865.32269354618, 34385.65614343856, 34444.31111377771, 34447.65552344476, 34509.65490345096, 7608.543487390747, 7830.099538553054, 7831.530108193499, 7838.176991415905, 7845.960770196141, 7723.459357844953, 7835.294823465887, 7836.608169591526, 7839.960800195991, 7842.647080881374, 7747.806304842396, 7802.0, 7804.414668899827, 7805.882911756328, 7806.063272407319, 7792.415568832332, 7846.803829904241, 7853.057633084038, 7855.371570274393, 7856.803579910491, 7746.573938433384, 7838.7256446024685, 7867.331276841475, 7875.330596899271, 7878.4485086044, 35524.28951420957, 35977.0, 36011.4598281026, 36025.279494409966, 36106.0, 3001.504751715964, 3069.8618562164756, 3084.2597776533694, 3132.79636823608, 3196.121066706651, 26775.732242677517, 27023.189304320902, 27101.72898271012, 27228.72771272282, 27519.724802752116, 3087.6757940416383, 3110.1758034120976, 3112.393083348748, 3163.4147682678777, 3183.697548732867, 186212.0, 190469.0, 190794.0, 190837.0, 196680.0, 49833.75083124561, 50122.24816627753, 50553.0, 50857.74571127195, 50895.49104508982, 42291.36562951558, 48282.758586206844, 48952.75523622359, 53572.464275357524, 54026.72986635042, 13883.097598656055, 14032.438702451787, 14037.227952462508, 14042.36809343582, 14058.367373468218, 10703.518341674644, 10757.354558726502, 10763.677089687322, 10769.353838769543, 10772.0, 13914.721705565831, 14031.859681403259, 14064.789028164585, 14162.0, 15945.202739863193, 6249.968790104694, 6430.485561155097, 6654.3142670215975, 6683.565568238049, 6794.728210871609, 933.6638810028385, 936.817320622472, 939.1266122506134, 999.4453078541334, 1013.1995723378449, 24545.50908981846, 27059.864700676764, 27253.0, 27271.72728272692, 27821.0, 1013.9493025348703, 1017.5065093429681, 1018.2821111116644, 1050.4747626186906, 1059.0944742245424, 13827.308634568231, 14296.926945592832, 14373.360182122213, 14629.414823406945, 14762.778558321634, 267973.0, 272288.0, 272966.0, 273099.0, 273877.0, 44601.55398445974, 45416.09167816625, 45531.0, 45621.771891140335, 45632.0, 1254.6988722706485, 1259.9181053231512, 1266.1453518874907, 1269.7397033608272, 1274.20362273579, 25034.74965250324, 26245.868770656023, 26282.531969564836, 26660.60009099826, 26667.06665266784, 40372.596274036885, 40492.595074048884, 40566.79716601398, 40773.59226407698, 40777.592224078566, 243577.0, 244862.0, 244962.0, 245822.0, 247216.0, 20091.59816803685, 22783.038205033903, 23248.0, 24011.27966161018, 24385.19570249373, 35011.17058761826, 35433.82283088568, 35699.64300357067, 39171.2165756689, 39711.20577588374, 32534.34931301408, 32783.50824737583, 32911.506327404626, 33074.0, 33500.32999340048, 32350.514742278414, 33193.17017074592, 33238.0, 33270.0, 33806.154846129044, 29187.85406072956, 29246.853765731033, 29462.705372945995, 29545.0, 33260.33479330448, 28667.28331791722, 30322.545161823033, 30327.24181895382, 30386.39227215399, 30500.0, 22995.77004230003, 23447.648285275394, 24112.397190069685, 24136.396590085387, 24222.394440138432], "value": 16257.325954317565, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.6518900395142, 386.67712460095834, 386.81432912202143, 392.7486408698432, 397.5170168245581, 15067.623309417257, 15315.693686126271, 15767.763483547742, 15870.285837137328, 15895.04629722216, 15511.612209694735, 16418.917905410457, 16645.33418663252, 16661.250243739032, 16675.41636042739, 4832.395950506187, 5087.033463641897, 5120.667156634807, 5123.308353372303, 5124.743762811863, 3645.726570507209, 3865.7873816940055, 5571.916421253664, 5849.561282903799, 5856.795012174553, 5734.168545560891, 5804.390538993408, 5805.042168042289, 5824.767009319622, 5832.387599302076, 5620.831375058734, 5746.770129194827, 5758.712064396764, 5779.190913272167, 5784.4504772046585, 3350.9329813403597, 3506.3863823830984, 3510.894673159784, 3512.7189824813954, 4907.773056735816, 19537.511562211057, 19615.411537653894, 19781.307654232176, 19815.0, 19824.90087549553, 1840.7607011088608, 1914.3873960332699, 1921.2315073970524, 1970.6255811395788, 2141.5288636499945, 12536.81194782079, 12632.557860474839, 12721.55474558386, 12743.681407964783, 13255.668608284774, 1759.5689056181318, 1814.963700725978, 1822.7812662480455, 1851.1762265791729, 1852.4257480181186, 55025.72487137579, 55041.72479137579, 55301.0, 56379.71810140964, 58321.41678583244, 9042.095790420904, 9394.718158455258, 9502.244349138673, 9662.227021838236, 10031.197504199647, 13142.145760525535, 13152.934235328763, 13215.867841321657, 13225.206487610774, 13256.734865302833, 7348.706051757977, 7401.0, 7519.924800752032, 7539.359154471822, 7575.545467271982, 7126.322999315057, 7142.392896603743, 7176.892346614805, 7250.259937614935, 7291.927080729125, 5915.290165180119, 6074.574779765374, 6161.322254551996, 6220.377962203834, 6220.688965551704, 1597.2988766963379, 1737.3832289537286, 1796.3263776083968, 1809.76494029873, 1822.0980614595594, 815.6981916690744, 858.914108589136, 876.6975393489236, 890.2699786175274, 954.0173621170205, 15314.693706125816, 15589.766153507706, 16071.678566428605, 16439.342426302814, 16861.325546978227, 913.9862902056342, 926.9675561355455, 942.4769253064615, 944.7317051364248, 946.536197263336, 9446.0, 9840.3603765755, 9851.113399794052, 9873.80252394948, 9892.851607225897, 285826.0, 291073.0, 291541.0, 292592.0, 294679.0, 64651.0, 67585.98621020689, 68273.3172668277, 69324.6533767338, 69791.0, 930.874331965176, 933.5192375926404, 953.9856902146335, 956.636478138303, 973.9707808765748, 14764.115620787521, 14814.40742370293, 15009.98003992016, 15241.901807552365, 15345.0, 32155.35689286248, 32308.0, 32321.51517727189, 32534.18664533311, 33209.0, 42654.36018459788, 43482.0, 43884.78057609691, 44147.558524414344, 44538.3319250218, 7380.77857664271, 7451.850962980819, 7472.589007604634, 7513.098428188652, 7516.661750221362, 9984.60061597528, 11456.82814757796, 11463.885361146282, 11488.94255528717, 11761.411929403324, 9342.626294948126, 9817.558209880715, 10076.546555404877, 10160.136388407069, 10241.897581024392, 9743.9025609743, 9902.0, 10079.395236285847, 10087.899121008695, 10224.591016359262, 6360.840978975378, 9613.423194608065, 9682.75793105178, 9740.318177727491, 9993.0, 7217.566945983258, 7730.458867879194, 7870.921290787019, 7966.0, 8027.357811375193, 9717.757056073655, 9953.073228751815, 10065.295429319878, 10112.949435252776, 10246.948765256126], "value": 8016.230354606096, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1203.7773011992788, 1378.2144177818643, 1434.361709039477, 1534.5856618712949, 1785.8839175453586, 7143.678534465948, 7385.778426647195, 7386.4460165487535, 7395.889061664073, 7407.370373518257, 7186.604736739478, 7327.816804579888, 7328.780136595898, 7335.706571737138, 7352.48532602718, 2281.7261928568555, 2292.0946226240626, 2299.0803678528637, 2300.700908881843, 2301.5857145713767, 2233.798958093771, 2264.1848934383693, 2279.168103642175, 2311.075569772088, 2317.6755254264417, 2255.954880902381, 2266.2068276103314, 2270.7048083749173, 2306.1121468234765, 2313.086330899302, 2179.2808373236953, 2209.5801797658473, 2218.8557743746605, 2220.678001689754, 2221.9777802222015, 2218.4564781628605, 2231.4644485323406, 2232.5200081982453, 2234.229190929127, 2234.3632064861436, 7337.523061001018, 7457.85084298311, 7625.351845093173, 7683.961580192119, 7689.038870141232, 4622.653301002405, 4743.075100355432, 4762.952370476286, 4767.904641907143, 4771.8091276348905, 2922.8100173488656, 2938.735513803768, 2955.3498230389496, 3086.8302243376606, 3106.3942531206426, 896.6906417286026, 926.305271046715, 962.9470379129145, 968.3947532792005, 986.4426598971559, 9626.75933101671, 10370.792584148276, 10381.740456488573, 10407.0, 10418.0, 4168.3955826405, 4214.609178970933, 4294.656427485794, 4299.118680670455, 4328.826846926151, 8197.344212463107, 8232.876506852403, 8233.8353232935, 8248.298894594027, 8330.708425205088, 4595.425571803525, 4795.544423279783, 4796.496367881392, 4797.232442809134, 4798.424189097331, 3768.3593789055926, 4219.683523735732, 4324.632406245441, 4330.501992270929, 4332.306830907103, 3420.9828950855585, 3470.392681280766, 3513.718902487795, 3531.6998055165086, 3565.322588708189, 1105.4748994227677, 1117.9888201117885, 1129.2377645089532, 1132.5073592986912, 1140.5722853929776, 670.6143967218869, 687.4706476013541, 761.3756719489965, 828.1511450762896, 894.579547612621, 4929.802807887644, 5131.794728210904, 5166.405863325691, 5186.377634683862, 5230.476952304739, 429.9914001720011, 437.8489421149762, 443.20666007845597, 467.1031619290969, 611.9755209791648, 3510.57873055235, 3581.1405262737276, 3617.981910090485, 3631.2374401375478, 3708.9443658345144, 8693.956530217309, 8993.325500587482, 9119.270458363315, 9139.862902056475, 9174.495402752913, 8939.776505587282, 8997.235235004968, 9037.231835294073, 9049.592768325441, 9055.501947392824, 6863.759768408082, 6881.13985751781, 7061.540999835097, 7072.1513418389095, 7080.681369338392, 4864.27035944597, 4919.901601967869, 5002.724850133278, 5028.924566131438, 5042.0168067228005, 7497.850042999, 7552.697892084255, 7762.805929851573, 7781.182975787688, 7807.882881756892, 7715.768526944201, 7807.141214466291, 7940.16628254025, 7944.523328600302, 7967.2431119043595, 6639.933600663931, 6906.963955406528, 6910.82515972296, 6918.06606108189, 6919.550229235084, 7243.7464688735645, 7328.1938986712485, 7346.485745997729, 7346.595937223504, 7347.55914645123, 5395.24466574672, 6626.370494802986, 6638.236602790547, 6653.0, 6817.625030623165, 6298.496120310272, 6436.0, 6529.5102867284195, 6702.229243637044, 6785.864282714417, 5921.822345329647, 5959.463648271676, 5964.761409543569, 5994.430529099903, 6086.878262434638, 4507.076049409798, 4579.221532339444, 4668.159731248408, 4716.929246061243, 4721.055788842314, 4441.244988351923, 4471.351654010085, 4543.7955292011275, 4588.311753237042, 4620.907581848277], "value": 3985.7131245519467, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.6988865967022, 313.87758774078105, 319.6372117646471, 322.47597653812556, 323.32263907114617, 4646.907061858761, 4688.460827004891, 4699.694519856207, 4718.127146477904, 4727.1727447696685, 4399.5160532341415, 4500.5949464548185, 4578.404807375045, 4628.375169352136, 4664.2537194048955, 3707.110293529547, 3714.2014466889614, 3723.3111874303204, 3738.4205448155444, 3753.4745135681096, 3731.3097077040698, 3732.5894151643297, 3755.967109045007, 3757.6054514276016, 3760.097576581628, 3537.2571759930315, 3610.2418492116685, 3701.130234394915, 3713.220223753015, 3721.2371463849845, 3703.7222208334347, 3704.944425833615, 3707.8516859325596, 3712.684421824148, 3727.850885964558, 3310.4372256716415, 3340.9810007947567, 3342.5265303675346, 3347.2636020075543, 3359.3617212729505, 4309.461317335333, 4437.356583295436, 4508.368828364031, 4528.9547104528865, 4535.63714902807, 4170.270202714543, 4200.831966721327, 4214.4099826024385, 4227.7463352198965, 4235.618794308496, 4842.0, 4842.394700662418, 4855.135470072674, 4861.927071093901, 4874.439439464471, 3591.4612808078737, 3599.1721903961975, 3601.459781032866, 3617.801020943847, 3649.1059690375764, 4951.504849515056, 5056.266841308026, 5066.847994560169, 5129.820456284012, 5133.153029750087, 3693.649103335179, 3694.5591219424446, 3695.4456831474954, 3708.0915175781565, 3712.0, 3762.8494860205833, 3766.8493260269283, 3776.811159442017, 3782.413725872494, 3788.0340513168967, 4026.456428382131, 4201.634468797653, 4220.0, 4244.535635205849, 4254.978725106416, 4852.2479015752615, 4883.633727470454, 4888.780004899717, 4917.704937703749, 4930.334404855299, 1290.9677258068436, 1314.7173357727943, 1364.5087768403366, 1380.323641415719, 1380.496118916588, 934.1872570863393, 953.3040880157524, 953.3326671330096, 959.3045042344384, 960.2845879819579, 4530.252508336153, 4533.841315554006, 4542.613877820356, 4545.045540436479, 4549.727016379028, 5318.73406329682, 5324.361076670747, 5329.733513324319, 5335.466453354711, 5336.733163341817, 4453.377160848347, 4546.158960592301, 4568.931466028012, 4570.405847239904, 4571.657125715585, 2717.972820271772, 2830.249983754307, 2830.830150190995, 2836.3618185908003, 2838.9006384776435, 5082.923756143661, 5086.847394578169, 5095.0, 5096.770645320969, 5097.796088156507, 5264.710440925785, 5384.5692344612335, 5427.83716488506, 5428.131498960148, 5445.264889239981, 5101.69389836611, 5101.795928162906, 5104.9744751276, 5106.591472682251, 5119.10415677255, 5249.921251181312, 5276.182191760283, 5289.814856480005, 5306.071437498499, 5307.840764777063, 4916.606671466346, 5173.974130129325, 5174.197999310113, 5198.844034678966, 5215.478452154906, 4994.1509943309, 5051.62112841531, 5066.797328106834, 5076.7207803571155, 5078.162103252922, 3895.006773272797, 3907.3162196614912, 3915.47141135943, 3925.5289365275207, 3944.2703099926607, 4690.179218636793, 5131.449178629434, 5286.312779338661, 5328.6802791832615, 5339.626226164131, 4694.507076756891, 4789.664723469463, 4852.369192005017, 4889.437714662717, 4924.384451943507, 4854.80580776765, 4862.902741945212, 4881.585065269492, 4889.9486610378935, 4891.633127515522, 4625.0, 4834.347363106076, 4838.903221935612, 4839.274108883696, 4859.2954021667365, 4926.852194434173, 4981.576565991932, 4983.9501604984935, 4988.376452943382, 4994.9750251248515, 4819.156647586588, 4839.540243676845, 4841.474935395339, 4852.296417019583, 4860.17377045896], "value": 3815.489186581705, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.0418417704915, 605.4308949587389, 645.6997496164282, 766.5247546521158, 776.0803447914226, 11920.105992050598, 12135.029197664187, 12251.14242003059, 12291.815622765644, 12300.753984920297, 11715.648530544076, 11768.941155294211, 11771.352575608338, 11772.646820595375, 11781.7643647127, 632.4813652804702, 678.4707927816287, 707.6497133918717, 799.9960000200006, 811.2860682599304, 801.8877357169972, 805.0942689474341, 806.8870358149863, 807.096052421289, 808.2119933065244, 849.5412477262271, 851.6550796927223, 860.1656393298522, 860.4020205956863, 861.2636196052379, 668.7559040950067, 829.6473998550653, 849.817289282804, 854.1245223645751, 856.4005196362509, 622.919020527333, 622.9314775374705, 622.937706229378, 623.1369553168848, 623.4451338308909, 12778.74442511154, 12815.423305951255, 12831.101822872402, 12846.871531284662, 12865.742685146244, 11465.426728663533, 12114.152009359348, 12615.495380184782, 12655.050871184698, 12908.0, 9890.851637225376, 9937.205023598095, 9966.20270378368, 10007.49962501872, 10084.495775211284, 4050.9797451012555, 4062.5328087270045, 4149.97925010376, 4158.4178215049915, 4235.385869048971, 44574.10851782979, 45714.31428528575, 45817.0, 45978.0, 46251.5374846254, 9658.227341812639, 9681.322307438553, 9748.415095094317, 9878.814542254975, 9880.851787223197, 16977.405790797264, 16982.490525284262, 16993.320267189174, 17035.744463833053, 17048.318067277418, 6764.729410823512, 6827.146606674166, 6941.028256044158, 6950.6177160256675, 7012.474064445187, 3556.928861422757, 3625.637436256406, 3650.8722194723587, 3861.189150278417, 3894.7273690841935, 2849.9430011399654, 2947.852607369623, 2952.616159899242, 2956.305268261957, 2956.438276727415, 536.696766327024, 541.1882176734898, 545.5662748115258, 545.7816873250731, 559.1110134885552, 615.7813976038532, 618.6257314324769, 641.9261784894703, 643.3855667837204, 648.8961766117493, 7345.816354591071, 7763.146053934062, 7843.294103530596, 7936.523808571505, 8035.598220088972, 508.496588377511, 588.4791959116213, 601.4586871815313, 607.2409488139825, 615.1203778596649, 3762.3227818992846, 3777.9244415111543, 3884.514435695538, 3976.701747368901, 4041.4341992121126, 50341.24488132681, 52656.21015684768, 53565.46434535605, 53823.46176538263, 54486.727566361915, 47354.5264547357, 47734.522654773704, 48893.266601001014, 49256.261156082684, 49509.75245123752, 43968.78015609965, 44711.55288447139, 45050.868220682816, 45241.09517809626, 46658.0, 7633.503822251758, 7783.571903545359, 7804.8829267559895, 8003.719869804529, 8046.833209184519, 29146.0, 29602.407951841273, 30082.09753707392, 30217.546736798526, 30383.392332153675, 35884.0, 37908.43137352997, 38181.80909095548, 38296.42555361616, 40034.39948400718, 10234.385936843813, 10278.897211028094, 10332.380057196593, 10357.9482102589, 10537.683869483928, 10821.18841086906, 11122.221444498808, 11392.601258955896, 11953.940230298793, 12185.14703970749, 11897.286162829912, 11924.523019079139, 12004.899959167049, 12025.579104731292, 12026.639200823989, 11410.771784564427, 11448.313101213955, 11841.171118021655, 11911.523539058688, 12192.329421881881, 11450.427478626201, 11537.241844056118, 11770.705732356759, 11807.17349785541, 12054.0, 9699.321047526606, 9708.805823883342, 10053.597856085675, 10208.642697505551, 10363.170946324426, 9024.826772519531, 9317.16145546904, 9769.755756106155, 9805.36265142792, 9877.703668889944], "value": 6011.054542682603, "unit": "score"}], "name": "dromaeo_css", "value": 6161.779554761317, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 110.0, 115.0, 112.0, 113.0, 100.0, 110.0, 113.0, 112.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 134.0, 169.0, 192.0, 140.0, 167.0, 165.0, 134.0, 203.0, 133.0], "value": 160.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 160.0, 161.0, 164.0, 162.0, 163.0, 163.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 97.0, 122.0, 75.0, 74.0, 76.0, 109.0, 102.0, 74.0], "value": 87.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 94.0, 145.0, 95.0, 96.0, 96.0, 141.0, 96.0, 96.0, 145.0], "value": 110.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 63.0, 64.0, 64.0, 64.0, 68.0, 82.0, 64.0, 62.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 65.0, 63.0, 64.0, 65.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 78.0, 79.0, 78.0, 78.0, 80.0, 80.0, 80.0, 79.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 134.0, 143.0, 133.0, 132.0, 136.0, 140.0, 145.0, 168.0, 134.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [215.0, 213.0, 218.0, 212.0, 218.0, 219.0, 212.0, 214.0, 212.0, 214.0], "value": 214.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 75.0, 74.0, 76.0, 74.0, 74.0, 82.0, 73.0, 76.0], "value": 75.8, "unit": "score"}], "name": "kraken", "value": 1629.0, "alertThreshold": 2.0}]} 03:46:17 INFO - Return code: 0 03:46:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:46:17 ERROR - # TBPL SUCCESS # 03:46:17 INFO - Running post-action listener: _resource_record_post_action 03:46:17 INFO - Running post-run listener: _resource_record_post_run 03:46:18 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518234112; Read time: 16; Write time: 422092 03:46:18 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234610688; Read time: 0; Write time: 199528 03:46:18 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283459584; Read time: 16; Write time: 222536 03:46:18 INFO - Running post-run listener: _upload_blobber_files 03:46:18 INFO - Blob upload gear active. 03:46:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:46:18 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 03:46:18 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'] 03:46:18 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 03:46:19 INFO - (blobuploader) - INFO - Open directory for files ... 03:46:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:46:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:46:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:19 INFO - (blobuploader) - INFO - Done attempting. 03:46:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:46:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:46:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:21 INFO - (blobuploader) - INFO - Done attempting. 03:46:21 INFO - (blobuploader) - INFO - Iteration through files over. 03:46:21 INFO - Return code: 0 03:46:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:46:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:46:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8f1aa54800f3690a10f509909ee10fa74b66c65d9209f5d638958d209dfd4f41dbee1aa49694a98172e8f6ea2cb2ae84d2b69d9387bb5acf2c8961c6f2d68b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/29e868545f6915bc976c099edd86d7bb90ea4a1245dc73b7d12dfe08d3bce08aca1321138add6cb6b409712ba3c91308a5408779d68734a576867c050e34345b"} 03:46:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:46:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:46:21 INFO - Contents: 03:46:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8f1aa54800f3690a10f509909ee10fa74b66c65d9209f5d638958d209dfd4f41dbee1aa49694a98172e8f6ea2cb2ae84d2b69d9387bb5acf2c8961c6f2d68b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/29e868545f6915bc976c099edd86d7bb90ea4a1245dc73b7d12dfe08d3bce08aca1321138add6cb6b409712ba3c91308a5408779d68734a576867c050e34345b"} 03:46:21 INFO - Running post-run listener: copy_logs_to_upload_dir 03:46:21 INFO - Copying logs to upload dir... 03:46:21 INFO - mkdir: /builds/slave/test/build/upload/logs 03:46:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.847546 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-28 03:46:20.631853) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 03:46:20.635779) ========= 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=0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981 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/e8f1aa54800f3690a10f509909ee10fa74b66c65d9209f5d638958d209dfd4f41dbee1aa49694a98172e8f6ea2cb2ae84d2b69d9387bb5acf2c8961c6f2d68b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/29e868545f6915bc976c099edd86d7bb90ea4a1245dc73b7d12dfe08d3bce08aca1321138add6cb6b409712ba3c91308a5408779d68734a576867c050e34345b"} build_url:https://queue.taskcluster.net/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011273 build_url: 'https://queue.taskcluster.net/v1/task/S1ZcQlk4RS2VZe_I-Ysv_A/artifacts/public/build/firefox-49.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/e8f1aa54800f3690a10f509909ee10fa74b66c65d9209f5d638958d209dfd4f41dbee1aa49694a98172e8f6ea2cb2ae84d2b69d9387bb5acf2c8961c6f2d68b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/29e868545f6915bc976c099edd86d7bb90ea4a1245dc73b7d12dfe08d3bce08aca1321138add6cb6b409712ba3c91308a5408779d68734a576867c050e34345b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 03:46:20.664768) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 03:46:20.665097) ========= 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=0e2a256762fed810e2f0f810000001b3-1461839142.973289-900868981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 03:46:20.746938) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 03:46:20.747251) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 03:46:20.747533) ========= ========= Total master_lag: 0.18 =========