builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-024 starttime: 1460979613.66 results: success (0) buildid: 20160418041220 builduid: 67275313bdf040c59e1cf5f1ed73f070 revision: 54303363802794f3c7fbc23d886965f5c5495335 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 04:40:13.661713) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 04:40:13.662190) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 04:40:13.662469) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 04:40:13.681456) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 04:40:13.681720) ========= 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=7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 04:40: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% 225M=0s 2016-04-18 04:40:14 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098664 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 04:40:13.793041) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 04:40:13.793339) ========= 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=7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018390 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 04:40:13.842502) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 04:40:13.842798) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 54303363802794f3c7fbc23d886965f5c5495335 --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 54303363802794f3c7fbc23d886965f5c5495335 --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=7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 04:40:14,364 truncating revision to first 12 chars 2016-04-18 04:40:14,364 Setting DEBUG logging. 2016-04-18 04:40:14,364 attempt 1/10 2016-04-18 04:40:14,364 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/543033638027?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 04:40:14,608 unpacking tar archive at: fx-team-543033638027/testing/mozharness/ program finished with exit code 0 elapsedTime=0.525819 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 04:40:14.381171) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 04:40:14.381488) ========= script_repo_revision: 54303363802794f3c7fbc23d886965f5c5495335 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 04:40:14.381900) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 04:40:14.382184) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 04:40:14.391045) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-18 04:40:14.391324) ========= /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=7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:40:14 INFO - MultiFileLogger online at 20160418 04:40:14 in /builds/slave/test 04:40:14 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 04:40:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:40:15 INFO - {'append_to_log': False, 04:40:15 INFO - 'base_work_dir': '/builds/slave/test', 04:40:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:40:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:40:15 INFO - 'branch': 'Fx-Team-Non-PGO', 04:40:15 INFO - 'buildbot_json_path': 'buildprops.json', 04:40:15 INFO - 'config_files': ('talos/linux_config.py',), 04:40:15 INFO - 'default_actions': ('clobber', 04:40:15 INFO - 'read-buildbot-config', 04:40:15 INFO - 'download-and-extract', 04:40:15 INFO - 'populate-webroot', 04:40:15 INFO - 'create-virtualenv', 04:40:15 INFO - 'install', 04:40:15 INFO - 'run-tests'), 04:40:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:40:15 INFO - 'download_minidump_stackwalk': True, 04:40:15 INFO - 'download_symbols': 'ondemand', 04:40:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:40:15 INFO - 'tooltool.py': '/tools/tooltool.py', 04:40:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:40:15 INFO - '/tools/misc-python/virtualenv.py')}, 04:40:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:40:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:40:15 INFO - 'installer_path': 'installer.exe', 04:40:15 INFO - 'log_level': 'info', 04:40:15 INFO - 'log_name': 'talos', 04:40:15 INFO - 'log_to_console': True, 04:40:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:40:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:40:15 INFO - 'opt_config_files': (), 04:40:15 INFO - 'pip_index': False, 04:40:15 INFO - 'sps_profile': False, 04:40:15 INFO - 'sps_profile_interval': 0, 04:40:15 INFO - 'suite': 'dromaeojs-e10s', 04:40:15 INFO - 'system_bits': '32', 04:40:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:40:15 INFO - 'title': 'talos-linux64-ix-024', 04:40:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:40:15 INFO - 'use_talos_json': True, 04:40:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:40:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:40:15 INFO - 'work_dir': 'build'} 04:40:15 INFO - ##### 04:40:15 INFO - ##### Running clobber step. 04:40:15 INFO - ##### 04:40:15 INFO - Running pre-action listener: _resource_record_pre_action 04:40:15 INFO - Running main action method: clobber 04:40:15 INFO - rmtree: /builds/slave/test/build 04:40:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:40:15 INFO - Running post-action listener: _resource_record_post_action 04:40:15 INFO - ##### 04:40:15 INFO - ##### Running read-buildbot-config step. 04:40:15 INFO - ##### 04:40:15 INFO - Running pre-action listener: _resource_record_pre_action 04:40:15 INFO - Running main action method: read_buildbot_config 04:40:15 INFO - Using buildbot properties: 04:40:15 INFO - { 04:40:15 INFO - "project": "", 04:40:15 INFO - "product": "firefox", 04:40:15 INFO - "script_repo_revision": "production", 04:40:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:40:15 INFO - "repository": "", 04:40:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 04:40:15 INFO - "buildid": "20160418041220", 04:40:15 INFO - "pgo_build": "False", 04:40:15 INFO - "basedir": "/builds/slave/test", 04:40:15 INFO - "buildnumber": 1167, 04:40:15 INFO - "slavename": "talos-linux64-ix-024", 04:40:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:40:15 INFO - "platform": "ubuntu64_hw", 04:40:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:40:15 INFO - "branch": "fx-team", 04:40:15 INFO - "repo_path": "integration/fx-team", 04:40:15 INFO - "revision": "54303363802794f3c7fbc23d886965f5c5495335", 04:40:15 INFO - "stage_platform": "linux64", 04:40:15 INFO - "builduid": "67275313bdf040c59e1cf5f1ed73f070", 04:40:15 INFO - "slavebuilddir": "test" 04:40:15 INFO - } 04:40:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/SfEDd-yNSD-UugV-tSYmqw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:40:15 INFO - Running post-action listener: _resource_record_post_action 04:40:15 INFO - ##### 04:40:15 INFO - ##### Running download-and-extract step. 04:40:15 INFO - ##### 04:40:15 INFO - Running pre-action listener: _resource_record_pre_action 04:40:15 INFO - Running main action method: download_and_extract 04:40:15 INFO - mkdir: /builds/slave/test/build/tests 04:40: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')]} 04:40:15 INFO - https://queue.taskcluster.net/v1/task/SfEDd-yNSD-UugV-tSYmqw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:40:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SfEDd-yNSD-UugV-tSYmqw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:40:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SfEDd-yNSD-UugV-tSYmqw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:40:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SfEDd-yNSD-UugV-tSYmqw/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 04:40:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SfEDd-yNSD-UugV-tSYmqw/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 04:40:21 INFO - Downloaded 1361 bytes. 04:40:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:40:21 INFO - Using the following test package requirements: 04:40:21 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:40:21 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:40:21 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:40:21 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:21 INFO - u'jsshell-linux-x86_64.zip'], 04:40:21 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:40:21 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:40:21 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:40:21 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:40:21 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:40:21 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:40:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:40:21 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')]} 04:40:21 INFO - https://queue.taskcluster.net/v1/task/SfEDd-yNSD-UugV-tSYmqw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:40:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SfEDd-yNSD-UugV-tSYmqw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:40:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SfEDd-yNSD-UugV-tSYmqw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:40:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SfEDd-yNSD-UugV-tSYmqw/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 04:40:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SfEDd-yNSD-UugV-tSYmqw/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 04:40:25 INFO - Downloaded 22203755 bytes. 04:40:25 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'] 04:40:25 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 04:40:26 INFO - Return code: 0 04:40:26 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 04:40: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')]} 04:40:26 INFO - https://queue.taskcluster.net/v1/task/SfEDd-yNSD-UugV-tSYmqw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:40:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SfEDd-yNSD-UugV-tSYmqw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:40:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SfEDd-yNSD-UugV-tSYmqw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:40:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SfEDd-yNSD-UugV-tSYmqw/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 04:40:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SfEDd-yNSD-UugV-tSYmqw/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 04:40:30 INFO - Downloaded 22203755 bytes. 04:40:30 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'] 04:40:30 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 04:40:32 INFO - Return code: 0 04:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:32 INFO - https://queue.taskcluster.net/v1/task/SfEDd-yNSD-UugV-tSYmqw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:40:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SfEDd-yNSD-UugV-tSYmqw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:40:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SfEDd-yNSD-UugV-tSYmqw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:40:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SfEDd-yNSD-UugV-tSYmqw/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 04:40:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SfEDd-yNSD-UugV-tSYmqw/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 04:40:33 INFO - Downloaded 10841076 bytes. 04:40:33 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'] 04:40:33 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 04:40:33 INFO - Return code: 0 04:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:33 INFO - https://queue.taskcluster.net/v1/task/SfEDd-yNSD-UugV-tSYmqw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:40:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SfEDd-yNSD-UugV-tSYmqw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:40:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SfEDd-yNSD-UugV-tSYmqw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:40:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SfEDd-yNSD-UugV-tSYmqw/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 04:40:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SfEDd-yNSD-UugV-tSYmqw/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 04:40:36 INFO - Downloaded 54449647 bytes. 04:40:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SfEDd-yNSD-UugV-tSYmqw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:40:36 INFO - mkdir: /builds/slave/test/properties 04:40:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:40:36 INFO - Writing to file /builds/slave/test/properties/build_url 04:40:36 INFO - Contents: 04:40:36 INFO - build_url:https://queue.taskcluster.net/v1/task/SfEDd-yNSD-UugV-tSYmqw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:40:37 INFO - Running post-action listener: _resource_record_post_action 04:40:37 INFO - Running post-action listener: set_extra_try_arguments 04:40:37 INFO - ##### 04:40:37 INFO - ##### Running populate-webroot step. 04:40:37 INFO - ##### 04:40:37 INFO - Running pre-action listener: _resource_record_pre_action 04:40:37 INFO - Running main action method: populate_webroot 04:40:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:40:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:40:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:40:37 INFO - '--tppagecycles', 04:40:37 INFO - '7'], 04:40:37 INFO - 'tests': ['tsvgm']}}, 04:40:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:40:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:40:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:40:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:40:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:40:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:40:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:37 INFO - 'talos_options': ['--disable-e10s'], 04:40:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:40:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:40:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:37 INFO - 'talos_options': ['--disable-e10s'], 04:40:37 INFO - 'tests': ['damp', 'tps']}, 04:40:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:37 INFO - 'tests': ['damp', 'tps']}, 04:40:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:40:37 INFO - 'tests': ['dromaeo_dom']}, 04:40:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:40:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:40:37 INFO - 'tests': ['a11yr', 04:40:37 INFO - 'ts_paint', 04:40:37 INFO - 'tpaint', 04:40:37 INFO - 'sessionrestore', 04:40:37 INFO - 'sessionrestore_no_auto_restore', 04:40:37 INFO - 'tabpaint']}, 04:40:37 INFO - 'other-e10s': {'tests': ['a11yr', 04:40:37 INFO - 'ts_paint', 04:40:37 INFO - 'tpaint', 04:40:37 INFO - 'sessionrestore', 04:40:37 INFO - 'sessionrestore_no_auto_restore', 04:40:37 INFO - 'tabpaint']}, 04:40:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:40:37 INFO - 'ts_paint', 04:40:37 INFO - 'tpaint', 04:40:37 INFO - 'sessionrestore', 04:40:37 INFO - 'sessionrestore_no_auto_restore', 04:40:37 INFO - 'tabpaint']}, 04:40:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:40:37 INFO - 'ts_paint', 04:40:37 INFO - 'tpaint', 04:40:37 INFO - 'sessionrestore', 04:40:37 INFO - 'sessionrestore_no_auto_restore', 04:40:37 INFO - 'tabpaint']}, 04:40:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:40:37 INFO - 'tests': ['a11yr', 04:40:37 INFO - 'ts_paint', 04:40:37 INFO - 'tpaint', 04:40:37 INFO - 'sessionrestore', 04:40:37 INFO - 'sessionrestore_no_auto_restore', 04:40:37 INFO - 'tabpaint']}, 04:40:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:40:37 INFO - 'tests': ['a11yr', 04:40:37 INFO - 'ts_paint', 04:40:37 INFO - 'tpaint', 04:40:37 INFO - 'sessionrestore', 04:40:37 INFO - 'sessionrestore_no_auto_restore', 04:40:37 INFO - 'tabpaint']}, 04:40:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:40:37 INFO - 'tests': ['tsvgx', 04:40:37 INFO - 'tsvgr_opacity', 04:40:37 INFO - 'tart', 04:40:37 INFO - 'tscrollx', 04:40:37 INFO - 'cart']}, 04:40:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:40:37 INFO - 'tsvgr_opacity', 04:40:37 INFO - 'tart', 04:40:37 INFO - 'tscrollx', 04:40:37 INFO - 'cart']}, 04:40:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:37 INFO - 'talos_options': ['--disable-e10s'], 04:40:37 INFO - 'tests': ['tp5o']}, 04:40:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:37 INFO - 'tests': ['tp5o']}, 04:40:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:37 INFO - 'talos_options': ['--disable-e10s', 04:40:37 INFO - '--xperf_path', 04:40:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:40:37 INFO - 'tests': ['tp5n']}, 04:40:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:37 INFO - 'talos_options': ['--xperf_path', 04:40:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:40:37 INFO - 'tests': ['tp5n']}}, 04:40:37 INFO - 'talos.zip': {'path': '', 04:40:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:40:37 INFO - Running post-action listener: _resource_record_post_action 04:40:37 INFO - ##### 04:40:37 INFO - ##### Running create-virtualenv step. 04:40:37 INFO - ##### 04:40:37 INFO - Running pre-action listener: _resource_record_pre_action 04:40:37 INFO - Running main action method: create_virtualenv 04:40:37 INFO - Creating virtualenv /builds/slave/test/build/venv 04:40:37 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 04:40:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:40:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:40:37 INFO - Using real prefix '/usr' 04:40:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:40:38 INFO - Installing distribute.............................................................................................................................................................................................done. 04:40:40 INFO - Installing pip.................done. 04:40:40 INFO - Return code: 0 04:40:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:40: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')]} 04:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40: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')]} 04:40:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:40 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 0x7f3727a49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29965a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a25410>, '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 0x2a26310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a267a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686', '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 04:40:40 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 04:40:40 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 04:40:40 INFO - Using env: {'DISPLAY': ':0', 04:40:40 INFO - 'HOME': '/home/cltbld', 04:40:40 INFO - 'LANG': 'en_US.UTF-8', 04:40:40 INFO - 'LANGUAGE': 'en_US:en', 04:40:40 INFO - 'LOGNAME': 'cltbld', 04:40:40 INFO - 'MAIL': '/var/mail/cltbld', 04:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:40 INFO - 'MOZ_NO_REMOTE': '1', 04:40:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:40 INFO - 'NO_EM_RESTART': '1', 04:40:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:40 INFO - 'PWD': '/builds/slave/test', 04:40:40 INFO - 'SHELL': '/bin/bash', 04:40:40 INFO - 'SHLVL': '1', 04:40:40 INFO - 'TERM': 'linux', 04:40:40 INFO - 'TMOUT': '86400', 04:40:40 INFO - 'USER': 'cltbld', 04:40:40 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686', 04:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:40 INFO - '_': '/tools/buildbot/bin/python'} 04:40:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:40 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 04:40:40 INFO - Cleaning up... 04:40:40 INFO - Return code: 0 04:40:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:40: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')]} 04:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40: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')]} 04:40:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:40 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 0x7f3727a49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29965a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a25410>, '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 0x2a26310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a267a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686', '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 04:40:40 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 04:40:40 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 04:40:40 INFO - Using env: {'DISPLAY': ':0', 04:40:40 INFO - 'HOME': '/home/cltbld', 04:40:40 INFO - 'LANG': 'en_US.UTF-8', 04:40:40 INFO - 'LANGUAGE': 'en_US:en', 04:40:40 INFO - 'LOGNAME': 'cltbld', 04:40:40 INFO - 'MAIL': '/var/mail/cltbld', 04:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:40 INFO - 'MOZ_NO_REMOTE': '1', 04:40:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:40 INFO - 'NO_EM_RESTART': '1', 04:40:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:40 INFO - 'PWD': '/builds/slave/test', 04:40:40 INFO - 'SHELL': '/bin/bash', 04:40:40 INFO - 'SHLVL': '1', 04:40:40 INFO - 'TERM': 'linux', 04:40:40 INFO - 'TMOUT': '86400', 04:40:40 INFO - 'USER': 'cltbld', 04:40:40 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686', 04:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:40 INFO - '_': '/tools/buildbot/bin/python'} 04:40:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:40 INFO - Downloading/unpacking psutil>=0.7.1 04:40:40 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 04:40:40 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 04:40:40 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 04:40:40 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 04:40:40 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 04:40:40 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 04:40:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:40:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:40:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:40:42 INFO - Installing collected packages: psutil 04:40:42 INFO - Running setup.py install for psutil 04:40:42 INFO - building 'psutil._psutil_linux' extension 04:40:42 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 04:40:42 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 04:40:42 INFO - building 'psutil._psutil_posix' extension 04:40:42 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 04:40:42 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 04:40:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:40:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:40:42 INFO - Successfully installed psutil 04:40:42 INFO - Cleaning up... 04:40:43 INFO - Return code: 0 04:40:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:40: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')]} 04:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40: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')]} 04:40:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:43 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 0x7f3727a49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29965a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a25410>, '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 0x2a26310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a267a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686', '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 04:40:43 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 04:40:43 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 04:40:43 INFO - Using env: {'DISPLAY': ':0', 04:40:43 INFO - 'HOME': '/home/cltbld', 04:40:43 INFO - 'LANG': 'en_US.UTF-8', 04:40:43 INFO - 'LANGUAGE': 'en_US:en', 04:40:43 INFO - 'LOGNAME': 'cltbld', 04:40:43 INFO - 'MAIL': '/var/mail/cltbld', 04:40:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:43 INFO - 'MOZ_NO_REMOTE': '1', 04:40:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:43 INFO - 'NO_EM_RESTART': '1', 04:40:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:43 INFO - 'PWD': '/builds/slave/test', 04:40:43 INFO - 'SHELL': '/bin/bash', 04:40:43 INFO - 'SHLVL': '1', 04:40:43 INFO - 'TERM': 'linux', 04:40:43 INFO - 'TMOUT': '86400', 04:40:43 INFO - 'USER': 'cltbld', 04:40:43 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686', 04:40:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:43 INFO - '_': '/tools/buildbot/bin/python'} 04:40:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:40:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:40:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:40:45 INFO - Installing collected packages: mozsystemmonitor 04:40:45 INFO - Running setup.py install for mozsystemmonitor 04:40:45 INFO - Successfully installed mozsystemmonitor 04:40:45 INFO - Cleaning up... 04:40:45 INFO - Return code: 0 04:40:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:45 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 0x7f3727a49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29965a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a25410>, '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 0x2a26310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a267a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686', '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 04:40:45 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 04:40:45 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 04:40:45 INFO - Using env: {'DISPLAY': ':0', 04:40:45 INFO - 'HOME': '/home/cltbld', 04:40:45 INFO - 'LANG': 'en_US.UTF-8', 04:40:45 INFO - 'LANGUAGE': 'en_US:en', 04:40:45 INFO - 'LOGNAME': 'cltbld', 04:40:45 INFO - 'MAIL': '/var/mail/cltbld', 04:40:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:45 INFO - 'MOZ_NO_REMOTE': '1', 04:40:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:45 INFO - 'NO_EM_RESTART': '1', 04:40:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:45 INFO - 'PWD': '/builds/slave/test', 04:40:45 INFO - 'SHELL': '/bin/bash', 04:40:45 INFO - 'SHLVL': '1', 04:40:45 INFO - 'TERM': 'linux', 04:40:45 INFO - 'TMOUT': '86400', 04:40:45 INFO - 'USER': 'cltbld', 04:40:45 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686', 04:40:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:45 INFO - '_': '/tools/buildbot/bin/python'} 04:40:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:45 INFO - Downloading/unpacking blobuploader==1.2.4 04:40:45 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 04:40:45 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 04:40:45 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 04:40:45 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 04:40:45 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 04:40:45 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 04:40:47 INFO - Downloading blobuploader-1.2.4.tar.gz 04:40:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:40:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:40: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 04:40: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 04:40: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 04:40: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 04:40: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 04:40: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 04:40:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:40:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:40: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 04:40: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 04:40: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 04:40: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 04:40: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 04:40: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 04:40:48 INFO - Downloading docopt-0.6.1.tar.gz 04:40:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:40:48 INFO - Installing collected packages: blobuploader, requests, docopt 04:40:48 INFO - Running setup.py install for blobuploader 04:40:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:40:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:40:48 INFO - Running setup.py install for requests 04:40:48 INFO - Running setup.py install for docopt 04:40:48 INFO - Successfully installed blobuploader requests docopt 04:40:48 INFO - Cleaning up... 04:40:48 INFO - Return code: 0 04:40:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:48 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 0x7f3727a49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29965a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a25410>, '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 0x2a26310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a267a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686', '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 04:40:48 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 04:40:48 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 04:40:48 INFO - Using env: {'DISPLAY': ':0', 04:40:48 INFO - 'HOME': '/home/cltbld', 04:40:48 INFO - 'LANG': 'en_US.UTF-8', 04:40:48 INFO - 'LANGUAGE': 'en_US:en', 04:40:48 INFO - 'LOGNAME': 'cltbld', 04:40:48 INFO - 'MAIL': '/var/mail/cltbld', 04:40:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:48 INFO - 'MOZ_NO_REMOTE': '1', 04:40:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:48 INFO - 'NO_EM_RESTART': '1', 04:40:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:48 INFO - 'PWD': '/builds/slave/test', 04:40:48 INFO - 'SHELL': '/bin/bash', 04:40:48 INFO - 'SHLVL': '1', 04:40:48 INFO - 'TERM': 'linux', 04:40:48 INFO - 'TMOUT': '86400', 04:40:48 INFO - 'USER': 'cltbld', 04:40:48 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686', 04:40:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:48 INFO - '_': '/tools/buildbot/bin/python'} 04:40:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:40:48 INFO - Running setup.py (path:/tmp/pip-NK4V9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:40:49 INFO - Running setup.py (path:/tmp/pip-wwoOmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:40:49 INFO - Running setup.py (path:/tmp/pip-s5kjQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:40:49 INFO - Running setup.py (path:/tmp/pip-PXLV7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:40:49 INFO - Running setup.py (path:/tmp/pip-cAtiYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:40:49 INFO - Running setup.py (path:/tmp/pip-z8bHc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:40:49 INFO - Running setup.py (path:/tmp/pip-ruI8pN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:40:49 INFO - Running setup.py (path:/tmp/pip-AgsMFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:40:49 INFO - Running setup.py (path:/tmp/pip-o4fUDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:40:49 INFO - Running setup.py (path:/tmp/pip-CSNdil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:40:49 INFO - Running setup.py (path:/tmp/pip-NV0SH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:40:49 INFO - Running setup.py (path:/tmp/pip-xvpMhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:40:49 INFO - Running setup.py (path:/tmp/pip-Z22Zuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:40:49 INFO - Running setup.py (path:/tmp/pip-WypIpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:49 INFO - Running setup.py (path:/tmp/pip-m2ebv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:40:50 INFO - Running setup.py (path:/tmp/pip-JZYBiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:40:50 INFO - Running setup.py (path:/tmp/pip-kJFle8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:40:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:40:50 INFO - Running setup.py install for manifestparser 04:40:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:40:50 INFO - Running setup.py install for mozcrash 04:40:50 INFO - Running setup.py install for mozdebug 04:40:50 INFO - Running setup.py install for mozdevice 04:40:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:40:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:40:50 INFO - Running setup.py install for mozfile 04:40:50 INFO - Running setup.py install for mozhttpd 04:40:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:40:50 INFO - Running setup.py install for mozinfo 04:40:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:40:50 INFO - Running setup.py install for mozInstall 04:40:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:40:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:40:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:40:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:40:50 INFO - Running setup.py install for mozleak 04:40:51 INFO - Running setup.py install for mozlog 04:40:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:40:51 INFO - Running setup.py install for moznetwork 04:40:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:40:51 INFO - Running setup.py install for mozprocess 04:40:51 INFO - Running setup.py install for mozprofile 04:40:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:40:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:40:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:40:51 INFO - Running setup.py install for mozrunner 04:40:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:40:51 INFO - Running setup.py install for mozscreenshot 04:40:51 INFO - Running setup.py install for moztest 04:40:51 INFO - Running setup.py install for mozversion 04:40:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:40:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:40:51 INFO - Cleaning up... 04:40:51 INFO - Return code: 0 04:40:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:51 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 0x7f3727a49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29965a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a25410>, '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 0x2a26310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a267a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686', '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 04:40:51 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 04:40:51 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 04:40:51 INFO - Using env: {'DISPLAY': ':0', 04:40:51 INFO - 'HOME': '/home/cltbld', 04:40:51 INFO - 'LANG': 'en_US.UTF-8', 04:40:51 INFO - 'LANGUAGE': 'en_US:en', 04:40:51 INFO - 'LOGNAME': 'cltbld', 04:40:51 INFO - 'MAIL': '/var/mail/cltbld', 04:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:51 INFO - 'MOZ_NO_REMOTE': '1', 04:40:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:51 INFO - 'NO_EM_RESTART': '1', 04:40:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:51 INFO - 'PWD': '/builds/slave/test', 04:40:51 INFO - 'SHELL': '/bin/bash', 04:40:51 INFO - 'SHLVL': '1', 04:40:51 INFO - 'TERM': 'linux', 04:40:51 INFO - 'TMOUT': '86400', 04:40:51 INFO - 'USER': 'cltbld', 04:40:51 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686', 04:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:51 INFO - '_': '/tools/buildbot/bin/python'} 04:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:40:52 INFO - Running setup.py (path:/tmp/pip-w5ZnK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:40:52 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)) 04:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:40:52 INFO - Running setup.py (path:/tmp/pip-7IoeaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:40:52 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)) 04:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:40:52 INFO - Running setup.py (path:/tmp/pip-Xg_5DC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:40:52 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)) 04:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:40:52 INFO - Running setup.py (path:/tmp/pip-yAuYDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:40:52 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)) 04:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:40:52 INFO - Running setup.py (path:/tmp/pip-wa2j3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:40:52 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)) 04:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:40:52 INFO - Running setup.py (path:/tmp/pip-ACg1CF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:40:52 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)) 04:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:40:52 INFO - Running setup.py (path:/tmp/pip-aMDCS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:40:52 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)) 04:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:40:52 INFO - Running setup.py (path:/tmp/pip-4Wykvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:40:52 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)) 04:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:40:52 INFO - Running setup.py (path:/tmp/pip-J0K056-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:40:52 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)) 04:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:40:52 INFO - Running setup.py (path:/tmp/pip-DuoFjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:40:52 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)) 04:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:40:52 INFO - Running setup.py (path:/tmp/pip-lQeuRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:40:52 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)) 04:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:40:52 INFO - Running setup.py (path:/tmp/pip-wjL5Jh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:40:53 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)) 04:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:40:53 INFO - Running setup.py (path:/tmp/pip-eBKk2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:40:53 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)) 04:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:40:53 INFO - Running setup.py (path:/tmp/pip-vAqwbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:40:53 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)) 04:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:53 INFO - Running setup.py (path:/tmp/pip-Q9OkC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:53 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)) 04:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:40:53 INFO - Running setup.py (path:/tmp/pip-cLtv7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:40:53 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)) 04:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:40:53 INFO - Running setup.py (path:/tmp/pip-ICZhLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:40:53 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)) 04:40:53 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)) 04:40:53 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)) 04:40:53 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)) 04:40:53 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)) 04:40:53 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)) 04:40:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:40:53 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 04:40:53 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 04:40:53 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 04:40:53 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 04:40:53 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 04:40:53 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 04:40:55 INFO - Downloading blessings-1.6.tar.gz 04:40:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:40:55 INFO - Installing collected packages: blessings 04:40:55 INFO - Running setup.py install for blessings 04:40:55 INFO - Successfully installed blessings 04:40:55 INFO - Cleaning up... 04:40:55 INFO - Return code: 0 04:40:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:40:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:40:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:40:55 INFO - Reading from file tmpfile_stdout 04:40:55 INFO - Current package versions: 04:40:55 INFO - argparse == 1.2.1 04:40:55 INFO - blessings == 1.6 04:40:55 INFO - blobuploader == 1.2.4 04:40:55 INFO - docopt == 0.6.1 04:40:55 INFO - manifestparser == 1.1 04:40:55 INFO - mozInstall == 1.12 04:40:55 INFO - mozcrash == 0.17 04:40:55 INFO - mozdebug == 0.1 04:40:55 INFO - mozdevice == 0.48 04:40:55 INFO - mozfile == 1.2 04:40:55 INFO - mozhttpd == 0.7 04:40:55 INFO - mozinfo == 0.9 04:40:55 INFO - mozleak == 0.1 04:40:55 INFO - mozlog == 3.1 04:40:55 INFO - moznetwork == 0.27 04:40:55 INFO - mozprocess == 0.22 04:40:55 INFO - mozprofile == 0.28 04:40:55 INFO - mozrunner == 6.11 04:40:55 INFO - mozscreenshot == 0.1 04:40:55 INFO - mozsystemmonitor == 0.0 04:40:55 INFO - moztest == 0.7 04:40:55 INFO - mozversion == 1.4 04:40:55 INFO - psutil == 3.1.1 04:40:55 INFO - requests == 1.2.3 04:40:55 INFO - wsgiref == 0.1.2 04:40:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:40:55 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')]} 04:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:55 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')]} 04:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:55 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 0x7f3727a49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29965a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a25410>, '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 0x2a26310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a267a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686', '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 04:40:55 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 04:40:55 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 04:40:55 INFO - Using env: {'DISPLAY': ':0', 04:40:55 INFO - 'HOME': '/home/cltbld', 04:40:55 INFO - 'LANG': 'en_US.UTF-8', 04:40:55 INFO - 'LANGUAGE': 'en_US:en', 04:40:55 INFO - 'LOGNAME': 'cltbld', 04:40:55 INFO - 'MAIL': '/var/mail/cltbld', 04:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:55 INFO - 'MOZ_NO_REMOTE': '1', 04:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:55 INFO - 'NO_EM_RESTART': '1', 04:40:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:55 INFO - 'PWD': '/builds/slave/test', 04:40:55 INFO - 'SHELL': '/bin/bash', 04:40:55 INFO - 'SHLVL': '1', 04:40:55 INFO - 'TERM': 'linux', 04:40:55 INFO - 'TMOUT': '86400', 04:40:55 INFO - 'USER': 'cltbld', 04:40:55 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686', 04:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:55 INFO - '_': '/tools/buildbot/bin/python'} 04:40:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:55 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)) 04:40:55 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)) 04:40:55 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)) 04:40:55 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)) 04:40:55 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)) 04:40:55 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)) 04:40:55 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)) 04:40:55 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)) 04:40:55 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)) 04:40:55 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)) 04:40:55 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)) 04:40:55 INFO - Cleaning up... 04:40:55 INFO - Return code: 0 04:40:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:40:55 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')]} 04:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:55 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')]} 04:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:55 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 0x7f3727a49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29965a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a25410>, '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 0x2a26310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a267a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686', '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 04:40:55 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 04:40:55 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 04:40:55 INFO - Using env: {'DISPLAY': ':0', 04:40:55 INFO - 'HOME': '/home/cltbld', 04:40:55 INFO - 'LANG': 'en_US.UTF-8', 04:40:55 INFO - 'LANGUAGE': 'en_US:en', 04:40:55 INFO - 'LOGNAME': 'cltbld', 04:40:55 INFO - 'MAIL': '/var/mail/cltbld', 04:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:55 INFO - 'MOZ_NO_REMOTE': '1', 04:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:55 INFO - 'NO_EM_RESTART': '1', 04:40:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:55 INFO - 'PWD': '/builds/slave/test', 04:40:55 INFO - 'SHELL': '/bin/bash', 04:40:55 INFO - 'SHLVL': '1', 04:40:55 INFO - 'TERM': 'linux', 04:40:55 INFO - 'TMOUT': '86400', 04:40:55 INFO - 'USER': 'cltbld', 04:40:55 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686', 04:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:55 INFO - '_': '/tools/buildbot/bin/python'} 04:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:56 INFO - Downloading/unpacking jsonschema 04:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:40:57 INFO - Downloading/unpacking functools32 (from jsonschema) 04:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:58 INFO - Downloading functools32-3.2.3-2.tar.gz 04:40:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:40:58 INFO - warning: no files found matching '*.txt' 04:40:58 INFO - no previously-included directories found matching 'build' 04:40:58 INFO - no previously-included directories found matching 'dist' 04:40:58 INFO - no previously-included directories found matching '.git*' 04:40:58 INFO - Installing collected packages: jsonschema, functools32 04:40:58 INFO - Running setup.py install for functools32 04:40:58 INFO - warning: no files found matching '*.txt' 04:40:58 INFO - no previously-included directories found matching 'build' 04:40:58 INFO - no previously-included directories found matching 'dist' 04:40:58 INFO - no previously-included directories found matching '.git*' 04:40:58 INFO - Successfully installed jsonschema functools32 04:40:58 INFO - Cleaning up... 04:40:58 INFO - Return code: 0 04:40:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:40:58 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')]} 04:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:58 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')]} 04:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:58 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 0x7f3727a49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29965a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a25410>, '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 0x2a26310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a267a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686', '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 04:40:58 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 04:40:58 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 04:40:58 INFO - Using env: {'DISPLAY': ':0', 04:40:58 INFO - 'HOME': '/home/cltbld', 04:40:58 INFO - 'LANG': 'en_US.UTF-8', 04:40:58 INFO - 'LANGUAGE': 'en_US:en', 04:40:58 INFO - 'LOGNAME': 'cltbld', 04:40:58 INFO - 'MAIL': '/var/mail/cltbld', 04:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:58 INFO - 'MOZ_NO_REMOTE': '1', 04:40:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:58 INFO - 'NO_EM_RESTART': '1', 04:40:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:58 INFO - 'PWD': '/builds/slave/test', 04:40:58 INFO - 'SHELL': '/bin/bash', 04:40:58 INFO - 'SHLVL': '1', 04:40:58 INFO - 'TERM': 'linux', 04:40:58 INFO - 'TMOUT': '86400', 04:40:58 INFO - 'USER': 'cltbld', 04:40:58 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686', 04:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:58 INFO - '_': '/tools/buildbot/bin/python'} 04:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:58 INFO - Downloading/unpacking flake8 04:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:41:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:41:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:41:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:41:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:41:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:41:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:41:01 INFO - no previously-included directories found matching 'docs/_build' 04:41:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:41:01 INFO - Running setup.py install for pep8 04:41:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:41:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:41:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:41:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:41:01 INFO - no previously-included directories found matching 'docs/_build' 04:41:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:41:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:41:01 INFO - Cleaning up... 04:41:01 INFO - Return code: 0 04:41:01 INFO - Running post-action listener: _resource_record_post_action 04:41:01 INFO - Running post-action listener: _start_resource_monitoring 04:41:01 INFO - Starting resource monitoring. 04:41:01 INFO - ##### 04:41:01 INFO - ##### Running install step. 04:41:01 INFO - ##### 04:41:01 INFO - Running pre-action listener: _resource_record_pre_action 04:41:01 INFO - Running main action method: install 04:41:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:41:01 INFO - Reading from file tmpfile_stdout 04:41:01 INFO - Detecting whether we're running mozinstall >=1.0... 04:41:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:41:01 INFO - Reading from file tmpfile_stdout 04:41:01 INFO - Output received: 04:41:01 INFO - Usage: mozinstall [options] installer 04:41:01 INFO - Options: 04:41:01 INFO - -h, --help show this help message and exit 04:41:01 INFO - -d DEST, --destination=DEST 04:41:01 INFO - Directory to install application into. [default: 04:41:01 INFO - "/builds/slave/test"] 04:41:01 INFO - --app=APP Application being installed. [default: firefox] 04:41:01 INFO - mkdir: /builds/slave/test/build/application 04:41:01 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'] 04:41:01 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 04:41:17 INFO - Reading from file tmpfile_stdout 04:41:17 INFO - Output received: 04:41:17 INFO - /builds/slave/test/build/application/firefox/firefox 04:41:17 INFO - Running post-action listener: _resource_record_post_action 04:41:17 INFO - ##### 04:41:17 INFO - ##### Running run-tests step. 04:41:17 INFO - ##### 04:41:17 INFO - Running pre-action listener: _resource_record_pre_action 04:41:17 INFO - Running main action method: run_tests 04:41:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:41:17 INFO - Python 2.7.3 04:41:17 INFO - Return code: 0 04:41:17 INFO - grabbing minidump binary from tooltool 04:41:17 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')]} 04:41:17 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 0x2a25410>, '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 0x2a26310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a267a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:41:17 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 04:41:17 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 04:41:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:41:17 INFO - Return code: 0 04:41:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:41:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:41:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:41:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:41:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:41:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:41:18 INFO - Return code: 0 04:41:18 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/SfEDd-yNSD-UugV-tSYmqw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 04:41:18 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/SfEDd-yNSD-UugV-tSYmqw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 04:41:18 INFO - Using env: {'DISPLAY': ':0', 04:41:18 INFO - 'HOME': '/home/cltbld', 04:41:18 INFO - 'LANG': 'en_US.UTF-8', 04:41:18 INFO - 'LANGUAGE': 'en_US:en', 04:41:18 INFO - 'LOGNAME': 'cltbld', 04:41:18 INFO - 'MAIL': '/var/mail/cltbld', 04:41:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:41:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:41:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:18 INFO - 'MOZ_NO_REMOTE': '1', 04:41:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:41:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:18 INFO - 'NO_EM_RESTART': '1', 04:41:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:18 INFO - 'PWD': '/builds/slave/test', 04:41:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:41:18 INFO - 'SHELL': '/bin/bash', 04:41:18 INFO - 'SHLVL': '1', 04:41:18 INFO - 'TERM': 'linux', 04:41:18 INFO - 'TMOUT': '86400', 04:41:18 INFO - 'USER': 'cltbld', 04:41:18 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686', 04:41:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:18 INFO - '_': '/tools/buildbot/bin/python'} 04:41:18 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/SfEDd-yNSD-UugV-tSYmqw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 04:41:18 INFO - mozversion application_buildid: 20160418041220 04:41:18 INFO - mozversion application_changeset: 54303363802794f3c7fbc23d886965f5c5495335 04:41:18 INFO - mozversion application_display_name: Nightly 04:41:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:41:18 INFO - mozversion application_name: Firefox 04:41:18 INFO - mozversion application_remotingname: firefox 04:41:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:41:18 INFO - mozversion application_vendor: Mozilla 04:41:18 INFO - mozversion application_version: 48.0a1 04:41:18 INFO - mozversion platform_buildid: 20160418041220 04:41:18 INFO - mozversion platform_changeset: 54303363802794f3c7fbc23d886965f5c5495335 04:41:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:41:18 INFO - mozversion platform_version: 48.0a1 04:41:18 INFO - using testdate: 1460979678 04:41:18 INFO - actual date: 1460979678 04:41:18 INFO - starting webserver on 'localhost:45895' 04:41:18 INFO - SUITE-START | Running 2 tests 04:41:18 INFO - TEST-START | dromaeo_css 04:41:18 INFO - operating with platform_type : linux_ 04:41:18 INFO - Initialising browser for dromaeo_css test... 04:41:18 INFO - TEST-INFO | started process 26803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvkmNXz/profile http://localhost:45895/getInfo.html) 04:41:22 INFO - PROCESS | 26803 | 04:41:22 INFO - PROCESS | 26803 | (process:26871): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:41:23 INFO - PROCESS | 26803 | 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] 04:41:23 INFO - PROCESS | 26803 | __metrics Screen width/height:1600/1200 04:41:23 INFO - PROCESS | 26803 | colorDepth:24 04:41:23 INFO - PROCESS | 26803 | Browser inner width/height: 1024/697 04:41:23 INFO - PROCESS | 26803 | __metrics 04:41:24 ERROR - PROCESS | 26803 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:41:25 INFO - TEST-INFO | 26803: exit 0 04:41:25 INFO - Browser initialized. 04:41:25 INFO - Running cycle 1/1 for dromaeo_css test... 04:41:25 INFO - TEST-INFO | started process 26922 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvkmNXz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:41:27 INFO - PROCESS | 26922 | 04:41:27 INFO - PROCESS | 26922 | (process:26981): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:41:37 INFO - PROCESS | 26922 | RSS: Main: 164417536 04:41:37 INFO - PROCESS | 26922 | 04:42:26 INFO - PROCESS | 26922 | 1460979746700 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] 04:44:38 INFO - PROCESS | 26922 | Cycle 1(1): loaded http://localhost:45895/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45895/tests/dromaeo/cssquery-ext.html) 04:44:39 INFO - PROCESS | 26922 | RSS: Main: 169938944 04:44:39 INFO - PROCESS | 26922 | 04:47:41 INFO - PROCESS | 26922 | Cycle 1(1): loaded http://localhost:45895/tests/dromaeo/cssquery-ext.html (next: http://localhost:45895/tests/dromaeo/cssquery-jquery.html) 04:47:42 INFO - PROCESS | 26922 | RSS: Main: 165834752 04:47:42 INFO - PROCESS | 26922 | 04:50:44 INFO - PROCESS | 26922 | Cycle 1(1): loaded http://localhost:45895/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45895/tests/dromaeo/cssquery-mootools.html) 04:50:44 INFO - PROCESS | 26922 | RSS: Main: 167522304 04:50:44 INFO - PROCESS | 26922 | 04:53:46 INFO - PROCESS | 26922 | Cycle 1(1): loaded http://localhost:45895/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45895/tests/dromaeo/cssquery-prototype.html) 04:53:47 INFO - PROCESS | 26922 | RSS: Main: 164806656 04:53:47 INFO - PROCESS | 26922 | 04:56:49 INFO - PROCESS | 26922 | Cycle 1(1): loaded http://localhost:45895/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45895/tests/dromaeo/cssquery-yui.html) 04:56:50 INFO - PROCESS | 26922 | RSS: Main: 166318080 04:56:50 INFO - PROCESS | 26922 | 04:59:52 INFO - PROCESS | 26922 | Cycle 1(1): loaded http://localhost:45895/tests/dromaeo/cssquery-yui.html (next: http://localhost:45895/tests/dromaeo/cssquery-dojo.html) 04:59:53 INFO - PROCESS | 26922 | RSS: Main: 168636416 04:59:53 INFO - PROCESS | 26922 | 04:59:53 INFO - PROCESS | 26922 | __start_tp_report 04:59:53 INFO - PROCESS | 26922 | _x_x_mozilla_page_load 04:59:53 INFO - PROCESS | 26922 | _x_x_mozilla_page_load_details 04:59:53 INFO - PROCESS | 26922 | |i|pagename|runs| 04:59:53 INFO - PROCESS | 26922 | |0;dojo.html;2621.921342359729;2706.7563919247264;2736.0287098080194;2742.602322663213;2750.5049091163582;4740.194166991611;4764.745654854229;4765.761711914403;4791.832285869995;4822.831200907969;4645.860624181271;4747.931715364041;4775.808967641299;4817.735024573647;4821.180399332122;4381.9342709859375;4393.692441529094;4448.710833795809;4453.153900758845;4493.281075027996;4410.735355878642;4504.549545045502;4520.570545798144;4556.157110934471;4573.062522182961;4295.634871035965;4365.716228445172;4414.624756895651;4456.866294011184;4494.258447356182;4343.022819865537;4353.346997950302;4369.43197384338;4403.889902752425;4403.933940990888;4341.044970106572;4397.362382454558;4399.582039706254;4402.119576084796;4429.667774916862;4626.653001024903;4711.222648263032;4712.31671407644;4717.292406139072;4750.548697873696;5142.897142057175;5162.690238585659;5189.195674670432;5198.350206224222;5238.580913526908;4956.306117143603;5163.819266325698;5217.817376391846;5223.347081614798;5223.555997740196;4701.294805779126;4723.929141062887;4739.928901066487;4740.051989602093;4746.1931471649905;5204.297419848272;5204.4014938281825;5235.712035837989;5251.553617942442;5299.205119232069;4711.528847115261;5012.548870601663;5014.398272207359;5034.144195486776;5047.394312682502;5171.4052883918075;5197.792088316501;5198.350206224222;5210.7915683373;5270.314859068373;4820.4456487503685;4885.5358740919555;4948.134076536592;4951.579115775199;4988.927380613186;4887.242477415935;4993.90012199754;5009.098362294749;5018.372703412074;5082.822101226439;4117.938230926538;4186.35111557709;4211.810468528924;4217.62041416274;4222.809973551136;3759.9060023499082;3765.4916586260506;3774.679152272088;3783.2055268393397;3809.580946095927;4379.5182529921685;4421.7789110544345;4447.088346888945;4447.510773814878;4463.553644635575;4980.228064649985;5119.0529751996;5154.123798954187;5215.765290561933;5240.109181439165;4404.317330813729;4410.625096866738;4429.15845989261;4446.844360447369;4487.461504619467;4554.24854898938;4574.08518296342;4575.99328147807;4581;4620.976895115503;4657.04530571232;4796.448408433075;4814.927776083291;4887.0714564232685;4908.730019848943;5106.157484015244;5155.845324640267;5172.405173405106;5199.532042116228;5212.087884620252;4633.490316065163;4846.418429788448;4863.416390033077;4883.291922671264;4883.902321953612;4993.500649934977;5080.669756465818;5106.080905437057;5130.102232109291;5169.4830516948;5059.87350316245;5082.796688132434;5087.796488140433;5093.567046801063;5119.718415487035;4773.069251495925;4924.433690125681;4927.28554359623;4931.876703082452;4992.525710057539;4824.589909857701;4955.876103097451;4965.82619608312;5023.547880690755;5036.546710795899;4944.456109827845;4950.059488697136;4963.032208719265;4993.725345106054;4999.0501804657;4796.328514008112;5070.4676009019995;5086.847394578021;5089.1094058538865;5101.617378696538;4874.293227481924;4913.091078150554;4925.876853078702;4940.456549779593;4982.277569752293 04:59:53 INFO - PROCESS | 26922 | |1;ext.html;566.8667863052182;603.9607425517341;620.1751670278533;627.6861569215392;631.9810405687831;34851.477227841606;36085.639143608554;36329.455058174084;36330.63669363305;36347.27305453893;36348.454773178426;37096.44355334665;37115.257694846085;37255;37256;7572.091349038109;7769.3784497240085;7781.105172905103;7795.649195786204;7845.176256493043;7512.5492470451945;7598.392128629696;7614.352780013705;7616.086069671647;7623.771286861403;7725.381969442431;7780.649870755829;7789.961050194741;7796.532208067506;7819.296263336299;7708.498947568418;7778.766637000871;7781.727639532646;7785.026871641045;7807.804804879866;7731.149573546905;7736.922630773676;7787.844243115106;7834;7845.529268243924;28161.29596760077;33503.497447538306;34060;34096.659033409844;34246;3069.7390721788674;3183.4269831430333;3224.5163225516126;3685.7235707322056;3907.0427745202323;27695.30761730953;29031.70968290311;29129.126126216248;29441.263968400748;29466.410671786445;3549.7337699672626;3574.749767516275;3615.2407994321225;3645.1798345372345;3783.791891445969;237392;243072;244188;244954;245228;34034;56391.71804140953;57642.423575764544;57750.4224957745;57789;33234.83382583072;33367.165820854185;33395.83302083474;33491;33662;12883;12930.741385172432;12953.676158096123;12963.416646250753;12974.286414247119;11168.385738784445;11223.933726295989;11258.943705281421;11271.54913803455;11329.09367250618;8371.748847534584;8394.118617545191;8415.495070295801;8483.83032339362;8510.063892971768;3248.6588908164304;3328.816915069646;3342.1477523231906;3354.647761985005;3383.5601371821504;862.7145553125797;894.6645008121955;910.0899100899101;917.5962576466334;946.3281070439928;27272.590911136347;27365.27691350342;27809;28263.858680706464;28529.71470285312;964.4213471916934;1043.155044414027;1055.762453447968;1058.4284486377423;1104.3373975614568;14399.280035998157;14915.477958271409;14945.402183912522;15192.620184495476;15293.770593441108;335914;339468;341375;342378;343376;47048.2942755859;47701.284480732815;48052;48083;48102.75948620235;1257.735875466144;1277.5145444730942;1282.653683505467;1290.5612091888615;1294.4175121195499;24870.751292486842;27308;27316.180514584594;27733.583996240475;27909.44181116407;41836;42393;42491.1501769969;42499.36250956176;42518;295593;301832;303524;304135;304355;25642.102526411487;25813.48373032491;26022.86988565045;26064;26086.478270434105;40455.1908961825;41107.7944610275;41198.79400602978;41915;42291;35446.29107417889;36393;36396;36429.08927276839;36544.26911461809;35621.28757424785;35700;35947.640523594426;35991;36239.81880090583;35358.823205883804;35529.1117722059;36538.451923221706;37304.253914921006;37319.62680373162;27590;28776.856115720126;29166.27084322909;29199.550730063645;29222.853885730434;24543.381259295984;24586.262412127664;24734.743394688507;24885.751142488345;25099.49801004006 04:59:53 INFO - PROCESS | 26922 | |2;jquery.html;379.67304271570845;380.62128182458457;382.636495329437;393.47471126046764;394.1250424058589;15208.706570125501;15742.449014284502;17013.91493042533;17104.31582736692;17157.48527544174;16066;16182.676346473063;17085;17087;17096.82903170968;5144.0483510550575;5220.895582088356;5259.447757985414;5266.289050978107;5316.388615309231;4986.87532811679;5218.947810521884;5228.320318358627;5266.183741520071;5281.287026251464;5203.895922081556;5207.453217412174;5214.817481388152;5227.817026404076;5234.73826308685;5053.267276244961;5143.408508021569;5206.088934436478;5218.739063046852;5267.841964741064;4651.674382793206;4691.038337140878;4702.929456058162;4716.103940251342;4718.952810471886;19434;19575.11911963965;19783.505412364662;20096.196152153898;20160.29438969629;1748.3531093495487;1977.337591906713;1998.9200431982704;2026.118638392304;2280.623697089978;9116.589753461043;9190.632374705005;9400.012998635113;9423.670171543963;9467.100625440573;1772.8122158154067;1801.1084513165936;1830.3044842959723;1840.0523730278917;1871.7192421136801;56423;61805.69097154486;67947;68054;68860.6556967217;9963.452010139366;10196.38821670702;10258.28192026566;10324.638637647646;10396.896031039743;14069.366878490493;14093.436262549383;14132.788008179885;14148.221847798264;14159.150450972975;6852.349026842442;6873.759418420332;6975.651217439209;7014.859702805916;7079.646017699094;6231.376862313732;6234.37656234382;6250.749970001149;6334.9683251584365;6527.3472652734345;4277.807498662568;4365.279728844768;4379.64962802975;4407.449068866392;4436.423264975597;1844.2991663167911;1882.5011371986434;1893.2427029188434;1896.6206758648325;1914.9138288777037;911.070707877974;918.8162367526521;922.7785331520387;929.8140371925642;934.0985948559672;15721;15937.246902840678;16017.878748487727;16791.97621848047;16859.915700421665;863.9524826134623;881.5724373678761;889.6396959231522;919.8436265834824;991.3803872579638;8954.507502087448;9080.591373388213;9214.677486287948;9377.578008989612;9493.67088607606;343857;348463;349975;352260;358837;56057;76709;77866.2213377859;79136;79879;935.462109287149;988.8220120378401;994.6916455898695;996.4121168510613;1002.2182697495965;15204.543863684106;15222.619434513783;15250.1612411314;15424.074555526704;15761.605959851095;29787.404251914406;33182.17044573905;33208.50187247145;33678.663213368534;33938;39378;40677;40825.183496329315;41964;42740.57259427366;7006.684699188447;7063.223045464892;7193.4604904631315;7278.199398066315;7471;8948.910510895068;10460.535525026655;10517.474126293502;10746.623868164577;10788.352698838095;9417.293702972167;9420.246380289698;9512.809743805223;9628.518574071408;9681.37071090377;8997.820043599222;9581.185599223865;9646.9035309646;9856.753581160528;9976.351537150062;9496.287778416785;9572.186364158846;9774.657886973922;9819.901800982185;10182.338148020355;7368.37368823656;7424.740134095281;7515.736949206752;7528.548287102792;7613.200613935457;7310.305520975498;8562.143785621638;9637.662681806103;9730.610775568897;9904.554295056596 04:59:53 INFO - PROCESS | 26922 | |3;mootools.html;1431.2342896550347;1446.3419144289348;1588.475802985015;1750.282384222469;1774.3434929076243;7087.220405755363;7319.634018299091;7397.112346518418;7665.463417560766;7703.499272547288;7227.566346019243;7257.600831954241;7292.234315396887;7338.706451741938;7365.33711965923;2189.4526368407937;2211.137656314039;2222.92219772308;2225.9777402226014;2234.0951914474663;2162.9242976495825;2166.2309879992613;2212.9557408851815;2213.701150344707;2218.944526386837;2194.1662168375997;2205.746339171;2206.415299945516;2216.434809123671;2230.3309007297744;2142.1859693316596;2148.2695883399642;2156.967645485319;2157.1802714968367;2158.568286342722;2140.967885481719;2154.4721543222013;2168.30614203455;2169.945751356213;2184.060853832851;7345.853082938364;7450.739224127184;7464.738734144333;7465.6267186641;7490.400767938552;4406.405135306724;4575.8627241182485;4625.444946606395;4636.86089417318;4646.326282688991;2992.850357482117;2997.7901546891726;3024.758019358446;3045.512717965137;3096.411681780477;958.836997710391;978.9070038346346;981.219930155521;1000.5947591225565;1001.209044854564;10959.56161753529;10961.56153753849;10981.890181098166;10998.450077496092;11034.448277586089;4101.630853223224;4144.150449157915;4161.83352665896;4296.183725092223;4350.086481838786;9339.626414943463;9356.766080847898;9363.90636093644;9397.248220142508;9398.718038458857;4481.215787237221;4514;4519.570640789119;4559.680822342404;4570.314452832102;3640.0717816956508;4058.6347228749555;4128.793560321972;4131.8967025824595;4168.687348448879;3609.5488063992;3656.8902932912056;3705.81470926458;3721.199942012426;3731.7201209909367;1189.6847335456112;1201.7175963648535;1205.6322821539516;1236.7093732972744;1244.4710997825887;859.6604341285157;878.7232021913077;882.6469412235028;894.1639567004871;895.2032690905099;5376.46235376467;5388.703621300866;5474.753636086386;5532.5020748132865;5568.693721845257;403.294235088595;422;423.68223832125904;424.0987900710989;427.69419864796197;3699.167687270343;3823.5794062653085;3861.092643228839;3868.497095377583;3870.651641352292;9578.137967582812;9792;9921.305508614329;9977.700668979942;10001;9332.90667093334;9644.95177524108;9735.610575576897;9885.703428897144;9889.851652225223;7354.521956072838;7472.439567032494;7479;7498.737544185928;7555.24447555251;5405.216243644728;5666.291713535808;5678.290213723285;5795.333536643171;5862.530997520103;8325.292350150305;8497.787555311166;8526.104759000216;8671.653133874826;8714.912850871664;8540.530270834915;8557.61490732906;8761.03628600866;8772;8772.254358379354;6148.415900489446;6509.349065093642;6749.595024298558;6757.290484499057;6921.48088893325;7398.186199517941;7458.47790654649;7499.137599176164;7504.174540800616;7518.586477743776;6595.571287866273;6830.31696830313;6862.348076932683;6885.827854303682;6980.232174460907;6710.66446677674;6766;6781.084553585203;6816.420604248694;6963.547369420971;6253.437190652863;6266.624002559679;6299.622022678471;6360.395762402564;6368.42684158428;4601.884952876205;4659.534046595313;4681.461631912373;4733.621310295237;4778.187708089703;4546.29532422475;4714.764261786965;4823.831165909176;4853.466118726867;4860.392450943632 04:59:53 INFO - PROCESS | 26922 | |4;prototype.html;311.90019193857967;312.56241262232885;317.91734149121237;318.0395206476441;323.13238953410087;5109.693418394894;5222.086134926387;5251.632385733;5280.9207861882105;5317.5214230719275;5208.661437006592;5219.686818790875;5235.293235413218;5236.738163091849;5246.895062098756;3882.7476214046137;3984.330498565968;4090.1615168890453;4120.537209290704;4137.296659567865;4104.220198162355;4113.856015039474;4119.258533463975;4120.237756015132;4130.277201489727;4078.1028173801715;4089.407035979796;4111.198316328318;4111.5477297497255;4115.958840411602;3965.8413663453425;4034.0721634024044;4074.1647962167685;4083.3874918762126;4101.159262351211;3559.7864128152396;3580.3555360035184;3589.2642008388216;3600.135967367839;3607.6753092221566;5011.749412529359;5029.647924645276;5049.722265275408;5071.56891664209;5086.084504789136;4648.395708557866;4734.076855013273;4744.454387745419;4754.381930349033;4768.809247630091;5542.612017158801;5560.4161563035705;5561.860953476155;5570;5575.581831362664;3926.391409331558;3937.9212415751526;3943.605639436062;3945.842166313344;3950.854252266839;5582.888342233173;5784.913226301567;5807.2160258365;5869.85325366865;5872.148538461942;4033.576474470197;4038.9394159087637;4055.513338399411;4062.4921884764403;4081.1225586499045;4121.4848143982;4121.97939010309;4125.1749650070105;4126.381042843597;4159.396887451363;4691.53084691535;4692.278478482472;4708.882277943078;4710;4715.834945776881;5246.422893481714;5557.722113894289;5562.415946325658;5574.331080270394;5587.161925711176;1375.2642336350004;1385.7852032934911;1385.7990591364196;1395.8743713065874;1397.8462369139386;876.991230087691;914.8078903430354;920.2453987729997;948.6110694615174;953.1802649721234;4747.216709243005;4778.832740854054;4788.49162513807;4790.760461976887;4828.106800241896;5580.162975553618;5664.603477756517;5672.574556908248;5682.090865461506;5699.287589051369;4623.8844028898875;4744.786484608201;4793.18515852306;4805.1590971579835;4821.879453013633;3034.30211051455;3044.9847750761105;3061.5560743692486;3063.1423201503617;3069.41681080594;5228.241904923841;5282.6302158849285;5324.893502129936;5333.813316533902;5342.465753424704;5585.441455854382;5736.913946290809;5746.166805813217;5754.769809207585;5822.679752613647;5256.316678831804;5263.131583288791;5301.54936830366;5304.946950530522;5320.946790532045;5438.945610543844;5616.129499927518;5637.746301416364;5673.34756502991;5674.7017457929605;5469.202645196105;5507;5520.696361700145;5528.391876893619;5550.694711790728;5248.081585722407;5273.78904843802;5277.076511610376;5303.867403314948;5328.254044433705;3813.618638136164;3875.438061481013;3878.3600705883214;3880.068783491998;3898.9220215596097;5583.497485226349;5609.59760059985;5622.353429355677;5628.437156284503;5653.434656534479;5399;5435.782568697208;5463.617546771847;5467.097928841856;5472;5313.973430132824;5430.266913966722;5435.2934118564335;5444.646098003617;5456.508914197582;5199.792008319625;5311.5485183758265;5340.786368545215;5373.328333958255;5384.838454846361;5419.888922770901;5568.526675232651;5616.1014237721765;5623.0721930880945;5626.943730562805;5475.863103422446;5479.0959491683425;5482.917756233739;5490.945090549203;5511.090670039399 04:59:53 INFO - PROCESS | 26922 | |5;yui.html;693.3170826735665;702.4626160986846;707.5754547271636;711.4592909388863;715.5492040014791;12151;12573;13659.180449173044;14028.929855350734;14078.507252246174;13929.930350348259;14028.789568156486;14037.649058773535;14091.859081409182;14133.222672752994;634.8095571328606;809.0938149272823;820.5815034332473;821.8027673358381;822.9177082291783;802.1016461563029;828.2711214131556;834.6285902773238;835.4152093534519;836.2097817562376;860.3160487412522;860.6084231674604;860.9655613775442;862.5687156421789;866.757307953774;843.5444859775714;854.7435769269194;855.4696088425154;856.7686724584389;861.9784505387385;621.9067139929001;623.2769986815318;627.5136769004013;627.6924307089539;628.5348841856993;11965.282083074957;11998.040156787436;12014.699632509257;12036.939815300955;12109.576164834189;11636.185467017312;11641.417929103596;11830.349330786803;11992.220505667105;12277.38613069343;9957.850632240523;10043.548040338203;10194.184465242763;10288.794224115476;10529.157667386668;3268.607767067967;3323.601167859848;3345.347657206821;3359.3617212729505;3429.657034296575;43304.56695433069;43404.78297608523;43530.347044794034;43784.56215437836;44035;9781.364211326241;9857.852132218022;9940.304178707422;9998.900010999942;10127.392356458637;16430;16642.251098700588;16687.415940442268;16774.580635483966;17035.91482042582;6738.225104112992;6791.558548694319;6871.278515755874;6887;6969.16370035599;3716.832742526593;3746.8501259949844;3773.754705944105;3788.8484460621817;3847.461355410245;2784.5962335461245;2845.061129827152;2867.569864520339;2869.7704183665674;2878.323593955419;492.8989557140778;497.42547357801794;539.7328322480319;544.3331918400007;571.5513322042177;587.2189987316858;587.2659176029963;589.6845187824493;592.8951725642218;608.7352001879196;7604.467687261949;7836.216378362118;7932.920670793218;8205.425620206648;8265.504069755834;498.2734823835428;583.3349981021639;636.8121404185777;652.5334385913999;675.8175292670951;3743.2700623378178;3788.6021967692996;3881.611838816152;3909.7263191576885;3920.196359746245;44190.558094419284;45145.77427112909;45196;45209.77395113003;46525.7673711636;40167;40753;41316;41710.58289417067;42023.159536809704;30259.848700756356;34773.82613086919;37005.629943700755;37216.25567488635;37630.43554346687;7497.9250207497225;7729.709761479275;7898.605069746375;8051.557164356017;8077.5961201940845;25339.239822805346;25922.48155036851;26644.333891652088;27177.45645087127;27358.5896211553;32023.359532808747;32675.18312042123;32718;35954;36611.81694091512;10292.176625870063;10451;10687.839682404614;10697.625583104555;10710.143188544742;11558.47986840611;11692.47383867711;11703.648890533297;11836.881631183922;11845.940770296093;10950.45247737594;11065.944670276596;11162.49768760424;11212;11224.158188136085;11278.436078196222;11454.770904582028;11539.249948753304;11622.476988535367;11845.644630660749;10545.420001899969;10595.576176952836;10605.469726513798;10673.626423075155;10866.293690910066;9142.771430714285;9275.211607013209;9470.242380609672;9651.527893194247;9881.12927191679;8641.783955401166;8661.784089670287;8896.199342059246;9045.355899544582;9077.818443631222 04:59:53 INFO - PROCESS | 26922 | __end_tp_report 04:59:53 INFO - PROCESS | 26922 | __start_cc_report 04:59:53 INFO - PROCESS | 26922 | _x_x_mozilla_cycle_collect,374 04:59:53 INFO - PROCESS | 26922 | __end_cc_report 04:59:53 INFO - PROCESS | 26922 | __startTimestamp1460980793045__endTimestamp 04:59:53 INFO - PROCESS | 26922 | 04:59:53 INFO - PROCESS | 26922 | ------- Summary: start ------- 04:59:53 INFO - PROCESS | 26922 | Number of tests: 6 04:59:53 INFO - PROCESS | 26922 | 04:59:53 INFO - PROCESS | 26922 | [#0] dojo.html Cycles:165 Average:4721.98 Median:4822.83 stddev:494.52 (10.3%) stddev-sans-first:467.79 04:59:53 INFO - PROCESS | 26922 | Values: 2621.9 2706.8 2736.0 2742.6 2750.5 4740.2 4764.7 4765.8 4791.8 4822.8 4645.9 4747.9 4775.8 4817.7 4821.2 4381.9 4393.7 4448.7 4453.2 4493.3 4410.7 4504.5 4520.6 4556.2 4573.1 4295.6 4365.7 4414.6 4456.9 4494.3 4343.0 4353.3 4369.4 4403.9 4403.9 4341.0 4397.4 4399.6 4402.1 4429.7 4626.7 4711.2 4712.3 4717.3 4750.5 5142.9 5162.7 5189.2 5198.4 5238.6 4956.3 5163.8 5217.8 5223.3 5223.6 4701.3 4723.9 4739.9 4740.1 4746.2 5204.3 5204.4 5235.7 5251.6 5299.2 4711.5 5012.5 5014.4 5034.1 5047.4 5171.4 5197.8 5198.4 5210.8 5270.3 4820.4 4885.5 4948.1 4951.6 4988.9 4887.2 4993.9 5009.1 5018.4 5082.8 4117.9 4186.4 4211.8 4217.6 4222.8 3759.9 3765.5 3774.7 3783.2 3809.6 4379.5 4421.8 4447.1 4447.5 4463.6 4980.2 5119.1 5154.1 5215.8 5240.1 4404.3 4410.6 4429.2 4446.8 4487.5 4554.2 4574.1 4576.0 4581.0 4621.0 4657.0 4796.4 4814.9 4887.1 4908.7 5106.2 5155.8 5172.4 5199.5 5212.1 4633.5 4846.4 4863.4 4883.3 4883.9 4993.5 5080.7 5106.1 5130.1 5169.5 5059.9 5082.8 5087.8 5093.6 5119.7 4773.1 4924.4 4927.3 4931.9 4992.5 4824.6 4955.9 4965.8 5023.5 5036.5 4944.5 4950.1 4963.0 4993.7 4999.1 4796.3 5070.5 5086.8 5089.1 5101.6 4874.3 4913.1 4925.9 4940.5 4982.3 04:59:53 INFO - PROCESS | 26922 | 04:59:53 INFO - PROCESS | 26922 | [#1] ext.html Cycles:180 Average:43922.65 Median:19498.01 stddev:78307.61 (401.6%) stddev-sans-first:78459.62 04:59:53 INFO - PROCESS | 26922 | Values: 566.9 604.0 620.2 627.7 632.0 34851.5 36085.6 36329.5 36330.6 36347.3 36348.5 37096.4 37115.3 37255.0 37256.0 7572.1 7769.4 7781.1 7795.6 7845.2 7512.5 7598.4 7614.4 7616.1 7623.8 7725.4 7780.6 7790.0 7796.5 7819.3 7708.5 7778.8 7781.7 7785.0 7807.8 7731.1 7736.9 7787.8 7834.0 7845.5 28161.3 33503.5 34060.0 34096.7 34246.0 3069.7 3183.4 3224.5 3685.7 3907.0 27695.3 29031.7 29129.1 29441.3 29466.4 3549.7 3574.7 3615.2 3645.2 3783.8 237392.0 243072.0 244188.0 244954.0 245228.0 34034.0 56391.7 57642.4 57750.4 57789.0 33234.8 33367.2 33395.8 33491.0 33662.0 12883.0 12930.7 12953.7 12963.4 12974.3 11168.4 11223.9 11258.9 11271.5 11329.1 8371.7 8394.1 8415.5 8483.8 8510.1 3248.7 3328.8 3342.1 3354.6 3383.6 862.7 894.7 910.1 917.6 946.3 27272.6 27365.3 27809.0 28263.9 28529.7 964.4 1043.2 1055.8 1058.4 1104.3 14399.3 14915.5 14945.4 15192.6 15293.8 335914.0 339468.0 341375.0 342378.0 343376.0 47048.3 47701.3 48052.0 48083.0 48102.8 1257.7 1277.5 1282.7 1290.6 1294.4 24870.8 27308.0 27316.2 27733.6 27909.4 41836.0 42393.0 42491.2 42499.4 42518.0 295593.0 301832.0 303524.0 304135.0 304355.0 25642.1 25813.5 26022.9 26064.0 26086.5 40455.2 41107.8 41198.8 41915.0 42291.0 35446.3 36393.0 36396.0 36429.1 36544.3 35621.3 35700.0 35947.6 35991.0 36239.8 35358.8 35529.1 36538.5 37304.3 37319.6 27590.0 28776.9 29166.3 29199.6 29222.9 24543.4 24586.3 24734.7 24885.8 25099.5 04:59:53 INFO - PROCESS | 26922 | 04:59:53 INFO - PROCESS | 26922 | [#2] jquery.html Cycles:180 Average:22378.16 Median:5206.77 stddev:57951.92 (1113.0%) stddev-sans-first:58090.95 04:59:53 INFO - PROCESS | 26922 | Values: 379.7 380.6 382.6 393.5 394.1 15208.7 15742.4 17013.9 17104.3 17157.5 16066.0 16182.7 17085.0 17087.0 17096.8 5144.0 5220.9 5259.4 5266.3 5316.4 4986.9 5218.9 5228.3 5266.2 5281.3 5203.9 5207.5 5214.8 5227.8 5234.7 5053.3 5143.4 5206.1 5218.7 5267.8 4651.7 4691.0 4702.9 4716.1 4719.0 19434.0 19575.1 19783.5 20096.2 20160.3 1748.4 1977.3 1998.9 2026.1 2280.6 9116.6 9190.6 9400.0 9423.7 9467.1 1772.8 1801.1 1830.3 1840.1 1871.7 56423.0 61805.7 67947.0 68054.0 68860.7 9963.5 10196.4 10258.3 10324.6 10396.9 14069.4 14093.4 14132.8 14148.2 14159.2 6852.3 6873.8 6975.7 7014.9 7079.6 6231.4 6234.4 6250.7 6335.0 6527.3 4277.8 4365.3 4379.6 4407.4 4436.4 1844.3 1882.5 1893.2 1896.6 1914.9 911.1 918.8 922.8 929.8 934.1 15721.0 15937.2 16017.9 16792.0 16859.9 864.0 881.6 889.6 919.8 991.4 8954.5 9080.6 9214.7 9377.6 9493.7 343857.0 348463.0 349975.0 352260.0 358837.0 56057.0 76709.0 77866.2 79136.0 79879.0 935.5 988.8 994.7 996.4 1002.2 15204.5 15222.6 15250.2 15424.1 15761.6 29787.4 33182.2 33208.5 33678.7 33938.0 39378.0 40677.0 40825.2 41964.0 42740.6 7006.7 7063.2 7193.5 7278.2 7471.0 8948.9 10460.5 10517.5 10746.6 10788.4 9417.3 9420.2 9512.8 9628.5 9681.4 8997.8 9581.2 9646.9 9856.8 9976.4 9496.3 9572.2 9774.7 9819.9 10182.3 7368.4 7424.7 7515.7 7528.5 7613.2 7310.3 8562.1 9637.7 9730.6 9904.6 04:59:53 INFO - PROCESS | 26922 | 04:59:53 INFO - PROCESS | 26922 | [#3] mootools.html Cycles:180 Average:5148.59 Median:4838.65 stddev:2875.31 (59.4%) stddev-sans-first:2869.80 04:59:53 INFO - PROCESS | 26922 | Values: 1431.2 1446.3 1588.5 1750.3 1774.3 7087.2 7319.6 7397.1 7665.5 7703.5 7227.6 7257.6 7292.2 7338.7 7365.3 2189.5 2211.1 2222.9 2226.0 2234.1 2162.9 2166.2 2213.0 2213.7 2218.9 2194.2 2205.7 2206.4 2216.4 2230.3 2142.2 2148.3 2157.0 2157.2 2158.6 2141.0 2154.5 2168.3 2169.9 2184.1 7345.9 7450.7 7464.7 7465.6 7490.4 4406.4 4575.9 4625.4 4636.9 4646.3 2992.9 2997.8 3024.8 3045.5 3096.4 958.8 978.9 981.2 1000.6 1001.2 10959.6 10961.6 10981.9 10998.5 11034.4 4101.6 4144.2 4161.8 4296.2 4350.1 9339.6 9356.8 9363.9 9397.2 9398.7 4481.2 4514.0 4519.6 4559.7 4570.3 3640.1 4058.6 4128.8 4131.9 4168.7 3609.5 3656.9 3705.8 3721.2 3731.7 1189.7 1201.7 1205.6 1236.7 1244.5 859.7 878.7 882.6 894.2 895.2 5376.5 5388.7 5474.8 5532.5 5568.7 403.3 422.0 423.7 424.1 427.7 3699.2 3823.6 3861.1 3868.5 3870.7 9578.1 9792.0 9921.3 9977.7 10001.0 9332.9 9645.0 9735.6 9885.7 9889.9 7354.5 7472.4 7479.0 7498.7 7555.2 5405.2 5666.3 5678.3 5795.3 5862.5 8325.3 8497.8 8526.1 8671.7 8714.9 8540.5 8557.6 8761.0 8772.0 8772.3 6148.4 6509.3 6749.6 6757.3 6921.5 7398.2 7458.5 7499.1 7504.2 7518.6 6595.6 6830.3 6862.3 6885.8 6980.2 6710.7 6766.0 6781.1 6816.4 6963.5 6253.4 6266.6 6299.6 6360.4 6368.4 4601.9 4659.5 4681.5 4733.6 4778.2 4546.3 4714.8 4823.8 4853.5 4860.4 04:59:53 INFO - PROCESS | 26922 | 04:59:53 INFO - PROCESS | 26922 | [#4] prototype.html Cycles:180 Average:4560.50 Median:5231.77 stddev:1324.62 (25.3%) stddev-sans-first:1289.39 04:59:53 INFO - PROCESS | 26922 | Values: 311.9 312.6 317.9 318.0 323.1 5109.7 5222.1 5251.6 5280.9 5317.5 5208.7 5219.7 5235.3 5236.7 5246.9 3882.7 3984.3 4090.2 4120.5 4137.3 4104.2 4113.9 4119.3 4120.2 4130.3 4078.1 4089.4 4111.2 4111.5 4116.0 3965.8 4034.1 4074.2 4083.4 4101.2 3559.8 3580.4 3589.3 3600.1 3607.7 5011.7 5029.6 5049.7 5071.6 5086.1 4648.4 4734.1 4744.5 4754.4 4768.8 5542.6 5560.4 5561.9 5570.0 5575.6 3926.4 3937.9 3943.6 3945.8 3950.9 5582.9 5784.9 5807.2 5869.9 5872.1 4033.6 4038.9 4055.5 4062.5 4081.1 4121.5 4122.0 4125.2 4126.4 4159.4 4691.5 4692.3 4708.9 4710.0 4715.8 5246.4 5557.7 5562.4 5574.3 5587.2 1375.3 1385.8 1385.8 1395.9 1397.8 877.0 914.8 920.2 948.6 953.2 4747.2 4778.8 4788.5 4790.8 4828.1 5580.2 5664.6 5672.6 5682.1 5699.3 4623.9 4744.8 4793.2 4805.2 4821.9 3034.3 3045.0 3061.6 3063.1 3069.4 5228.2 5282.6 5324.9 5333.8 5342.5 5585.4 5736.9 5746.2 5754.8 5822.7 5256.3 5263.1 5301.5 5304.9 5320.9 5438.9 5616.1 5637.7 5673.3 5674.7 5469.2 5507.0 5520.7 5528.4 5550.7 5248.1 5273.8 5277.1 5303.9 5328.3 3813.6 3875.4 3878.4 3880.1 3898.9 5583.5 5609.6 5622.4 5628.4 5653.4 5399.0 5435.8 5463.6 5467.1 5472.0 5314.0 5430.3 5435.3 5444.6 5456.5 5199.8 5311.5 5340.8 5373.3 5384.8 5419.9 5568.5 5616.1 5623.1 5626.9 5475.9 5479.1 5482.9 5490.9 5511.1 04:59:53 INFO - PROCESS | 26922 | 04:59:53 INFO - PROCESS | 26922 | [#5] yui.html Cycles:180 Average:11968.70 Median:40460.00 stddev:12693.37 (31.4%) stddev-sans-first:12700.74 04:59:53 INFO - PROCESS | 26922 | Values: 693.3 702.5 707.6 711.5 715.5 12151.0 12573.0 13659.2 14028.9 14078.5 13929.9 14028.8 14037.6 14091.9 14133.2 634.8 809.1 820.6 821.8 822.9 802.1 828.3 834.6 835.4 836.2 860.3 860.6 861.0 862.6 866.8 843.5 854.7 855.5 856.8 862.0 621.9 623.3 627.5 627.7 628.5 11965.3 11998.0 12014.7 12036.9 12109.6 11636.2 11641.4 11830.3 11992.2 12277.4 9957.9 10043.5 10194.2 10288.8 10529.2 3268.6 3323.6 3345.3 3359.4 3429.7 43304.6 43404.8 43530.3 43784.6 44035.0 9781.4 9857.9 9940.3 9998.9 10127.4 16430.0 16642.3 16687.4 16774.6 17035.9 6738.2 6791.6 6871.3 6887.0 6969.2 3716.8 3746.9 3773.8 3788.8 3847.5 2784.6 2845.1 2867.6 2869.8 2878.3 492.9 497.4 539.7 544.3 571.6 587.2 587.3 589.7 592.9 608.7 7604.5 7836.2 7932.9 8205.4 8265.5 498.3 583.3 636.8 652.5 675.8 3743.3 3788.6 3881.6 3909.7 3920.2 44190.6 45145.8 45196.0 45209.8 46525.8 40167.0 40753.0 41316.0 41710.6 42023.2 30259.8 34773.8 37005.6 37216.3 37630.4 7497.9 7729.7 7898.6 8051.6 8077.6 25339.2 25922.5 26644.3 27177.5 27358.6 32023.4 32675.2 32718.0 35954.0 36611.8 10292.2 10451.0 10687.8 10697.6 10710.1 11558.5 11692.5 11703.6 11836.9 11845.9 10950.5 11065.9 11162.5 11212.0 11224.2 11278.4 11454.8 11539.2 11622.5 11845.6 10545.4 10595.6 10605.5 10673.6 10866.3 9142.8 9275.2 9470.2 9651.5 9881.1 8641.8 8661.8 8896.2 9045.4 9077.8 04:59:53 INFO - PROCESS | 26922 | -------- Summary: end -------- 04:59:53 INFO - PROCESS | 26922 | 04:59:53 INFO - TEST-INFO | 26922: exit 0 04:59:53 INFO - TEST-OK | dromaeo_css | took 1114827ms 04:59:53 INFO - TEST-START | kraken 04:59:53 INFO - operating with platform_type : linux_ 04:59:53 INFO - Initialising browser for kraken test... 04:59:53 INFO - TEST-INFO | started process 27154 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYY1_la/profile http://localhost:45895/getInfo.html) 04:59:57 INFO - PROCESS | 27154 | 04:59:57 INFO - PROCESS | 27154 | (process:27222): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:59:57 INFO - PROCESS | 27154 | 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] 04:59:58 INFO - PROCESS | 27154 | __metrics Screen width/height:1600/1200 04:59:58 INFO - PROCESS | 27154 | colorDepth:24 04:59:58 INFO - PROCESS | 27154 | Browser inner width/height: 1024/697 04:59:58 INFO - PROCESS | 27154 | __metrics 04:59:58 ERROR - PROCESS | 27154 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:59:59 INFO - TEST-INFO | 27154: exit 0 04:59:59 INFO - Browser initialized. 04:59:59 INFO - Running cycle 1/1 for kraken test... 04:59:59 INFO - TEST-INFO | started process 27273 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYY1_la/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:00:01 INFO - PROCESS | 27273 | 05:00:01 INFO - PROCESS | 27273 | (process:27335): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:00:11 INFO - PROCESS | 27273 | RSS: Main: 164597760 05:00:11 INFO - PROCESS | 27273 | 05:00:14 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:45895/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45895/tests/kraken/driver.html?testName=audio-beat-detection) 05:00:15 INFO - PROCESS | 27273 | RSS: Main: 169029632 05:00:15 INFO - PROCESS | 27273 | 05:00:18 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:45895/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45895/tests/kraken/driver.html?testName=audio-dft) 05:00:18 INFO - PROCESS | 27273 | RSS: Main: 172032000 05:00:18 INFO - PROCESS | 27273 | 05:00:21 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:45895/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45895/tests/kraken/driver.html?testName=audio-fft) 05:00:22 INFO - PROCESS | 27273 | RSS: Main: 162611200 05:00:22 INFO - PROCESS | 27273 | 05:00:24 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:45895/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45895/tests/kraken/driver.html?testName=audio-oscillator) 05:00:25 INFO - PROCESS | 27273 | RSS: Main: 163979264 05:00:25 INFO - PROCESS | 27273 | 05:00:27 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:45895/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45895/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:00:27 INFO - PROCESS | 27273 | RSS: Main: 164622336 05:00:27 INFO - PROCESS | 27273 | 05:00:31 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:45895/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45895/tests/kraken/driver.html?testName=imaging-darkroom) 05:00:31 INFO - PROCESS | 27273 | RSS: Main: 165060608 05:00:31 INFO - PROCESS | 27273 | 05:00:35 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:45895/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45895/tests/kraken/driver.html?testName=imaging-desaturate) 05:00:36 INFO - PROCESS | 27273 | RSS: Main: 164397056 05:00:36 INFO - PROCESS | 27273 | 05:00:38 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:45895/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45895/tests/kraken/driver.html?testName=json-parse-financial) 05:00:39 INFO - PROCESS | 27273 | RSS: Main: 164376576 05:00:39 INFO - PROCESS | 27273 | 05:00:41 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:45895/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45895/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:00:41 INFO - PROCESS | 27273 | RSS: Main: 164900864 05:00:41 INFO - PROCESS | 27273 | 05:00:43 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:45895/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45895/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:00:44 INFO - PROCESS | 27273 | RSS: Main: 165023744 05:00:44 INFO - PROCESS | 27273 | 05:00:46 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:45895/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45895/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:00:47 INFO - PROCESS | 27273 | RSS: Main: 165347328 05:00:47 INFO - PROCESS | 27273 | 05:00:50 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:45895/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45895/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:00:50 INFO - PROCESS | 27273 | RSS: Main: 165543936 05:00:50 INFO - PROCESS | 27273 | 05:00:53 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:45895/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45895/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:00:54 INFO - PROCESS | 27273 | RSS: Main: 165613568 05:00:54 INFO - PROCESS | 27273 | 05:00:56 INFO - PROCESS | 27273 | Cycle 1(1): loaded http://localhost:45895/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45895/tests/kraken/driver.html?testName=ai-astar) 05:00:56 INFO - PROCESS | 27273 | RSS: Main: 167186432 05:00:56 INFO - PROCESS | 27273 | 05:00:56 INFO - PROCESS | 27273 | __start_tp_report 05:00:56 INFO - PROCESS | 27273 | _x_x_mozilla_page_load 05:00:56 INFO - PROCESS | 27273 | _x_x_mozilla_page_load_details 05:00:56 INFO - PROCESS | 27273 | |i|pagename|runs| 05:00:56 INFO - PROCESS | 27273 | |0;ai-astar;114;109;113;114;112;125;116;114;114;113 05:00:56 INFO - PROCESS | 27273 | |1;audio-beat-detection;164;132;155;188;138;158;165;133;206;133 05:00:56 INFO - PROCESS | 27273 | |2;audio-dft;162;163;164;168;166;167;162;165;165;161 05:00:56 INFO - PROCESS | 27273 | |3;audio-fft;75;78;74;169;78;74;75;77;159;79 05:00:56 INFO - PROCESS | 27273 | |4;audio-oscillator;96;94;146;94;95;95;135;94;95;151 05:00:56 INFO - PROCESS | 27273 | |5;imaging-gaussian-blur;118;118;119;118;117;118;118;117;118;118 05:00:56 INFO - PROCESS | 27273 | |6;imaging-darkroom;147;148;146;147;146;147;148;147;147;147 05:00:56 INFO - PROCESS | 27273 | |7;imaging-desaturate;95;95;95;95;95;96;96;96;96;95 05:00:56 INFO - PROCESS | 27273 | |8;json-parse-financial;67;68;67;67;67;66;65;67;66;69 05:00:56 INFO - PROCESS | 27273 | |9;json-stringify-tinderbox;64;66;65;64;65;65;64;65;64;64 05:00:56 INFO - PROCESS | 27273 | |10;stanford-crypto-aes;80;80;80;79;80;82;89;79;115;80 05:00:56 INFO - PROCESS | 27273 | |11;stanford-crypto-ccm;142;133;143;144;134;143;136;134;137;151 05:00:56 INFO - PROCESS | 27273 | |12;stanford-crypto-pbkdf2;184;173;179;177;176;178;178;176;177;179 05:00:56 INFO - PROCESS | 27273 | |13;stanford-crypto-sha256-iterative;73;73;73;72;76;72;69;75;71;75 05:00:56 INFO - PROCESS | 27273 | __end_tp_report 05:00:56 INFO - PROCESS | 27273 | __start_cc_report 05:00:56 INFO - PROCESS | 27273 | _x_x_mozilla_cycle_collect,890 05:00:56 INFO - PROCESS | 27273 | __end_cc_report 05:00:56 INFO - PROCESS | 27273 | __startTimestamp1460980856416__endTimestamp 05:00:56 INFO - PROCESS | 27273 | 05:00:56 INFO - PROCESS | 27273 | ------- Summary: start ------- 05:00:56 INFO - PROCESS | 27273 | Number of tests: 14 05:00:56 INFO - PROCESS | 27273 | 05:00:56 INFO - PROCESS | 27273 | [#0] ai-astar Cycles:10 Average:114.40 Median:114.00 stddev:4.14 (3.6%) stddev-sans-first:4.39 05:00:56 INFO - PROCESS | 27273 | Values: 114.0 109.0 113.0 114.0 112.0 125.0 116.0 114.0 114.0 113.0 05:00:56 INFO - PROCESS | 27273 | 05:00:56 INFO - PROCESS | 27273 | [#1] audio-beat-detection Cycles:10 Average:157.20 Median:161.00 stddev:24.98 (15.5%) stddev-sans-first:26.38 05:00:56 INFO - PROCESS | 27273 | Values: 164.0 132.0 155.0 188.0 138.0 158.0 165.0 133.0 206.0 133.0 05:00:56 INFO - PROCESS | 27273 | 05:00:56 INFO - PROCESS | 27273 | [#2] audio-dft Cycles:10 Average:164.30 Median:165.00 stddev:2.31 (1.4%) stddev-sans-first:2.30 05:00:56 INFO - PROCESS | 27273 | Values: 162.0 163.0 164.0 168.0 166.0 167.0 162.0 165.0 165.0 161.0 05:00:56 INFO - PROCESS | 27273 | 05:00:56 INFO - PROCESS | 27273 | [#3] audio-fft Cycles:10 Average:93.80 Median:76.00 stddev:37.11 (48.8%) stddev-sans-first:38.74 05:00:56 INFO - PROCESS | 27273 | Values: 75.0 78.0 74.0 169.0 78.0 74.0 75.0 77.0 159.0 79.0 05:00:56 INFO - PROCESS | 27273 | 05:00:56 INFO - PROCESS | 27273 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:94.50 stddev:24.13 (25.5%) stddev-sans-first:25.09 05:00:56 INFO - PROCESS | 27273 | Values: 96.0 94.0 146.0 94.0 95.0 95.0 135.0 94.0 95.0 151.0 05:00:56 INFO - PROCESS | 27273 | 05:00:56 INFO - PROCESS | 27273 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 05:00:56 INFO - PROCESS | 27273 | Values: 118.0 118.0 119.0 118.0 117.0 118.0 118.0 117.0 118.0 118.0 05:00:56 INFO - PROCESS | 27273 | 05:00:56 INFO - PROCESS | 27273 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 05:00:56 INFO - PROCESS | 27273 | Values: 147.0 148.0 146.0 147.0 146.0 147.0 148.0 147.0 147.0 147.0 05:00:56 INFO - PROCESS | 27273 | 05:00:56 INFO - PROCESS | 27273 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:00:56 INFO - PROCESS | 27273 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 05:00:56 INFO - PROCESS | 27273 | 05:00:56 INFO - PROCESS | 27273 | [#8] json-parse-financial Cycles:10 Average:66.90 Median:67.00 stddev:1.10 (1.6%) stddev-sans-first:1.17 05:00:56 INFO - PROCESS | 27273 | Values: 67.0 68.0 67.0 67.0 67.0 66.0 65.0 67.0 66.0 69.0 05:00:56 INFO - PROCESS | 27273 | 05:00:56 INFO - PROCESS | 27273 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 05:00:56 INFO - PROCESS | 27273 | Values: 64.0 66.0 65.0 64.0 65.0 65.0 64.0 65.0 64.0 64.0 05:00:56 INFO - PROCESS | 27273 | 05:00:56 INFO - PROCESS | 27273 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:80.00 stddev:11.15 (13.9%) stddev-sans-first:11.71 05:00:56 INFO - PROCESS | 27273 | Values: 80.0 80.0 80.0 79.0 80.0 82.0 89.0 79.0 115.0 80.0 05:00:56 INFO - PROCESS | 27273 | 05:00:56 INFO - PROCESS | 27273 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:142.50 stddev:5.81 (4.1%) stddev-sans-first:6.11 05:00:56 INFO - PROCESS | 27273 | Values: 142.0 133.0 143.0 144.0 134.0 143.0 136.0 134.0 137.0 151.0 05:00:56 INFO - PROCESS | 27273 | 05:00:56 INFO - PROCESS | 27273 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.70 Median:178.00 stddev:2.83 (1.6%) stddev-sans-first:1.87 05:00:56 INFO - PROCESS | 27273 | Values: 184.0 173.0 179.0 177.0 176.0 178.0 178.0 176.0 177.0 179.0 05:00:56 INFO - PROCESS | 27273 | 05:00:56 INFO - PROCESS | 27273 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:73.00 stddev:2.08 (2.8%) stddev-sans-first:2.20 05:00:56 INFO - PROCESS | 27273 | Values: 73.0 73.0 73.0 72.0 76.0 72.0 69.0 75.0 71.0 75.0 05:00:56 INFO - PROCESS | 27273 | -------- Summary: end -------- 05:00:56 INFO - PROCESS | 27273 | 05:00:57 INFO - TEST-INFO | 27273: exit 0 05:00:57 INFO - TEST-OK | kraken | took 63609ms 05:00:57 INFO - SUITE-END | took 1178s 05:00:57 INFO - Completed test suite (00:19:38) 05:00:57 INFO - javascript benchmark 05:00:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2621.921342359729, 2706.7563919247264, 2736.0287098080194, 2742.602322663213, 2750.5049091163582, 4740.194166991611, 4764.745654854229, 4765.761711914403, 4791.832285869995, 4822.831200907969, 4645.860624181271, 4747.931715364041, 4775.808967641299, 4817.735024573647, 4821.180399332122, 4381.9342709859375, 4393.692441529094, 4448.710833795809, 4453.153900758845, 4493.281075027996, 4410.735355878642, 4504.549545045502, 4520.570545798144, 4556.157110934471, 4573.062522182961, 4295.634871035965, 4365.716228445172, 4414.624756895651, 4456.866294011184, 4494.258447356182, 4343.022819865537, 4353.346997950302, 4369.43197384338, 4403.889902752425, 4403.933940990888, 4341.044970106572, 4397.362382454558, 4399.582039706254, 4402.119576084796, 4429.667774916862, 4626.653001024903, 4711.222648263032, 4712.31671407644, 4717.292406139072, 4750.548697873696, 5142.897142057175, 5162.690238585659, 5189.195674670432, 5198.350206224222, 5238.580913526908, 4956.306117143603, 5163.819266325698, 5217.817376391846, 5223.347081614798, 5223.555997740196, 4701.294805779126, 4723.929141062887, 4739.928901066487, 4740.051989602093, 4746.1931471649905, 5204.297419848272, 5204.4014938281825, 5235.712035837989, 5251.553617942442, 5299.205119232069, 4711.528847115261, 5012.548870601663, 5014.398272207359, 5034.144195486776, 5047.394312682502, 5171.4052883918075, 5197.792088316501, 5198.350206224222, 5210.7915683373, 5270.314859068373, 4820.4456487503685, 4885.5358740919555, 4948.134076536592, 4951.579115775199, 4988.927380613186, 4887.242477415935, 4993.90012199754, 5009.098362294749, 5018.372703412074, 5082.822101226439, 4117.938230926538, 4186.35111557709, 4211.810468528924, 4217.62041416274, 4222.809973551136, 3759.9060023499082, 3765.4916586260506, 3774.679152272088, 3783.2055268393397, 3809.580946095927, 4379.5182529921685, 4421.7789110544345, 4447.088346888945, 4447.510773814878, 4463.553644635575, 4980.228064649985, 5119.0529751996, 5154.123798954187, 5215.765290561933, 5240.109181439165, 4404.317330813729, 4410.625096866738, 4429.15845989261, 4446.844360447369, 4487.461504619467, 4554.24854898938, 4574.08518296342, 4575.99328147807, 4581.0, 4620.976895115503, 4657.04530571232, 4796.448408433075, 4814.927776083291, 4887.0714564232685, 4908.730019848943, 5106.157484015244, 5155.845324640267, 5172.405173405106, 5199.532042116228, 5212.087884620252, 4633.490316065163, 4846.418429788448, 4863.416390033077, 4883.291922671264, 4883.902321953612, 4993.500649934977, 5080.669756465818, 5106.080905437057, 5130.102232109291, 5169.4830516948, 5059.87350316245, 5082.796688132434, 5087.796488140433, 5093.567046801063, 5119.718415487035, 4773.069251495925, 4924.433690125681, 4927.28554359623, 4931.876703082452, 4992.525710057539, 4824.589909857701, 4955.876103097451, 4965.82619608312, 5023.547880690755, 5036.546710795899, 4944.456109827845, 4950.059488697136, 4963.032208719265, 4993.725345106054, 4999.0501804657, 4796.328514008112, 5070.4676009019995, 5086.847394578021, 5089.1094058538865, 5101.617378696538, 4874.293227481924, 4913.091078150554, 4925.876853078702, 4940.456549779593, 4982.277569752293], "value": 4690.9901155242205, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.8667863052182, 603.9607425517341, 620.1751670278533, 627.6861569215392, 631.9810405687831, 34851.477227841606, 36085.639143608554, 36329.455058174084, 36330.63669363305, 36347.27305453893, 36348.454773178426, 37096.44355334665, 37115.257694846085, 37255.0, 37256.0, 7572.091349038109, 7769.3784497240085, 7781.105172905103, 7795.649195786204, 7845.176256493043, 7512.5492470451945, 7598.392128629696, 7614.352780013705, 7616.086069671647, 7623.771286861403, 7725.381969442431, 7780.649870755829, 7789.961050194741, 7796.532208067506, 7819.296263336299, 7708.498947568418, 7778.766637000871, 7781.727639532646, 7785.026871641045, 7807.804804879866, 7731.149573546905, 7736.922630773676, 7787.844243115106, 7834.0, 7845.529268243924, 28161.29596760077, 33503.497447538306, 34060.0, 34096.659033409844, 34246.0, 3069.7390721788674, 3183.4269831430333, 3224.5163225516126, 3685.7235707322056, 3907.0427745202323, 27695.30761730953, 29031.70968290311, 29129.126126216248, 29441.263968400748, 29466.410671786445, 3549.7337699672626, 3574.749767516275, 3615.2407994321225, 3645.1798345372345, 3783.791891445969, 237392.0, 243072.0, 244188.0, 244954.0, 245228.0, 34034.0, 56391.71804140953, 57642.423575764544, 57750.4224957745, 57789.0, 33234.83382583072, 33367.165820854185, 33395.83302083474, 33491.0, 33662.0, 12883.0, 12930.741385172432, 12953.676158096123, 12963.416646250753, 12974.286414247119, 11168.385738784445, 11223.933726295989, 11258.943705281421, 11271.54913803455, 11329.09367250618, 8371.748847534584, 8394.118617545191, 8415.495070295801, 8483.83032339362, 8510.063892971768, 3248.6588908164304, 3328.816915069646, 3342.1477523231906, 3354.647761985005, 3383.5601371821504, 862.7145553125797, 894.6645008121955, 910.0899100899101, 917.5962576466334, 946.3281070439928, 27272.590911136347, 27365.27691350342, 27809.0, 28263.858680706464, 28529.71470285312, 964.4213471916934, 1043.155044414027, 1055.762453447968, 1058.4284486377423, 1104.3373975614568, 14399.280035998157, 14915.477958271409, 14945.402183912522, 15192.620184495476, 15293.770593441108, 335914.0, 339468.0, 341375.0, 342378.0, 343376.0, 47048.2942755859, 47701.284480732815, 48052.0, 48083.0, 48102.75948620235, 1257.735875466144, 1277.5145444730942, 1282.653683505467, 1290.5612091888615, 1294.4175121195499, 24870.751292486842, 27308.0, 27316.180514584594, 27733.583996240475, 27909.44181116407, 41836.0, 42393.0, 42491.1501769969, 42499.36250956176, 42518.0, 295593.0, 301832.0, 303524.0, 304135.0, 304355.0, 25642.102526411487, 25813.48373032491, 26022.86988565045, 26064.0, 26086.478270434105, 40455.1908961825, 41107.7944610275, 41198.79400602978, 41915.0, 42291.0, 35446.29107417889, 36393.0, 36396.0, 36429.08927276839, 36544.26911461809, 35621.28757424785, 35700.0, 35947.640523594426, 35991.0, 36239.81880090583, 35358.823205883804, 35529.1117722059, 36538.451923221706, 37304.253914921006, 37319.62680373162, 27590.0, 28776.856115720126, 29166.27084322909, 29199.550730063645, 29222.853885730434, 24543.381259295984, 24586.262412127664, 24734.743394688507, 24885.751142488345, 25099.49801004006], "value": 16345.649162365933, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.67304271570845, 380.62128182458457, 382.636495329437, 393.47471126046764, 394.1250424058589, 15208.706570125501, 15742.449014284502, 17013.91493042533, 17104.31582736692, 17157.48527544174, 16066.0, 16182.676346473063, 17085.0, 17087.0, 17096.82903170968, 5144.0483510550575, 5220.895582088356, 5259.447757985414, 5266.289050978107, 5316.388615309231, 4986.87532811679, 5218.947810521884, 5228.320318358627, 5266.183741520071, 5281.287026251464, 5203.895922081556, 5207.453217412174, 5214.817481388152, 5227.817026404076, 5234.73826308685, 5053.267276244961, 5143.408508021569, 5206.088934436478, 5218.739063046852, 5267.841964741064, 4651.674382793206, 4691.038337140878, 4702.929456058162, 4716.103940251342, 4718.952810471886, 19434.0, 19575.11911963965, 19783.505412364662, 20096.196152153898, 20160.29438969629, 1748.3531093495487, 1977.337591906713, 1998.9200431982704, 2026.118638392304, 2280.623697089978, 9116.589753461043, 9190.632374705005, 9400.012998635113, 9423.670171543963, 9467.100625440573, 1772.8122158154067, 1801.1084513165936, 1830.3044842959723, 1840.0523730278917, 1871.7192421136801, 56423.0, 61805.69097154486, 67947.0, 68054.0, 68860.6556967217, 9963.452010139366, 10196.38821670702, 10258.28192026566, 10324.638637647646, 10396.896031039743, 14069.366878490493, 14093.436262549383, 14132.788008179885, 14148.221847798264, 14159.150450972975, 6852.349026842442, 6873.759418420332, 6975.651217439209, 7014.859702805916, 7079.646017699094, 6231.376862313732, 6234.37656234382, 6250.749970001149, 6334.9683251584365, 6527.3472652734345, 4277.807498662568, 4365.279728844768, 4379.64962802975, 4407.449068866392, 4436.423264975597, 1844.2991663167911, 1882.5011371986434, 1893.2427029188434, 1896.6206758648325, 1914.9138288777037, 911.070707877974, 918.8162367526521, 922.7785331520387, 929.8140371925642, 934.0985948559672, 15721.0, 15937.246902840678, 16017.878748487727, 16791.97621848047, 16859.915700421665, 863.9524826134623, 881.5724373678761, 889.6396959231522, 919.8436265834824, 991.3803872579638, 8954.507502087448, 9080.591373388213, 9214.677486287948, 9377.578008989612, 9493.67088607606, 343857.0, 348463.0, 349975.0, 352260.0, 358837.0, 56057.0, 76709.0, 77866.2213377859, 79136.0, 79879.0, 935.462109287149, 988.8220120378401, 994.6916455898695, 996.4121168510613, 1002.2182697495965, 15204.543863684106, 15222.619434513783, 15250.1612411314, 15424.074555526704, 15761.605959851095, 29787.404251914406, 33182.17044573905, 33208.50187247145, 33678.663213368534, 33938.0, 39378.0, 40677.0, 40825.183496329315, 41964.0, 42740.57259427366, 7006.684699188447, 7063.223045464892, 7193.4604904631315, 7278.199398066315, 7471.0, 8948.910510895068, 10460.535525026655, 10517.474126293502, 10746.623868164577, 10788.352698838095, 9417.293702972167, 9420.246380289698, 9512.809743805223, 9628.518574071408, 9681.37071090377, 8997.820043599222, 9581.185599223865, 9646.9035309646, 9856.753581160528, 9976.351537150062, 9496.287778416785, 9572.186364158846, 9774.657886973922, 9819.901800982185, 10182.338148020355, 7368.37368823656, 7424.740134095281, 7515.736949206752, 7528.548287102792, 7613.200613935457, 7310.305520975498, 8562.143785621638, 9637.662681806103, 9730.610775568897, 9904.554295056596], "value": 7943.475676002392, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.2342896550347, 1446.3419144289348, 1588.475802985015, 1750.282384222469, 1774.3434929076243, 7087.220405755363, 7319.634018299091, 7397.112346518418, 7665.463417560766, 7703.499272547288, 7227.566346019243, 7257.600831954241, 7292.234315396887, 7338.706451741938, 7365.33711965923, 2189.4526368407937, 2211.137656314039, 2222.92219772308, 2225.9777402226014, 2234.0951914474663, 2162.9242976495825, 2166.2309879992613, 2212.9557408851815, 2213.701150344707, 2218.944526386837, 2194.1662168375997, 2205.746339171, 2206.415299945516, 2216.434809123671, 2230.3309007297744, 2142.1859693316596, 2148.2695883399642, 2156.967645485319, 2157.1802714968367, 2158.568286342722, 2140.967885481719, 2154.4721543222013, 2168.30614203455, 2169.945751356213, 2184.060853832851, 7345.853082938364, 7450.739224127184, 7464.738734144333, 7465.6267186641, 7490.400767938552, 4406.405135306724, 4575.8627241182485, 4625.444946606395, 4636.86089417318, 4646.326282688991, 2992.850357482117, 2997.7901546891726, 3024.758019358446, 3045.512717965137, 3096.411681780477, 958.836997710391, 978.9070038346346, 981.219930155521, 1000.5947591225565, 1001.209044854564, 10959.56161753529, 10961.56153753849, 10981.890181098166, 10998.450077496092, 11034.448277586089, 4101.630853223224, 4144.150449157915, 4161.83352665896, 4296.183725092223, 4350.086481838786, 9339.626414943463, 9356.766080847898, 9363.90636093644, 9397.248220142508, 9398.718038458857, 4481.215787237221, 4514.0, 4519.570640789119, 4559.680822342404, 4570.314452832102, 3640.0717816956508, 4058.6347228749555, 4128.793560321972, 4131.8967025824595, 4168.687348448879, 3609.5488063992, 3656.8902932912056, 3705.81470926458, 3721.199942012426, 3731.7201209909367, 1189.6847335456112, 1201.7175963648535, 1205.6322821539516, 1236.7093732972744, 1244.4710997825887, 859.6604341285157, 878.7232021913077, 882.6469412235028, 894.1639567004871, 895.2032690905099, 5376.46235376467, 5388.703621300866, 5474.753636086386, 5532.5020748132865, 5568.693721845257, 403.294235088595, 422.0, 423.68223832125904, 424.0987900710989, 427.69419864796197, 3699.167687270343, 3823.5794062653085, 3861.092643228839, 3868.497095377583, 3870.651641352292, 9578.137967582812, 9792.0, 9921.305508614329, 9977.700668979942, 10001.0, 9332.90667093334, 9644.95177524108, 9735.610575576897, 9885.703428897144, 9889.851652225223, 7354.521956072838, 7472.439567032494, 7479.0, 7498.737544185928, 7555.24447555251, 5405.216243644728, 5666.291713535808, 5678.290213723285, 5795.333536643171, 5862.530997520103, 8325.292350150305, 8497.787555311166, 8526.104759000216, 8671.653133874826, 8714.912850871664, 8540.530270834915, 8557.61490732906, 8761.03628600866, 8772.0, 8772.254358379354, 6148.415900489446, 6509.349065093642, 6749.595024298558, 6757.290484499057, 6921.48088893325, 7398.186199517941, 7458.47790654649, 7499.137599176164, 7504.174540800616, 7518.586477743776, 6595.571287866273, 6830.31696830313, 6862.348076932683, 6885.827854303682, 6980.232174460907, 6710.66446677674, 6766.0, 6781.084553585203, 6816.420604248694, 6963.547369420971, 6253.437190652863, 6266.624002559679, 6299.622022678471, 6360.395762402564, 6368.42684158428, 4601.884952876205, 4659.534046595313, 4681.461631912373, 4733.621310295237, 4778.187708089703, 4546.29532422475, 4714.764261786965, 4823.831165909176, 4853.466118726867, 4860.392450943632], "value": 4103.707343952635, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.90019193857967, 312.56241262232885, 317.91734149121237, 318.0395206476441, 323.13238953410087, 5109.693418394894, 5222.086134926387, 5251.632385733, 5280.9207861882105, 5317.5214230719275, 5208.661437006592, 5219.686818790875, 5235.293235413218, 5236.738163091849, 5246.895062098756, 3882.7476214046137, 3984.330498565968, 4090.1615168890453, 4120.537209290704, 4137.296659567865, 4104.220198162355, 4113.856015039474, 4119.258533463975, 4120.237756015132, 4130.277201489727, 4078.1028173801715, 4089.407035979796, 4111.198316328318, 4111.5477297497255, 4115.958840411602, 3965.8413663453425, 4034.0721634024044, 4074.1647962167685, 4083.3874918762126, 4101.159262351211, 3559.7864128152396, 3580.3555360035184, 3589.2642008388216, 3600.135967367839, 3607.6753092221566, 5011.749412529359, 5029.647924645276, 5049.722265275408, 5071.56891664209, 5086.084504789136, 4648.395708557866, 4734.076855013273, 4744.454387745419, 4754.381930349033, 4768.809247630091, 5542.612017158801, 5560.4161563035705, 5561.860953476155, 5570.0, 5575.581831362664, 3926.391409331558, 3937.9212415751526, 3943.605639436062, 3945.842166313344, 3950.854252266839, 5582.888342233173, 5784.913226301567, 5807.2160258365, 5869.85325366865, 5872.148538461942, 4033.576474470197, 4038.9394159087637, 4055.513338399411, 4062.4921884764403, 4081.1225586499045, 4121.4848143982, 4121.97939010309, 4125.1749650070105, 4126.381042843597, 4159.396887451363, 4691.53084691535, 4692.278478482472, 4708.882277943078, 4710.0, 4715.834945776881, 5246.422893481714, 5557.722113894289, 5562.415946325658, 5574.331080270394, 5587.161925711176, 1375.2642336350004, 1385.7852032934911, 1385.7990591364196, 1395.8743713065874, 1397.8462369139386, 876.991230087691, 914.8078903430354, 920.2453987729997, 948.6110694615174, 953.1802649721234, 4747.216709243005, 4778.832740854054, 4788.49162513807, 4790.760461976887, 4828.106800241896, 5580.162975553618, 5664.603477756517, 5672.574556908248, 5682.090865461506, 5699.287589051369, 4623.8844028898875, 4744.786484608201, 4793.18515852306, 4805.1590971579835, 4821.879453013633, 3034.30211051455, 3044.9847750761105, 3061.5560743692486, 3063.1423201503617, 3069.41681080594, 5228.241904923841, 5282.6302158849285, 5324.893502129936, 5333.813316533902, 5342.465753424704, 5585.441455854382, 5736.913946290809, 5746.166805813217, 5754.769809207585, 5822.679752613647, 5256.316678831804, 5263.131583288791, 5301.54936830366, 5304.946950530522, 5320.946790532045, 5438.945610543844, 5616.129499927518, 5637.746301416364, 5673.34756502991, 5674.7017457929605, 5469.202645196105, 5507.0, 5520.696361700145, 5528.391876893619, 5550.694711790728, 5248.081585722407, 5273.78904843802, 5277.076511610376, 5303.867403314948, 5328.254044433705, 3813.618638136164, 3875.438061481013, 3878.3600705883214, 3880.068783491998, 3898.9220215596097, 5583.497485226349, 5609.59760059985, 5622.353429355677, 5628.437156284503, 5653.434656534479, 5399.0, 5435.782568697208, 5463.617546771847, 5467.097928841856, 5472.0, 5313.973430132824, 5430.266913966722, 5435.2934118564335, 5444.646098003617, 5456.508914197582, 5199.792008319625, 5311.5485183758265, 5340.786368545215, 5373.328333958255, 5384.838454846361, 5419.888922770901, 5568.526675232651, 5616.1014237721765, 5623.0721930880945, 5626.943730562805, 5475.863103422446, 5479.0959491683425, 5482.917756233739, 5490.945090549203, 5511.090670039399], "value": 4135.60906934135, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.3170826735665, 702.4626160986846, 707.5754547271636, 711.4592909388863, 715.5492040014791, 12151.0, 12573.0, 13659.180449173044, 14028.929855350734, 14078.507252246174, 13929.930350348259, 14028.789568156486, 14037.649058773535, 14091.859081409182, 14133.222672752994, 634.8095571328606, 809.0938149272823, 820.5815034332473, 821.8027673358381, 822.9177082291783, 802.1016461563029, 828.2711214131556, 834.6285902773238, 835.4152093534519, 836.2097817562376, 860.3160487412522, 860.6084231674604, 860.9655613775442, 862.5687156421789, 866.757307953774, 843.5444859775714, 854.7435769269194, 855.4696088425154, 856.7686724584389, 861.9784505387385, 621.9067139929001, 623.2769986815318, 627.5136769004013, 627.6924307089539, 628.5348841856993, 11965.282083074957, 11998.040156787436, 12014.699632509257, 12036.939815300955, 12109.576164834189, 11636.185467017312, 11641.417929103596, 11830.349330786803, 11992.220505667105, 12277.38613069343, 9957.850632240523, 10043.548040338203, 10194.184465242763, 10288.794224115476, 10529.157667386668, 3268.607767067967, 3323.601167859848, 3345.347657206821, 3359.3617212729505, 3429.657034296575, 43304.56695433069, 43404.78297608523, 43530.347044794034, 43784.56215437836, 44035.0, 9781.364211326241, 9857.852132218022, 9940.304178707422, 9998.900010999942, 10127.392356458637, 16430.0, 16642.251098700588, 16687.415940442268, 16774.580635483966, 17035.91482042582, 6738.225104112992, 6791.558548694319, 6871.278515755874, 6887.0, 6969.16370035599, 3716.832742526593, 3746.8501259949844, 3773.754705944105, 3788.8484460621817, 3847.461355410245, 2784.5962335461245, 2845.061129827152, 2867.569864520339, 2869.7704183665674, 2878.323593955419, 492.8989557140778, 497.42547357801794, 539.7328322480319, 544.3331918400007, 571.5513322042177, 587.2189987316858, 587.2659176029963, 589.6845187824493, 592.8951725642218, 608.7352001879196, 7604.467687261949, 7836.216378362118, 7932.920670793218, 8205.425620206648, 8265.504069755834, 498.2734823835428, 583.3349981021639, 636.8121404185777, 652.5334385913999, 675.8175292670951, 3743.2700623378178, 3788.6021967692996, 3881.611838816152, 3909.7263191576885, 3920.196359746245, 44190.558094419284, 45145.77427112909, 45196.0, 45209.77395113003, 46525.7673711636, 40167.0, 40753.0, 41316.0, 41710.58289417067, 42023.159536809704, 30259.848700756356, 34773.82613086919, 37005.629943700755, 37216.25567488635, 37630.43554346687, 7497.9250207497225, 7729.709761479275, 7898.605069746375, 8051.557164356017, 8077.5961201940845, 25339.239822805346, 25922.48155036851, 26644.333891652088, 27177.45645087127, 27358.5896211553, 32023.359532808747, 32675.18312042123, 32718.0, 35954.0, 36611.81694091512, 10292.176625870063, 10451.0, 10687.839682404614, 10697.625583104555, 10710.143188544742, 11558.47986840611, 11692.47383867711, 11703.648890533297, 11836.881631183922, 11845.940770296093, 10950.45247737594, 11065.944670276596, 11162.49768760424, 11212.0, 11224.158188136085, 11278.436078196222, 11454.770904582028, 11539.249948753304, 11622.476988535367, 11845.644630660749, 10545.420001899969, 10595.576176952836, 10605.469726513798, 10673.626423075155, 10866.293690910066, 9142.771430714285, 9275.211607013209, 9470.242380609672, 9651.527893194247, 9881.12927191679, 8641.783955401166, 8661.784089670287, 8896.199342059246, 9045.355899544582, 9077.818443631222], "value": 5845.501203210473, "unit": "score"}], "name": "dromaeo_css", "value": 6264.354255879035, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 113.0, 114.0, 112.0, 125.0, 116.0, 114.0, 114.0, 113.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 132.0, 155.0, 188.0, 138.0, 158.0, 165.0, 133.0, 206.0, 133.0], "value": 157.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 168.0, 166.0, 167.0, 162.0, 165.0, 165.0, 161.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 74.0, 169.0, 78.0, 74.0, 75.0, 77.0, 159.0, 79.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 146.0, 94.0, 95.0, 95.0, 135.0, 94.0, 95.0, 151.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 147.0, 146.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 66.0, 65.0, 67.0, 66.0, 69.0], "value": 66.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 79.0, 80.0, 82.0, 89.0, 79.0, 115.0, 80.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 133.0, 143.0, 144.0, 134.0, 143.0, 136.0, 134.0, 137.0, 151.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 173.0, 179.0, 177.0, 176.0, 178.0, 178.0, 176.0, 177.0, 179.0], "value": 177.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 72.0, 76.0, 72.0, 69.0, 75.0, 71.0, 75.0], "value": 72.9, "unit": "score"}], "name": "kraken", "value": 1605.7000000000003, "alertThreshold": 2.0}]} 05:00:57 INFO - Return code: 0 05:00:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:00:57 ERROR - # TBPL SUCCESS # 05:00:57 INFO - Running post-action listener: _resource_record_post_action 05:00:57 INFO - Running post-run listener: _resource_record_post_run 05:00:58 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 517660672; Read time: 0; Write time: 340244 05:00:58 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234053632; Read time: 0; Write time: 198936 05:00:58 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 283607040; Read time: 0; Write time: 141308 05:00:58 INFO - Running post-run listener: _upload_blobber_files 05:00:58 INFO - Blob upload gear active. 05:00:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:00:58 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 05:00:58 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'] 05:00:58 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 05:00:59 INFO - (blobuploader) - INFO - Open directory for files ... 05:00:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:00:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:00:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:00:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:00:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:00:59 INFO - (blobuploader) - INFO - Done attempting. 05:00:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:00:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:00:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:01:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:01:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:01:00 INFO - (blobuploader) - INFO - Done attempting. 05:01:00 INFO - (blobuploader) - INFO - Iteration through files over. 05:01:00 INFO - Return code: 0 05:01:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:01:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:01:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3ce323e8efef80a1e379582dcd5c9e84cf5c8cf5fc05539e073b3d4ce6dd9d6bddbf35d374ccc95681e8c054e44f1e266eea4b37d8d855812eb5b8494bc6b2dc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/683aab2edcc33d100f85ed23a5489cba06fc5a5978457b229a64c55b3f05e38794511d690e5e9b014c8995b8e9623371863793c3c58b90f95e07644fd0867d36"} 05:01:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:01:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:01:00 INFO - Contents: 05:01:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3ce323e8efef80a1e379582dcd5c9e84cf5c8cf5fc05539e073b3d4ce6dd9d6bddbf35d374ccc95681e8c054e44f1e266eea4b37d8d855812eb5b8494bc6b2dc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/683aab2edcc33d100f85ed23a5489cba06fc5a5978457b229a64c55b3f05e38794511d690e5e9b014c8995b8e9623371863793c3c58b90f95e07644fd0867d36"} 05:01:00 INFO - Running post-run listener: copy_logs_to_upload_dir 05:01:00 INFO - Copying logs to upload dir... 05:01:00 INFO - mkdir: /builds/slave/test/build/upload/logs 05:01:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.871008 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-18 05:01:00.278602) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 05:01:00.282432) ========= 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=7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686 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/3ce323e8efef80a1e379582dcd5c9e84cf5c8cf5fc05539e073b3d4ce6dd9d6bddbf35d374ccc95681e8c054e44f1e266eea4b37d8d855812eb5b8494bc6b2dc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/683aab2edcc33d100f85ed23a5489cba06fc5a5978457b229a64c55b3f05e38794511d690e5e9b014c8995b8e9623371863793c3c58b90f95e07644fd0867d36"} build_url:https://queue.taskcluster.net/v1/task/SfEDd-yNSD-UugV-tSYmqw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011403 build_url: 'https://queue.taskcluster.net/v1/task/SfEDd-yNSD-UugV-tSYmqw/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/3ce323e8efef80a1e379582dcd5c9e84cf5c8cf5fc05539e073b3d4ce6dd9d6bddbf35d374ccc95681e8c054e44f1e266eea4b37d8d855812eb5b8494bc6b2dc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/683aab2edcc33d100f85ed23a5489cba06fc5a5978457b229a64c55b3f05e38794511d690e5e9b014c8995b8e9623371863793c3c58b90f95e07644fd0867d36"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 05:01:00.306442) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 05:01:00.306727) ========= 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=7cf709767345e0a0c5a90e72000001d4-1460978564.855035-1992408686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004355 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 05:01:00.389762) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 05:01:00.390061) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 05:01:00.390352) ========= ========= Total master_lag: 0.16 =========