builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-044 starttime: 1460647273.74 results: success (0) buildid: 20160414073525 builduid: 354f8ba478354196ac567a043990194c revision: aef9d5c535ae78da48047a076c4a66bab551a2da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:13.742906) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:13.743502) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:13.744564) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:13.982148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:13.982469) ========= 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=574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 08:21:14-- 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% 22.6M=0.001s 2016-04-14 08:21:14 (22.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168541 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:14.169772) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:14.171739) ========= 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=574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019472 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:14.231334) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:14.231687) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev aef9d5c535ae78da48047a076c4a66bab551a2da --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 aef9d5c535ae78da48047a076c4a66bab551a2da --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=574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 08:21:14,408 truncating revision to first 12 chars 2016-04-14 08:21:14,409 Setting DEBUG logging. 2016-04-14 08:21:14,409 attempt 1/10 2016-04-14 08:21:14,409 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/aef9d5c535ae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 08:21:15,089 unpacking tar archive at: fx-team-aef9d5c535ae/testing/mozharness/ program finished with exit code 0 elapsedTime=0.946352 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:15.197696) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:15.198053) ========= script_repo_revision: aef9d5c535ae78da48047a076c4a66bab551a2da ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:15.198460) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:15.198847) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 08:21:15.208377) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-14 08:21:15.208801) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:21:15 INFO - MultiFileLogger online at 20160414 08:21:15 in /builds/slave/test 08:21:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 08:21:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:21:15 INFO - {'append_to_log': False, 08:21:15 INFO - 'base_work_dir': '/builds/slave/test', 08:21:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:21:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:21:15 INFO - 'branch': 'Fx-Team-Non-PGO', 08:21:15 INFO - 'buildbot_json_path': 'buildprops.json', 08:21:15 INFO - 'config_files': ('talos/linux_config.py',), 08:21:15 INFO - 'default_actions': ('clobber', 08:21:15 INFO - 'read-buildbot-config', 08:21:15 INFO - 'download-and-extract', 08:21:15 INFO - 'populate-webroot', 08:21:15 INFO - 'create-virtualenv', 08:21:15 INFO - 'install', 08:21:15 INFO - 'run-tests'), 08:21:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:21:15 INFO - 'download_minidump_stackwalk': True, 08:21:15 INFO - 'download_symbols': 'ondemand', 08:21:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:21:15 INFO - 'tooltool.py': '/tools/tooltool.py', 08:21:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:21:15 INFO - '/tools/misc-python/virtualenv.py')}, 08:21:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:21:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:21:15 INFO - 'installer_path': 'installer.exe', 08:21:15 INFO - 'log_level': 'info', 08:21:15 INFO - 'log_name': 'talos', 08:21:15 INFO - 'log_to_console': True, 08:21:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:21:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:21:15 INFO - 'opt_config_files': (), 08:21:15 INFO - 'pip_index': False, 08:21:15 INFO - 'sps_profile': False, 08:21:15 INFO - 'sps_profile_interval': 0, 08:21:15 INFO - 'suite': 'dromaeojs-e10s', 08:21:15 INFO - 'system_bits': '32', 08:21:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:21:15 INFO - 'title': 'talos-linux64-ix-044', 08:21:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:21:15 INFO - 'use_talos_json': True, 08:21:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:21:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:21:15 INFO - 'work_dir': 'build'} 08:21:15 INFO - ##### 08:21:15 INFO - ##### Running clobber step. 08:21:15 INFO - ##### 08:21:15 INFO - Running pre-action listener: _resource_record_pre_action 08:21:15 INFO - Running main action method: clobber 08:21:15 INFO - rmtree: /builds/slave/test/build 08:21:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:21:15 INFO - Running post-action listener: _resource_record_post_action 08:21:15 INFO - ##### 08:21:15 INFO - ##### Running read-buildbot-config step. 08:21:15 INFO - ##### 08:21:15 INFO - Running pre-action listener: _resource_record_pre_action 08:21:15 INFO - Running main action method: read_buildbot_config 08:21:15 INFO - Using buildbot properties: 08:21:15 INFO - { 08:21:15 INFO - "project": "", 08:21:15 INFO - "product": "firefox", 08:21:15 INFO - "script_repo_revision": "production", 08:21:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:21:15 INFO - "repository": "", 08:21:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 08:21:15 INFO - "buildid": "20160414073525", 08:21:15 INFO - "pgo_build": "False", 08:21:15 INFO - "basedir": "/builds/slave/test", 08:21:15 INFO - "buildnumber": 1407, 08:21:15 INFO - "slavename": "talos-linux64-ix-044", 08:21:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:21:15 INFO - "platform": "ubuntu64_hw", 08:21:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:21:15 INFO - "branch": "fx-team", 08:21:15 INFO - "repo_path": "integration/fx-team", 08:21:15 INFO - "revision": "aef9d5c535ae78da48047a076c4a66bab551a2da", 08:21:15 INFO - "stage_platform": "linux64", 08:21:15 INFO - "builduid": "354f8ba478354196ac567a043990194c", 08:21:15 INFO - "slavebuilddir": "test" 08:21:15 INFO - } 08:21:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:21:15 INFO - Running post-action listener: _resource_record_post_action 08:21:15 INFO - ##### 08:21:15 INFO - ##### Running download-and-extract step. 08:21:15 INFO - ##### 08:21:15 INFO - Running pre-action listener: _resource_record_pre_action 08:21:15 INFO - Running main action method: download_and_extract 08:21:15 INFO - mkdir: /builds/slave/test/build/tests 08:21: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')]} 08:21:15 INFO - https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:21:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:21:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:21:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:21:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:21:16 INFO - Downloaded 1361 bytes. 08:21:16 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:21:16 INFO - Using the following test package requirements: 08:21:16 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:21:16 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:21:16 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:21:16 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:16 INFO - u'jsshell-linux-x86_64.zip'], 08:21:16 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:21:16 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:21:16 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:21:16 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:21:16 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:21:16 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:21:16 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:21:16 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')]} 08:21:16 INFO - https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:21:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:21:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:21:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:21:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:21:18 INFO - Downloaded 22202881 bytes. 08:21:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:21:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:21:19 INFO - Return code: 0 08:21:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:21:19 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')]} 08:21:19 INFO - https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:21:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:21:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:21:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:21:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:21:24 INFO - Downloaded 22202881 bytes. 08:21:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:21:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:21:25 INFO - Return code: 0 08:21:25 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')]} 08:21:25 INFO - https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:21:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:21:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:21:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:21:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:21:26 INFO - Downloaded 10841076 bytes. 08:21:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:21:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:21:26 INFO - Return code: 0 08:21:26 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')]} 08:21:26 INFO - https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:21:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:21:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:21:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:21:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:21:28 INFO - Downloaded 54446176 bytes. 08:21:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:21:28 INFO - mkdir: /builds/slave/test/properties 08:21:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:21:28 INFO - Writing to file /builds/slave/test/properties/build_url 08:21:28 INFO - Contents: 08:21:28 INFO - build_url:https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:21:28 INFO - Running post-action listener: _resource_record_post_action 08:21:28 INFO - Running post-action listener: set_extra_try_arguments 08:21:28 INFO - ##### 08:21:28 INFO - ##### Running populate-webroot step. 08:21:28 INFO - ##### 08:21:28 INFO - Running pre-action listener: _resource_record_pre_action 08:21:28 INFO - Running main action method: populate_webroot 08:21:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:21:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:21:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:21:28 INFO - '--tppagecycles', 08:21:28 INFO - '7'], 08:21:28 INFO - 'tests': ['tsvgm']}}, 08:21:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:21:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:21:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:21:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:21:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:21:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:21:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:28 INFO - 'talos_options': ['--disable-e10s'], 08:21:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:28 INFO - 'talos_options': ['--disable-e10s'], 08:21:28 INFO - 'tests': ['damp', 'tps']}, 08:21:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:28 INFO - 'tests': ['damp', 'tps']}, 08:21:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:21:28 INFO - 'tests': ['dromaeo_dom']}, 08:21:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:21:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:21:28 INFO - 'tests': ['a11yr', 08:21:28 INFO - 'ts_paint', 08:21:28 INFO - 'tpaint', 08:21:28 INFO - 'sessionrestore', 08:21:28 INFO - 'sessionrestore_no_auto_restore', 08:21:28 INFO - 'tabpaint']}, 08:21:28 INFO - 'other-e10s': {'tests': ['a11yr', 08:21:28 INFO - 'ts_paint', 08:21:28 INFO - 'tpaint', 08:21:28 INFO - 'sessionrestore', 08:21:28 INFO - 'sessionrestore_no_auto_restore', 08:21:28 INFO - 'tabpaint']}, 08:21:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:21:28 INFO - 'ts_paint', 08:21:28 INFO - 'tpaint', 08:21:28 INFO - 'sessionrestore', 08:21:28 INFO - 'sessionrestore_no_auto_restore', 08:21:28 INFO - 'tabpaint']}, 08:21:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:21:28 INFO - 'ts_paint', 08:21:28 INFO - 'tpaint', 08:21:28 INFO - 'sessionrestore', 08:21:28 INFO - 'sessionrestore_no_auto_restore', 08:21:28 INFO - 'tabpaint']}, 08:21:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:21:28 INFO - 'tests': ['a11yr', 08:21:28 INFO - 'ts_paint', 08:21:28 INFO - 'tpaint', 08:21:28 INFO - 'sessionrestore', 08:21:28 INFO - 'sessionrestore_no_auto_restore', 08:21:28 INFO - 'tabpaint']}, 08:21:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:21:28 INFO - 'tests': ['a11yr', 08:21:28 INFO - 'ts_paint', 08:21:28 INFO - 'tpaint', 08:21:28 INFO - 'sessionrestore', 08:21:28 INFO - 'sessionrestore_no_auto_restore', 08:21:28 INFO - 'tabpaint']}, 08:21:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:21:28 INFO - 'tests': ['tsvgx', 08:21:28 INFO - 'tsvgr_opacity', 08:21:28 INFO - 'tart', 08:21:28 INFO - 'tscrollx', 08:21:28 INFO - 'cart']}, 08:21:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:21:28 INFO - 'tsvgr_opacity', 08:21:28 INFO - 'tart', 08:21:28 INFO - 'tscrollx', 08:21:28 INFO - 'cart']}, 08:21:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:28 INFO - 'talos_options': ['--disable-e10s'], 08:21:28 INFO - 'tests': ['tp5o']}, 08:21:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:28 INFO - 'tests': ['tp5o']}, 08:21:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:28 INFO - 'talos_options': ['--disable-e10s', 08:21:28 INFO - '--xperf_path', 08:21:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:28 INFO - 'tests': ['tp5n']}, 08:21:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:28 INFO - 'talos_options': ['--xperf_path', 08:21:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:28 INFO - 'tests': ['tp5n']}}, 08:21:28 INFO - 'talos.zip': {'path': '', 08:21:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:21:28 INFO - Running post-action listener: _resource_record_post_action 08:21:28 INFO - ##### 08:21:28 INFO - ##### Running create-virtualenv step. 08:21:28 INFO - ##### 08:21:28 INFO - Running pre-action listener: _resource_record_pre_action 08:21:28 INFO - Running main action method: create_virtualenv 08:21:28 INFO - Creating virtualenv /builds/slave/test/build/venv 08:21:28 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 08:21:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:21:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:21:28 INFO - Using real prefix '/usr' 08:21:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:21:29 INFO - Installing distribute.............................................................................................................................................................................................done. 08:21:31 INFO - Installing pip.................done. 08:21:31 INFO - Return code: 0 08:21:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:21:31 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')]} 08:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:31 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')]} 08:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:31 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 0x7fb675cfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfee640>, '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 0xfef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfef9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937', '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 08:21:31 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 08:21:31 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 08:21:31 INFO - Using env: {'DISPLAY': ':0', 08:21:31 INFO - 'HOME': '/home/cltbld', 08:21:31 INFO - 'LANG': 'en_US.UTF-8', 08:21:31 INFO - 'LANGUAGE': 'en_US:en', 08:21:31 INFO - 'LOGNAME': 'cltbld', 08:21:31 INFO - 'MAIL': '/var/mail/cltbld', 08:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:31 INFO - 'MOZ_NO_REMOTE': '1', 08:21:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:31 INFO - 'NO_EM_RESTART': '1', 08:21:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:31 INFO - 'PWD': '/builds/slave/test', 08:21:31 INFO - 'SHELL': '/bin/bash', 08:21:31 INFO - 'SHLVL': '1', 08:21:31 INFO - 'TERM': 'linux', 08:21:31 INFO - 'TMOUT': '86400', 08:21:31 INFO - 'USER': 'cltbld', 08:21:31 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937', 08:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:31 INFO - '_': '/tools/buildbot/bin/python'} 08:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:31 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 08:21:31 INFO - Cleaning up... 08:21:31 INFO - Return code: 0 08:21:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:21:31 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')]} 08:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:31 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')]} 08:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:31 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 0x7fb675cfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfee640>, '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 0xfef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfef9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937', '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 08:21:31 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 08:21:31 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 08:21:31 INFO - Using env: {'DISPLAY': ':0', 08:21:31 INFO - 'HOME': '/home/cltbld', 08:21:31 INFO - 'LANG': 'en_US.UTF-8', 08:21:31 INFO - 'LANGUAGE': 'en_US:en', 08:21:31 INFO - 'LOGNAME': 'cltbld', 08:21:31 INFO - 'MAIL': '/var/mail/cltbld', 08:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:31 INFO - 'MOZ_NO_REMOTE': '1', 08:21:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:31 INFO - 'NO_EM_RESTART': '1', 08:21:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:31 INFO - 'PWD': '/builds/slave/test', 08:21:31 INFO - 'SHELL': '/bin/bash', 08:21:31 INFO - 'SHLVL': '1', 08:21:31 INFO - 'TERM': 'linux', 08:21:31 INFO - 'TMOUT': '86400', 08:21:31 INFO - 'USER': 'cltbld', 08:21:31 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937', 08:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:31 INFO - '_': '/tools/buildbot/bin/python'} 08:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:31 INFO - Downloading/unpacking psutil>=0.7.1 08:21:31 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 08:21:31 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 08:21:31 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 08:21:31 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 08:21:31 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 08:21:31 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 08:21:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:21:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:33 INFO - Installing collected packages: psutil 08:21:33 INFO - Running setup.py install for psutil 08:21:33 INFO - building 'psutil._psutil_linux' extension 08:21:33 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 08:21:34 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 08:21:34 INFO - building 'psutil._psutil_posix' extension 08:21:34 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 08:21:34 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 08:21:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:34 INFO - Successfully installed psutil 08:21:34 INFO - Cleaning up... 08:21:34 INFO - Return code: 0 08:21:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:21: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')]} 08:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21: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')]} 08:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:34 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 0x7fb675cfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfee640>, '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 0xfef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfef9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937', '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 08:21:34 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 08:21:34 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 08:21:34 INFO - Using env: {'DISPLAY': ':0', 08:21:34 INFO - 'HOME': '/home/cltbld', 08:21:34 INFO - 'LANG': 'en_US.UTF-8', 08:21:34 INFO - 'LANGUAGE': 'en_US:en', 08:21:34 INFO - 'LOGNAME': 'cltbld', 08:21:34 INFO - 'MAIL': '/var/mail/cltbld', 08:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:34 INFO - 'MOZ_NO_REMOTE': '1', 08:21:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:34 INFO - 'NO_EM_RESTART': '1', 08:21:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:34 INFO - 'PWD': '/builds/slave/test', 08:21:34 INFO - 'SHELL': '/bin/bash', 08:21:34 INFO - 'SHLVL': '1', 08:21:34 INFO - 'TERM': 'linux', 08:21:34 INFO - 'TMOUT': '86400', 08:21:34 INFO - 'USER': 'cltbld', 08:21:34 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937', 08:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:34 INFO - '_': '/tools/buildbot/bin/python'} 08:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:21:34 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 08:21:34 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 08:21:34 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 08:21:34 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 08:21:34 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 08:21:34 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 08:21:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:21:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:21:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:21:36 INFO - Installing collected packages: mozsystemmonitor 08:21:36 INFO - Running setup.py install for mozsystemmonitor 08:21:36 INFO - Successfully installed mozsystemmonitor 08:21:36 INFO - Cleaning up... 08:21:36 INFO - Return code: 0 08:21:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:36 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 0x7fb675cfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfee640>, '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 0xfef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfef9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937', '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 08:21:36 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 08:21:36 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 08:21:36 INFO - Using env: {'DISPLAY': ':0', 08:21:36 INFO - 'HOME': '/home/cltbld', 08:21:36 INFO - 'LANG': 'en_US.UTF-8', 08:21:36 INFO - 'LANGUAGE': 'en_US:en', 08:21:36 INFO - 'LOGNAME': 'cltbld', 08:21:36 INFO - 'MAIL': '/var/mail/cltbld', 08:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:36 INFO - 'MOZ_NO_REMOTE': '1', 08:21:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:36 INFO - 'NO_EM_RESTART': '1', 08:21:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:36 INFO - 'PWD': '/builds/slave/test', 08:21:36 INFO - 'SHELL': '/bin/bash', 08:21:36 INFO - 'SHLVL': '1', 08:21:36 INFO - 'TERM': 'linux', 08:21:36 INFO - 'TMOUT': '86400', 08:21:36 INFO - 'USER': 'cltbld', 08:21:36 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937', 08:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:36 INFO - '_': '/tools/buildbot/bin/python'} 08:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:36 INFO - Downloading/unpacking blobuploader==1.2.4 08:21:36 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 08:21:36 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 08:21:36 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 08:21:36 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 08:21:36 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 08:21:36 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 08:21:38 INFO - Downloading blobuploader-1.2.4.tar.gz 08:21:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:21:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:21:38 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 08:21:38 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 08:21:38 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 08:21:38 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 08:21:38 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 08:21:38 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 08:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:21:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:21:39 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 08:21:39 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 08:21:39 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 08:21:39 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 08:21:39 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 08:21:39 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 08:21:39 INFO - Downloading docopt-0.6.1.tar.gz 08:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:21:39 INFO - Installing collected packages: blobuploader, requests, docopt 08:21:39 INFO - Running setup.py install for blobuploader 08:21:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:21:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:21:39 INFO - Running setup.py install for requests 08:21:39 INFO - Running setup.py install for docopt 08:21:40 INFO - Successfully installed blobuploader requests docopt 08:21:40 INFO - Cleaning up... 08:21:40 INFO - Return code: 0 08:21:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:40 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 0x7fb675cfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfee640>, '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 0xfef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfef9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937', '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 08:21:40 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 08:21:40 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 08:21:40 INFO - Using env: {'DISPLAY': ':0', 08:21:40 INFO - 'HOME': '/home/cltbld', 08:21:40 INFO - 'LANG': 'en_US.UTF-8', 08:21:40 INFO - 'LANGUAGE': 'en_US:en', 08:21:40 INFO - 'LOGNAME': 'cltbld', 08:21:40 INFO - 'MAIL': '/var/mail/cltbld', 08:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:40 INFO - 'MOZ_NO_REMOTE': '1', 08:21:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:40 INFO - 'NO_EM_RESTART': '1', 08:21:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:40 INFO - 'PWD': '/builds/slave/test', 08:21:40 INFO - 'SHELL': '/bin/bash', 08:21:40 INFO - 'SHLVL': '1', 08:21:40 INFO - 'TERM': 'linux', 08:21:40 INFO - 'TMOUT': '86400', 08:21:40 INFO - 'USER': 'cltbld', 08:21:40 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937', 08:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:40 INFO - '_': '/tools/buildbot/bin/python'} 08:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:21:40 INFO - Running setup.py (path:/tmp/pip-fQeKPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:21:40 INFO - Running setup.py (path:/tmp/pip-9vC0hn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:21:40 INFO - Running setup.py (path:/tmp/pip-rpUG51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:21:40 INFO - Running setup.py (path:/tmp/pip-7sHfl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:21:40 INFO - Running setup.py (path:/tmp/pip-xheBaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:21:40 INFO - Running setup.py (path:/tmp/pip-pwegjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:21:40 INFO - Running setup.py (path:/tmp/pip-dGktok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:21:40 INFO - Running setup.py (path:/tmp/pip-JLrjjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:21:40 INFO - Running setup.py (path:/tmp/pip-uUDVF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:21:40 INFO - Running setup.py (path:/tmp/pip-Na21PJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:21:41 INFO - Running setup.py (path:/tmp/pip-32rlPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:21:41 INFO - Running setup.py (path:/tmp/pip-TSp9hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:21:41 INFO - Running setup.py (path:/tmp/pip-6AiB75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:21:41 INFO - Running setup.py (path:/tmp/pip-9_YfkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:41 INFO - Running setup.py (path:/tmp/pip-0O6iih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:21:41 INFO - Running setup.py (path:/tmp/pip-VacZnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:21:41 INFO - Running setup.py (path:/tmp/pip-A73L49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:21:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:21:41 INFO - Running setup.py install for manifestparser 08:21:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:21:41 INFO - Running setup.py install for mozcrash 08:21:41 INFO - Running setup.py install for mozdebug 08:21:41 INFO - Running setup.py install for mozdevice 08:21:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:21:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:21:41 INFO - Running setup.py install for mozfile 08:21:42 INFO - Running setup.py install for mozhttpd 08:21:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:21:42 INFO - Running setup.py install for mozinfo 08:21:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:21:42 INFO - Running setup.py install for mozInstall 08:21:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:21:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:21:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:21:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:21:42 INFO - Running setup.py install for mozleak 08:21:42 INFO - Running setup.py install for mozlog 08:21:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:21:42 INFO - Running setup.py install for moznetwork 08:21:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:21:42 INFO - Running setup.py install for mozprocess 08:21:42 INFO - Running setup.py install for mozprofile 08:21:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:21:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:21:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:21:42 INFO - Running setup.py install for mozrunner 08:21:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:21:43 INFO - Running setup.py install for mozscreenshot 08:21:43 INFO - Running setup.py install for moztest 08:21:43 INFO - Running setup.py install for mozversion 08:21:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:21:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:21:43 INFO - Cleaning up... 08:21:43 INFO - Return code: 0 08:21:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:43 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')]} 08:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:43 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')]} 08:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:43 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 0x7fb675cfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfee640>, '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 0xfef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfef9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937', '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 08:21:43 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 08:21:43 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 08:21:43 INFO - Using env: {'DISPLAY': ':0', 08:21:43 INFO - 'HOME': '/home/cltbld', 08:21:43 INFO - 'LANG': 'en_US.UTF-8', 08:21:43 INFO - 'LANGUAGE': 'en_US:en', 08:21:43 INFO - 'LOGNAME': 'cltbld', 08:21:43 INFO - 'MAIL': '/var/mail/cltbld', 08:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:43 INFO - 'MOZ_NO_REMOTE': '1', 08:21:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:43 INFO - 'NO_EM_RESTART': '1', 08:21:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:43 INFO - 'PWD': '/builds/slave/test', 08:21:43 INFO - 'SHELL': '/bin/bash', 08:21:43 INFO - 'SHLVL': '1', 08:21:43 INFO - 'TERM': 'linux', 08:21:43 INFO - 'TMOUT': '86400', 08:21:43 INFO - 'USER': 'cltbld', 08:21:43 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937', 08:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:43 INFO - '_': '/tools/buildbot/bin/python'} 08:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:21:43 INFO - Running setup.py (path:/tmp/pip-mIpBtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:21:43 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)) 08:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:21:43 INFO - Running setup.py (path:/tmp/pip-XynXUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:21:43 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)) 08:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:21:43 INFO - Running setup.py (path:/tmp/pip-OpURYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:21:43 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)) 08:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:21:43 INFO - Running setup.py (path:/tmp/pip-nsr7uG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:21:43 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)) 08:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:21:43 INFO - Running setup.py (path:/tmp/pip-9ttKkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:21:43 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)) 08:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:21:43 INFO - Running setup.py (path:/tmp/pip-arxuc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:21:43 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)) 08:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:21:43 INFO - Running setup.py (path:/tmp/pip-2bmmgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:21:44 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)) 08:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:21:44 INFO - Running setup.py (path:/tmp/pip-PhOwPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:21:44 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)) 08:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:21:44 INFO - Running setup.py (path:/tmp/pip-3c8N1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:21:44 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)) 08:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:21:44 INFO - Running setup.py (path:/tmp/pip-7lW4t4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:21:44 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)) 08:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:21:44 INFO - Running setup.py (path:/tmp/pip-FOqZM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:21:44 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)) 08:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:21:44 INFO - Running setup.py (path:/tmp/pip-xqUb0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:21:44 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)) 08:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:21:44 INFO - Running setup.py (path:/tmp/pip-ggTk5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:21:44 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)) 08:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:21:44 INFO - Running setup.py (path:/tmp/pip-LBogsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:21:44 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)) 08:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:44 INFO - Running setup.py (path:/tmp/pip-AlwDCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:44 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)) 08:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:21:44 INFO - Running setup.py (path:/tmp/pip-J1ZlRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:21:44 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)) 08:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:21:44 INFO - Running setup.py (path:/tmp/pip-XHBV5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:21:44 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)) 08:21:44 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)) 08:21:44 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)) 08:21:44 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)) 08:21:44 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)) 08:21:44 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)) 08:21:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:46 INFO - Downloading blessings-1.6.tar.gz 08:21:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:21:46 INFO - Installing collected packages: blessings 08:21:46 INFO - Running setup.py install for blessings 08:21:46 INFO - Successfully installed blessings 08:21:46 INFO - Cleaning up... 08:21:46 INFO - Return code: 0 08:21:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:21:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:21:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:21:47 INFO - Reading from file tmpfile_stdout 08:21:47 INFO - Current package versions: 08:21:47 INFO - argparse == 1.2.1 08:21:47 INFO - blessings == 1.6 08:21:47 INFO - blobuploader == 1.2.4 08:21:47 INFO - docopt == 0.6.1 08:21:47 INFO - manifestparser == 1.1 08:21:47 INFO - mozInstall == 1.12 08:21:47 INFO - mozcrash == 0.17 08:21:47 INFO - mozdebug == 0.1 08:21:47 INFO - mozdevice == 0.48 08:21:47 INFO - mozfile == 1.2 08:21:47 INFO - mozhttpd == 0.7 08:21:47 INFO - mozinfo == 0.9 08:21:47 INFO - mozleak == 0.1 08:21:47 INFO - mozlog == 3.1 08:21:47 INFO - moznetwork == 0.27 08:21:47 INFO - mozprocess == 0.22 08:21:47 INFO - mozprofile == 0.28 08:21:47 INFO - mozrunner == 6.11 08:21:47 INFO - mozscreenshot == 0.1 08:21:47 INFO - mozsystemmonitor == 0.0 08:21:47 INFO - moztest == 0.7 08:21:47 INFO - mozversion == 1.4 08:21:47 INFO - psutil == 3.1.1 08:21:47 INFO - requests == 1.2.3 08:21:47 INFO - wsgiref == 0.1.2 08:21:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:47 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 0x7fb675cfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfee640>, '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 0xfef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfef9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937', '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 08:21:47 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 08:21:47 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 08:21:47 INFO - Using env: {'DISPLAY': ':0', 08:21:47 INFO - 'HOME': '/home/cltbld', 08:21:47 INFO - 'LANG': 'en_US.UTF-8', 08:21:47 INFO - 'LANGUAGE': 'en_US:en', 08:21:47 INFO - 'LOGNAME': 'cltbld', 08:21:47 INFO - 'MAIL': '/var/mail/cltbld', 08:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:47 INFO - 'MOZ_NO_REMOTE': '1', 08:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:47 INFO - 'NO_EM_RESTART': '1', 08:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:47 INFO - 'PWD': '/builds/slave/test', 08:21:47 INFO - 'SHELL': '/bin/bash', 08:21:47 INFO - 'SHLVL': '1', 08:21:47 INFO - 'TERM': 'linux', 08:21:47 INFO - 'TMOUT': '86400', 08:21:47 INFO - 'USER': 'cltbld', 08:21:47 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937', 08:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:47 INFO - '_': '/tools/buildbot/bin/python'} 08:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:47 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)) 08:21:47 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)) 08:21:47 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)) 08:21:47 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)) 08:21:47 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)) 08:21:47 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)) 08:21:47 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)) 08:21:47 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)) 08:21:47 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)) 08:21:47 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)) 08:21:47 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)) 08:21:47 INFO - Cleaning up... 08:21:47 INFO - Return code: 0 08:21:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb675cfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfee640>, '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 0xfef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfef9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937', '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 08:21:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:21:47 INFO - Using env: {'DISPLAY': ':0', 08:21:47 INFO - 'HOME': '/home/cltbld', 08:21:47 INFO - 'LANG': 'en_US.UTF-8', 08:21:47 INFO - 'LANGUAGE': 'en_US:en', 08:21:47 INFO - 'LOGNAME': 'cltbld', 08:21:47 INFO - 'MAIL': '/var/mail/cltbld', 08:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:47 INFO - 'MOZ_NO_REMOTE': '1', 08:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:47 INFO - 'NO_EM_RESTART': '1', 08:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:47 INFO - 'PWD': '/builds/slave/test', 08:21:47 INFO - 'SHELL': '/bin/bash', 08:21:47 INFO - 'SHLVL': '1', 08:21:47 INFO - 'TERM': 'linux', 08:21:47 INFO - 'TMOUT': '86400', 08:21:47 INFO - 'USER': 'cltbld', 08:21:47 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937', 08:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:47 INFO - '_': '/tools/buildbot/bin/python'} 08:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:47 INFO - Downloading/unpacking jsonschema 08:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:21:49 INFO - Downloading/unpacking functools32 (from jsonschema) 08:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:49 INFO - Downloading functools32-3.2.3-2.tar.gz 08:21:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:21:49 INFO - warning: no files found matching '*.txt' 08:21:49 INFO - no previously-included directories found matching 'build' 08:21:49 INFO - no previously-included directories found matching 'dist' 08:21:49 INFO - no previously-included directories found matching '.git*' 08:21:49 INFO - Installing collected packages: jsonschema, functools32 08:21:49 INFO - Running setup.py install for functools32 08:21:49 INFO - warning: no files found matching '*.txt' 08:21:49 INFO - no previously-included directories found matching 'build' 08:21:49 INFO - no previously-included directories found matching 'dist' 08:21:49 INFO - no previously-included directories found matching '.git*' 08:21:49 INFO - Successfully installed jsonschema functools32 08:21:49 INFO - Cleaning up... 08:21:49 INFO - Return code: 0 08:21:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb675cfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfee640>, '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 0xfef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfef9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937', '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 08:21:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:21:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:21:49 INFO - Using env: {'DISPLAY': ':0', 08:21:49 INFO - 'HOME': '/home/cltbld', 08:21:49 INFO - 'LANG': 'en_US.UTF-8', 08:21:49 INFO - 'LANGUAGE': 'en_US:en', 08:21:49 INFO - 'LOGNAME': 'cltbld', 08:21:49 INFO - 'MAIL': '/var/mail/cltbld', 08:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:49 INFO - 'MOZ_NO_REMOTE': '1', 08:21:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:49 INFO - 'NO_EM_RESTART': '1', 08:21:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:49 INFO - 'PWD': '/builds/slave/test', 08:21:49 INFO - 'SHELL': '/bin/bash', 08:21:49 INFO - 'SHLVL': '1', 08:21:49 INFO - 'TERM': 'linux', 08:21:49 INFO - 'TMOUT': '86400', 08:21:49 INFO - 'USER': 'cltbld', 08:21:49 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937', 08:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:49 INFO - '_': '/tools/buildbot/bin/python'} 08:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:50 INFO - Downloading/unpacking flake8 08:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:21:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:21:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:21:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:21:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:21:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:21:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:21:52 INFO - no previously-included directories found matching 'docs/_build' 08:21:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:21:52 INFO - Running setup.py install for pep8 08:21:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:21:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:21:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:21:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:21:52 INFO - no previously-included directories found matching 'docs/_build' 08:21:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:21:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:21:52 INFO - Cleaning up... 08:21:52 INFO - Return code: 0 08:21:52 INFO - Running post-action listener: _resource_record_post_action 08:21:52 INFO - Running post-action listener: _start_resource_monitoring 08:21:52 INFO - Starting resource monitoring. 08:21:52 INFO - ##### 08:21:52 INFO - ##### Running install step. 08:21:52 INFO - ##### 08:21:52 INFO - Running pre-action listener: _resource_record_pre_action 08:21:52 INFO - Running main action method: install 08:21:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:21:53 INFO - Reading from file tmpfile_stdout 08:21:53 INFO - Detecting whether we're running mozinstall >=1.0... 08:21:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:21:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:21:53 INFO - Reading from file tmpfile_stdout 08:21:53 INFO - Output received: 08:21:53 INFO - Usage: mozinstall [options] installer 08:21:53 INFO - Options: 08:21:53 INFO - -h, --help show this help message and exit 08:21:53 INFO - -d DEST, --destination=DEST 08:21:53 INFO - Directory to install application into. [default: 08:21:53 INFO - "/builds/slave/test"] 08:21:53 INFO - --app=APP Application being installed. [default: firefox] 08:21:53 INFO - mkdir: /builds/slave/test/build/application 08:21:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:21:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:22:08 INFO - Reading from file tmpfile_stdout 08:22:08 INFO - Output received: 08:22:08 INFO - /builds/slave/test/build/application/firefox/firefox 08:22:08 INFO - Running post-action listener: _resource_record_post_action 08:22:08 INFO - ##### 08:22:08 INFO - ##### Running run-tests step. 08:22:08 INFO - ##### 08:22:08 INFO - Running pre-action listener: _resource_record_pre_action 08:22:08 INFO - Running main action method: run_tests 08:22:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:22:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:22:08 INFO - Python 2.7.3 08:22:08 INFO - Return code: 0 08:22:08 INFO - grabbing minidump binary from tooltool 08:22: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')]} 08:22:08 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 0xfee640>, '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 0xfef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfef9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:22:08 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 08:22:08 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 08:22:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:22:09 INFO - Return code: 0 08:22:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:22:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:22:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:22:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:22:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:22:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:22:10 INFO - Return code: 0 08:22:10 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:22:10 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:22:10 INFO - Using env: {'DISPLAY': ':0', 08:22:10 INFO - 'HOME': '/home/cltbld', 08:22:10 INFO - 'LANG': 'en_US.UTF-8', 08:22:10 INFO - 'LANGUAGE': 'en_US:en', 08:22:10 INFO - 'LOGNAME': 'cltbld', 08:22:10 INFO - 'MAIL': '/var/mail/cltbld', 08:22:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:22:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:10 INFO - 'MOZ_NO_REMOTE': '1', 08:22:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:22:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:10 INFO - 'NO_EM_RESTART': '1', 08:22:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:10 INFO - 'PWD': '/builds/slave/test', 08:22:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:22:10 INFO - 'SHELL': '/bin/bash', 08:22:10 INFO - 'SHLVL': '1', 08:22:10 INFO - 'TERM': 'linux', 08:22:10 INFO - 'TMOUT': '86400', 08:22:10 INFO - 'USER': 'cltbld', 08:22:10 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937', 08:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:10 INFO - '_': '/tools/buildbot/bin/python'} 08:22:10 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:22:10 INFO - mozversion application_buildid: 20160414073525 08:22:10 INFO - mozversion application_changeset: aef9d5c535ae78da48047a076c4a66bab551a2da 08:22:10 INFO - mozversion application_display_name: Nightly 08:22:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:22:10 INFO - mozversion application_name: Firefox 08:22:10 INFO - mozversion application_remotingname: firefox 08:22:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:22:10 INFO - mozversion application_vendor: Mozilla 08:22:10 INFO - mozversion application_version: 48.0a1 08:22:10 INFO - mozversion platform_buildid: 20160414073525 08:22:10 INFO - mozversion platform_changeset: aef9d5c535ae78da48047a076c4a66bab551a2da 08:22:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:22:10 INFO - mozversion platform_version: 48.0a1 08:22:10 INFO - using testdate: 1460647330 08:22:10 INFO - actual date: 1460647330 08:22:10 INFO - starting webserver on 'localhost:54754' 08:22:10 INFO - SUITE-START | Running 2 tests 08:22:10 INFO - TEST-START | dromaeo_css 08:22:10 INFO - operating with platform_type : linux_ 08:22:10 INFO - Initialising browser for dromaeo_css test... 08:22:10 INFO - TEST-INFO | started process 18156 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSoQhVc/profile http://localhost:54754/getInfo.html) 08:22:14 INFO - PROCESS | 18156 | 08:22:14 INFO - PROCESS | 18156 | (process:18224): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:22:14 INFO - PROCESS | 18156 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 08:22:15 INFO - PROCESS | 18156 | __metrics Screen width/height:1600/1200 08:22:15 INFO - PROCESS | 18156 | colorDepth:24 08:22:15 INFO - PROCESS | 18156 | Browser inner width/height: 1024/697 08:22:15 INFO - PROCESS | 18156 | __metrics 08:22:15 ERROR - PROCESS | 18156 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:22:16 INFO - TEST-INFO | 18156: exit 0 08:22:16 INFO - Browser initialized. 08:22:16 INFO - Running cycle 1/1 for dromaeo_css test... 08:22:16 INFO - TEST-INFO | started process 18275 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSoQhVc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:22:18 INFO - PROCESS | 18275 | 08:22:18 INFO - PROCESS | 18275 | (process:18333): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:22:28 INFO - PROCESS | 18275 | RSS: Main: 164536320 08:22:28 INFO - PROCESS | 18275 | 08:23:18 INFO - PROCESS | 18275 | 1460647398287 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] 08:25:30 INFO - PROCESS | 18275 | Cycle 1(1): loaded http://localhost:54754/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54754/tests/dromaeo/cssquery-ext.html) 08:25:31 INFO - PROCESS | 18275 | RSS: Main: 169238528 08:25:31 INFO - PROCESS | 18275 | 08:28:33 INFO - PROCESS | 18275 | Cycle 1(1): loaded http://localhost:54754/tests/dromaeo/cssquery-ext.html (next: http://localhost:54754/tests/dromaeo/cssquery-jquery.html) 08:28:34 INFO - PROCESS | 18275 | RSS: Main: 165781504 08:28:34 INFO - PROCESS | 18275 | 08:31:35 INFO - PROCESS | 18275 | Cycle 1(1): loaded http://localhost:54754/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54754/tests/dromaeo/cssquery-mootools.html) 08:31:36 INFO - PROCESS | 18275 | RSS: Main: 166653952 08:31:36 INFO - PROCESS | 18275 | 08:34:38 INFO - PROCESS | 18275 | Cycle 1(1): loaded http://localhost:54754/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54754/tests/dromaeo/cssquery-prototype.html) 08:34:38 INFO - PROCESS | 18275 | RSS: Main: 164270080 08:34:38 INFO - PROCESS | 18275 | 08:37:41 INFO - PROCESS | 18275 | Cycle 1(1): loaded http://localhost:54754/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54754/tests/dromaeo/cssquery-yui.html) 08:37:42 INFO - PROCESS | 18275 | RSS: Main: 165806080 08:37:42 INFO - PROCESS | 18275 | 08:40:44 INFO - PROCESS | 18275 | Cycle 1(1): loaded http://localhost:54754/tests/dromaeo/cssquery-yui.html (next: http://localhost:54754/tests/dromaeo/cssquery-dojo.html) 08:40:44 INFO - PROCESS | 18275 | RSS: Main: 167788544 08:40:44 INFO - PROCESS | 18275 | 08:40:44 INFO - PROCESS | 18275 | __start_tp_report 08:40:44 INFO - PROCESS | 18275 | _x_x_mozilla_page_load 08:40:44 INFO - PROCESS | 18275 | _x_x_mozilla_page_load_details 08:40:44 INFO - PROCESS | 18275 | |i|pagename|runs| 08:40:44 INFO - PROCESS | 18275 | |0;dojo.html;2634.6443230163927;2708.4041510867614;2724.6866610339816;2754.6969833318344;2759.613654088428;4728.054389122172;4777.3789407377035;4790.7365094919805;4802.8559143225675;4858.611311095113;4682.8595142145705;4813.446453657822;4813.879653008667;4859.489753575876;4897.412310522734;4395.67032472565;4459.108178364324;4492.303692927585;4494.056248187884;4556.794944227501;571.1100886888933;4338.284183109783;4373.475182978047;4373.737575745449;4401.779911004453;4363.738175709467;4399.38408622793;4410.448693913261;4442.800073996662;4457.621102206316;4397.142557201347;4397.758123303217;4402.801873915681;4414.139242847646;4423.977880110611;4344.587264209895;4368.475782906072;4375.606195442394;4405.647548196137;4406.581374769392;4667.183242932473;4673.789679464398;4676.064787042571;4685.250359942393;4691.413573303337;5064.341635587387;5081.28861959326;5103.362079740033;5118.436971933084;5134.229865520165;5161.767720452589;5163.509466600667;5181.715005674687;5185.325907632021;5235.895282094375;4794.280857871312;4811.855644330676;4812.230043193073;4820.975895120572;4853.490383509716;5071.518205770446;5204.245384419238;5286.048511268009;5291.206319052173;5292.603054770908;5087.618428617869;5094.719790411489;5104.9744751276;5110.488951104934;5145.845624631267;5159.2003239497935;5172.353525719508;5185.844424667266;5187.170052791611;5207.401148867929;4925.285833554186;5059.696418214919;5125.666831655931;5145.485451454824;5175.327207463081;5138;5143.691378517301;5146.485351464824;5151.459096794858;5161.638685291993;4350.238708226111;4355.651547876162;4362.236608593484;4397.802098905557;4404.141192467502;3646.234290798962;3713.0717320669833;3758.624137586274;3849.095462566295;3879.689624830007;4470.8435204767675;4483.2602620567895;4505.977470112694;4534.319852022223;4549.7042692224895;5183.481651834786;5185.948140518546;5186.351706036746;5188.014277287379;5194.714290713971;4374.78126093694;4499.1451624191295;4553.5218802025975;4564.543545645409;4576.130535198302;4628.629709623289;4664.883377915511;4679.602233810097;4680.602148817321;4725.952740472551;4886.511348865085;4917.311576379238;4920.803167873388;4923.040007198633;4955.6531042826655;5040.647154699136;5151.562117220078;5216.347956505437;5248.9475105249985;5255.448177941261;4858.514148585114;4860.708357498562;4874.975625121851;4891.902161956812;4937.21004639256;4930.433000205022;5084.542391184663;5095.464976177448;5113.718745469035;5125.333706618116;5125.666831655931;5131.050755610224;5136.2038883971545;5182.144946083854;5207.609429292894;4970.254461830755;4981.128302547112;4986;5002.574781143643;5068.417132029716;4835.492273311252;4937.629677774253;4980.925286120783;4988.725620090785;4993.325901003318;4826.638002149783;4912.754362281943;4916.434610019894;4917.483664215349;4975.955049439658;4974.427940786711;4998.650094493496;5011.624128190328;5027.622928280321;5069.467705890828;4850.587700045536;4924.236743304794;4924.679895806761;4932.383452068491;4962.578180854523 08:40:44 INFO - PROCESS | 18275 | |1;ext.html;561.5339268407222;586.560079940045;606.8300875754791;609.6037575575875;635.3043417457882;34067.14832129198;34852.128696782594;34950.82524587373;35074.47388289171;35139.2430378481;33840.32319353611;34297.82851085741;34320.31359372811;34375.65624343756;34626.653733462656;7657.349125324354;7829.647665855022;7835.569043702594;7853.253940875607;7857.0964339101165;7573;7650.273224043734;7676.347510461617;7678.577678227695;7713.884291735629;7638.312551870331;7644.617769111522;7708.537487750725;7745.6127193640095;7767.262110099559;7650.8469830603635;7680.884786728204;7689.846203075935;7734.845303093906;7753.418493613001;7689.692412303501;7773.650185741655;7828.960855195744;7859.52842829432;7877.566733829637;29234.85382573095;33492.1626959328;33819.661803381896;33880;33982.1504462388;2895.985520072386;2932.5894374787545;2937.4565705344367;3172.714455698975;3362.7646064775477;24174.758252417425;24319.756802431926;24375.26874193777;24498.877505612538;24587.87706061458;3114.532820076984;3142.591463109804;3172.873085076594;3239.757018223619;3307.7353811695007;181673;182028;183196.0840195804;183215;183892;31680.36639267248;31784;31842.363152736816;31873.521897171562;31934.840325798687;32506;32534.674653253165;59527;60304;60689;14990.700185996437;15132.319045642973;15181.544553663407;15270.770938435933;15313.310901009481;10412.167026638002;10462.895371046345;10508.737281567868;10524.421156836295;10546.63086791974;18288.359907403177;18406.26374944987;18476.445706628823;18490.630187396448;18506.056864029084;6740.595564266159;6931.341522555349;7042.401395881408;7050.25972272904;7096.219415864251;881.4446898454061;896.5382827843666;919.2599957034518;987.550664447689;994.6667866264883;27570;28503.71496285052;30594;31278.84360578228;32096;920.3787443475627;924.4684306523776;948.5446985446886;976.829054915387;1053.6838948315628;14078.296085195903;14122.646933826736;14358.856411435752;14395.496157634432;14446.85553144476;330452;337257;337549;337763;337787;46733.766331168124;47273;47314.76342618334;47350;47748.522514774406;1184.703824043989;1230.7661544306552;1241.9254844709346;1248.3570960954935;1265.8227848101274;26655.200343989713;27518;27807.582886256318;28054;28218.2945426366;41881.1623767529;42526.36210456784;42613;42826.571734283505;42931.141377171654;323007;325515;325874;326894;327376;24791.752082478943;24986.75013249844;25097.24708258755;25137.120200792884;38165;36204.81897590495;37094.44358334681;37266.25467490689;37336;37596.2480750378;34424.655753442144;34779.82610087035;34797;34821.82589087039;34932.82533587316;33955.32089358248;34056.829715851265;34521.65478345184;34544.96365109051;34740;31186.68813311838;35017.29965400627;35317.29365412729;37791.43312850255;38419.615803842724;30198.698013019588;31142.221444463165;31367.529487058167;31513.8424307877;31600.209994749395;24686.629700554866;25316.620250696622;25350;25367.873160634077;25368.619470707585 08:40:44 INFO - PROCESS | 18275 | |2;jquery.html;367.5057048270077;369.78737226095;373.7103744597937;379.85375630382293;380.50344300687607;16231.513054608366;16824;17412;17513.91243043786;17530.035848028387;15544.222788860568;15884.84115158848;16416;16753.162341882886;16779.32882684691;5000.849974500762;5189.558887494568;5198.948010519903;5203.0374380739495;5211.921821172686;3658.3780757271193;5161.767720452589;5607.943920560803;5936.614120082202;5946.197263369433;5825.242718446596;5833.066709326508;5843.590948633598;5860.384659610743;5883.970580147094;5857.297124345063;5873.588848780587;5996.880062398771;6020.2775666919815;6068.757249710006;5211.687298762048;5249.685018898878;5334.893302133974;5335.306410166692;5341.786328546854;20211.89894050535;20342;20522.58954820895;20541.76749395041;20559.486012849797;1959.6276707425543;1969.5791718996034;1970.044528403723;1971.0637447212603;1978.3174804692358;12950.48198072076;13441.798373024412;13502.594922152352;13588.38852251651;13611.387487563083;1759.568905618119;1808.7919889212778;1827.4426299978634;1839.062078340043;1842.5209445544122;70535;70862.64568677175;71380;72007;72507.27492725058;9278.860817087614;9523.714288571355;9593.520323983774;9762.804743905082;9823.508824558887;12526.123171378098;12556.93266072394;12603.18079324841;12634.747305053848;12681.619551413472;7289.927100729031;7344.192138864721;7374.926250737424;7463.365613922769;7586.962065189749;7285.235050319746;7319.085114360705;7391.408687305003;7409.8147546311775;7516.173220945691;5710.428957104256;5939.287285525765;6031.396860313934;6046.576739628272;6204.937950620526;1613.7740716299727;1661.551381127089;1670.6742185273754;1672.6152984813561;1715.5796829776784;878.3587980773943;913.2602591900448;936.7611259128879;982.6118683120128;1031.128696251666;16348.75476867848;17575.82424175742;17677.646447070987;17787.911060444614;17965.820341796676;913.5660561233361;921.6497730862229;924.6255266617031;933.7478880702308;936.5832204668993;9423.19902808269;9678.75803104914;9886.703398898044;9919.206463483048;10156.644517441853;302275;305773;306288;315269;391632;82017;82955.09657161971;82995.5850220745;83341.16658833456;83448.58275708582;977.4965892565334;984.9556769945513;998.5756053677159;1006.8338724110587;1009.1775203209361;15290.464833730766;15383;15465.149416781735;15534.1456219909;15933.760993585338;35170.29659406849;35413.46879796857;35967.64032359748;36049.81975090108;36248.09379765527;47477.52522474731;47955;48313.27530087122;49170;49964.50035499599;7543.434242431949;7658.502197357154;7676.6161691916295;7720.961395192988;7730.845383092419;8473.195046470822;10593.258471906893;10708.946455267675;11357.48891299877;11468.197226194086;9956.402615843073;9959.908419231753;10115.848262275924;10121.544530496292;10548.841767373342;9961.850572241277;9992.550335234786;10026.799464010533;10393.636222732168;10501.212409069198;10301.9484902578;10327.535260913126;10447.477626118512;10451.947740261554;10528.315659482108;6750.763723269662;6955.826104347432;7166.319199676022;7585.658645360862;7688.730894418669;10012.098911097744;10020.09819116283;10026.298159129083;10035.297529172887;10247.333923294962 08:40:44 INFO - PROCESS | 18275 | |3;mootools.html;1444.927753612319;1498.2059508460516;1627.3571939084063;1730.9653806923855;1805.7020591602386;7106.96446517768;7718.228177182279;7756.767296981086;8035.357171426286;8045.839083218332;7730.34292085172;7761.223877612236;7763.06843178818;7843.372530197585;7850.8037299067555;2203.327984964585;2229.1194977983687;2235.94410139747;2236.194969810875;2238.40682219212;2144.8069673729437;2163.0482587661377;2208.7018252535945;2209.668549717539;2209.834262430316;2197.604431202383;2221.4113259986116;2225.4547635829244;2232.866028038323;2246.6068438023362;2130.7869213078725;2152.4080877758583;2154.353693891826;2157.4822042709716;2161.6109100361928;2088.7075809386697;2170.934871953844;2174.239016344283;2177.716896803421;2184.486645638274;7957.164497727771;8065.596720164027;8081.111077781439;8091.433599648027;8098.311643510308;4504.617107545862;4631.444226692818;4639;4646;4652.209124448852;2929.8828046878098;2936.765058795291;3057.785954983152;3058.525928481089;3094.5358196270513;976.414151509096;982.641335912394;983.3657291047306;1002.2533212756471;1007.9244056695704;10611.946940265327;10733.570657173781;10775.946120269427;10814.51334689933;10854.348739075602;4235.195312890541;4253.2769429197115;4399.186150562156;4421.38100665907;4488.775561221926;9279.489628070385;9281.396709214014;9297.488638124969;9349.065093490597;9367.063293670579;4534.637229021736;4539.364488971547;4547.727136371828;4549.795259213343;4563.977180114144;3696.2607478504406;4106.507219133723;4113.876583702494;4259.446271984684;4367.737935723867;3786.9431958520645;3858.382658774639;3893.260280546687;3899.9610003900166;3940.1725637616423;1229.9815502767465;1232.211384713784;1238.5355491690616;1242.5092088624942;1255.7049093463029;736.8924874857902;914.0356923445828;920.3833431600843;932.8880534335788;946.20518764237;5519.972400137974;5556.888862222733;5603.327600687943;5603.467670571289;5699.202111704365;419.0048634493079;420.2204909892106;423.36072530479197;424.613601622522;429.7765162115682;3956.347202711578;4012.0972781124015;4016.5180178378782;4019.055521952339;4103.630673239423;9696;9823.557939892722;9857.063578959987;9992.550335234931;10027.699169024942;9870.111689947938;9891.752706182258;9896.901030989598;9925.950370248247;9939.751506212402;7249.492535522569;7392.74125405619;7474.289942455458;7482.96258518704;7491.138519070377;5528.44715528444;5581.609287349846;5594.468525490072;5712.514436272963;5742.937556552051;8989.41568798026;9240.122188392092;9326.72019839406;9339.252859771066;9371.625134994523;9019;9138.817223655622;9368.25053995665;9437.528123593931;9497.667581634609;6249.78125765596;6524.1192439022025;6702.664866756741;6923;7104.502684812013;7287.4534409920525;7346.375558077623;7346.595937223504;7419.258074192753;7440;6474.5791523550815;6666.233383160805;6701.597904125768;6712.362325579063;6798.4221341184575;6576.572522786004;6596.076549283008;6619.238787539302;6670.733170673313;6677.833054173684;6436.452901503425;6437;6477.384648458389;6500.252470965899;6519.869602607826;4779.976100119477;4838.7338696372035;4907.3620429343955;4915.090708218991;4916.680415772963;4831.613470922248;4836.274558816206;4877.048975449753;4940.382452193476;4990.176620857518 08:40:44 INFO - PROCESS | 18275 | |4;prototype.html;316.0896617740907;318.99999999999983;319.8049189994104;322.05155816121504;322.8805342023451;5393.164059570768;5451.155070963997;5470.288862447876;5471.835844924649;5472.589555783312;5369.087255166622;5375.489328513795;5403;5412.134058550632;5414.35027796664;3977.840886364542;4101.794910254475;4234.851780187694;4235.195312890541;4243.448351714288;4224.429701990238;4225.767582782945;4229.709938468765;4243.087736136746;4244.872653820375;4199.45407097077;4220.155968806235;4221.451211342536;4223.408722778798;4228.640565551917;4108.28105081611;4169.895752606179;4200.432941552882;4212.199682060399;4226.36604509323;3690.0774806298427;3700.1859590889962;3703.8333275002688;3733.626637336272;3754.6808521275725;5174.689518628894;5194.727321787288;5213.869653258661;5227.163653815409;5232.189010703347;4763.14263432582;4826.951730482685;4842.104210721028;4882.316475693406;4883.5604795568215;5655.943440565583;5684.658920464785;5703.857403564903;5714.9714251428895;5733.054046082391;4094.2016306820183;4106.342985122396;4106.741292289229;4112.362583799516;4115.279826030433;5743.4543718346695;5984.670843103628;6005.369436209179;6025.969870150665;6028.980291602318;4198.5591512890705;4221.366794980716;4227;4231.286329036745;4247.5752424757275;4268.295731204378;4288.678349123766;4299.54854740254;4299.97850010748;4309.095090031066;4703.412073490814;4847.418309802776;4858.101251268456;4867.075255701406;4883.389576302962;5714.114312281603;5719.742611582489;5737.77048918047;5745.454181852718;5751.942480575224;1490.9935793339453;1491.0010293103646;1491.7911492391074;1511.2670354877876;1512.10785636475;934.2712684106408;967.2358836519071;993.8707967964118;996.5166894056376;1005.5374527717332;4915.476202377275;4951.9752401237765;4973.55238028572;4980.626453016038;4989.052080104769;5800.7099645018425;5801.8549536261935;5868.647881127146;5874.676892770854;5886.6173698709445;4859.757012149378;4870.6103511718975;4944.085344211332;4982.725950072709;5011.3986321640905;3130.2174456385906;3152.4956007038763;3159.0996565979044;3160;3170.4134735074085;5491.643043202179;5491.890162196733;5492.890142197134;5506.201600767866;5512.310961129859;5868.383819698955;5963.642181469126;5968.045112781934;5980.970095149496;6005.3394126646035;5434.70109143993;5462.0987537056735;5468.863278418072;5484.7531861066345;5498.917516237339;5640.182173584889;5822.76708931655;5832.270966129234;5852.648841069549;5867.618604790675;5719.799807006735;5743.483086522233;5749.568782341257;5751.252337196138;5751.827445176484;5446.482584154499;5493.368262649847;5494.36814766291;5495.972520137374;5496.203050557567;4094.1402305514985;4223.535411104837;4223.662107031491;4224.619784219435;4240.78796060202;5816.592838501264;5836.912446313224;5837.94162058374;5842.5325973921135;5871.735771890189;5616.494515493625;5644.85887852807;5646.181303710857;5655.773769049192;5656.462636049569;5442.12925931849;5745.971270143623;5759.683217423082;5764.13537969308;5764.855878603068;5329.920051199158;5583.497485226349;5592.580556458201;5601.663900166003;5659.660420374791;5524.861878453071;5767.192593037062;5770.769169233184;5778.653280803165;5785.566082543742;5574.526165275997;5581.162825576196;5596.3284405871555;5602.383737788921;5622.5783066271015 08:40:44 INFO - PROCESS | 18275 | |5;yui.html;665.7037618259874;760.0878945265679;773.6325245508384;779.8479296537178;796.2913007423394;10270.229732770034;11877.346745928971;11948.940255298712;11953.163278570504;12719.682007949783;12622.621321360351;12663.30351830649;12695.809562856564;12712.93643531781;12713.173643713153;787.8857565652977;792.1128336263394;792.3186059988406;798.2576204130156;801.5751651624648;787.9251471110235;792.0574516325582;797.3023604346197;798.4450806689354;801.4830434369828;844.1136806353335;844.5312851367488;845.327964268405;845.8900342955408;847.6270441005969;830.5307501261768;838.6561509780961;841.4194205997842;843.7300063979529;845.6490556419079;593.4510577715596;614.5698011391999;615.8368032471399;616.374380004296;617.7621615677951;11585.884141158649;11605.24565903222;11613.477393517227;11624.476898539586;11631.825522617168;11563.364014979257;12362.75274494505;12464.688382790502;12544.498220071186;12560.74878502434;9884.406935583887;10087.344322619007;10120.696379108565;10167.135793457564;10386.792264154674;3287.0960485866576;3305.405027095122;3316.7512436567113;3342.064222017839;3424.298018906118;42133.67994800774;43419.046142923646;43662.56337436649;47122;47367.052658946974;10093.880423899254;10110.747231319128;10167.7458063549;10267.383956962607;10406.479676016168;17247.482575522754;17255.91372043132;17288.827111728722;17289.56776080583;17353.826461735473;6548.738050478023;6613.801585952429;6651.368120028589;6769.830754231184;6804.353586409283;3677.6690097890782;3694.649008344203;3714.201446688975;3729.366007778684;3760.3983362661843;2981.373911478614;3067.6472205696186;3074.1085085325003;3202.6957439043254;3369.663033696611;549.1076999875203;554.8612846788303;564.8700798816295;573.7618888161367;574.22192928582;539.7571093008083;600.1940926170137;637.2957881540923;643.411278680012;643.6459947029115;6825.658717064127;7364.410847132217;7386.778396648109;7456.40348772097;7753.883691744629;507.4899725775646;546.8359492152339;586.1237450012259;611.181017436637;618.1438707390297;3751.118487155516;3777.4522694209186;3782.243551289753;3816.3512202925012;3820.541535015816;55544.72227638836;56429.717851411304;56712.71643641838;56756.14865776934;57588.424115759146;49291;49425.25862112071;49554.75222623936;50252;50597.747011264706;36461;36558.81720591433;36931.4460283096;37731.43402849014;37760.62239377626;7712.730054448291;7724.8455030900195;7947.84104317922;7956.323712484504;8027.879581806161;26230.344241393355;26557;26651.733482664924;26859;28586.42827143487;34232.31535369329;37085.629143709295;38304.616953830104;38720.419193711554;38741.6125838738;10147.985201479793;10242.53908574131;10345.861955184773;10440.26918115755;10451.16390688728;11884.46519906589;11925.701857453287;11962.820557691468;12066.336351500751;12455.813162802384;10803.081738052353;10806.13550915909;11044.558217671203;11295.661130166109;11668.416579171177;11047.12249469682;11221.158413119212;11292.830607540729;11392.145589081018;11860.406979651156;10616.256862019585;10822.621208257673;10845.620403285848;10876.782464350827;10912.672619821418;9560.23518118535;9635.518224088628;9680.612775489184;9698.224142068477;9760.658376957057;9451.527423628653;9685.32202745801;9734.659286924923;9944.35361701487;9968 08:40:44 INFO - PROCESS | 18275 | __end_tp_report 08:40:44 INFO - PROCESS | 18275 | __start_cc_report 08:40:44 INFO - PROCESS | 18275 | _x_x_mozilla_cycle_collect,364 08:40:44 INFO - PROCESS | 18275 | __end_cc_report 08:40:44 INFO - PROCESS | 18275 | __startTimestamp1460648444669__endTimestamp 08:40:44 INFO - PROCESS | 18275 | 08:40:44 INFO - PROCESS | 18275 | ------- Summary: start ------- 08:40:44 INFO - PROCESS | 18275 | Number of tests: 6 08:40:44 INFO - PROCESS | 18275 | 08:40:44 INFO - PROCESS | 18275 | [#0] dojo.html Cycles:165 Average:4733.05 Median:4912.75 stddev:592.93 (12.1%) stddev-sans-first:571.44 08:40:44 INFO - PROCESS | 18275 | Values: 2634.6 2708.4 2724.7 2754.7 2759.6 4728.1 4777.4 4790.7 4802.9 4858.6 4682.9 4813.4 4813.9 4859.5 4897.4 4395.7 4459.1 4492.3 4494.1 4556.8 571.1 4338.3 4373.5 4373.7 4401.8 4363.7 4399.4 4410.4 4442.8 4457.6 4397.1 4397.8 4402.8 4414.1 4424.0 4344.6 4368.5 4375.6 4405.6 4406.6 4667.2 4673.8 4676.1 4685.3 4691.4 5064.3 5081.3 5103.4 5118.4 5134.2 5161.8 5163.5 5181.7 5185.3 5235.9 4794.3 4811.9 4812.2 4821.0 4853.5 5071.5 5204.2 5286.0 5291.2 5292.6 5087.6 5094.7 5105.0 5110.5 5145.8 5159.2 5172.4 5185.8 5187.2 5207.4 4925.3 5059.7 5125.7 5145.5 5175.3 5138.0 5143.7 5146.5 5151.5 5161.6 4350.2 4355.7 4362.2 4397.8 4404.1 3646.2 3713.1 3758.6 3849.1 3879.7 4470.8 4483.3 4506.0 4534.3 4549.7 5183.5 5185.9 5186.4 5188.0 5194.7 4374.8 4499.1 4553.5 4564.5 4576.1 4628.6 4664.9 4679.6 4680.6 4726.0 4886.5 4917.3 4920.8 4923.0 4955.7 5040.6 5151.6 5216.3 5248.9 5255.4 4858.5 4860.7 4875.0 4891.9 4937.2 4930.4 5084.5 5095.5 5113.7 5125.3 5125.7 5131.1 5136.2 5182.1 5207.6 4970.3 4981.1 4986.0 5002.6 5068.4 4835.5 4937.6 4980.9 4988.7 4993.3 4826.6 4912.8 4916.4 4917.5 4976.0 4974.4 4998.7 5011.6 5027.6 5069.5 4850.6 4924.2 4924.7 4932.4 4962.6 08:40:44 INFO - PROCESS | 18275 | 08:40:44 INFO - PROCESS | 18275 | [#1] ext.html Cycles:180 Average:42758.61 Median:33829.99 stddev:76369.51 (225.7%) stddev-sans-first:76518.03 08:40:44 INFO - PROCESS | 18275 | Values: 561.5 586.6 606.8 609.6 635.3 34067.1 34852.1 34950.8 35074.5 35139.2 33840.3 34297.8 34320.3 34375.7 34626.7 7657.3 7829.6 7835.6 7853.3 7857.1 7573.0 7650.3 7676.3 7678.6 7713.9 7638.3 7644.6 7708.5 7745.6 7767.3 7650.8 7680.9 7689.8 7734.8 7753.4 7689.7 7773.7 7829.0 7859.5 7877.6 29234.9 33492.2 33819.7 33880.0 33982.2 2896.0 2932.6 2937.5 3172.7 3362.8 24174.8 24319.8 24375.3 24498.9 24587.9 3114.5 3142.6 3172.9 3239.8 3307.7 181673.0 182028.0 183196.1 183215.0 183892.0 31680.4 31784.0 31842.4 31873.5 31934.8 32506.0 32534.7 59527.0 60304.0 60689.0 14990.7 15132.3 15181.5 15270.8 15313.3 10412.2 10462.9 10508.7 10524.4 10546.6 18288.4 18406.3 18476.4 18490.6 18506.1 6740.6 6931.3 7042.4 7050.3 7096.2 881.4 896.5 919.3 987.6 994.7 27570.0 28503.7 30594.0 31278.8 32096.0 920.4 924.5 948.5 976.8 1053.7 14078.3 14122.6 14358.9 14395.5 14446.9 330452.0 337257.0 337549.0 337763.0 337787.0 46733.8 47273.0 47314.8 47350.0 47748.5 1184.7 1230.8 1241.9 1248.4 1265.8 26655.2 27518.0 27807.6 28054.0 28218.3 41881.2 42526.4 42613.0 42826.6 42931.1 323007.0 325515.0 325874.0 326894.0 327376.0 24791.8 24986.8 25097.2 25137.1 38165.0 36204.8 37094.4 37266.3 37336.0 37596.2 34424.7 34779.8 34797.0 34821.8 34932.8 33955.3 34056.8 34521.7 34545.0 34740.0 31186.7 35017.3 35317.3 37791.4 38419.6 30198.7 31142.2 31367.5 31513.8 31600.2 24686.6 25316.6 25350.0 25367.9 25368.6 08:40:44 INFO - PROCESS | 18275 | 08:40:44 INFO - PROCESS | 18275 | [#2] jquery.html Cycles:180 Average:22734.95 Median:47716.26 stddev:54493.66 (114.2%) stddev-sans-first:54620.65 08:40:44 INFO - PROCESS | 18275 | Values: 367.5 369.8 373.7 379.9 380.5 16231.5 16824.0 17412.0 17513.9 17530.0 15544.2 15884.8 16416.0 16753.2 16779.3 5000.8 5189.6 5198.9 5203.0 5211.9 3658.4 5161.8 5607.9 5936.6 5946.2 5825.2 5833.1 5843.6 5860.4 5884.0 5857.3 5873.6 5996.9 6020.3 6068.8 5211.7 5249.7 5334.9 5335.3 5341.8 20211.9 20342.0 20522.6 20541.8 20559.5 1959.6 1969.6 1970.0 1971.1 1978.3 12950.5 13441.8 13502.6 13588.4 13611.4 1759.6 1808.8 1827.4 1839.1 1842.5 70535.0 70862.6 71380.0 72007.0 72507.3 9278.9 9523.7 9593.5 9762.8 9823.5 12526.1 12556.9 12603.2 12634.7 12681.6 7289.9 7344.2 7374.9 7463.4 7587.0 7285.2 7319.1 7391.4 7409.8 7516.2 5710.4 5939.3 6031.4 6046.6 6204.9 1613.8 1661.6 1670.7 1672.6 1715.6 878.4 913.3 936.8 982.6 1031.1 16348.8 17575.8 17677.6 17787.9 17965.8 913.6 921.6 924.6 933.7 936.6 9423.2 9678.8 9886.7 9919.2 10156.6 302275.0 305773.0 306288.0 315269.0 391632.0 82017.0 82955.1 82995.6 83341.2 83448.6 977.5 985.0 998.6 1006.8 1009.2 15290.5 15383.0 15465.1 15534.1 15933.8 35170.3 35413.5 35967.6 36049.8 36248.1 47477.5 47955.0 48313.3 49170.0 49964.5 7543.4 7658.5 7676.6 7721.0 7730.8 8473.2 10593.3 10708.9 11357.5 11468.2 9956.4 9959.9 10115.8 10121.5 10548.8 9961.9 9992.6 10026.8 10393.6 10501.2 10301.9 10327.5 10447.5 10451.9 10528.3 6750.8 6955.8 7166.3 7585.7 7688.7 10012.1 10020.1 10026.3 10035.3 10247.3 08:40:44 INFO - PROCESS | 18275 | 08:40:44 INFO - PROCESS | 18275 | [#3] mootools.html Cycles:180 Average:5247.17 Median:4928.53 stddev:2935.06 (59.6%) stddev-sans-first:2929.38 08:40:44 INFO - PROCESS | 18275 | Values: 1444.9 1498.2 1627.4 1731.0 1805.7 7107.0 7718.2 7756.8 8035.4 8045.8 7730.3 7761.2 7763.1 7843.4 7850.8 2203.3 2229.1 2235.9 2236.2 2238.4 2144.8 2163.0 2208.7 2209.7 2209.8 2197.6 2221.4 2225.5 2232.9 2246.6 2130.8 2152.4 2154.4 2157.5 2161.6 2088.7 2170.9 2174.2 2177.7 2184.5 7957.2 8065.6 8081.1 8091.4 8098.3 4504.6 4631.4 4639.0 4646.0 4652.2 2929.9 2936.8 3057.8 3058.5 3094.5 976.4 982.6 983.4 1002.3 1007.9 10611.9 10733.6 10775.9 10814.5 10854.3 4235.2 4253.3 4399.2 4421.4 4488.8 9279.5 9281.4 9297.5 9349.1 9367.1 4534.6 4539.4 4547.7 4549.8 4564.0 3696.3 4106.5 4113.9 4259.4 4367.7 3786.9 3858.4 3893.3 3900.0 3940.2 1230.0 1232.2 1238.5 1242.5 1255.7 736.9 914.0 920.4 932.9 946.2 5520.0 5556.9 5603.3 5603.5 5699.2 419.0 420.2 423.4 424.6 429.8 3956.3 4012.1 4016.5 4019.1 4103.6 9696.0 9823.6 9857.1 9992.6 10027.7 9870.1 9891.8 9896.9 9926.0 9939.8 7249.5 7392.7 7474.3 7483.0 7491.1 5528.4 5581.6 5594.5 5712.5 5742.9 8989.4 9240.1 9326.7 9339.3 9371.6 9019.0 9138.8 9368.3 9437.5 9497.7 6249.8 6524.1 6702.7 6923.0 7104.5 7287.5 7346.4 7346.6 7419.3 7440.0 6474.6 6666.2 6701.6 6712.4 6798.4 6576.6 6596.1 6619.2 6670.7 6677.8 6436.5 6437.0 6477.4 6500.3 6519.9 4780.0 4838.7 4907.4 4915.1 4916.7 4831.6 4836.3 4877.0 4940.4 4990.2 08:40:44 INFO - PROCESS | 18275 | 08:40:44 INFO - PROCESS | 18275 | [#4] prototype.html Cycles:180 Average:4726.72 Median:5407.57 stddev:1364.18 (25.2%) stddev-sans-first:1327.24 08:40:44 INFO - PROCESS | 18275 | Values: 316.1 319.0 319.8 322.1 322.9 5393.2 5451.2 5470.3 5471.8 5472.6 5369.1 5375.5 5403.0 5412.1 5414.4 3977.8 4101.8 4234.9 4235.2 4243.4 4224.4 4225.8 4229.7 4243.1 4244.9 4199.5 4220.2 4221.5 4223.4 4228.6 4108.3 4169.9 4200.4 4212.2 4226.4 3690.1 3700.2 3703.8 3733.6 3754.7 5174.7 5194.7 5213.9 5227.2 5232.2 4763.1 4827.0 4842.1 4882.3 4883.6 5655.9 5684.7 5703.9 5715.0 5733.1 4094.2 4106.3 4106.7 4112.4 4115.3 5743.5 5984.7 6005.4 6026.0 6029.0 4198.6 4221.4 4227.0 4231.3 4247.6 4268.3 4288.7 4299.5 4300.0 4309.1 4703.4 4847.4 4858.1 4867.1 4883.4 5714.1 5719.7 5737.8 5745.5 5751.9 1491.0 1491.0 1491.8 1511.3 1512.1 934.3 967.2 993.9 996.5 1005.5 4915.5 4952.0 4973.6 4980.6 4989.1 5800.7 5801.9 5868.6 5874.7 5886.6 4859.8 4870.6 4944.1 4982.7 5011.4 3130.2 3152.5 3159.1 3160.0 3170.4 5491.6 5491.9 5492.9 5506.2 5512.3 5868.4 5963.6 5968.0 5981.0 6005.3 5434.7 5462.1 5468.9 5484.8 5498.9 5640.2 5822.8 5832.3 5852.6 5867.6 5719.8 5743.5 5749.6 5751.3 5751.8 5446.5 5493.4 5494.4 5496.0 5496.2 4094.1 4223.5 4223.7 4224.6 4240.8 5816.6 5836.9 5837.9 5842.5 5871.7 5616.5 5644.9 5646.2 5655.8 5656.5 5442.1 5746.0 5759.7 5764.1 5764.9 5329.9 5583.5 5592.6 5601.7 5659.7 5524.9 5767.2 5770.8 5778.7 5785.6 5574.5 5581.2 5596.3 5602.4 5622.6 08:40:44 INFO - PROCESS | 18275 | 08:40:44 INFO - PROCESS | 18275 | [#5] yui.html Cycles:180 Average:12667.11 Median:21062.58 stddev:14513.99 (68.9%) stddev-sans-first:14526.72 08:40:44 INFO - PROCESS | 18275 | Values: 665.7 760.1 773.6 779.8 796.3 10270.2 11877.3 11948.9 11953.2 12719.7 12622.6 12663.3 12695.8 12712.9 12713.2 787.9 792.1 792.3 798.3 801.6 787.9 792.1 797.3 798.4 801.5 844.1 844.5 845.3 845.9 847.6 830.5 838.7 841.4 843.7 845.6 593.5 614.6 615.8 616.4 617.8 11585.9 11605.2 11613.5 11624.5 11631.8 11563.4 12362.8 12464.7 12544.5 12560.7 9884.4 10087.3 10120.7 10167.1 10386.8 3287.1 3305.4 3316.8 3342.1 3424.3 42133.7 43419.0 43662.6 47122.0 47367.1 10093.9 10110.7 10167.7 10267.4 10406.5 17247.5 17255.9 17288.8 17289.6 17353.8 6548.7 6613.8 6651.4 6769.8 6804.4 3677.7 3694.6 3714.2 3729.4 3760.4 2981.4 3067.6 3074.1 3202.7 3369.7 549.1 554.9 564.9 573.8 574.2 539.8 600.2 637.3 643.4 643.6 6825.7 7364.4 7386.8 7456.4 7753.9 507.5 546.8 586.1 611.2 618.1 3751.1 3777.5 3782.2 3816.4 3820.5 55544.7 56429.7 56712.7 56756.1 57588.4 49291.0 49425.3 49554.8 50252.0 50597.7 36461.0 36558.8 36931.4 37731.4 37760.6 7712.7 7724.8 7947.8 7956.3 8027.9 26230.3 26557.0 26651.7 26859.0 28586.4 34232.3 37085.6 38304.6 38720.4 38741.6 10148.0 10242.5 10345.9 10440.3 10451.2 11884.5 11925.7 11962.8 12066.3 12455.8 10803.1 10806.1 11044.6 11295.7 11668.4 11047.1 11221.2 11292.8 11392.1 11860.4 10616.3 10822.6 10845.6 10876.8 10912.7 9560.2 9635.5 9680.6 9698.2 9760.7 9451.5 9685.3 9734.7 9944.4 9968.0 08:40:44 INFO - PROCESS | 18275 | -------- Summary: end -------- 08:40:44 INFO - PROCESS | 18275 | 08:40:45 INFO - TEST-INFO | 18275: exit 0 08:40:45 INFO - TEST-OK | dromaeo_css | took 1115186ms 08:40:45 INFO - TEST-START | kraken 08:40:45 INFO - operating with platform_type : linux_ 08:40:45 INFO - Initialising browser for kraken test... 08:40:45 INFO - TEST-INFO | started process 18503 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI10NZU/profile http://localhost:54754/getInfo.html) 08:40:49 INFO - PROCESS | 18503 | 08:40:49 INFO - PROCESS | 18503 | (process:18568): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:40:49 INFO - PROCESS | 18503 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 08:40:50 INFO - PROCESS | 18503 | __metrics Screen width/height:1600/1200 08:40:50 INFO - PROCESS | 18503 | colorDepth:24 08:40:50 INFO - PROCESS | 18503 | Browser inner width/height: 1024/697 08:40:50 INFO - PROCESS | 18503 | __metrics 08:40:50 ERROR - PROCESS | 18503 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:40:51 INFO - TEST-INFO | 18503: exit 0 08:40:51 INFO - Browser initialized. 08:40:51 INFO - Running cycle 1/1 for kraken test... 08:40:51 INFO - TEST-INFO | started process 18619 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI10NZU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:40:53 INFO - PROCESS | 18619 | 08:40:53 INFO - PROCESS | 18619 | (process:18678): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:41:03 INFO - PROCESS | 18619 | RSS: Main: 164589568 08:41:03 INFO - PROCESS | 18619 | 08:41:06 INFO - PROCESS | 18619 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54754/tests/kraken/driver.html?testName=audio-beat-detection) 08:41:07 INFO - PROCESS | 18619 | RSS: Main: 168747008 08:41:07 INFO - PROCESS | 18619 | 08:41:09 INFO - PROCESS | 18619 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54754/tests/kraken/driver.html?testName=audio-dft) 08:41:10 INFO - PROCESS | 18619 | RSS: Main: 172187648 08:41:10 INFO - PROCESS | 18619 | 08:41:13 INFO - PROCESS | 18619 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54754/tests/kraken/driver.html?testName=audio-fft) 08:41:14 INFO - PROCESS | 18619 | RSS: Main: 163454976 08:41:14 INFO - PROCESS | 18619 | 08:41:16 INFO - PROCESS | 18619 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54754/tests/kraken/driver.html?testName=audio-oscillator) 08:41:16 INFO - PROCESS | 18619 | RSS: Main: 163840000 08:41:16 INFO - PROCESS | 18619 | 08:41:19 INFO - PROCESS | 18619 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54754/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:41:19 INFO - PROCESS | 18619 | RSS: Main: 164372480 08:41:19 INFO - PROCESS | 18619 | 08:41:23 INFO - PROCESS | 18619 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54754/tests/kraken/driver.html?testName=imaging-darkroom) 08:41:23 INFO - PROCESS | 18619 | RSS: Main: 164368384 08:41:23 INFO - PROCESS | 18619 | 08:41:27 INFO - PROCESS | 18619 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54754/tests/kraken/driver.html?testName=imaging-desaturate) 08:41:27 INFO - PROCESS | 18619 | RSS: Main: 163799040 08:41:27 INFO - PROCESS | 18619 | 08:41:30 INFO - PROCESS | 18619 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54754/tests/kraken/driver.html?testName=json-parse-financial) 08:41:31 INFO - PROCESS | 18619 | RSS: Main: 164614144 08:41:31 INFO - PROCESS | 18619 | 08:41:33 INFO - PROCESS | 18619 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54754/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:41:33 INFO - PROCESS | 18619 | RSS: Main: 164937728 08:41:33 INFO - PROCESS | 18619 | 08:41:35 INFO - PROCESS | 18619 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54754/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:41:36 INFO - PROCESS | 18619 | RSS: Main: 165769216 08:41:36 INFO - PROCESS | 18619 | 08:41:38 INFO - PROCESS | 18619 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54754/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:41:39 INFO - PROCESS | 18619 | RSS: Main: 165355520 08:41:39 INFO - PROCESS | 18619 | 08:41:42 INFO - PROCESS | 18619 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54754/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:41:42 INFO - PROCESS | 18619 | RSS: Main: 165617664 08:41:42 INFO - PROCESS | 18619 | 08:41:45 INFO - PROCESS | 18619 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54754/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:41:46 INFO - PROCESS | 18619 | RSS: Main: 165703680 08:41:46 INFO - PROCESS | 18619 | 08:41:48 INFO - PROCESS | 18619 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54754/tests/kraken/driver.html?testName=ai-astar) 08:41:48 INFO - PROCESS | 18619 | RSS: Main: 167264256 08:41:48 INFO - PROCESS | 18619 | 08:41:48 INFO - PROCESS | 18619 | __start_tp_report 08:41:48 INFO - PROCESS | 18619 | _x_x_mozilla_page_load 08:41:48 INFO - PROCESS | 18619 | _x_x_mozilla_page_load_details 08:41:48 INFO - PROCESS | 18619 | |i|pagename|runs| 08:41:48 INFO - PROCESS | 18619 | |0;ai-astar;113;109;113;114;115;126;113;112;114;113 08:41:48 INFO - PROCESS | 18619 | |1;audio-beat-detection;156;132;165;183;132;166;166;134;195;134 08:41:48 INFO - PROCESS | 18619 | |2;audio-dft;162;161;161;168;168;165;164;165;166;163 08:41:48 INFO - PROCESS | 18619 | |3;audio-fft;77;75;74;153;74;82;75;76;155;73 08:41:48 INFO - PROCESS | 18619 | |4;audio-oscillator;95;94;156;94;96;94;144;94;94;140 08:41:48 INFO - PROCESS | 18619 | |5;imaging-gaussian-blur;117;118;118;118;117;118;118;117;119;118 08:41:48 INFO - PROCESS | 18619 | |6;imaging-darkroom;147;148;151;147;149;148;147;147;148;148 08:41:48 INFO - PROCESS | 18619 | |7;imaging-desaturate;96;96;97;96;96;97;96;97;96;96 08:41:48 INFO - PROCESS | 18619 | |8;json-parse-financial;67;67;67;67;66;66;68;86;65;65 08:41:48 INFO - PROCESS | 18619 | |9;json-stringify-tinderbox;66;65;65;65;68;65;68;65;64;64 08:41:48 INFO - PROCESS | 18619 | |10;stanford-crypto-aes;84;84;94;85;87;101;85;86;86;85 08:41:48 INFO - PROCESS | 18619 | |11;stanford-crypto-ccm;141;151;146;147;139;146;144;140;170;149 08:41:48 INFO - PROCESS | 18619 | |12;stanford-crypto-pbkdf2;178;180;184;176;175;175;179;179;175;178 08:41:48 INFO - PROCESS | 18619 | |13;stanford-crypto-sha256-iterative;75;74;74;72;75;75;75;71;72;73 08:41:48 INFO - PROCESS | 18619 | __end_tp_report 08:41:48 INFO - PROCESS | 18619 | __start_cc_report 08:41:48 INFO - PROCESS | 18619 | _x_x_mozilla_cycle_collect,934 08:41:48 INFO - PROCESS | 18619 | __end_cc_report 08:41:48 INFO - PROCESS | 18619 | __startTimestamp1460648508293__endTimestamp 08:41:48 INFO - PROCESS | 18619 | 08:41:48 INFO - PROCESS | 18619 | ------- Summary: start ------- 08:41:48 INFO - PROCESS | 18619 | Number of tests: 14 08:41:48 INFO - PROCESS | 18619 | 08:41:48 INFO - PROCESS | 18619 | [#0] ai-astar Cycles:10 Average:114.20 Median:113.50 stddev:4.44 (3.9%) stddev-sans-first:4.69 08:41:48 INFO - PROCESS | 18619 | Values: 113.0 109.0 113.0 114.0 115.0 126.0 113.0 112.0 114.0 113.0 08:41:48 INFO - PROCESS | 18619 | 08:41:48 INFO - PROCESS | 18619 | [#1] audio-beat-detection Cycles:10 Average:156.30 Median:165.50 stddev:22.73 (13.7%) stddev-sans-first:24.11 08:41:48 INFO - PROCESS | 18619 | Values: 156.0 132.0 165.0 183.0 132.0 166.0 166.0 134.0 195.0 134.0 08:41:48 INFO - PROCESS | 18619 | 08:41:48 INFO - PROCESS | 18619 | [#2] audio-dft Cycles:10 Average:164.30 Median:165.00 stddev:2.58 (1.6%) stddev-sans-first:2.60 08:41:48 INFO - PROCESS | 18619 | Values: 162.0 161.0 161.0 168.0 168.0 165.0 164.0 165.0 166.0 163.0 08:41:48 INFO - PROCESS | 18619 | 08:41:48 INFO - PROCESS | 18619 | [#3] audio-fft Cycles:10 Average:91.40 Median:75.00 stddev:33.09 (44.1%) stddev-sans-first:34.68 08:41:48 INFO - PROCESS | 18619 | Values: 77.0 75.0 74.0 153.0 74.0 82.0 75.0 76.0 155.0 73.0 08:41:48 INFO - PROCESS | 18619 | 08:41:48 INFO - PROCESS | 18619 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:94.00 stddev:25.54 (27.2%) stddev-sans-first:26.50 08:41:48 INFO - PROCESS | 18619 | Values: 95.0 94.0 156.0 94.0 96.0 94.0 144.0 94.0 94.0 140.0 08:41:48 INFO - PROCESS | 18619 | 08:41:48 INFO - PROCESS | 18619 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 08:41:48 INFO - PROCESS | 18619 | Values: 117.0 118.0 118.0 118.0 117.0 118.0 118.0 117.0 119.0 118.0 08:41:48 INFO - PROCESS | 18619 | 08:41:48 INFO - PROCESS | 18619 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 08:41:48 INFO - PROCESS | 18619 | Values: 147.0 148.0 151.0 147.0 149.0 148.0 147.0 147.0 148.0 148.0 08:41:48 INFO - PROCESS | 18619 | 08:41:48 INFO - PROCESS | 18619 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:41:48 INFO - PROCESS | 18619 | Values: 96.0 96.0 97.0 96.0 96.0 97.0 96.0 97.0 96.0 96.0 08:41:48 INFO - PROCESS | 18619 | 08:41:48 INFO - PROCESS | 18619 | [#8] json-parse-financial Cycles:10 Average:68.40 Median:67.00 stddev:6.26 (9.3%) stddev-sans-first:6.62 08:41:48 INFO - PROCESS | 18619 | Values: 67.0 67.0 67.0 67.0 66.0 66.0 68.0 86.0 65.0 65.0 08:41:48 INFO - PROCESS | 18619 | 08:41:48 INFO - PROCESS | 18619 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.00 stddev:1.43 (2.2%) stddev-sans-first:1.51 08:41:48 INFO - PROCESS | 18619 | Values: 66.0 65.0 65.0 65.0 68.0 65.0 68.0 65.0 64.0 64.0 08:41:48 INFO - PROCESS | 18619 | 08:41:48 INFO - PROCESS | 18619 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:85.50 stddev:5.50 (6.4%) stddev-sans-first:5.67 08:41:48 INFO - PROCESS | 18619 | Values: 84.0 84.0 94.0 85.0 87.0 101.0 85.0 86.0 86.0 85.0 08:41:48 INFO - PROCESS | 18619 | 08:41:48 INFO - PROCESS | 18619 | [#11] stanford-crypto-ccm Cycles:10 Average:147.30 Median:146.50 stddev:8.87 (6.1%) stddev-sans-first:9.11 08:41:48 INFO - PROCESS | 18619 | Values: 141.0 151.0 146.0 147.0 139.0 146.0 144.0 140.0 170.0 149.0 08:41:48 INFO - PROCESS | 18619 | 08:41:48 INFO - PROCESS | 18619 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.90 Median:178.50 stddev:2.85 (1.6%) stddev-sans-first:3.02 08:41:48 INFO - PROCESS | 18619 | Values: 178.0 180.0 184.0 176.0 175.0 175.0 179.0 179.0 175.0 178.0 08:41:48 INFO - PROCESS | 18619 | 08:41:48 INFO - PROCESS | 18619 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:74.50 stddev:1.51 (2.0%) stddev-sans-first:1.51 08:41:48 INFO - PROCESS | 18619 | Values: 75.0 74.0 74.0 72.0 75.0 75.0 75.0 71.0 72.0 73.0 08:41:48 INFO - PROCESS | 18619 | -------- Summary: end -------- 08:41:48 INFO - PROCESS | 18619 | 08:41:49 INFO - TEST-INFO | 18619: exit 0 08:41:49 INFO - TEST-OK | kraken | took 63952ms 08:41:49 INFO - SUITE-END | took 1179s 08:41:49 INFO - Completed test suite (00:19:39) 08:41:49 INFO - javascript benchmark 08:41:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2634.6443230163927, 2708.4041510867614, 2724.6866610339816, 2754.6969833318344, 2759.613654088428, 4728.054389122172, 4777.3789407377035, 4790.7365094919805, 4802.8559143225675, 4858.611311095113, 4682.8595142145705, 4813.446453657822, 4813.879653008667, 4859.489753575876, 4897.412310522734, 4395.67032472565, 4459.108178364324, 4492.303692927585, 4494.056248187884, 4556.794944227501, 571.1100886888933, 4338.284183109783, 4373.475182978047, 4373.737575745449, 4401.779911004453, 4363.738175709467, 4399.38408622793, 4410.448693913261, 4442.800073996662, 4457.621102206316, 4397.142557201347, 4397.758123303217, 4402.801873915681, 4414.139242847646, 4423.977880110611, 4344.587264209895, 4368.475782906072, 4375.606195442394, 4405.647548196137, 4406.581374769392, 4667.183242932473, 4673.789679464398, 4676.064787042571, 4685.250359942393, 4691.413573303337, 5064.341635587387, 5081.28861959326, 5103.362079740033, 5118.436971933084, 5134.229865520165, 5161.767720452589, 5163.509466600667, 5181.715005674687, 5185.325907632021, 5235.895282094375, 4794.280857871312, 4811.855644330676, 4812.230043193073, 4820.975895120572, 4853.490383509716, 5071.518205770446, 5204.245384419238, 5286.048511268009, 5291.206319052173, 5292.603054770908, 5087.618428617869, 5094.719790411489, 5104.9744751276, 5110.488951104934, 5145.845624631267, 5159.2003239497935, 5172.353525719508, 5185.844424667266, 5187.170052791611, 5207.401148867929, 4925.285833554186, 5059.696418214919, 5125.666831655931, 5145.485451454824, 5175.327207463081, 5138.0, 5143.691378517301, 5146.485351464824, 5151.459096794858, 5161.638685291993, 4350.238708226111, 4355.651547876162, 4362.236608593484, 4397.802098905557, 4404.141192467502, 3646.234290798962, 3713.0717320669833, 3758.624137586274, 3849.095462566295, 3879.689624830007, 4470.8435204767675, 4483.2602620567895, 4505.977470112694, 4534.319852022223, 4549.7042692224895, 5183.481651834786, 5185.948140518546, 5186.351706036746, 5188.014277287379, 5194.714290713971, 4374.78126093694, 4499.1451624191295, 4553.5218802025975, 4564.543545645409, 4576.130535198302, 4628.629709623289, 4664.883377915511, 4679.602233810097, 4680.602148817321, 4725.952740472551, 4886.511348865085, 4917.311576379238, 4920.803167873388, 4923.040007198633, 4955.6531042826655, 5040.647154699136, 5151.562117220078, 5216.347956505437, 5248.9475105249985, 5255.448177941261, 4858.514148585114, 4860.708357498562, 4874.975625121851, 4891.902161956812, 4937.21004639256, 4930.433000205022, 5084.542391184663, 5095.464976177448, 5113.718745469035, 5125.333706618116, 5125.666831655931, 5131.050755610224, 5136.2038883971545, 5182.144946083854, 5207.609429292894, 4970.254461830755, 4981.128302547112, 4986.0, 5002.574781143643, 5068.417132029716, 4835.492273311252, 4937.629677774253, 4980.925286120783, 4988.725620090785, 4993.325901003318, 4826.638002149783, 4912.754362281943, 4916.434610019894, 4917.483664215349, 4975.955049439658, 4974.427940786711, 4998.650094493496, 5011.624128190328, 5027.622928280321, 5069.467705890828, 4850.587700045536, 4924.236743304794, 4924.679895806761, 4932.383452068491, 4962.578180854523], "value": 4697.4276024898745, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.5339268407222, 586.560079940045, 606.8300875754791, 609.6037575575875, 635.3043417457882, 34067.14832129198, 34852.128696782594, 34950.82524587373, 35074.47388289171, 35139.2430378481, 33840.32319353611, 34297.82851085741, 34320.31359372811, 34375.65624343756, 34626.653733462656, 7657.349125324354, 7829.647665855022, 7835.569043702594, 7853.253940875607, 7857.0964339101165, 7573.0, 7650.273224043734, 7676.347510461617, 7678.577678227695, 7713.884291735629, 7638.312551870331, 7644.617769111522, 7708.537487750725, 7745.6127193640095, 7767.262110099559, 7650.8469830603635, 7680.884786728204, 7689.846203075935, 7734.845303093906, 7753.418493613001, 7689.692412303501, 7773.650185741655, 7828.960855195744, 7859.52842829432, 7877.566733829637, 29234.85382573095, 33492.1626959328, 33819.661803381896, 33880.0, 33982.1504462388, 2895.985520072386, 2932.5894374787545, 2937.4565705344367, 3172.714455698975, 3362.7646064775477, 24174.758252417425, 24319.756802431926, 24375.26874193777, 24498.877505612538, 24587.87706061458, 3114.532820076984, 3142.591463109804, 3172.873085076594, 3239.757018223619, 3307.7353811695007, 181673.0, 182028.0, 183196.0840195804, 183215.0, 183892.0, 31680.36639267248, 31784.0, 31842.363152736816, 31873.521897171562, 31934.840325798687, 32506.0, 32534.674653253165, 59527.0, 60304.0, 60689.0, 14990.700185996437, 15132.319045642973, 15181.544553663407, 15270.770938435933, 15313.310901009481, 10412.167026638002, 10462.895371046345, 10508.737281567868, 10524.421156836295, 10546.63086791974, 18288.359907403177, 18406.26374944987, 18476.445706628823, 18490.630187396448, 18506.056864029084, 6740.595564266159, 6931.341522555349, 7042.401395881408, 7050.25972272904, 7096.219415864251, 881.4446898454061, 896.5382827843666, 919.2599957034518, 987.550664447689, 994.6667866264883, 27570.0, 28503.71496285052, 30594.0, 31278.84360578228, 32096.0, 920.3787443475627, 924.4684306523776, 948.5446985446886, 976.829054915387, 1053.6838948315628, 14078.296085195903, 14122.646933826736, 14358.856411435752, 14395.496157634432, 14446.85553144476, 330452.0, 337257.0, 337549.0, 337763.0, 337787.0, 46733.766331168124, 47273.0, 47314.76342618334, 47350.0, 47748.522514774406, 1184.703824043989, 1230.7661544306552, 1241.9254844709346, 1248.3570960954935, 1265.8227848101274, 26655.200343989713, 27518.0, 27807.582886256318, 28054.0, 28218.2945426366, 41881.1623767529, 42526.36210456784, 42613.0, 42826.571734283505, 42931.141377171654, 323007.0, 325515.0, 325874.0, 326894.0, 327376.0, 24791.752082478943, 24986.75013249844, 25097.24708258755, 25137.120200792884, 38165.0, 36204.81897590495, 37094.44358334681, 37266.25467490689, 37336.0, 37596.2480750378, 34424.655753442144, 34779.82610087035, 34797.0, 34821.82589087039, 34932.82533587316, 33955.32089358248, 34056.829715851265, 34521.65478345184, 34544.96365109051, 34740.0, 31186.68813311838, 35017.29965400627, 35317.29365412729, 37791.43312850255, 38419.615803842724, 30198.698013019588, 31142.221444463165, 31367.529487058167, 31513.8424307877, 31600.209994749395, 24686.629700554866, 25316.620250696622, 25350.0, 25367.873160634077, 25368.619470707585], "value": 16636.918141022034, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.5057048270077, 369.78737226095, 373.7103744597937, 379.85375630382293, 380.50344300687607, 16231.513054608366, 16824.0, 17412.0, 17513.91243043786, 17530.035848028387, 15544.222788860568, 15884.84115158848, 16416.0, 16753.162341882886, 16779.32882684691, 5000.849974500762, 5189.558887494568, 5198.948010519903, 5203.0374380739495, 5211.921821172686, 3658.3780757271193, 5161.767720452589, 5607.943920560803, 5936.614120082202, 5946.197263369433, 5825.242718446596, 5833.066709326508, 5843.590948633598, 5860.384659610743, 5883.970580147094, 5857.297124345063, 5873.588848780587, 5996.880062398771, 6020.2775666919815, 6068.757249710006, 5211.687298762048, 5249.685018898878, 5334.893302133974, 5335.306410166692, 5341.786328546854, 20211.89894050535, 20342.0, 20522.58954820895, 20541.76749395041, 20559.486012849797, 1959.6276707425543, 1969.5791718996034, 1970.044528403723, 1971.0637447212603, 1978.3174804692358, 12950.48198072076, 13441.798373024412, 13502.594922152352, 13588.38852251651, 13611.387487563083, 1759.568905618119, 1808.7919889212778, 1827.4426299978634, 1839.062078340043, 1842.5209445544122, 70535.0, 70862.64568677175, 71380.0, 72007.0, 72507.27492725058, 9278.860817087614, 9523.714288571355, 9593.520323983774, 9762.804743905082, 9823.508824558887, 12526.123171378098, 12556.93266072394, 12603.18079324841, 12634.747305053848, 12681.619551413472, 7289.927100729031, 7344.192138864721, 7374.926250737424, 7463.365613922769, 7586.962065189749, 7285.235050319746, 7319.085114360705, 7391.408687305003, 7409.8147546311775, 7516.173220945691, 5710.428957104256, 5939.287285525765, 6031.396860313934, 6046.576739628272, 6204.937950620526, 1613.7740716299727, 1661.551381127089, 1670.6742185273754, 1672.6152984813561, 1715.5796829776784, 878.3587980773943, 913.2602591900448, 936.7611259128879, 982.6118683120128, 1031.128696251666, 16348.75476867848, 17575.82424175742, 17677.646447070987, 17787.911060444614, 17965.820341796676, 913.5660561233361, 921.6497730862229, 924.6255266617031, 933.7478880702308, 936.5832204668993, 9423.19902808269, 9678.75803104914, 9886.703398898044, 9919.206463483048, 10156.644517441853, 302275.0, 305773.0, 306288.0, 315269.0, 391632.0, 82017.0, 82955.09657161971, 82995.5850220745, 83341.16658833456, 83448.58275708582, 977.4965892565334, 984.9556769945513, 998.5756053677159, 1006.8338724110587, 1009.1775203209361, 15290.464833730766, 15383.0, 15465.149416781735, 15534.1456219909, 15933.760993585338, 35170.29659406849, 35413.46879796857, 35967.64032359748, 36049.81975090108, 36248.09379765527, 47477.52522474731, 47955.0, 48313.27530087122, 49170.0, 49964.50035499599, 7543.434242431949, 7658.502197357154, 7676.6161691916295, 7720.961395192988, 7730.845383092419, 8473.195046470822, 10593.258471906893, 10708.946455267675, 11357.48891299877, 11468.197226194086, 9956.402615843073, 9959.908419231753, 10115.848262275924, 10121.544530496292, 10548.841767373342, 9961.850572241277, 9992.550335234786, 10026.799464010533, 10393.636222732168, 10501.212409069198, 10301.9484902578, 10327.535260913126, 10447.477626118512, 10451.947740261554, 10528.315659482108, 6750.763723269662, 6955.826104347432, 7166.319199676022, 7585.658645360862, 7688.730894418669, 10012.098911097744, 10020.09819116283, 10026.298159129083, 10035.297529172887, 10247.333923294962], "value": 8372.160707903564, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1444.927753612319, 1498.2059508460516, 1627.3571939084063, 1730.9653806923855, 1805.7020591602386, 7106.96446517768, 7718.228177182279, 7756.767296981086, 8035.357171426286, 8045.839083218332, 7730.34292085172, 7761.223877612236, 7763.06843178818, 7843.372530197585, 7850.8037299067555, 2203.327984964585, 2229.1194977983687, 2235.94410139747, 2236.194969810875, 2238.40682219212, 2144.8069673729437, 2163.0482587661377, 2208.7018252535945, 2209.668549717539, 2209.834262430316, 2197.604431202383, 2221.4113259986116, 2225.4547635829244, 2232.866028038323, 2246.6068438023362, 2130.7869213078725, 2152.4080877758583, 2154.353693891826, 2157.4822042709716, 2161.6109100361928, 2088.7075809386697, 2170.934871953844, 2174.239016344283, 2177.716896803421, 2184.486645638274, 7957.164497727771, 8065.596720164027, 8081.111077781439, 8091.433599648027, 8098.311643510308, 4504.617107545862, 4631.444226692818, 4639.0, 4646.0, 4652.209124448852, 2929.8828046878098, 2936.765058795291, 3057.785954983152, 3058.525928481089, 3094.5358196270513, 976.414151509096, 982.641335912394, 983.3657291047306, 1002.2533212756471, 1007.9244056695704, 10611.946940265327, 10733.570657173781, 10775.946120269427, 10814.51334689933, 10854.348739075602, 4235.195312890541, 4253.2769429197115, 4399.186150562156, 4421.38100665907, 4488.775561221926, 9279.489628070385, 9281.396709214014, 9297.488638124969, 9349.065093490597, 9367.063293670579, 4534.637229021736, 4539.364488971547, 4547.727136371828, 4549.795259213343, 4563.977180114144, 3696.2607478504406, 4106.507219133723, 4113.876583702494, 4259.446271984684, 4367.737935723867, 3786.9431958520645, 3858.382658774639, 3893.260280546687, 3899.9610003900166, 3940.1725637616423, 1229.9815502767465, 1232.211384713784, 1238.5355491690616, 1242.5092088624942, 1255.7049093463029, 736.8924874857902, 914.0356923445828, 920.3833431600843, 932.8880534335788, 946.20518764237, 5519.972400137974, 5556.888862222733, 5603.327600687943, 5603.467670571289, 5699.202111704365, 419.0048634493079, 420.2204909892106, 423.36072530479197, 424.613601622522, 429.7765162115682, 3956.347202711578, 4012.0972781124015, 4016.5180178378782, 4019.055521952339, 4103.630673239423, 9696.0, 9823.557939892722, 9857.063578959987, 9992.550335234931, 10027.699169024942, 9870.111689947938, 9891.752706182258, 9896.901030989598, 9925.950370248247, 9939.751506212402, 7249.492535522569, 7392.74125405619, 7474.289942455458, 7482.96258518704, 7491.138519070377, 5528.44715528444, 5581.609287349846, 5594.468525490072, 5712.514436272963, 5742.937556552051, 8989.41568798026, 9240.122188392092, 9326.72019839406, 9339.252859771066, 9371.625134994523, 9019.0, 9138.817223655622, 9368.25053995665, 9437.528123593931, 9497.667581634609, 6249.78125765596, 6524.1192439022025, 6702.664866756741, 6923.0, 7104.502684812013, 7287.4534409920525, 7346.375558077623, 7346.595937223504, 7419.258074192753, 7440.0, 6474.5791523550815, 6666.233383160805, 6701.597904125768, 6712.362325579063, 6798.4221341184575, 6576.572522786004, 6596.076549283008, 6619.238787539302, 6670.733170673313, 6677.833054173684, 6436.452901503425, 6437.0, 6477.384648458389, 6500.252470965899, 6519.869602607826, 4779.976100119477, 4838.7338696372035, 4907.3620429343955, 4915.090708218991, 4916.680415772963, 4831.613470922248, 4836.274558816206, 4877.048975449753, 4940.382452193476, 4990.176620857518], "value": 4172.670881612393, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.0896617740907, 318.99999999999983, 319.8049189994104, 322.05155816121504, 322.8805342023451, 5393.164059570768, 5451.155070963997, 5470.288862447876, 5471.835844924649, 5472.589555783312, 5369.087255166622, 5375.489328513795, 5403.0, 5412.134058550632, 5414.35027796664, 3977.840886364542, 4101.794910254475, 4234.851780187694, 4235.195312890541, 4243.448351714288, 4224.429701990238, 4225.767582782945, 4229.709938468765, 4243.087736136746, 4244.872653820375, 4199.45407097077, 4220.155968806235, 4221.451211342536, 4223.408722778798, 4228.640565551917, 4108.28105081611, 4169.895752606179, 4200.432941552882, 4212.199682060399, 4226.36604509323, 3690.0774806298427, 3700.1859590889962, 3703.8333275002688, 3733.626637336272, 3754.6808521275725, 5174.689518628894, 5194.727321787288, 5213.869653258661, 5227.163653815409, 5232.189010703347, 4763.14263432582, 4826.951730482685, 4842.104210721028, 4882.316475693406, 4883.5604795568215, 5655.943440565583, 5684.658920464785, 5703.857403564903, 5714.9714251428895, 5733.054046082391, 4094.2016306820183, 4106.342985122396, 4106.741292289229, 4112.362583799516, 4115.279826030433, 5743.4543718346695, 5984.670843103628, 6005.369436209179, 6025.969870150665, 6028.980291602318, 4198.5591512890705, 4221.366794980716, 4227.0, 4231.286329036745, 4247.5752424757275, 4268.295731204378, 4288.678349123766, 4299.54854740254, 4299.97850010748, 4309.095090031066, 4703.412073490814, 4847.418309802776, 4858.101251268456, 4867.075255701406, 4883.389576302962, 5714.114312281603, 5719.742611582489, 5737.77048918047, 5745.454181852718, 5751.942480575224, 1490.9935793339453, 1491.0010293103646, 1491.7911492391074, 1511.2670354877876, 1512.10785636475, 934.2712684106408, 967.2358836519071, 993.8707967964118, 996.5166894056376, 1005.5374527717332, 4915.476202377275, 4951.9752401237765, 4973.55238028572, 4980.626453016038, 4989.052080104769, 5800.7099645018425, 5801.8549536261935, 5868.647881127146, 5874.676892770854, 5886.6173698709445, 4859.757012149378, 4870.6103511718975, 4944.085344211332, 4982.725950072709, 5011.3986321640905, 3130.2174456385906, 3152.4956007038763, 3159.0996565979044, 3160.0, 3170.4134735074085, 5491.643043202179, 5491.890162196733, 5492.890142197134, 5506.201600767866, 5512.310961129859, 5868.383819698955, 5963.642181469126, 5968.045112781934, 5980.970095149496, 6005.3394126646035, 5434.70109143993, 5462.0987537056735, 5468.863278418072, 5484.7531861066345, 5498.917516237339, 5640.182173584889, 5822.76708931655, 5832.270966129234, 5852.648841069549, 5867.618604790675, 5719.799807006735, 5743.483086522233, 5749.568782341257, 5751.252337196138, 5751.827445176484, 5446.482584154499, 5493.368262649847, 5494.36814766291, 5495.972520137374, 5496.203050557567, 4094.1402305514985, 4223.535411104837, 4223.662107031491, 4224.619784219435, 4240.78796060202, 5816.592838501264, 5836.912446313224, 5837.94162058374, 5842.5325973921135, 5871.735771890189, 5616.494515493625, 5644.85887852807, 5646.181303710857, 5655.773769049192, 5656.462636049569, 5442.12925931849, 5745.971270143623, 5759.683217423082, 5764.13537969308, 5764.855878603068, 5329.920051199158, 5583.497485226349, 5592.580556458201, 5601.663900166003, 5659.660420374791, 5524.861878453071, 5767.192593037062, 5770.769169233184, 5778.653280803165, 5785.566082543742, 5574.526165275997, 5581.162825576196, 5596.3284405871555, 5602.383737788921, 5622.5783066271015], "value": 4290.041894047235, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.7037618259874, 760.0878945265679, 773.6325245508384, 779.8479296537178, 796.2913007423394, 10270.229732770034, 11877.346745928971, 11948.940255298712, 11953.163278570504, 12719.682007949783, 12622.621321360351, 12663.30351830649, 12695.809562856564, 12712.93643531781, 12713.173643713153, 787.8857565652977, 792.1128336263394, 792.3186059988406, 798.2576204130156, 801.5751651624648, 787.9251471110235, 792.0574516325582, 797.3023604346197, 798.4450806689354, 801.4830434369828, 844.1136806353335, 844.5312851367488, 845.327964268405, 845.8900342955408, 847.6270441005969, 830.5307501261768, 838.6561509780961, 841.4194205997842, 843.7300063979529, 845.6490556419079, 593.4510577715596, 614.5698011391999, 615.8368032471399, 616.374380004296, 617.7621615677951, 11585.884141158649, 11605.24565903222, 11613.477393517227, 11624.476898539586, 11631.825522617168, 11563.364014979257, 12362.75274494505, 12464.688382790502, 12544.498220071186, 12560.74878502434, 9884.406935583887, 10087.344322619007, 10120.696379108565, 10167.135793457564, 10386.792264154674, 3287.0960485866576, 3305.405027095122, 3316.7512436567113, 3342.064222017839, 3424.298018906118, 42133.67994800774, 43419.046142923646, 43662.56337436649, 47122.0, 47367.052658946974, 10093.880423899254, 10110.747231319128, 10167.7458063549, 10267.383956962607, 10406.479676016168, 17247.482575522754, 17255.91372043132, 17288.827111728722, 17289.56776080583, 17353.826461735473, 6548.738050478023, 6613.801585952429, 6651.368120028589, 6769.830754231184, 6804.353586409283, 3677.6690097890782, 3694.649008344203, 3714.201446688975, 3729.366007778684, 3760.3983362661843, 2981.373911478614, 3067.6472205696186, 3074.1085085325003, 3202.6957439043254, 3369.663033696611, 549.1076999875203, 554.8612846788303, 564.8700798816295, 573.7618888161367, 574.22192928582, 539.7571093008083, 600.1940926170137, 637.2957881540923, 643.411278680012, 643.6459947029115, 6825.658717064127, 7364.410847132217, 7386.778396648109, 7456.40348772097, 7753.883691744629, 507.4899725775646, 546.8359492152339, 586.1237450012259, 611.181017436637, 618.1438707390297, 3751.118487155516, 3777.4522694209186, 3782.243551289753, 3816.3512202925012, 3820.541535015816, 55544.72227638836, 56429.717851411304, 56712.71643641838, 56756.14865776934, 57588.424115759146, 49291.0, 49425.25862112071, 49554.75222623936, 50252.0, 50597.747011264706, 36461.0, 36558.81720591433, 36931.4460283096, 37731.43402849014, 37760.62239377626, 7712.730054448291, 7724.8455030900195, 7947.84104317922, 7956.323712484504, 8027.879581806161, 26230.344241393355, 26557.0, 26651.733482664924, 26859.0, 28586.42827143487, 34232.31535369329, 37085.629143709295, 38304.616953830104, 38720.419193711554, 38741.6125838738, 10147.985201479793, 10242.53908574131, 10345.861955184773, 10440.26918115755, 10451.16390688728, 11884.46519906589, 11925.701857453287, 11962.820557691468, 12066.336351500751, 12455.813162802384, 10803.081738052353, 10806.13550915909, 11044.558217671203, 11295.661130166109, 11668.416579171177, 11047.12249469682, 11221.158413119212, 11292.830607540729, 11392.145589081018, 11860.406979651156, 10616.256862019585, 10822.621208257673, 10845.620403285848, 10876.782464350827, 10912.672619821418, 9560.23518118535, 9635.518224088628, 9680.612775489184, 9698.224142068477, 9760.658376957057, 9451.527423628653, 9685.32202745801, 9734.659286924923, 9944.35361701487, 9968.0], "value": 5931.606645188884, "unit": "score"}], "name": "dromaeo_css", "value": 6411.753940324205, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 113.0, 114.0, 115.0, 126.0, 113.0, 112.0, 114.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 132.0, 165.0, 183.0, 132.0, 166.0, 166.0, 134.0, 195.0, 134.0], "value": 156.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 168.0, 168.0, 165.0, 164.0, 165.0, 166.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 74.0, 153.0, 74.0, 82.0, 75.0, 76.0, 155.0, 73.0], "value": 91.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 156.0, 94.0, 96.0, 94.0, 144.0, 94.0, 94.0, 140.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 119.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 151.0, 147.0, 149.0, 148.0, 147.0, 147.0, 148.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 66.0, 66.0, 68.0, 86.0, 65.0, 65.0], "value": 68.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 68.0, 65.0, 68.0, 65.0, 64.0, 64.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 94.0, 85.0, 87.0, 101.0, 85.0, 86.0, 86.0, 85.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 151.0, 146.0, 147.0, 139.0, 146.0, 144.0, 140.0, 170.0, 149.0], "value": 147.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 180.0, 184.0, 176.0, 175.0, 175.0, 179.0, 179.0, 175.0, 178.0], "value": 177.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 72.0, 75.0, 75.0, 75.0, 71.0, 72.0, 73.0], "value": 73.6, "unit": "score"}], "name": "kraken", "value": 1618.8, "alertThreshold": 2.0}]} 08:41:49 INFO - Return code: 0 08:41:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:41:49 ERROR - # TBPL SUCCESS # 08:41:49 INFO - Running post-action listener: _resource_record_post_action 08:41:49 INFO - Running post-run listener: _resource_record_post_run 08:41:50 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 200704; Write bytes: 517582848; Read time: 96; Write time: 538432 08:41:50 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 233902080; Read time: 0; Write time: 334444 08:41:50 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 200704; Write bytes: 283627520; Read time: 96; Write time: 203972 08:41:50 INFO - Running post-run listener: _upload_blobber_files 08:41:50 INFO - Blob upload gear active. 08:41:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:41:50 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 08:41:50 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'] 08:41:50 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 08:41:58 INFO - (blobuploader) - INFO - Open directory for files ... 08:41:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:41:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:41:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:41:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:41:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:41:58 INFO - (blobuploader) - INFO - Done attempting. 08:41:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:41:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:41:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:41:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:41:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:41:59 INFO - (blobuploader) - INFO - Done attempting. 08:41:59 INFO - (blobuploader) - INFO - Iteration through files over. 08:41:59 INFO - Return code: 0 08:41:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:41:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:41:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82efaca0778df08ebda3ad20f5ba496123117f7fd2dcde7b15f4ba605ab0672fc0b61871c2f324194398563126a9398f5e6b477069c0a444407f754ac303a297", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/97af2fcb39f34e82dd444d7abc92d50abdf58f14845837f48647d55a6c1c3e407566c1ce840121ff9324b16bfae8c1a1a71d839e19d26a79dd769d23a6b73539"} 08:41:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:41:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:41:59 INFO - Contents: 08:41:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82efaca0778df08ebda3ad20f5ba496123117f7fd2dcde7b15f4ba605ab0672fc0b61871c2f324194398563126a9398f5e6b477069c0a444407f754ac303a297", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/97af2fcb39f34e82dd444d7abc92d50abdf58f14845837f48647d55a6c1c3e407566c1ce840121ff9324b16bfae8c1a1a71d839e19d26a79dd769d23a6b73539"} 08:41:59 INFO - Running post-run listener: copy_logs_to_upload_dir 08:41:59 INFO - Copying logs to upload dir... 08:41:59 INFO - mkdir: /builds/slave/test/build/upload/logs 08:41:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.561799 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-14 08:41:59.797449) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 08:41:59.802501) ========= 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=574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82efaca0778df08ebda3ad20f5ba496123117f7fd2dcde7b15f4ba605ab0672fc0b61871c2f324194398563126a9398f5e6b477069c0a444407f754ac303a297", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/97af2fcb39f34e82dd444d7abc92d50abdf58f14845837f48647d55a6c1c3e407566c1ce840121ff9324b16bfae8c1a1a71d839e19d26a79dd769d23a6b73539"} build_url:https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011476 build_url: 'https://queue.taskcluster.net/v1/task/dQ2Ijhe7Sl2k-9MiK2saew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82efaca0778df08ebda3ad20f5ba496123117f7fd2dcde7b15f4ba605ab0672fc0b61871c2f324194398563126a9398f5e6b477069c0a444407f754ac303a297", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/97af2fcb39f34e82dd444d7abc92d50abdf58f14845837f48647d55a6c1c3e407566c1ce840121ff9324b16bfae8c1a1a71d839e19d26a79dd769d23a6b73539"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 08:41:59.830350) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:41:59.830726) ========= 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=574dc5aafe09851ec43d388c000001b6-1460646982.267196-43358937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:41:59.911983) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 08:41:59.912333) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 08:41:59.912643) ========= ========= Total master_lag: 0.20 =========