builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1462483601.24 results: success (0) buildid: 20160505113031 builduid: 420857a753c44529895ccaeabda2e487 revision: 48fd2d23e181161cb97ec2b91049fc09200439bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 14:26:41.238060) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 14:26:41.238722) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 14:26:41.239099) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 14:26:41.257114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:26:41.257560) ========= 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=03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-05 14:26:41-- 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% 220M=0s 2016-05-05 14:26:41 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108725 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:26:41.380370) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:26:41.380936) ========= 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=03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022692 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:26:41.434499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:26:41.434907) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 48fd2d23e181161cb97ec2b91049fc09200439bc --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 48fd2d23e181161cb97ec2b91049fc09200439bc --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=03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-05 14:26:41,447 truncating revision to first 12 chars 2016-05-05 14:26:41,447 Setting DEBUG logging. 2016-05-05 14:26:41,447 attempt 1/10 2016-05-05 14:26:41,447 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/48fd2d23e181?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-05 14:26:41,733 unpacking tar archive at: fx-team-48fd2d23e181/testing/mozharness/ program finished with exit code 0 elapsedTime=0.555797 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:26:42.004004) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 14:26:42.004417) ========= script_repo_revision: 48fd2d23e181161cb97ec2b91049fc09200439bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 14:26:42.004887) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 14:26:42.005159) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 14:26:42.019016) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-05 14:26:42.019497) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:26:42 INFO - MultiFileLogger online at 20160505 14:26:42 in /builds/slave/test 14:26:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:26:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:26:42 INFO - {'append_to_log': False, 14:26:42 INFO - 'base_work_dir': '/builds/slave/test', 14:26:42 INFO - 'blob_upload_branch': 'Fx-Team', 14:26:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:26:42 INFO - 'branch': 'Fx-Team', 14:26:42 INFO - 'buildbot_json_path': 'buildprops.json', 14:26:42 INFO - 'config_files': ('talos/linux_config.py',), 14:26:42 INFO - 'default_actions': ('clobber', 14:26:42 INFO - 'read-buildbot-config', 14:26:42 INFO - 'download-and-extract', 14:26:42 INFO - 'populate-webroot', 14:26:42 INFO - 'create-virtualenv', 14:26:42 INFO - 'install', 14:26:42 INFO - 'run-tests'), 14:26:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:26:42 INFO - 'download_minidump_stackwalk': True, 14:26:42 INFO - 'download_symbols': 'ondemand', 14:26:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:26:42 INFO - 'tooltool.py': '/tools/tooltool.py', 14:26:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:26:42 INFO - '/tools/misc-python/virtualenv.py')}, 14:26:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:26:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:26:42 INFO - 'installer_path': 'installer.exe', 14:26:42 INFO - 'log_level': 'info', 14:26:42 INFO - 'log_name': 'talos', 14:26:42 INFO - 'log_to_console': True, 14:26:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:26:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:26:42 INFO - 'opt_config_files': (), 14:26:42 INFO - 'pip_index': False, 14:26:42 INFO - 'sps_profile': False, 14:26:42 INFO - 'sps_profile_interval': 0, 14:26:42 INFO - 'suite': 'dromaeojs', 14:26:42 INFO - 'system_bits': '32', 14:26:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:26:42 INFO - 'title': 'talos-linux64-ix-047', 14:26:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:26:42 INFO - 'use_talos_json': True, 14:26:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:26:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:26:42 INFO - 'work_dir': 'build'} 14:26:42 INFO - ##### 14:26:42 INFO - ##### Running clobber step. 14:26:42 INFO - ##### 14:26:42 INFO - Running pre-action listener: _resource_record_pre_action 14:26:42 INFO - Running main action method: clobber 14:26:42 INFO - rmtree: /builds/slave/test/build 14:26:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:26:43 INFO - Running post-action listener: _resource_record_post_action 14:26:43 INFO - ##### 14:26:43 INFO - ##### Running read-buildbot-config step. 14:26:43 INFO - ##### 14:26:43 INFO - Running pre-action listener: _resource_record_pre_action 14:26:43 INFO - Running main action method: read_buildbot_config 14:26:43 INFO - Using buildbot properties: 14:26:43 INFO - { 14:26:43 INFO - "project": "", 14:26:43 INFO - "product": "firefox", 14:26:43 INFO - "script_repo_revision": "production", 14:26:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:26:43 INFO - "repository": "", 14:26:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:26:43 INFO - "buildid": "20160505113031", 14:26:43 INFO - "pgo_build": "True", 14:26:43 INFO - "basedir": "/builds/slave/test", 14:26:43 INFO - "buildnumber": 1129, 14:26:43 INFO - "slavename": "talos-linux64-ix-047", 14:26:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:26:43 INFO - "platform": "ubuntu64_hw", 14:26:43 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:26:43 INFO - "branch": "fx-team", 14:26:43 INFO - "repo_path": "integration/fx-team", 14:26:43 INFO - "revision": "48fd2d23e181161cb97ec2b91049fc09200439bc", 14:26:43 INFO - "stage_platform": "linux64-pgo", 14:26:43 INFO - "builduid": "420857a753c44529895ccaeabda2e487", 14:26:43 INFO - "slavebuilddir": "test" 14:26:43 INFO - } 14:26:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:26:43 INFO - Running post-action listener: _resource_record_post_action 14:26:43 INFO - ##### 14:26:43 INFO - ##### Running download-and-extract step. 14:26:43 INFO - ##### 14:26:43 INFO - Running pre-action listener: _resource_record_pre_action 14:26:43 INFO - Running main action method: download_and_extract 14:26:43 INFO - mkdir: /builds/slave/test/build/tests 14:26: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')]} 14:26:43 INFO - https://queue.taskcluster.net/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:26:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:26:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:26:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:26:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:26:49 INFO - Downloaded 1361 bytes. 14:26:49 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:26:49 INFO - Using the following test package requirements: 14:26:49 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:26:49 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:26:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:26:49 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:26:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:26:49 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:26:49 INFO - u'jsshell-linux-x86_64.zip'], 14:26:49 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:26:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:26:49 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:26:49 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:26:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:26:49 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:26:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:26:49 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:26:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:26:49 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:26:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:26:49 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:26:49 INFO - https://queue.taskcluster.net/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:26:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:26:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:26:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:26:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:26:53 INFO - Downloaded 23880109 bytes. 14:26:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:26:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:26:55 INFO - Return code: 0 14:26:55 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:26: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')]} 14:26:55 INFO - https://queue.taskcluster.net/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:26:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:26:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:26:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:26:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:26:56 INFO - Downloaded 23880109 bytes. 14:26:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:26:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:26:58 INFO - Return code: 0 14:26: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')]} 14:26:58 INFO - https://queue.taskcluster.net/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:26:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:26:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:26:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:26:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:27:01 INFO - Downloaded 10840152 bytes. 14:27:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:27:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:27:01 INFO - Return code: 0 14:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:01 INFO - https://queue.taskcluster.net/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:27:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:27:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:27:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:27:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:27:05 INFO - Downloaded 58397042 bytes. 14:27:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:27:05 INFO - mkdir: /builds/slave/test/properties 14:27:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:27:05 INFO - Writing to file /builds/slave/test/properties/build_url 14:27:05 INFO - Contents: 14:27:05 INFO - build_url:https://queue.taskcluster.net/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:27:06 INFO - Running post-action listener: _resource_record_post_action 14:27:06 INFO - Running post-action listener: set_extra_try_arguments 14:27:06 INFO - ##### 14:27:06 INFO - ##### Running populate-webroot step. 14:27:06 INFO - ##### 14:27:06 INFO - Running pre-action listener: _resource_record_pre_action 14:27:06 INFO - Running main action method: populate_webroot 14:27:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:27:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:27:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:27:06 INFO - '--tppagecycles', 14:27:06 INFO - '7'], 14:27:06 INFO - 'tests': ['tsvgm']}}, 14:27:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:27:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:27:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:27:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:27:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:27:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:27:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:06 INFO - 'talos_options': ['--disable-e10s'], 14:27:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:27:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:27:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:06 INFO - 'talos_options': ['--disable-e10s'], 14:27:06 INFO - 'tests': ['damp', 'tps']}, 14:27:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:06 INFO - 'tests': ['damp', 'tps']}, 14:27:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:27:06 INFO - 'tests': ['dromaeo_dom']}, 14:27:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:27:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:27:06 INFO - 'tests': ['a11yr', 14:27:06 INFO - 'ts_paint', 14:27:06 INFO - 'tpaint', 14:27:06 INFO - 'sessionrestore', 14:27:06 INFO - 'sessionrestore_no_auto_restore', 14:27:06 INFO - 'tabpaint']}, 14:27:06 INFO - 'other-e10s': {'tests': ['a11yr', 14:27:06 INFO - 'ts_paint', 14:27:06 INFO - 'tpaint', 14:27:06 INFO - 'sessionrestore', 14:27:06 INFO - 'sessionrestore_no_auto_restore', 14:27:06 INFO - 'tabpaint']}, 14:27:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:27:06 INFO - 'ts_paint', 14:27:06 INFO - 'tpaint', 14:27:06 INFO - 'sessionrestore', 14:27:06 INFO - 'sessionrestore_no_auto_restore', 14:27:06 INFO - 'tabpaint']}, 14:27:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:27:06 INFO - 'ts_paint', 14:27:06 INFO - 'tpaint', 14:27:06 INFO - 'sessionrestore', 14:27:06 INFO - 'sessionrestore_no_auto_restore', 14:27:06 INFO - 'tabpaint']}, 14:27:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:27:06 INFO - 'tests': ['a11yr', 14:27:06 INFO - 'ts_paint', 14:27:06 INFO - 'tpaint', 14:27:06 INFO - 'sessionrestore', 14:27:06 INFO - 'sessionrestore_no_auto_restore', 14:27:06 INFO - 'tabpaint']}, 14:27:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:27:06 INFO - 'tests': ['a11yr', 14:27:06 INFO - 'ts_paint', 14:27:06 INFO - 'tpaint', 14:27:06 INFO - 'sessionrestore', 14:27:06 INFO - 'sessionrestore_no_auto_restore', 14:27:06 INFO - 'tabpaint']}, 14:27:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:27:06 INFO - 'tests': ['tsvgx', 14:27:06 INFO - 'tsvgr_opacity', 14:27:06 INFO - 'tart', 14:27:06 INFO - 'tscrollx', 14:27:06 INFO - 'cart']}, 14:27:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:27:06 INFO - 'tsvgr_opacity', 14:27:06 INFO - 'tart', 14:27:06 INFO - 'tscrollx', 14:27:06 INFO - 'cart']}, 14:27:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:06 INFO - 'talos_options': ['--disable-e10s'], 14:27:06 INFO - 'tests': ['tp5o']}, 14:27:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:06 INFO - 'tests': ['tp5o']}, 14:27:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:06 INFO - 'talos_options': ['--disable-e10s', 14:27:06 INFO - '--xperf_path', 14:27:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:27:06 INFO - 'tests': ['tp5n']}, 14:27:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:06 INFO - 'talos_options': ['--xperf_path', 14:27:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:27:06 INFO - 'tests': ['tp5n']}}, 14:27:06 INFO - 'talos.zip': {'path': '', 14:27:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:27:06 INFO - Running post-action listener: _resource_record_post_action 14:27:06 INFO - ##### 14:27:06 INFO - ##### Running create-virtualenv step. 14:27:06 INFO - ##### 14:27:06 INFO - Running pre-action listener: _resource_record_pre_action 14:27:06 INFO - Running main action method: create_virtualenv 14:27:06 INFO - Creating virtualenv /builds/slave/test/build/venv 14:27:06 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 14:27:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:27:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:27:06 INFO - Using real prefix '/usr' 14:27:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:27:06 INFO - Installing distribute.............................................................................................................................................................................................done. 14:27:08 INFO - Installing pip.................done. 14:27:08 INFO - Return code: 0 14:27:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:08 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 0x7f48f2f92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a919a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20810>, '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 0x2b21710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b21ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517', '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 14:27:08 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 14:27:08 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 14:27:08 INFO - Using env: {'DISPLAY': ':0', 14:27:08 INFO - 'HOME': '/home/cltbld', 14:27:08 INFO - 'LANG': 'en_US.UTF-8', 14:27:08 INFO - 'LANGUAGE': 'en_US:en', 14:27:08 INFO - 'LOGNAME': 'cltbld', 14:27:08 INFO - 'MAIL': '/var/mail/cltbld', 14:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:08 INFO - 'MOZ_NO_REMOTE': '1', 14:27:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:27:08 INFO - 'NO_EM_RESTART': '1', 14:27:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:08 INFO - 'PWD': '/builds/slave/test', 14:27:08 INFO - 'SHELL': '/bin/bash', 14:27:08 INFO - 'SHLVL': '1', 14:27:08 INFO - 'TERM': 'linux', 14:27:08 INFO - 'TMOUT': '86400', 14:27:08 INFO - 'USER': 'cltbld', 14:27:08 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517', 14:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:08 INFO - '_': '/tools/buildbot/bin/python'} 14:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:08 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 14:27:08 INFO - Cleaning up... 14:27:08 INFO - Return code: 0 14:27:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:08 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 0x7f48f2f92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a919a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20810>, '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 0x2b21710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b21ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517', '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 14:27:08 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 14:27:08 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 14:27:08 INFO - Using env: {'DISPLAY': ':0', 14:27:08 INFO - 'HOME': '/home/cltbld', 14:27:08 INFO - 'LANG': 'en_US.UTF-8', 14:27:08 INFO - 'LANGUAGE': 'en_US:en', 14:27:08 INFO - 'LOGNAME': 'cltbld', 14:27:08 INFO - 'MAIL': '/var/mail/cltbld', 14:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:08 INFO - 'MOZ_NO_REMOTE': '1', 14:27:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:27:08 INFO - 'NO_EM_RESTART': '1', 14:27:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:08 INFO - 'PWD': '/builds/slave/test', 14:27:08 INFO - 'SHELL': '/bin/bash', 14:27:08 INFO - 'SHLVL': '1', 14:27:08 INFO - 'TERM': 'linux', 14:27:08 INFO - 'TMOUT': '86400', 14:27:08 INFO - 'USER': 'cltbld', 14:27:08 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517', 14:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:08 INFO - '_': '/tools/buildbot/bin/python'} 14:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:09 INFO - Downloading/unpacking psutil>=0.7.1 14:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:27:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:27:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:27:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:27:11 INFO - Installing collected packages: psutil 14:27:11 INFO - Running setup.py install for psutil 14:27:11 INFO - building 'psutil._psutil_linux' extension 14:27:11 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 14:27:11 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 14:27:11 INFO - building 'psutil._psutil_posix' extension 14:27:11 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 14:27:11 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 14:27:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:27:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:27:11 INFO - Successfully installed psutil 14:27:11 INFO - Cleaning up... 14:27:11 INFO - Return code: 0 14:27:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:27:11 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')]} 14:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:11 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')]} 14:27:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:11 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 0x7f48f2f92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a919a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20810>, '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 0x2b21710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b21ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517', '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 14:27:11 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 14:27:11 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 14:27:11 INFO - Using env: {'DISPLAY': ':0', 14:27:11 INFO - 'HOME': '/home/cltbld', 14:27:11 INFO - 'LANG': 'en_US.UTF-8', 14:27:11 INFO - 'LANGUAGE': 'en_US:en', 14:27:11 INFO - 'LOGNAME': 'cltbld', 14:27:11 INFO - 'MAIL': '/var/mail/cltbld', 14:27:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:11 INFO - 'MOZ_NO_REMOTE': '1', 14:27:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:27:11 INFO - 'NO_EM_RESTART': '1', 14:27:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:27:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:11 INFO - 'PWD': '/builds/slave/test', 14:27:11 INFO - 'SHELL': '/bin/bash', 14:27:11 INFO - 'SHLVL': '1', 14:27:11 INFO - 'TERM': 'linux', 14:27:11 INFO - 'TMOUT': '86400', 14:27:11 INFO - 'USER': 'cltbld', 14:27:11 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517', 14:27:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:11 INFO - '_': '/tools/buildbot/bin/python'} 14:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:27:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:27:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:27:13 INFO - Installing collected packages: mozsystemmonitor 14:27:13 INFO - Running setup.py install for mozsystemmonitor 14:27:14 INFO - Successfully installed mozsystemmonitor 14:27:14 INFO - Cleaning up... 14:27:14 INFO - Return code: 0 14:27:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:27:14 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')]} 14:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:14 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')]} 14:27:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:14 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 0x7f48f2f92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a919a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20810>, '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 0x2b21710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b21ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517', '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 14:27:14 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 14:27:14 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 14:27:14 INFO - Using env: {'DISPLAY': ':0', 14:27:14 INFO - 'HOME': '/home/cltbld', 14:27:14 INFO - 'LANG': 'en_US.UTF-8', 14:27:14 INFO - 'LANGUAGE': 'en_US:en', 14:27:14 INFO - 'LOGNAME': 'cltbld', 14:27:14 INFO - 'MAIL': '/var/mail/cltbld', 14:27:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:14 INFO - 'MOZ_NO_REMOTE': '1', 14:27:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:27:14 INFO - 'NO_EM_RESTART': '1', 14:27:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:27:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:14 INFO - 'PWD': '/builds/slave/test', 14:27:14 INFO - 'SHELL': '/bin/bash', 14:27:14 INFO - 'SHLVL': '1', 14:27:14 INFO - 'TERM': 'linux', 14:27:14 INFO - 'TMOUT': '86400', 14:27:14 INFO - 'USER': 'cltbld', 14:27:14 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517', 14:27:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:14 INFO - '_': '/tools/buildbot/bin/python'} 14:27:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:14 INFO - Downloading/unpacking blobuploader==1.2.4 14:27:14 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 14:27:14 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 14:27:14 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 14:27:14 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 14:27:14 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 14:27:14 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 14:27:16 INFO - Downloading blobuploader-1.2.4.tar.gz 14:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:27:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:27:16 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 14:27:16 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 14:27:16 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 14:27:16 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 14:27:16 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 14:27:16 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 14:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:27:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:27:16 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 14:27:16 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 14:27:16 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 14:27:16 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 14:27:16 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 14:27:16 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 14:27:16 INFO - Downloading docopt-0.6.1.tar.gz 14:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:27:16 INFO - Installing collected packages: blobuploader, requests, docopt 14:27:16 INFO - Running setup.py install for blobuploader 14:27:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:27:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:27:17 INFO - Running setup.py install for requests 14:27:18 INFO - Running setup.py install for docopt 14:27:18 INFO - Successfully installed blobuploader requests docopt 14:27:18 INFO - Cleaning up... 14:27:18 INFO - Return code: 0 14:27:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:27:18 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')]} 14:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:18 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')]} 14:27:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:18 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 0x7f48f2f92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a919a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20810>, '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 0x2b21710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b21ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517', '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 14:27:18 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 14:27:18 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 14:27:18 INFO - Using env: {'DISPLAY': ':0', 14:27:18 INFO - 'HOME': '/home/cltbld', 14:27:18 INFO - 'LANG': 'en_US.UTF-8', 14:27:18 INFO - 'LANGUAGE': 'en_US:en', 14:27:18 INFO - 'LOGNAME': 'cltbld', 14:27:18 INFO - 'MAIL': '/var/mail/cltbld', 14:27:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:18 INFO - 'MOZ_NO_REMOTE': '1', 14:27:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:27:18 INFO - 'NO_EM_RESTART': '1', 14:27:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:27:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:18 INFO - 'PWD': '/builds/slave/test', 14:27:18 INFO - 'SHELL': '/bin/bash', 14:27:18 INFO - 'SHLVL': '1', 14:27:18 INFO - 'TERM': 'linux', 14:27:18 INFO - 'TMOUT': '86400', 14:27:18 INFO - 'USER': 'cltbld', 14:27:18 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517', 14:27:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:18 INFO - '_': '/tools/buildbot/bin/python'} 14:27:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:27:18 INFO - Running setup.py (path:/tmp/pip-PTIWNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:27:18 INFO - Running setup.py (path:/tmp/pip-F_CMeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:27:18 INFO - Running setup.py (path:/tmp/pip-UHsnLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:27:18 INFO - Running setup.py (path:/tmp/pip-6fZFR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:27:18 INFO - Running setup.py (path:/tmp/pip-OiuUft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:27:18 INFO - Running setup.py (path:/tmp/pip-yF92ts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:27:18 INFO - Running setup.py (path:/tmp/pip-2VUW88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:27:19 INFO - Running setup.py (path:/tmp/pip-ybeoN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:27:19 INFO - Running setup.py (path:/tmp/pip-TzyYPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:27:19 INFO - Running setup.py (path:/tmp/pip-vGEbFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:27:19 INFO - Running setup.py (path:/tmp/pip-7PMlGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:27:19 INFO - Running setup.py (path:/tmp/pip-V1hdSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:27:19 INFO - Running setup.py (path:/tmp/pip-4y7ScN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:27:19 INFO - Running setup.py (path:/tmp/pip-yCgefj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:27:19 INFO - Running setup.py (path:/tmp/pip-GyaDpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:27:19 INFO - Running setup.py (path:/tmp/pip-q3pwEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:27:19 INFO - Running setup.py (path:/tmp/pip-5QzSop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:27:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:27:19 INFO - Running setup.py install for manifestparser 14:27:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:27:19 INFO - Running setup.py install for mozcrash 14:27:19 INFO - Running setup.py install for mozdebug 14:27:20 INFO - Running setup.py install for mozdevice 14:27:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:27:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:27:20 INFO - Running setup.py install for mozfile 14:27:20 INFO - Running setup.py install for mozhttpd 14:27:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:27:20 INFO - Running setup.py install for mozinfo 14:27:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:27:20 INFO - Running setup.py install for mozInstall 14:27:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:27:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:27:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:27:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:27:20 INFO - Running setup.py install for mozleak 14:27:20 INFO - Running setup.py install for mozlog 14:27:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:27:20 INFO - Running setup.py install for moznetwork 14:27:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:27:20 INFO - Running setup.py install for mozprocess 14:27:21 INFO - Running setup.py install for mozprofile 14:27:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:27:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:27:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:27:21 INFO - Running setup.py install for mozrunner 14:27:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:27:21 INFO - Running setup.py install for mozscreenshot 14:27:21 INFO - Running setup.py install for moztest 14:27:21 INFO - Running setup.py install for mozversion 14:27:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:27:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:27:21 INFO - Cleaning up... 14:27:21 INFO - Return code: 0 14:27:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:27: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')]} 14:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27: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')]} 14:27:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:21 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 0x7f48f2f92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a919a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20810>, '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 0x2b21710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b21ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517', '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 14:27:21 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 14:27:21 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 14:27:21 INFO - Using env: {'DISPLAY': ':0', 14:27:21 INFO - 'HOME': '/home/cltbld', 14:27:21 INFO - 'LANG': 'en_US.UTF-8', 14:27:21 INFO - 'LANGUAGE': 'en_US:en', 14:27:21 INFO - 'LOGNAME': 'cltbld', 14:27:21 INFO - 'MAIL': '/var/mail/cltbld', 14:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:21 INFO - 'MOZ_NO_REMOTE': '1', 14:27:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:27:21 INFO - 'NO_EM_RESTART': '1', 14:27:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:21 INFO - 'PWD': '/builds/slave/test', 14:27:21 INFO - 'SHELL': '/bin/bash', 14:27:21 INFO - 'SHLVL': '1', 14:27:21 INFO - 'TERM': 'linux', 14:27:21 INFO - 'TMOUT': '86400', 14:27:21 INFO - 'USER': 'cltbld', 14:27:21 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517', 14:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:21 INFO - '_': '/tools/buildbot/bin/python'} 14:27:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:27:21 INFO - Running setup.py (path:/tmp/pip-z50t4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:27:21 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)) 14:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:27:21 INFO - Running setup.py (path:/tmp/pip-CZZk9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:27:21 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)) 14:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:27:21 INFO - Running setup.py (path:/tmp/pip-DIV1TC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:27:22 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)) 14:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:27:22 INFO - Running setup.py (path:/tmp/pip-vpLxH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:27:22 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)) 14:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:27:22 INFO - Running setup.py (path:/tmp/pip-fL3cV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:27:22 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)) 14:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:27:22 INFO - Running setup.py (path:/tmp/pip-jhmXf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:27:22 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)) 14:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:27:22 INFO - Running setup.py (path:/tmp/pip-wxuTHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:27:22 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)) 14:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:27:22 INFO - Running setup.py (path:/tmp/pip-wrp83D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:27:22 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)) 14:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:27:22 INFO - Running setup.py (path:/tmp/pip-BpP5tN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:27:22 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)) 14:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:27:22 INFO - Running setup.py (path:/tmp/pip-XgUDb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:27:22 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)) 14:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:27:22 INFO - Running setup.py (path:/tmp/pip-2yjGDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:27:22 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)) 14:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:27:22 INFO - Running setup.py (path:/tmp/pip-92OzBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:27:22 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)) 14:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:27:22 INFO - Running setup.py (path:/tmp/pip-hWZrid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:27:22 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)) 14:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:27:22 INFO - Running setup.py (path:/tmp/pip-eBTJdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:27:22 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)) 14:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:27:22 INFO - Running setup.py (path:/tmp/pip-rB31jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:27:22 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)) 14:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:27:22 INFO - Running setup.py (path:/tmp/pip-fZbIcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:27:22 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)) 14:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:27:22 INFO - Running setup.py (path:/tmp/pip-SRFMqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:27:23 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)) 14:27:23 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)) 14:27:23 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)) 14:27:23 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)) 14:27:23 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)) 14:27:23 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)) 14:27:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:27:23 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 14:27:23 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 14:27:23 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 14:27:23 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 14:27:23 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 14:27:23 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 14:27:24 INFO - Downloading blessings-1.6.tar.gz 14:27:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:27:24 INFO - Installing collected packages: blessings 14:27:24 INFO - Running setup.py install for blessings 14:27:25 INFO - Successfully installed blessings 14:27:25 INFO - Cleaning up... 14:27:25 INFO - Return code: 0 14:27:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:27:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:27:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:27:25 INFO - Reading from file tmpfile_stdout 14:27:25 INFO - Current package versions: 14:27:25 INFO - argparse == 1.2.1 14:27:25 INFO - blessings == 1.6 14:27:25 INFO - blobuploader == 1.2.4 14:27:25 INFO - docopt == 0.6.1 14:27:25 INFO - manifestparser == 1.1 14:27:25 INFO - mozInstall == 1.12 14:27:25 INFO - mozcrash == 0.17 14:27:25 INFO - mozdebug == 0.1 14:27:25 INFO - mozdevice == 0.48 14:27:25 INFO - mozfile == 1.2 14:27:25 INFO - mozhttpd == 0.7 14:27:25 INFO - mozinfo == 0.9 14:27:25 INFO - mozleak == 0.1 14:27:25 INFO - mozlog == 3.1 14:27:25 INFO - moznetwork == 0.27 14:27:25 INFO - mozprocess == 0.22 14:27:25 INFO - mozprofile == 0.28 14:27:25 INFO - mozrunner == 6.11 14:27:25 INFO - mozscreenshot == 0.1 14:27:25 INFO - mozsystemmonitor == 0.0 14:27:25 INFO - moztest == 0.7 14:27:25 INFO - mozversion == 1.4 14:27:25 INFO - psutil == 3.1.1 14:27:25 INFO - requests == 1.2.3 14:27:25 INFO - wsgiref == 0.1.2 14:27:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:27:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:25 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 0x7f48f2f92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a919a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20810>, '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 0x2b21710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b21ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517', '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 14:27:25 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 14:27:25 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 14:27:25 INFO - Using env: {'DISPLAY': ':0', 14:27:25 INFO - 'HOME': '/home/cltbld', 14:27:25 INFO - 'LANG': 'en_US.UTF-8', 14:27:25 INFO - 'LANGUAGE': 'en_US:en', 14:27:25 INFO - 'LOGNAME': 'cltbld', 14:27:25 INFO - 'MAIL': '/var/mail/cltbld', 14:27:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:25 INFO - 'MOZ_NO_REMOTE': '1', 14:27:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:27:25 INFO - 'NO_EM_RESTART': '1', 14:27:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:27:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:25 INFO - 'PWD': '/builds/slave/test', 14:27:25 INFO - 'SHELL': '/bin/bash', 14:27:25 INFO - 'SHLVL': '1', 14:27:25 INFO - 'TERM': 'linux', 14:27:25 INFO - 'TMOUT': '86400', 14:27:25 INFO - 'USER': 'cltbld', 14:27:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517', 14:27:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:25 INFO - '_': '/tools/buildbot/bin/python'} 14:27:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:25 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)) 14:27:25 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)) 14:27:25 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)) 14:27:25 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)) 14:27:25 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)) 14:27:25 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)) 14:27:25 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)) 14:27:25 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)) 14:27:25 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)) 14:27:25 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)) 14:27:25 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)) 14:27:25 INFO - Cleaning up... 14:27:25 INFO - Return code: 0 14:27:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:27:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:25 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 0x7f48f2f92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a919a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20810>, '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 0x2b21710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b21ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517', '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 14:27:25 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 14:27:25 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 14:27:25 INFO - Using env: {'DISPLAY': ':0', 14:27:25 INFO - 'HOME': '/home/cltbld', 14:27:25 INFO - 'LANG': 'en_US.UTF-8', 14:27:25 INFO - 'LANGUAGE': 'en_US:en', 14:27:25 INFO - 'LOGNAME': 'cltbld', 14:27:25 INFO - 'MAIL': '/var/mail/cltbld', 14:27:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:25 INFO - 'MOZ_NO_REMOTE': '1', 14:27:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:27:25 INFO - 'NO_EM_RESTART': '1', 14:27:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:27:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:25 INFO - 'PWD': '/builds/slave/test', 14:27:25 INFO - 'SHELL': '/bin/bash', 14:27:25 INFO - 'SHLVL': '1', 14:27:25 INFO - 'TERM': 'linux', 14:27:25 INFO - 'TMOUT': '86400', 14:27:25 INFO - 'USER': 'cltbld', 14:27:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517', 14:27:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:25 INFO - '_': '/tools/buildbot/bin/python'} 14:27:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:25 INFO - Downloading/unpacking jsonschema 14:27:25 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 14:27:25 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 14:27:25 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 14:27:25 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 14:27:25 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 14:27:25 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 14:27:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:27:27 INFO - Downloading/unpacking functools32 (from jsonschema) 14:27:27 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 14:27:27 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 14:27:27 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 14:27:27 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 14:27:27 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 14:27:27 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 14:27:27 INFO - Downloading functools32-3.2.3-2.tar.gz 14:27:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:27:27 INFO - warning: no files found matching '*.txt' 14:27:27 INFO - no previously-included directories found matching 'build' 14:27:27 INFO - no previously-included directories found matching 'dist' 14:27:27 INFO - no previously-included directories found matching '.git*' 14:27:27 INFO - Installing collected packages: jsonschema, functools32 14:27:28 INFO - Running setup.py install for functools32 14:27:28 INFO - warning: no files found matching '*.txt' 14:27:28 INFO - no previously-included directories found matching 'build' 14:27:28 INFO - no previously-included directories found matching 'dist' 14:27:28 INFO - no previously-included directories found matching '.git*' 14:27:28 INFO - Successfully installed jsonschema functools32 14:27:28 INFO - Cleaning up... 14:27:28 INFO - Return code: 0 14:27:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:27:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:28 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 0x7f48f2f92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a919a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20810>, '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 0x2b21710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b21ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517', '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 14:27:28 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 14:27:28 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 14:27:28 INFO - Using env: {'DISPLAY': ':0', 14:27:28 INFO - 'HOME': '/home/cltbld', 14:27:28 INFO - 'LANG': 'en_US.UTF-8', 14:27:28 INFO - 'LANGUAGE': 'en_US:en', 14:27:28 INFO - 'LOGNAME': 'cltbld', 14:27:28 INFO - 'MAIL': '/var/mail/cltbld', 14:27:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:28 INFO - 'MOZ_NO_REMOTE': '1', 14:27:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:27:28 INFO - 'NO_EM_RESTART': '1', 14:27:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:27:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:28 INFO - 'PWD': '/builds/slave/test', 14:27:28 INFO - 'SHELL': '/bin/bash', 14:27:28 INFO - 'SHLVL': '1', 14:27:28 INFO - 'TERM': 'linux', 14:27:28 INFO - 'TMOUT': '86400', 14:27:28 INFO - 'USER': 'cltbld', 14:27:28 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517', 14:27:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:28 INFO - '_': '/tools/buildbot/bin/python'} 14:27:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:28 INFO - Downloading/unpacking flake8 14:27:28 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 14:27:28 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 14:27:28 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 14:27:28 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 14:27:28 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 14:27:28 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 14:27:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:27:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:27:30 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 14:27:30 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 14:27:30 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 14:27:30 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 14:27:30 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 14:27:30 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 14:27:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:27:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:27:30 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 14:27:30 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 14:27:30 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 14:27:30 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 14:27:30 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 14:27:30 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 14:27:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:27:30 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 14:27:30 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 14:27:30 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 14:27:30 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 14:27:30 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 14:27:30 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 14:27:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:27:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:27:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:27:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:27:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:27:31 INFO - no previously-included directories found matching 'docs/_build' 14:27:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:27:31 INFO - Running setup.py install for pep8 14:27:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:27:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:27:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:27:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:27:31 INFO - no previously-included directories found matching 'docs/_build' 14:27:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:27:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:27:31 INFO - Cleaning up... 14:27:31 INFO - Return code: 0 14:27:31 INFO - Running post-action listener: _resource_record_post_action 14:27:31 INFO - Running post-action listener: _start_resource_monitoring 14:27:31 INFO - Starting resource monitoring. 14:27:31 INFO - ##### 14:27:31 INFO - ##### Running install step. 14:27:31 INFO - ##### 14:27:31 INFO - Running pre-action listener: _resource_record_pre_action 14:27:31 INFO - Running main action method: install 14:27:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:27:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:27:31 INFO - Reading from file tmpfile_stdout 14:27:31 INFO - Detecting whether we're running mozinstall >=1.0... 14:27:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:27:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:27:31 INFO - Reading from file tmpfile_stdout 14:27:31 INFO - Output received: 14:27:31 INFO - Usage: mozinstall [options] installer 14:27:31 INFO - Options: 14:27:31 INFO - -h, --help show this help message and exit 14:27:31 INFO - -d DEST, --destination=DEST 14:27:31 INFO - Directory to install application into. [default: 14:27:31 INFO - "/builds/slave/test"] 14:27:31 INFO - --app=APP Application being installed. [default: firefox] 14:27:31 INFO - mkdir: /builds/slave/test/build/application 14:27:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:27:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:27:48 INFO - Reading from file tmpfile_stdout 14:27:48 INFO - Output received: 14:27:48 INFO - /builds/slave/test/build/application/firefox/firefox 14:27:48 INFO - Running post-action listener: _resource_record_post_action 14:27:48 INFO - ##### 14:27:48 INFO - ##### Running run-tests step. 14:27:48 INFO - ##### 14:27:48 INFO - Running pre-action listener: _resource_record_pre_action 14:27:48 INFO - Running main action method: run_tests 14:27:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:27:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:27:48 INFO - Python 2.7.3 14:27:48 INFO - Return code: 0 14:27:48 INFO - grabbing minidump binary from tooltool 14:27: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')]} 14:27:48 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 0x2b20810>, '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 0x2b21710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b21ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:27:48 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 14:27:48 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 14:27:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:27:48 INFO - Return code: 0 14:27:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:27:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:27:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:27:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:27:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:27:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:27:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:27:49 INFO - Return code: 0 14:27:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:27:49 INFO - Using env: {'DISPLAY': ':0', 14:27:49 INFO - 'HOME': '/home/cltbld', 14:27:49 INFO - 'LANG': 'en_US.UTF-8', 14:27:49 INFO - 'LANGUAGE': 'en_US:en', 14:27:49 INFO - 'LOGNAME': 'cltbld', 14:27:49 INFO - 'MAIL': '/var/mail/cltbld', 14:27:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:27:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:49 INFO - 'MOZ_NO_REMOTE': '1', 14:27:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:27:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:27:49 INFO - 'NO_EM_RESTART': '1', 14:27:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:49 INFO - 'PWD': '/builds/slave/test', 14:27:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:27:49 INFO - 'SHELL': '/bin/bash', 14:27:49 INFO - 'SHLVL': '1', 14:27:49 INFO - 'TERM': 'linux', 14:27:49 INFO - 'TMOUT': '86400', 14:27:49 INFO - 'USER': 'cltbld', 14:27:49 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517', 14:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:49 INFO - '_': '/tools/buildbot/bin/python'} 14:27:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:27:49 INFO - mozversion application_buildid: 20160505113031 14:27:49 INFO - mozversion application_changeset: 48fd2d23e181161cb97ec2b91049fc09200439bc 14:27:49 INFO - mozversion application_display_name: Nightly 14:27:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:27:49 INFO - mozversion application_name: Firefox 14:27:49 INFO - mozversion application_remotingname: firefox 14:27:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:27:49 INFO - mozversion application_vendor: Mozilla 14:27:49 INFO - mozversion application_version: 49.0a1 14:27:49 INFO - mozversion platform_buildid: 20160505113031 14:27:49 INFO - mozversion platform_changeset: 48fd2d23e181161cb97ec2b91049fc09200439bc 14:27:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:27:49 INFO - mozversion platform_version: 49.0a1 14:27:49 INFO - using testdate: 1462483669 14:27:49 INFO - actual date: 1462483669 14:27:49 INFO - starting webserver on 'localhost:48236' 14:27:49 INFO - SUITE-START | Running 2 tests 14:27:49 INFO - TEST-START | dromaeo_css 14:27:49 INFO - operating with platform_type : linux_ 14:27:49 INFO - Initialising browser for dromaeo_css test... 14:27:49 INFO - TEST-INFO | started process 28842 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5iCkL9/profile http://localhost:48236/getInfo.html) 14:27:53 INFO - PROCESS | 28842 | __metrics Screen width/height:1600/1200 14:27:53 INFO - PROCESS | 28842 | colorDepth:24 14:27:53 INFO - PROCESS | 28842 | Browser inner width/height: 1024/697 14:27:53 INFO - PROCESS | 28842 | __metrics 14:27:54 ERROR - PROCESS | 28842 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:27:55 INFO - TEST-INFO | 28842: exit 0 14:27:55 INFO - Browser initialized. 14:27:55 INFO - Running cycle 1/1 for dromaeo_css test... 14:27:55 INFO - TEST-INFO | started process 28923 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5iCkL9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:28:07 INFO - PROCESS | 28923 | RSS: Main: 154562560 14:28:07 INFO - PROCESS | 28923 | 14:28:58 INFO - PROCESS | 28923 | 1462483738586 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] 14:31:06 INFO - PROCESS | 28923 | Cycle 1(1): loaded http://localhost:48236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48236/tests/dromaeo/cssquery-ext.html) 14:31:07 INFO - PROCESS | 28923 | RSS: Main: 261898240 14:31:07 INFO - PROCESS | 28923 | 14:34:09 INFO - PROCESS | 28923 | Cycle 1(1): loaded http://localhost:48236/tests/dromaeo/cssquery-ext.html (next: http://localhost:48236/tests/dromaeo/cssquery-jquery.html) 14:34:10 INFO - PROCESS | 28923 | RSS: Main: 237268992 14:34:10 INFO - PROCESS | 28923 | 14:37:12 INFO - PROCESS | 28923 | Cycle 1(1): loaded http://localhost:48236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48236/tests/dromaeo/cssquery-mootools.html) 14:37:12 INFO - PROCESS | 28923 | RSS: Main: 236589056 14:37:12 INFO - PROCESS | 28923 | 14:40:14 INFO - PROCESS | 28923 | Cycle 1(1): loaded http://localhost:48236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48236/tests/dromaeo/cssquery-prototype.html) 14:40:15 INFO - PROCESS | 28923 | RSS: Main: 232706048 14:40:15 INFO - PROCESS | 28923 | 14:43:17 INFO - PROCESS | 28923 | Cycle 1(1): loaded http://localhost:48236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48236/tests/dromaeo/cssquery-yui.html) 14:43:18 INFO - PROCESS | 28923 | RSS: Main: 222564352 14:43:18 INFO - PROCESS | 28923 | 14:46:20 INFO - PROCESS | 28923 | Cycle 1(1): loaded http://localhost:48236/tests/dromaeo/cssquery-yui.html (next: http://localhost:48236/tests/dromaeo/cssquery-dojo.html) 14:46:21 INFO - PROCESS | 28923 | RSS: Main: 257687552 14:46:21 INFO - PROCESS | 28923 | 14:46:21 INFO - PROCESS | 28923 | __start_tp_report 14:46:21 INFO - PROCESS | 28923 | _x_x_mozilla_page_load 14:46:21 INFO - PROCESS | 28923 | _x_x_mozilla_page_load_details 14:46:21 INFO - PROCESS | 28923 | |i|pagename|runs| 14:46:21 INFO - PROCESS | 28923 | |0;dojo.html;3090.505519116941;3155.668654791248;3187.537807017984;3190.776645634805;3221.436248656485;5335.679859208451;5372.194170874371;5423.159410291406;5459.426760190182;5462.972685136579;5272.578193744501;5282.2076688496745;5383.569314454844;5468.343798744157;5509.47659972303;4742;4793.7842797074045;4803.447603525587;4820.879478013043;5022.522860328263;4914.287428322891;4946.604271658259;4960.503949605047;4963.404391473028;5011.323471331379;4746.24060150376;4844.2975768513725;4871.2206047032305;4907.75461226939;4944.110060189165;4803.711777293373;4826.734529600871;4832.1543729847135;4837.105135549935;4893.168161412568;4809.254565542346;4844.5882100021545;4845.515448455161;4852.514748525155;4862.17343051682;5116.692998420107;5236.188390799432;5300.443453437372;5326.547243484309;5344.198370244456;5693.3452652945025;5739.053056245714;5754.942450575524;5760.193572899798;5782.479576838063;5788.218590490272;5802.564807639402;5811.476967072941;5819.6508209507565;5824.30108386992;5195.506426889439;5315.920261196085;5379.596530260207;5435.266239057755;5446.972765136188;5800.1299805029585;5801.274840644919;5804.854878628068;5851.268591426072;5863.765449381977;5577.0797818359515;5581.832545023656;5582.24639673647;5583.218349431083;5599.608027438122;5617.354004289477;5659.547236221092;5707.600467967285;5775.6823374714795;5785.768569257267;5631.7747290108755;5645.2096706461125;5649.576281778883;5673.290838645169;5677.034904066319;5607.214989901417;5650.576206784508;5655.066913959151;5659.547236221092;5659.915101273484;4269.701120921506;4287.957120428819;4369.978150109293;4371.409859668967;4373.562643735665;3847.942280865789;3917.6082391760597;3930.2336044471053;3960.405939109099;3967.4048892666333;5345.438728933484;5425.810096646598;5449.536789372868;5450.700211488327;5451.672899626035;5768.798092066758;5787.479126878601;5789.305283366023;5796.072628379439;5855.882882342329;5231.921521177185;5416.187571864173;5458.399576046631;5502.312210973629;5514.696691681916;4789.066132104276;4801.231802911588;4822.590079843182;4830.468648448667;4873.439554451213;5780.104083867007;5784.82645520635;5785.971070144622;5794.3626201117;5795.043817770021;5671.035923892866;5748.252727145445;5751.511121554715;5772.134179873053;5778.364379918122;5826.737796799239;5828.358880523224;5829.09649004405;5832.300123985149;5838.241028666246;5534.169874518854;5580.748866300945;5583.218349431002;5585.469380408855;5587.664740115606;5620.803271885465;5703.7433315500075;5715.428457154418;5768.105943578752;5770.826875193751;5490.835274941758;5491.835244942658;5492.148716948879;5493.725313734218;5497.120460726264;5410.3507579090765;5477.507024367826;5494.835154945198;5499.670019798665;5556.222128902038;5449.264349312951;5491.341039075336;5499.862503437286;5537.723113844372;5546.861328466821;5476.863078423071;5520;5540.141278101901;5546.251256080377;5569.582281328835;5312.867178320573;5462.071447853954;5462.672239665632;5501.229827824028;5536.7785288588 14:46:21 INFO - PROCESS | 28923 | |1;ext.html;593.7090825495505;641.8844607970564;643.6395618453665;649.6849028221309;680.4046459348067;31599.84200078999;32563.185920352003;32603.67396326036;32613.51079733806;32617.51073733893;32750.508742368824;39277.82166535001;39934.80032599833;39982.20035599286;40087.39868901969;8435.91564084359;8623.95688021559;8627.180417860325;8638.784030399227;8639.049704532496;8680.782980425509;8864.8670269946;8870.290376769875;8871.733847984571;8877.378583499158;8837.38138330317;8932.910670893305;8941.105889411072;8949.507777072291;8954.104589541026;8803.163699448542;8871.2015918567;8884.8667269991;8892.955535222314;8894.688685895962;8722.825543489158;8817.911820881773;8819.250363719091;8824.602892869836;8829.558522073934;40588;41108.79445602753;41142.1771564567;41157.176856462705;41171.7941410294;3581.928361432783;3643.1620727232885;3648.3980143276594;3723.925521489582;3733.7386382953205;30146.547801782992;30926.22684432885;31263.218419539695;31472.685273147203;31474.527882081788;4252.621360185062;4377.4571434273275;4382.978085109554;4479.484859241196;4587.128445595326;342128;349401;349869;350577;350640;65665;66407.33592664011;66449.35506449317;66527.01885245527;66577.66711166414;53409;61214.38785612176;61907.690461547405;62026;62039;17776.644467110586;17867.37464188773;17936.55158621019;17938.103094845206;17967.37114201023;12226.572069977687;13637.454501820015;13856.722865542633;13873.236971966639;13883.514077007256;19564.60870782605;19624;19837.504062398268;19914;19938.20247190125;7590.316871481593;7605.23947605235;7762.650680719381;7848.293653571206;7849.136594974549;985.2512090810892;1037.9740506487246;1038.937663740178;1109.7447587054862;1130.8756036835941;30379.69620303813;30705.846470767505;31218.53172202419;31355.216119596735;32901.670983290336;1140.2246472398683;1161.1609614492654;1178.6563317817695;1180.7933611617932;1206.23404138371;15137.219144275829;15956.441524546817;16153.67692646164;16220.026798392135;16415.507534773737;497219;499920;501055;501949;502104;56582.43417565854;57336.426635733944;57357.13964290539;57381.139282910786;57428;1399.6500874781304;1402.4740722229164;1420.4389266239777;1437.4465830655065;1451.2163431746949;29682.257943551584;30233;30277.394452110395;30748.231294217825;30886.69113308838;49371.50628493669;49749;49966;50009.249861252836;50066.249006265665;433935;436101;436430;436492.8104313751;437892;24057.51884962326;28160;42394.7281581553;42526.149477010906;45015.32477012913;46435.071298573166;46975;47585.193184545846;47912.5208747922;48449.27326090182;41273.380899285934;41376.58623413848;42466.78766606147;43030.35454468248;43434;42401.15197696091;42508.78745606376;42718.359224611035;42897;43216;39012.2197556053;39968.80015599904;40072.79963600163;40345.1930961385;42810.78594607007;33986;35941.82029089838;36213.27573448463;36534.45198321974;36900.261994759414;26925.461490770467;27759.44481110407;27954.86022569874;28031.859840701483;28118.578221327105 14:46:21 INFO - PROCESS | 28923 | |2;jquery.html;398.3089339995109;398.3427344880946;398.7866491427087;404.8684177642266;414.77394819823195;13974.161550306988;17616.295348186057;18503.814961850378;19278.90360548197;19321.227150913946;14931.552053438414;17638.647227055484;17992.280308787635;18058.36795712147;18860.905695471538;5503.257060296869;5652.463016013472;5659.971700141494;5663.886722265553;5688.772449102031;4178.937315940263;5591.384947655754;5653.067243904751;6139.8772024559485;6446.161998940154;6371.331010243927;6393.680315984206;6413.454856337217;6415.6471394073305;6422.357764223563;6079.635221886657;6276.403741644536;6303.873922521547;6398.1362516060435;6405.29541750407;5531.032069387841;5541.639793413416;5542.972285138589;5547.084731019377;6812.4550035997;24247.2725818224;24507.754922450724;24867.87566062158;26587.867060664765;26588.202353929413;2408;2708.553088740375;3090.18110200797;3154.7318477929175;3409.3863104641155;14570.635734106627;14648.047876888075;15461.5361539154;15707.68584628301;16395.672086558323;2050.917963281467;2174.554216385637;2182.007186730034;2189.5511420158828;2219.844610877239;94968;97790.51104744502;98020;98310;98523.99999999929;17599.91200044017;17602.94382337064;17607.29570817153;17895.821041789415;18093.457196284133;32911.835440822644;33418.83290583531;33630.49554256688;33782;33798.83100584481;10308.845367319496;10462.529186186639;10491.68524944253;10588;10602.363858168535;7682.193369696101;8814.60334284946;8876.778080548038;8923.233797522658;9004.50475223856;7955.5226686399;8566.61450234741;8639.870401943976;8649.394542381973;8873.689420870238;3286;3350.6314305426386;3386.6274709781906;3426.3274645776332;3620.131168519589;969.7866469376726;1061.4692653673164;1069.2782371898936;1071.5338827610015;1092.5192915117323;17732.9113354435;18181.54546136331;18460.723089153675;18496;19266.22935082581;987.698751880669;998.4807899892015;1008.178334657252;1052.652624633869;1066.7386490309923;10320.277580569438;10680.198985076151;10727.141828653688;10785.13718902486;10820.891791082146;486337;488388;499146;499322;502078;94752;95126.52436737771;96195;96972;97101;917.2982668258787;930.6417029443578;934.8878134623889;934.9485778282124;951.177231694593;16383.180840958143;16684.416045438353;16826.831731683014;16883.324667013672;17181;38007;38338;39711.040255082626;40485.1902961945;40970;54882;56994.43005569891;57822.4217757817;58130;58623.70688146532;7738;7802.180771019188;7921.1682773307975;8051;8463.365247606578;8579.099194584478;12514.12401131912;13051.347432628141;13144.934275328562;13399.665008374868;11328.886711132784;11587.478563464832;11587.710307242387;11718.121140914294;11841.171118021655;11645.010174135294;11922.701932451759;11926.165168438127;11973;12043.337616431181;11874.940625296818;12033.338166400932;12077.27536347822;12248.693782655504;12348.876511234772;7785.64964576584;7911.446198766032;8015.7595272141925;8068.878966815385;8219.465734727224;8475.449095808754;10715.624953126604;11599.014083802971;11925.82111268349;11929.761404771682 14:46:21 INFO - PROCESS | 28923 | |3;mootools.html;1405.114777690055;1520.6958608278344;1524.9542513724589;1677.698014357415;1806.0518227930327;7581;7966.362690984722;7967.960160199205;7978.441509094366;7987.760367188979;7668.233176682329;7900.249476299757;7917.168697286774;7919.326857217144;7921.603919804001;2021.3733742539787;2192.0574153114153;2197.219986904646;2225.5660146271484;2281.4866655002656;2227.7549469558335;2237.742659594143;2238.2725614175456;2238.630625946717;2246.3148739634403;2159.373781603341;2214.1143542582936;2229.052652622629;2229.9108035678632;2230.342049095521;1960.3824795189541;2154.8922553872244;2229.1529218896717;2229.598672238996;2249.8312626553075;2202.1851914791628;2206.9227577034726;2216.8115710164657;2217.922372716947;2260.626996545568;8184.386171037196;8227.382946279053;8248.876266856001;8249.546274954875;8262.83474330516;4767.833125840579;4917.704937703749;4929.75351232437;4953.900921981576;5021.974890125526;3188.2029492626843;3257.397381484433;3319.4191016572004;3353.0946644406117;3369.1408690783937;1079.611339917629;1082.5128692088592;1112.6606385052555;1131.2759833706434;1133.7789131119434;11273.43632818364;11306.830397544043;11354.545818167346;11358.488868000959;11366.545338186463;4305.182015417124;4350.978245108754;4430.246858034142;4435.112977404532;4448.888777780581;9646.228301735844;9664.516774161264;9670.274729395323;9684.322097453252;9695.806083878282;4559.817607295738;4940.752962351868;4962.776675049631;4963.553280204799;4967.428745694219;4280.871573852789;4282.914341713148;4283.828646854154;4530.252508336088;4664.207084795593;3782.149016471327;3837.65461108496;3898.3762597984187;3904.4143378492886;3991.201759648082;1247.6194760598105;1256.7674980128522;1269.0482138396203;1276.5914907229596;1291.8320618319558;889.3418870036256;960.1358777100666;984.8768903887014;985.2069084387138;999.4952548962873;5620.634658747168;5659.179418984307;5660.462256085665;5690.77236910519;5927;424.43973954379925;432.366582955971;435.2861307455775;438.2418416140032;449.24302550203015;3852.1332700142243;3868.5937976512623;3880.8059597020037;3896.7272290939927;3941.507311586052;9891.752706182404;10093.24300677452;10233.59065637381;10460.476976151162;10466.790664186827;9870.654527091518;10259.076683098558;10324;10373.118284945864;10398.740031499274;7613.390928725688;7654.3160504689995;7767.18444563324;7778.805529861799;7888.7633370998965;5324.307839980777;5453.132162717044;5470.64440811346;5538.529225015757;5575.275214222287;9279.164875161268;9305.302102342215;9404.435733855991;9467.147956683932;9496.85754713666;9116.817663646823;9323.860142097737;9327;9337.906620933703;9541.570629321835;6848.452123829982;7328.926710732824;7339.229380914927;7482.476226664081;7525.510841795266;8028;8045.517268963881;8112.513249205066;8117.594120293844;8133.511989280425;7199.6760145794615;7297;7459.664315105725;7598.734044308423;7615.619219039137;7229.240929702306;7446.329830315298;7456.440766942393;7551.395888329031;7567.205443428361;6438.420542151229;6485.189351331083;6500.869982600416;6516.902246466401;6527.902081468686;4686.437627484587;4980.327655766425;4995;5008.549230569266;5037.445880953019;4710.882227944328;4770.332153498443;4790.113828941657;4827.686200396963;4918.606511479002 14:46:21 INFO - PROCESS | 28923 | |4;prototype.html;318.25052002534045;329.4892915980231;330.6594207965795;331.42497766375334;332.53611212358777;5188.896222075557;5212.400573933994;5315.890204230525;5355.143177091666;5388.488093631108;5187.872972081447;5236.188390799432;5247.947520524794;5248.976449592331;5267.28891599634;4071.4503542021894;4085.079168394597;4101.241270364977;4108.465899433077;4108.979455102721;4039.7374170678813;4137.13120244749;4142.647874930634;4143.834246630131;4149.190907772985;4067.694922880781;4101.487314085739;4106.815193316308;4110.671146308303;4111.177764447108;4088.2232375848494;4096.713230073896;4102.5076990761;4109.4246805447265;4126.938095928548;3615.529981102466;3632.3824949758605;3632.600413954463;3635.5273814404222;3639.2357604903004;4867.683600565952;5051.848444546633;5066.721330326867;5077.5684066854365;5103.795848166069;4617.191991401525;4649.7910543258995;4651.558101980307;4670.673052886299;4710.222813235812;5451.700156491392;5458;5467.917981230285;5493.901219756065;5549.833504994856;3754.6808521275725;3902.5316961964745;3910.2570511602703;3930.4300876372768;3937.330653788863;5360.544353729899;5454.61817672763;5608.943910560883;5696.202531645573;5700.144978253254;3811;3813.3326667833016;3818.3890577508023;3841.519810023747;3881.3595756700392;3936.1143742657673;3951.802409879552;3961.980190099031;3962.3660214365564;3970.2258059678084;4388.846390376321;4489.2592722201125;4569.680122391401;4570.583119233049;4598.356230127785;5405.243265942771;5425.701586412706;5431.37539182999;5435.157550579666;5450.236966824647;1462.590474667095;1479.807625008742;1482.814648168979;1488.3971991343524;1491.9627009324854;965.6137544981923;999.2505620784411;1007.8185926533295;1009.4296722351847;1013.4527355228241;5513.641613295123;5596.720163991784;5648.096304591246;5653.80211692597;5658.886822263614;6001.1898393717165;6014.548908831855;6020.157177994996;6022.247219097613;6028.9397106029255;5359.249705041298;5597.104463285855;5605.971970140124;5607.691576963224;5608.719564021782;3174.8253846038688;3178.4596618574437;3188.5173394371263;3192.3136525647096;3199.2801619635397;6078.969605151946;6100.847478813065;6125.356837531995;6158.692065396713;6159.5688301818445;5923.7926672566255;6056.454919057306;6071.180390647206;6074.635521868702;6112.908306375319;6074.878502429927;6099.176611157437;6113.84715382119;6129.11127886454;6174.44430001293;5745.224394706661;5964.135200395832;5975.462208401264;5985.5810093294795;6007.279126504847;5354.491323324434;5511.53151982086;5914.970425147847;5931.1992880960515;5941.821745347646;5769.567282453749;5813.215215945962;5823.650580965155;5835.99446285172;5840.328362238227;3993.5607083220243;4009.5589485157193;4013.2776100302226;4019.517657881073;4035.7174997749876;5384.353877534721;5645.604807663424;5676.77292908279;5733.226014487991;5742.224799651994;5517.834464966058;5531.778728850801;5537.723113844372;5572.545022086332;5577.749001295033;5516.586256030894;5517.924004819182;5552.250446189712;5559.833205003856;5593.412691667317;5184.844454666366;5438.945610543844;5448.645838020516;5480.671159730269;5491.148871924858;5566.304211973504;5577.944220557904;5588.636738611977;5598.1322894951345;5619.438056194348;5145.716985565829;5382.542483888913;5440.156775699773;5448.237246785374;5492.5605951524585 14:46:21 INFO - PROCESS | 28923 | |5;yui.html;793.361344117985;804.2882049386293;858.9527575983323;867.7830542364409;870.5342641686691;14653.12081275123;15000.5499835005;15011.399544018226;15018.474353397633;15054.623634409132;14957.626059348522;15019.699606007873;15032.774508382356;15044.849551504481;15045.473408430707;694.1392673085388;826.1903334731936;829.050736906242;839.1776059461731;858.4634603372892;841.9789505262356;851.0893344121761;851.1403482482675;851.6210286422513;851.7402192331336;871.507598207011;879.7976465412959;880.3529405886668;880.6697488441835;881.3962435731512;715.0668377767012;734.6473692627516;735.3639102176579;859.1709000814182;883.4478450968113;633.0788702437987;633.6673246545554;635.0125554762343;635.5614625908108;637.8373514753755;13730.794038089436;13909.374078166507;13920;13944.372503237277;13955.372008259652;14029.929850350683;14441.277936103153;14472.131672099602;14479.42082316706;14528.854711452961;11400.543978240861;11615.361155136465;11716.88283117175;11919.106067045006;12302.01583873288;3867.651911327994;3889.183271512986;3969.6625786807867;3998.820053097618;4003.83984640614;62363.37636623666;63069;63222.367776322106;63643;64673.3532664672;11128.833067503994;11256.437178141061;11270.830937535944;11343.546258149581;11409.771804564029;21674.458138546346;21698.891505542688;21716;21718.565628687338;21729.56540869174;8273.875891861628;8550.78623034429;8820.426672266281;8891;9009.23421509166;4901.09329773993;4923.286123512143;4937.950620493821;4977.601791856643;5033.672811267256;3384.323135372935;3430.8970730878113;3451.413259745799;3459.584849818038;3545.5745310562897;646.3536463536464;649.0297005976001;656.2617055812211;657.6777379084215;662.6819126819154;742.6138408027796;749.1983577571946;765.9195784442664;771.8842173673994;803.8472690188845;9068.455892646462;9371.203447707021;9469.242460603135;9482.857757133648;9528.523573821281;764.1327093748524;766.3830616353889;767.370755980091;788.168482251219;802.7752229375784;4300.648076875338;4400.537943515885;4512.481064677539;4554.476235232924;4558.020025694492;63107;64120.67939660272;64950.350496495375;65155.674221628586;65670;56220.15669764957;56716.43283567111;57399.71300143473;58250.339972802074;59814.401855981756;49232.261516077284;50843.491565084616;53406.19890701643;53611.73194134004;54128.18807717887;8745.431546949429;8784.472931624123;8823.161799629024;8888.333374996771;8922.509261990654;35005.124871878405;35094.82452587721;35265.64734352624;35539.11152221215;36100.81949590235;45764;46298;46704.7664761674;47041.355037394365;47769;11795.646130616095;11833.704157396134;11979.460924258603;11999.940000300292;12266.693332666755;11784.882151178379;11837.763244734884;11955.163138580216;12018.158728888893;12256.38718064111;11686.691289413366;11768;11901.880981190077;11958.222715523463;12312.630621081023;12088.75822483563;12098;12164.939175304067;12302.938485307515;12496.437660305126;12642.115051946275;12802.74394512086;12842.935785321013;13008.544700935421;13099.541516046893;10705.357678539312;11273.887261127284;11493.367864767519;11500.539978401104;11608.30350178992;9192.54037298119;9411.482368469526;9526.121288379542;9845.556949937127;11357.204995650225 14:46:21 INFO - PROCESS | 28923 | __end_tp_report 14:46:21 INFO - PROCESS | 28923 | __start_cc_report 14:46:21 INFO - PROCESS | 28923 | _x_x_mozilla_cycle_collect,870 14:46:21 INFO - PROCESS | 28923 | __end_cc_report 14:46:21 INFO - PROCESS | 28923 | __startTimestamp1462484781178__endTimestamp 14:46:21 INFO - PROCESS | 28923 | 14:46:21 INFO - PROCESS | 28923 | ------- Summary: start ------- 14:46:21 INFO - PROCESS | 28923 | Number of tests: 6 14:46:21 INFO - PROCESS | 28923 | 14:46:21 INFO - PROCESS | 28923 | [#0] dojo.html Cycles:165 Average:5295.58 Median:5492.15 stddev:587.17 (10.7%) stddev-sans-first:562.92 14:46:21 INFO - PROCESS | 28923 | Values: 3090.5 3155.7 3187.5 3190.8 3221.4 5335.7 5372.2 5423.2 5459.4 5463.0 5272.6 5282.2 5383.6 5468.3 5509.5 4742.0 4793.8 4803.4 4820.9 5022.5 4914.3 4946.6 4960.5 4963.4 5011.3 4746.2 4844.3 4871.2 4907.8 4944.1 4803.7 4826.7 4832.2 4837.1 4893.2 4809.3 4844.6 4845.5 4852.5 4862.2 5116.7 5236.2 5300.4 5326.5 5344.2 5693.3 5739.1 5754.9 5760.2 5782.5 5788.2 5802.6 5811.5 5819.7 5824.3 5195.5 5315.9 5379.6 5435.3 5447.0 5800.1 5801.3 5804.9 5851.3 5863.8 5577.1 5581.8 5582.2 5583.2 5599.6 5617.4 5659.5 5707.6 5775.7 5785.8 5631.8 5645.2 5649.6 5673.3 5677.0 5607.2 5650.6 5655.1 5659.5 5659.9 4269.7 4288.0 4370.0 4371.4 4373.6 3847.9 3917.6 3930.2 3960.4 3967.4 5345.4 5425.8 5449.5 5450.7 5451.7 5768.8 5787.5 5789.3 5796.1 5855.9 5231.9 5416.2 5458.4 5502.3 5514.7 4789.1 4801.2 4822.6 4830.5 4873.4 5780.1 5784.8 5786.0 5794.4 5795.0 5671.0 5748.3 5751.5 5772.1 5778.4 5826.7 5828.4 5829.1 5832.3 5838.2 5534.2 5580.7 5583.2 5585.5 5587.7 5620.8 5703.7 5715.4 5768.1 5770.8 5490.8 5491.8 5492.1 5493.7 5497.1 5410.4 5477.5 5494.8 5499.7 5556.2 5449.3 5491.3 5499.9 5537.7 5546.9 5476.9 5520.0 5540.1 5546.3 5569.6 5312.9 5462.1 5462.7 5501.2 5536.8 14:46:21 INFO - PROCESS | 28923 | 14:46:21 INFO - PROCESS | 28923 | [#1] ext.html Cycles:180 Average:59099.16 Median:41324.98 stddev:114569.19 (277.2%) stddev-sans-first:114806.37 14:46:21 INFO - PROCESS | 28923 | Values: 593.7 641.9 643.6 649.7 680.4 31599.8 32563.2 32603.7 32613.5 32617.5 32750.5 39277.8 39934.8 39982.2 40087.4 8435.9 8624.0 8627.2 8638.8 8639.0 8680.8 8864.9 8870.3 8871.7 8877.4 8837.4 8932.9 8941.1 8949.5 8954.1 8803.2 8871.2 8884.9 8893.0 8894.7 8722.8 8817.9 8819.3 8824.6 8829.6 40588.0 41108.8 41142.2 41157.2 41171.8 3581.9 3643.2 3648.4 3723.9 3733.7 30146.5 30926.2 31263.2 31472.7 31474.5 4252.6 4377.5 4383.0 4479.5 4587.1 342128.0 349401.0 349869.0 350577.0 350640.0 65665.0 66407.3 66449.4 66527.0 66577.7 53409.0 61214.4 61907.7 62026.0 62039.0 17776.6 17867.4 17936.6 17938.1 17967.4 12226.6 13637.5 13856.7 13873.2 13883.5 19564.6 19624.0 19837.5 19914.0 19938.2 7590.3 7605.2 7762.7 7848.3 7849.1 985.3 1038.0 1038.9 1109.7 1130.9 30379.7 30705.8 31218.5 31355.2 32901.7 1140.2 1161.2 1178.7 1180.8 1206.2 15137.2 15956.4 16153.7 16220.0 16415.5 497219.0 499920.0 501055.0 501949.0 502104.0 56582.4 57336.4 57357.1 57381.1 57428.0 1399.7 1402.5 1420.4 1437.4 1451.2 29682.3 30233.0 30277.4 30748.2 30886.7 49371.5 49749.0 49966.0 50009.2 50066.2 433935.0 436101.0 436430.0 436492.8 437892.0 24057.5 28160.0 42394.7 42526.1 45015.3 46435.1 46975.0 47585.2 47912.5 48449.3 41273.4 41376.6 42466.8 43030.4 43434.0 42401.2 42508.8 42718.4 42897.0 43216.0 39012.2 39968.8 40072.8 40345.2 42810.8 33986.0 35941.8 36213.3 36534.5 36900.3 26925.5 27759.4 27954.9 28031.9 28118.6 14:46:21 INFO - PROCESS | 28923 | 14:46:21 INFO - PROCESS | 28923 | [#2] jquery.html Cycles:180 Average:30626.58 Median:18592.73 stddev:81860.63 (440.3%) stddev-sans-first:82058.81 14:46:21 INFO - PROCESS | 28923 | Values: 398.3 398.3 398.8 404.9 414.8 13974.2 17616.3 18503.8 19278.9 19321.2 14931.6 17638.6 17992.3 18058.4 18860.9 5503.3 5652.5 5660.0 5663.9 5688.8 4178.9 5591.4 5653.1 6139.9 6446.2 6371.3 6393.7 6413.5 6415.6 6422.4 6079.6 6276.4 6303.9 6398.1 6405.3 5531.0 5541.6 5543.0 5547.1 6812.5 24247.3 24507.8 24867.9 26587.9 26588.2 2408.0 2708.6 3090.2 3154.7 3409.4 14570.6 14648.0 15461.5 15707.7 16395.7 2050.9 2174.6 2182.0 2189.6 2219.8 94968.0 97790.5 98020.0 98310.0 98524.0 17599.9 17602.9 17607.3 17895.8 18093.5 32911.8 33418.8 33630.5 33782.0 33798.8 10308.8 10462.5 10491.7 10588.0 10602.4 7682.2 8814.6 8876.8 8923.2 9004.5 7955.5 8566.6 8639.9 8649.4 8873.7 3286.0 3350.6 3386.6 3426.3 3620.1 969.8 1061.5 1069.3 1071.5 1092.5 17732.9 18181.5 18460.7 18496.0 19266.2 987.7 998.5 1008.2 1052.7 1066.7 10320.3 10680.2 10727.1 10785.1 10820.9 486337.0 488388.0 499146.0 499322.0 502078.0 94752.0 95126.5 96195.0 96972.0 97101.0 917.3 930.6 934.9 934.9 951.2 16383.2 16684.4 16826.8 16883.3 17181.0 38007.0 38338.0 39711.0 40485.2 40970.0 54882.0 56994.4 57822.4 58130.0 58623.7 7738.0 7802.2 7921.2 8051.0 8463.4 8579.1 12514.1 13051.3 13144.9 13399.7 11328.9 11587.5 11587.7 11718.1 11841.2 11645.0 11922.7 11926.2 11973.0 12043.3 11874.9 12033.3 12077.3 12248.7 12348.9 7785.6 7911.4 8015.8 8068.9 8219.5 8475.4 10715.6 11599.0 11925.8 11929.8 14:46:21 INFO - PROCESS | 28923 | 14:46:21 INFO - PROCESS | 28923 | [#3] mootools.html Cycles:180 Average:5435.69 Median:4918.16 stddev:3062.61 (62.3%) stddev-sans-first:3056.22 14:46:21 INFO - PROCESS | 28923 | Values: 1405.1 1520.7 1525.0 1677.7 1806.1 7581.0 7966.4 7968.0 7978.4 7987.8 7668.2 7900.2 7917.2 7919.3 7921.6 2021.4 2192.1 2197.2 2225.6 2281.5 2227.8 2237.7 2238.3 2238.6 2246.3 2159.4 2214.1 2229.1 2229.9 2230.3 1960.4 2154.9 2229.2 2229.6 2249.8 2202.2 2206.9 2216.8 2217.9 2260.6 8184.4 8227.4 8248.9 8249.5 8262.8 4767.8 4917.7 4929.8 4953.9 5022.0 3188.2 3257.4 3319.4 3353.1 3369.1 1079.6 1082.5 1112.7 1131.3 1133.8 11273.4 11306.8 11354.5 11358.5 11366.5 4305.2 4351.0 4430.2 4435.1 4448.9 9646.2 9664.5 9670.3 9684.3 9695.8 4559.8 4940.8 4962.8 4963.6 4967.4 4280.9 4282.9 4283.8 4530.3 4664.2 3782.1 3837.7 3898.4 3904.4 3991.2 1247.6 1256.8 1269.0 1276.6 1291.8 889.3 960.1 984.9 985.2 999.5 5620.6 5659.2 5660.5 5690.8 5927.0 424.4 432.4 435.3 438.2 449.2 3852.1 3868.6 3880.8 3896.7 3941.5 9891.8 10093.2 10233.6 10460.5 10466.8 9870.7 10259.1 10324.0 10373.1 10398.7 7613.4 7654.3 7767.2 7778.8 7888.8 5324.3 5453.1 5470.6 5538.5 5575.3 9279.2 9305.3 9404.4 9467.1 9496.9 9116.8 9323.9 9327.0 9337.9 9541.6 6848.5 7328.9 7339.2 7482.5 7525.5 8028.0 8045.5 8112.5 8117.6 8133.5 7199.7 7297.0 7459.7 7598.7 7615.6 7229.2 7446.3 7456.4 7551.4 7567.2 6438.4 6485.2 6500.9 6516.9 6527.9 4686.4 4980.3 4995.0 5008.5 5037.4 4710.9 4770.3 4790.1 4827.7 4918.6 14:46:21 INFO - PROCESS | 28923 | 14:46:21 INFO - PROCESS | 28923 | [#4] prototype.html Cycles:180 Average:4695.49 Median:5359.90 stddev:1402.17 (26.2%) stddev-sans-first:1367.07 14:46:21 INFO - PROCESS | 28923 | Values: 318.3 329.5 330.7 331.4 332.5 5188.9 5212.4 5315.9 5355.1 5388.5 5187.9 5236.2 5247.9 5249.0 5267.3 4071.5 4085.1 4101.2 4108.5 4109.0 4039.7 4137.1 4142.6 4143.8 4149.2 4067.7 4101.5 4106.8 4110.7 4111.2 4088.2 4096.7 4102.5 4109.4 4126.9 3615.5 3632.4 3632.6 3635.5 3639.2 4867.7 5051.8 5066.7 5077.6 5103.8 4617.2 4649.8 4651.6 4670.7 4710.2 5451.7 5458.0 5467.9 5493.9 5549.8 3754.7 3902.5 3910.3 3930.4 3937.3 5360.5 5454.6 5608.9 5696.2 5700.1 3811.0 3813.3 3818.4 3841.5 3881.4 3936.1 3951.8 3962.0 3962.4 3970.2 4388.8 4489.3 4569.7 4570.6 4598.4 5405.2 5425.7 5431.4 5435.2 5450.2 1462.6 1479.8 1482.8 1488.4 1492.0 965.6 999.3 1007.8 1009.4 1013.5 5513.6 5596.7 5648.1 5653.8 5658.9 6001.2 6014.5 6020.2 6022.2 6028.9 5359.2 5597.1 5606.0 5607.7 5608.7 3174.8 3178.5 3188.5 3192.3 3199.3 6079.0 6100.8 6125.4 6158.7 6159.6 5923.8 6056.5 6071.2 6074.6 6112.9 6074.9 6099.2 6113.8 6129.1 6174.4 5745.2 5964.1 5975.5 5985.6 6007.3 5354.5 5511.5 5915.0 5931.2 5941.8 5769.6 5813.2 5823.7 5836.0 5840.3 3993.6 4009.6 4013.3 4019.5 4035.7 5384.4 5645.6 5676.8 5733.2 5742.2 5517.8 5531.8 5537.7 5572.5 5577.7 5516.6 5517.9 5552.3 5559.8 5593.4 5184.8 5438.9 5448.6 5480.7 5491.1 5566.3 5577.9 5588.6 5598.1 5619.4 5145.7 5382.5 5440.2 5448.2 5492.6 14:46:21 INFO - PROCESS | 28923 | 14:46:21 INFO - PROCESS | 28923 | [#5] yui.html Cycles:180 Average:15443.66 Median:26335.05 stddev:18294.62 (69.5%) stddev-sans-first:18312.86 14:46:21 INFO - PROCESS | 28923 | Values: 793.4 804.3 859.0 867.8 870.5 14653.1 15000.5 15011.4 15018.5 15054.6 14957.6 15019.7 15032.8 15044.8 15045.5 694.1 826.2 829.1 839.2 858.5 842.0 851.1 851.1 851.6 851.7 871.5 879.8 880.4 880.7 881.4 715.1 734.6 735.4 859.2 883.4 633.1 633.7 635.0 635.6 637.8 13730.8 13909.4 13920.0 13944.4 13955.4 14029.9 14441.3 14472.1 14479.4 14528.9 11400.5 11615.4 11716.9 11919.1 12302.0 3867.7 3889.2 3969.7 3998.8 4003.8 62363.4 63069.0 63222.4 63643.0 64673.4 11128.8 11256.4 11270.8 11343.5 11409.8 21674.5 21698.9 21716.0 21718.6 21729.6 8273.9 8550.8 8820.4 8891.0 9009.2 4901.1 4923.3 4938.0 4977.6 5033.7 3384.3 3430.9 3451.4 3459.6 3545.6 646.4 649.0 656.3 657.7 662.7 742.6 749.2 765.9 771.9 803.8 9068.5 9371.2 9469.2 9482.9 9528.5 764.1 766.4 767.4 788.2 802.8 4300.6 4400.5 4512.5 4554.5 4558.0 63107.0 64120.7 64950.4 65155.7 65670.0 56220.2 56716.4 57399.7 58250.3 59814.4 49232.3 50843.5 53406.2 53611.7 54128.2 8745.4 8784.5 8823.2 8888.3 8922.5 35005.1 35094.8 35265.6 35539.1 36100.8 45764.0 46298.0 46704.8 47041.4 47769.0 11795.6 11833.7 11979.5 11999.9 12266.7 11784.9 11837.8 11955.2 12018.2 12256.4 11686.7 11768.0 11901.9 11958.2 12312.6 12088.8 12098.0 12164.9 12302.9 12496.4 12642.1 12802.7 12842.9 13008.5 13099.5 10705.4 11273.9 11493.4 11500.5 11608.3 9192.5 9411.5 9526.1 9845.6 11357.2 14:46:21 INFO - PROCESS | 28923 | -------- Summary: end -------- 14:46:21 INFO - PROCESS | 28923 | 14:46:21 INFO - TEST-INFO | 28923: exit 0 14:46:21 INFO - TEST-OK | dromaeo_css | took 1112403ms 14:46:21 INFO - TEST-START | kraken 14:46:21 INFO - operating with platform_type : linux_ 14:46:21 INFO - Initialising browser for kraken test... 14:46:21 INFO - TEST-INFO | started process 29101 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoCHzJJ/profile http://localhost:48236/getInfo.html) 14:46:25 INFO - PROCESS | 29101 | __metrics Screen width/height:1600/1200 14:46:25 INFO - PROCESS | 29101 | colorDepth:24 14:46:25 INFO - PROCESS | 29101 | Browser inner width/height: 1024/697 14:46:25 INFO - PROCESS | 29101 | __metrics 14:46:26 ERROR - PROCESS | 29101 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:46:27 INFO - TEST-INFO | 29101: exit 0 14:46:27 INFO - Browser initialized. 14:46:27 INFO - Running cycle 1/1 for kraken test... 14:46:27 INFO - TEST-INFO | started process 29182 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoCHzJJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:46:39 INFO - PROCESS | 29182 | RSS: Main: 154529792 14:46:39 INFO - PROCESS | 29182 | 14:46:42 INFO - PROCESS | 29182 | Cycle 1(1): loaded http://localhost:48236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48236/tests/kraken/driver.html?testName=audio-beat-detection) 14:46:42 INFO - PROCESS | 29182 | RSS: Main: 210092032 14:46:42 INFO - PROCESS | 29182 | 14:46:45 INFO - PROCESS | 29182 | Cycle 1(1): loaded http://localhost:48236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48236/tests/kraken/driver.html?testName=audio-dft) 14:46:46 INFO - PROCESS | 29182 | RSS: Main: 196390912 14:46:46 INFO - PROCESS | 29182 | 14:46:49 INFO - PROCESS | 29182 | Cycle 1(1): loaded http://localhost:48236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48236/tests/kraken/driver.html?testName=audio-fft) 14:46:49 INFO - PROCESS | 29182 | RSS: Main: 265768960 14:46:49 INFO - PROCESS | 29182 | 14:46:51 INFO - PROCESS | 29182 | Cycle 1(1): loaded http://localhost:48236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48236/tests/kraken/driver.html?testName=audio-oscillator) 14:46:52 INFO - PROCESS | 29182 | RSS: Main: 173879296 14:46:52 INFO - PROCESS | 29182 | 14:46:54 INFO - PROCESS | 29182 | Cycle 1(1): loaded http://localhost:48236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:46:55 INFO - PROCESS | 29182 | RSS: Main: 177106944 14:46:55 INFO - PROCESS | 29182 | 14:46:58 INFO - PROCESS | 29182 | Cycle 1(1): loaded http://localhost:48236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48236/tests/kraken/driver.html?testName=imaging-darkroom) 14:46:58 INFO - PROCESS | 29182 | RSS: Main: 214376448 14:46:58 INFO - PROCESS | 29182 | 14:47:02 INFO - PROCESS | 29182 | Cycle 1(1): loaded http://localhost:48236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48236/tests/kraken/driver.html?testName=imaging-desaturate) 14:47:02 INFO - PROCESS | 29182 | RSS: Main: 214978560 14:47:02 INFO - PROCESS | 29182 | 14:47:05 INFO - PROCESS | 29182 | Cycle 1(1): loaded http://localhost:48236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48236/tests/kraken/driver.html?testName=json-parse-financial) 14:47:06 INFO - PROCESS | 29182 | RSS: Main: 215232512 14:47:06 INFO - PROCESS | 29182 | 14:47:07 INFO - PROCESS | 29182 | Cycle 1(1): loaded http://localhost:48236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:47:08 INFO - PROCESS | 29182 | RSS: Main: 205094912 14:47:08 INFO - PROCESS | 29182 | 14:47:10 INFO - PROCESS | 29182 | Cycle 1(1): loaded http://localhost:48236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48236/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:47:10 INFO - PROCESS | 29182 | RSS: Main: 203067392 14:47:10 INFO - PROCESS | 29182 | 14:47:12 INFO - PROCESS | 29182 | Cycle 1(1): loaded http://localhost:48236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:47:13 INFO - PROCESS | 29182 | RSS: Main: 216141824 14:47:13 INFO - PROCESS | 29182 | 14:47:15 INFO - PROCESS | 29182 | Cycle 1(1): loaded http://localhost:48236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:47:16 INFO - PROCESS | 29182 | RSS: Main: 222953472 14:47:16 INFO - PROCESS | 29182 | 14:47:19 INFO - PROCESS | 29182 | Cycle 1(1): loaded http://localhost:48236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:47:19 INFO - PROCESS | 29182 | RSS: Main: 218247168 14:47:19 INFO - PROCESS | 29182 | 14:47:21 INFO - PROCESS | 29182 | Cycle 1(1): loaded http://localhost:48236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48236/tests/kraken/driver.html?testName=ai-astar) 14:47:21 INFO - PROCESS | 29182 | RSS: Main: 281935872 14:47:21 INFO - PROCESS | 29182 | 14:47:21 INFO - PROCESS | 29182 | __start_tp_report 14:47:21 INFO - PROCESS | 29182 | _x_x_mozilla_page_load 14:47:21 INFO - PROCESS | 29182 | _x_x_mozilla_page_load_details 14:47:21 INFO - PROCESS | 29182 | |i|pagename|runs| 14:47:21 INFO - PROCESS | 29182 | |0;ai-astar;109;110;108;109;111;111;99;109;110;107 14:47:21 INFO - PROCESS | 29182 | |1;audio-beat-detection;151;128;153;178;128;154;157;132;186;135 14:47:21 INFO - PROCESS | 29182 | |2;audio-dft;160;162;160;160;161;161;162;161;162;163 14:47:21 INFO - PROCESS | 29182 | |3;audio-fft;77;78;106;114;76;73;77;109;103;72 14:47:21 INFO - PROCESS | 29182 | |4;audio-oscillator;92;92;154;93;93;92;151;92;92;153 14:47:21 INFO - PROCESS | 29182 | |5;imaging-gaussian-blur;117;116;117;116;116;117;118;117;116;117 14:47:21 INFO - PROCESS | 29182 | |6;imaging-darkroom;145;146;146;146;146;147;145;146;146;147 14:47:21 INFO - PROCESS | 29182 | |7;imaging-desaturate;95;94;95;95;94;95;95;95;96;95 14:47:21 INFO - PROCESS | 29182 | |8;json-parse-financial;55;55;57;56;57;55;57;72;53;53 14:47:21 INFO - PROCESS | 29182 | |9;json-stringify-tinderbox;59;59;58;58;60;59;58;58;58;58 14:47:21 INFO - PROCESS | 29182 | |10;stanford-crypto-aes;76;75;76;76;85;76;77;77;76;76 14:47:21 INFO - PROCESS | 29182 | |11;stanford-crypto-ccm;124;123;123;136;122;121;121;123;155;122 14:47:21 INFO - PROCESS | 29182 | |12;stanford-crypto-pbkdf2;165;169;172;166;170;171;170;168;171;168 14:47:21 INFO - PROCESS | 29182 | |13;stanford-crypto-sha256-iterative;67;71;68;68;68;69;67;67;67;67 14:47:21 INFO - PROCESS | 29182 | __end_tp_report 14:47:21 INFO - PROCESS | 29182 | __start_cc_report 14:47:21 INFO - PROCESS | 29182 | _x_x_mozilla_cycle_collect,1669 14:47:21 INFO - PROCESS | 29182 | __end_cc_report 14:47:21 INFO - PROCESS | 29182 | __startTimestamp1462484841919__endTimestamp 14:47:21 INFO - PROCESS | 29182 | 14:47:21 INFO - PROCESS | 29182 | ------- Summary: start ------- 14:47:21 INFO - PROCESS | 29182 | Number of tests: 14 14:47:21 INFO - PROCESS | 29182 | 14:47:21 INFO - PROCESS | 29182 | [#0] ai-astar Cycles:10 Average:108.30 Median:110.00 stddev:3.50 (3.2%) stddev-sans-first:3.70 14:47:21 INFO - PROCESS | 29182 | Values: 109.0 110.0 108.0 109.0 111.0 111.0 99.0 109.0 110.0 107.0 14:47:21 INFO - PROCESS | 29182 | 14:47:21 INFO - PROCESS | 29182 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:153.50 stddev:20.20 (13.2%) stddev-sans-first:21.42 14:47:21 INFO - PROCESS | 29182 | Values: 151.0 128.0 153.0 178.0 128.0 154.0 157.0 132.0 186.0 135.0 14:47:21 INFO - PROCESS | 29182 | 14:47:21 INFO - PROCESS | 29182 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.03 (0.6%) stddev-sans-first:1.00 14:47:21 INFO - PROCESS | 29182 | Values: 160.0 162.0 160.0 160.0 161.0 161.0 162.0 161.0 162.0 163.0 14:47:21 INFO - PROCESS | 29182 | 14:47:21 INFO - PROCESS | 29182 | [#3] audio-fft Cycles:10 Average:88.50 Median:74.50 stddev:17.10 (22.9%) stddev-sans-first:17.62 14:47:21 INFO - PROCESS | 29182 | Values: 77.0 78.0 106.0 114.0 76.0 73.0 77.0 109.0 103.0 72.0 14:47:21 INFO - PROCESS | 29182 | 14:47:21 INFO - PROCESS | 29182 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:92.00 stddev:29.18 (31.7%) stddev-sans-first:30.18 14:47:21 INFO - PROCESS | 29182 | Values: 92.0 92.0 154.0 93.0 93.0 92.0 151.0 92.0 92.0 153.0 14:47:21 INFO - PROCESS | 29182 | 14:47:21 INFO - PROCESS | 29182 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 14:47:21 INFO - PROCESS | 29182 | Values: 117.0 116.0 117.0 116.0 116.0 117.0 118.0 117.0 116.0 117.0 14:47:21 INFO - PROCESS | 29182 | 14:47:21 INFO - PROCESS | 29182 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 14:47:21 INFO - PROCESS | 29182 | Values: 145.0 146.0 146.0 146.0 146.0 147.0 145.0 146.0 146.0 147.0 14:47:21 INFO - PROCESS | 29182 | 14:47:21 INFO - PROCESS | 29182 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 14:47:21 INFO - PROCESS | 29182 | Values: 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 96.0 95.0 14:47:21 INFO - PROCESS | 29182 | 14:47:21 INFO - PROCESS | 29182 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:56.50 stddev:5.48 (9.7%) stddev-sans-first:5.76 14:47:21 INFO - PROCESS | 29182 | Values: 55.0 55.0 57.0 56.0 57.0 55.0 57.0 72.0 53.0 53.0 14:47:21 INFO - PROCESS | 29182 | 14:47:21 INFO - PROCESS | 29182 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:58.50 stddev:0.71 (1.2%) stddev-sans-first:0.73 14:47:21 INFO - PROCESS | 29182 | Values: 59.0 59.0 58.0 58.0 60.0 59.0 58.0 58.0 58.0 58.0 14:47:21 INFO - PROCESS | 29182 | 14:47:21 INFO - PROCESS | 29182 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:76.00 stddev:2.87 (3.8%) stddev-sans-first:3.02 14:47:21 INFO - PROCESS | 29182 | Values: 76.0 75.0 76.0 76.0 85.0 76.0 77.0 77.0 76.0 76.0 14:47:21 INFO - PROCESS | 29182 | 14:47:21 INFO - PROCESS | 29182 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:123.00 stddev:10.77 (8.8%) stddev-sans-first:11.37 14:47:21 INFO - PROCESS | 29182 | Values: 124.0 123.0 123.0 136.0 122.0 121.0 121.0 123.0 155.0 122.0 14:47:21 INFO - PROCESS | 29182 | 14:47:21 INFO - PROCESS | 29182 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:170.00 stddev:2.26 (1.3%) stddev-sans-first:1.88 14:47:21 INFO - PROCESS | 29182 | Values: 165.0 169.0 172.0 166.0 170.0 171.0 170.0 168.0 171.0 168.0 14:47:21 INFO - PROCESS | 29182 | 14:47:21 INFO - PROCESS | 29182 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.29 (1.9%) stddev-sans-first:1.32 14:47:21 INFO - PROCESS | 29182 | Values: 67.0 71.0 68.0 68.0 68.0 69.0 67.0 67.0 67.0 67.0 14:47:21 INFO - PROCESS | 29182 | -------- Summary: end -------- 14:47:21 INFO - PROCESS | 29182 | 14:47:22 INFO - TEST-INFO | 29182: exit 0 14:47:22 INFO - TEST-OK | kraken | took 60995ms 14:47:22 INFO - SUITE-END | took 1173s 14:47:23 INFO - Completed test suite (00:19:33) 14:47:23 INFO - javascript benchmark 14:47:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.505519116941, 3155.668654791248, 3187.537807017984, 3190.776645634805, 3221.436248656485, 5335.679859208451, 5372.194170874371, 5423.159410291406, 5459.426760190182, 5462.972685136579, 5272.578193744501, 5282.2076688496745, 5383.569314454844, 5468.343798744157, 5509.47659972303, 4742.0, 4793.7842797074045, 4803.447603525587, 4820.879478013043, 5022.522860328263, 4914.287428322891, 4946.604271658259, 4960.503949605047, 4963.404391473028, 5011.323471331379, 4746.24060150376, 4844.2975768513725, 4871.2206047032305, 4907.75461226939, 4944.110060189165, 4803.711777293373, 4826.734529600871, 4832.1543729847135, 4837.105135549935, 4893.168161412568, 4809.254565542346, 4844.5882100021545, 4845.515448455161, 4852.514748525155, 4862.17343051682, 5116.692998420107, 5236.188390799432, 5300.443453437372, 5326.547243484309, 5344.198370244456, 5693.3452652945025, 5739.053056245714, 5754.942450575524, 5760.193572899798, 5782.479576838063, 5788.218590490272, 5802.564807639402, 5811.476967072941, 5819.6508209507565, 5824.30108386992, 5195.506426889439, 5315.920261196085, 5379.596530260207, 5435.266239057755, 5446.972765136188, 5800.1299805029585, 5801.274840644919, 5804.854878628068, 5851.268591426072, 5863.765449381977, 5577.0797818359515, 5581.832545023656, 5582.24639673647, 5583.218349431083, 5599.608027438122, 5617.354004289477, 5659.547236221092, 5707.600467967285, 5775.6823374714795, 5785.768569257267, 5631.7747290108755, 5645.2096706461125, 5649.576281778883, 5673.290838645169, 5677.034904066319, 5607.214989901417, 5650.576206784508, 5655.066913959151, 5659.547236221092, 5659.915101273484, 4269.701120921506, 4287.957120428819, 4369.978150109293, 4371.409859668967, 4373.562643735665, 3847.942280865789, 3917.6082391760597, 3930.2336044471053, 3960.405939109099, 3967.4048892666333, 5345.438728933484, 5425.810096646598, 5449.536789372868, 5450.700211488327, 5451.672899626035, 5768.798092066758, 5787.479126878601, 5789.305283366023, 5796.072628379439, 5855.882882342329, 5231.921521177185, 5416.187571864173, 5458.399576046631, 5502.312210973629, 5514.696691681916, 4789.066132104276, 4801.231802911588, 4822.590079843182, 4830.468648448667, 4873.439554451213, 5780.104083867007, 5784.82645520635, 5785.971070144622, 5794.3626201117, 5795.043817770021, 5671.035923892866, 5748.252727145445, 5751.511121554715, 5772.134179873053, 5778.364379918122, 5826.737796799239, 5828.358880523224, 5829.09649004405, 5832.300123985149, 5838.241028666246, 5534.169874518854, 5580.748866300945, 5583.218349431002, 5585.469380408855, 5587.664740115606, 5620.803271885465, 5703.7433315500075, 5715.428457154418, 5768.105943578752, 5770.826875193751, 5490.835274941758, 5491.835244942658, 5492.148716948879, 5493.725313734218, 5497.120460726264, 5410.3507579090765, 5477.507024367826, 5494.835154945198, 5499.670019798665, 5556.222128902038, 5449.264349312951, 5491.341039075336, 5499.862503437286, 5537.723113844372, 5546.861328466821, 5476.863078423071, 5520.0, 5540.141278101901, 5546.251256080377, 5569.582281328835, 5312.867178320573, 5462.071447853954, 5462.672239665632, 5501.229827824028, 5536.7785288588], "value": 5257.281092954017, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.7090825495505, 641.8844607970564, 643.6395618453665, 649.6849028221309, 680.4046459348067, 31599.84200078999, 32563.185920352003, 32603.67396326036, 32613.51079733806, 32617.51073733893, 32750.508742368824, 39277.82166535001, 39934.80032599833, 39982.20035599286, 40087.39868901969, 8435.91564084359, 8623.95688021559, 8627.180417860325, 8638.784030399227, 8639.049704532496, 8680.782980425509, 8864.8670269946, 8870.290376769875, 8871.733847984571, 8877.378583499158, 8837.38138330317, 8932.910670893305, 8941.105889411072, 8949.507777072291, 8954.104589541026, 8803.163699448542, 8871.2015918567, 8884.8667269991, 8892.955535222314, 8894.688685895962, 8722.825543489158, 8817.911820881773, 8819.250363719091, 8824.602892869836, 8829.558522073934, 40588.0, 41108.79445602753, 41142.1771564567, 41157.176856462705, 41171.7941410294, 3581.928361432783, 3643.1620727232885, 3648.3980143276594, 3723.925521489582, 3733.7386382953205, 30146.547801782992, 30926.22684432885, 31263.218419539695, 31472.685273147203, 31474.527882081788, 4252.621360185062, 4377.4571434273275, 4382.978085109554, 4479.484859241196, 4587.128445595326, 342128.0, 349401.0, 349869.0, 350577.0, 350640.0, 65665.0, 66407.33592664011, 66449.35506449317, 66527.01885245527, 66577.66711166414, 53409.0, 61214.38785612176, 61907.690461547405, 62026.0, 62039.0, 17776.644467110586, 17867.37464188773, 17936.55158621019, 17938.103094845206, 17967.37114201023, 12226.572069977687, 13637.454501820015, 13856.722865542633, 13873.236971966639, 13883.514077007256, 19564.60870782605, 19624.0, 19837.504062398268, 19914.0, 19938.20247190125, 7590.316871481593, 7605.23947605235, 7762.650680719381, 7848.293653571206, 7849.136594974549, 985.2512090810892, 1037.9740506487246, 1038.937663740178, 1109.7447587054862, 1130.8756036835941, 30379.69620303813, 30705.846470767505, 31218.53172202419, 31355.216119596735, 32901.670983290336, 1140.2246472398683, 1161.1609614492654, 1178.6563317817695, 1180.7933611617932, 1206.23404138371, 15137.219144275829, 15956.441524546817, 16153.67692646164, 16220.026798392135, 16415.507534773737, 497219.0, 499920.0, 501055.0, 501949.0, 502104.0, 56582.43417565854, 57336.426635733944, 57357.13964290539, 57381.139282910786, 57428.0, 1399.6500874781304, 1402.4740722229164, 1420.4389266239777, 1437.4465830655065, 1451.2163431746949, 29682.257943551584, 30233.0, 30277.394452110395, 30748.231294217825, 30886.69113308838, 49371.50628493669, 49749.0, 49966.0, 50009.249861252836, 50066.249006265665, 433935.0, 436101.0, 436430.0, 436492.8104313751, 437892.0, 24057.51884962326, 28160.0, 42394.7281581553, 42526.149477010906, 45015.32477012913, 46435.071298573166, 46975.0, 47585.193184545846, 47912.5208747922, 48449.27326090182, 41273.380899285934, 41376.58623413848, 42466.78766606147, 43030.35454468248, 43434.0, 42401.15197696091, 42508.78745606376, 42718.359224611035, 42897.0, 43216.0, 39012.2197556053, 39968.80015599904, 40072.79963600163, 40345.1930961385, 42810.78594607007, 33986.0, 35941.82029089838, 36213.27573448463, 36534.45198321974, 36900.261994759414, 26925.461490770467, 27759.44481110407, 27954.86022569874, 28031.859840701483, 28118.578221327105], "value": 20179.392535122868, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.3089339995109, 398.3427344880946, 398.7866491427087, 404.8684177642266, 414.77394819823195, 13974.161550306988, 17616.295348186057, 18503.814961850378, 19278.90360548197, 19321.227150913946, 14931.552053438414, 17638.647227055484, 17992.280308787635, 18058.36795712147, 18860.905695471538, 5503.257060296869, 5652.463016013472, 5659.971700141494, 5663.886722265553, 5688.772449102031, 4178.937315940263, 5591.384947655754, 5653.067243904751, 6139.8772024559485, 6446.161998940154, 6371.331010243927, 6393.680315984206, 6413.454856337217, 6415.6471394073305, 6422.357764223563, 6079.635221886657, 6276.403741644536, 6303.873922521547, 6398.1362516060435, 6405.29541750407, 5531.032069387841, 5541.639793413416, 5542.972285138589, 5547.084731019377, 6812.4550035997, 24247.2725818224, 24507.754922450724, 24867.87566062158, 26587.867060664765, 26588.202353929413, 2408.0, 2708.553088740375, 3090.18110200797, 3154.7318477929175, 3409.3863104641155, 14570.635734106627, 14648.047876888075, 15461.5361539154, 15707.68584628301, 16395.672086558323, 2050.917963281467, 2174.554216385637, 2182.007186730034, 2189.5511420158828, 2219.844610877239, 94968.0, 97790.51104744502, 98020.0, 98310.0, 98523.99999999929, 17599.91200044017, 17602.94382337064, 17607.29570817153, 17895.821041789415, 18093.457196284133, 32911.835440822644, 33418.83290583531, 33630.49554256688, 33782.0, 33798.83100584481, 10308.845367319496, 10462.529186186639, 10491.68524944253, 10588.0, 10602.363858168535, 7682.193369696101, 8814.60334284946, 8876.778080548038, 8923.233797522658, 9004.50475223856, 7955.5226686399, 8566.61450234741, 8639.870401943976, 8649.394542381973, 8873.689420870238, 3286.0, 3350.6314305426386, 3386.6274709781906, 3426.3274645776332, 3620.131168519589, 969.7866469376726, 1061.4692653673164, 1069.2782371898936, 1071.5338827610015, 1092.5192915117323, 17732.9113354435, 18181.54546136331, 18460.723089153675, 18496.0, 19266.22935082581, 987.698751880669, 998.4807899892015, 1008.178334657252, 1052.652624633869, 1066.7386490309923, 10320.277580569438, 10680.198985076151, 10727.141828653688, 10785.13718902486, 10820.891791082146, 486337.0, 488388.0, 499146.0, 499322.0, 502078.0, 94752.0, 95126.52436737771, 96195.0, 96972.0, 97101.0, 917.2982668258787, 930.6417029443578, 934.8878134623889, 934.9485778282124, 951.177231694593, 16383.180840958143, 16684.416045438353, 16826.831731683014, 16883.324667013672, 17181.0, 38007.0, 38338.0, 39711.040255082626, 40485.1902961945, 40970.0, 54882.0, 56994.43005569891, 57822.4217757817, 58130.0, 58623.70688146532, 7738.0, 7802.180771019188, 7921.1682773307975, 8051.0, 8463.365247606578, 8579.099194584478, 12514.12401131912, 13051.347432628141, 13144.934275328562, 13399.665008374868, 11328.886711132784, 11587.478563464832, 11587.710307242387, 11718.121140914294, 11841.171118021655, 11645.010174135294, 11922.701932451759, 11926.165168438127, 11973.0, 12043.337616431181, 11874.940625296818, 12033.338166400932, 12077.27536347822, 12248.693782655504, 12348.876511234772, 7785.64964576584, 7911.446198766032, 8015.7595272141925, 8068.878966815385, 8219.465734727224, 8475.449095808754, 10715.624953126604, 11599.014083802971, 11925.82111268349, 11929.761404771682], "value": 10164.405227109457, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1405.114777690055, 1520.6958608278344, 1524.9542513724589, 1677.698014357415, 1806.0518227930327, 7581.0, 7966.362690984722, 7967.960160199205, 7978.441509094366, 7987.760367188979, 7668.233176682329, 7900.249476299757, 7917.168697286774, 7919.326857217144, 7921.603919804001, 2021.3733742539787, 2192.0574153114153, 2197.219986904646, 2225.5660146271484, 2281.4866655002656, 2227.7549469558335, 2237.742659594143, 2238.2725614175456, 2238.630625946717, 2246.3148739634403, 2159.373781603341, 2214.1143542582936, 2229.052652622629, 2229.9108035678632, 2230.342049095521, 1960.3824795189541, 2154.8922553872244, 2229.1529218896717, 2229.598672238996, 2249.8312626553075, 2202.1851914791628, 2206.9227577034726, 2216.8115710164657, 2217.922372716947, 2260.626996545568, 8184.386171037196, 8227.382946279053, 8248.876266856001, 8249.546274954875, 8262.83474330516, 4767.833125840579, 4917.704937703749, 4929.75351232437, 4953.900921981576, 5021.974890125526, 3188.2029492626843, 3257.397381484433, 3319.4191016572004, 3353.0946644406117, 3369.1408690783937, 1079.611339917629, 1082.5128692088592, 1112.6606385052555, 1131.2759833706434, 1133.7789131119434, 11273.43632818364, 11306.830397544043, 11354.545818167346, 11358.488868000959, 11366.545338186463, 4305.182015417124, 4350.978245108754, 4430.246858034142, 4435.112977404532, 4448.888777780581, 9646.228301735844, 9664.516774161264, 9670.274729395323, 9684.322097453252, 9695.806083878282, 4559.817607295738, 4940.752962351868, 4962.776675049631, 4963.553280204799, 4967.428745694219, 4280.871573852789, 4282.914341713148, 4283.828646854154, 4530.252508336088, 4664.207084795593, 3782.149016471327, 3837.65461108496, 3898.3762597984187, 3904.4143378492886, 3991.201759648082, 1247.6194760598105, 1256.7674980128522, 1269.0482138396203, 1276.5914907229596, 1291.8320618319558, 889.3418870036256, 960.1358777100666, 984.8768903887014, 985.2069084387138, 999.4952548962873, 5620.634658747168, 5659.179418984307, 5660.462256085665, 5690.77236910519, 5927.0, 424.43973954379925, 432.366582955971, 435.2861307455775, 438.2418416140032, 449.24302550203015, 3852.1332700142243, 3868.5937976512623, 3880.8059597020037, 3896.7272290939927, 3941.507311586052, 9891.752706182404, 10093.24300677452, 10233.59065637381, 10460.476976151162, 10466.790664186827, 9870.654527091518, 10259.076683098558, 10324.0, 10373.118284945864, 10398.740031499274, 7613.390928725688, 7654.3160504689995, 7767.18444563324, 7778.805529861799, 7888.7633370998965, 5324.307839980777, 5453.132162717044, 5470.64440811346, 5538.529225015757, 5575.275214222287, 9279.164875161268, 9305.302102342215, 9404.435733855991, 9467.147956683932, 9496.85754713666, 9116.817663646823, 9323.860142097737, 9327.0, 9337.906620933703, 9541.570629321835, 6848.452123829982, 7328.926710732824, 7339.229380914927, 7482.476226664081, 7525.510841795266, 8028.0, 8045.517268963881, 8112.513249205066, 8117.594120293844, 8133.511989280425, 7199.6760145794615, 7297.0, 7459.664315105725, 7598.734044308423, 7615.619219039137, 7229.240929702306, 7446.329830315298, 7456.440766942393, 7551.395888329031, 7567.205443428361, 6438.420542151229, 6485.189351331083, 6500.869982600416, 6516.902246466401, 6527.902081468686, 4686.437627484587, 4980.327655766425, 4995.0, 5008.549230569266, 5037.445880953019, 4710.882227944328, 4770.332153498443, 4790.113828941657, 4827.686200396963, 4918.606511479002], "value": 4312.835985166951, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.25052002534045, 329.4892915980231, 330.6594207965795, 331.42497766375334, 332.53611212358777, 5188.896222075557, 5212.400573933994, 5315.890204230525, 5355.143177091666, 5388.488093631108, 5187.872972081447, 5236.188390799432, 5247.947520524794, 5248.976449592331, 5267.28891599634, 4071.4503542021894, 4085.079168394597, 4101.241270364977, 4108.465899433077, 4108.979455102721, 4039.7374170678813, 4137.13120244749, 4142.647874930634, 4143.834246630131, 4149.190907772985, 4067.694922880781, 4101.487314085739, 4106.815193316308, 4110.671146308303, 4111.177764447108, 4088.2232375848494, 4096.713230073896, 4102.5076990761, 4109.4246805447265, 4126.938095928548, 3615.529981102466, 3632.3824949758605, 3632.600413954463, 3635.5273814404222, 3639.2357604903004, 4867.683600565952, 5051.848444546633, 5066.721330326867, 5077.5684066854365, 5103.795848166069, 4617.191991401525, 4649.7910543258995, 4651.558101980307, 4670.673052886299, 4710.222813235812, 5451.700156491392, 5458.0, 5467.917981230285, 5493.901219756065, 5549.833504994856, 3754.6808521275725, 3902.5316961964745, 3910.2570511602703, 3930.4300876372768, 3937.330653788863, 5360.544353729899, 5454.61817672763, 5608.943910560883, 5696.202531645573, 5700.144978253254, 3811.0, 3813.3326667833016, 3818.3890577508023, 3841.519810023747, 3881.3595756700392, 3936.1143742657673, 3951.802409879552, 3961.980190099031, 3962.3660214365564, 3970.2258059678084, 4388.846390376321, 4489.2592722201125, 4569.680122391401, 4570.583119233049, 4598.356230127785, 5405.243265942771, 5425.701586412706, 5431.37539182999, 5435.157550579666, 5450.236966824647, 1462.590474667095, 1479.807625008742, 1482.814648168979, 1488.3971991343524, 1491.9627009324854, 965.6137544981923, 999.2505620784411, 1007.8185926533295, 1009.4296722351847, 1013.4527355228241, 5513.641613295123, 5596.720163991784, 5648.096304591246, 5653.80211692597, 5658.886822263614, 6001.1898393717165, 6014.548908831855, 6020.157177994996, 6022.247219097613, 6028.9397106029255, 5359.249705041298, 5597.104463285855, 5605.971970140124, 5607.691576963224, 5608.719564021782, 3174.8253846038688, 3178.4596618574437, 3188.5173394371263, 3192.3136525647096, 3199.2801619635397, 6078.969605151946, 6100.847478813065, 6125.356837531995, 6158.692065396713, 6159.5688301818445, 5923.7926672566255, 6056.454919057306, 6071.180390647206, 6074.635521868702, 6112.908306375319, 6074.878502429927, 6099.176611157437, 6113.84715382119, 6129.11127886454, 6174.44430001293, 5745.224394706661, 5964.135200395832, 5975.462208401264, 5985.5810093294795, 6007.279126504847, 5354.491323324434, 5511.53151982086, 5914.970425147847, 5931.1992880960515, 5941.821745347646, 5769.567282453749, 5813.215215945962, 5823.650580965155, 5835.99446285172, 5840.328362238227, 3993.5607083220243, 4009.5589485157193, 4013.2776100302226, 4019.517657881073, 4035.7174997749876, 5384.353877534721, 5645.604807663424, 5676.77292908279, 5733.226014487991, 5742.224799651994, 5517.834464966058, 5531.778728850801, 5537.723113844372, 5572.545022086332, 5577.749001295033, 5516.586256030894, 5517.924004819182, 5552.250446189712, 5559.833205003856, 5593.412691667317, 5184.844454666366, 5438.945610543844, 5448.645838020516, 5480.671159730269, 5491.148871924858, 5566.304211973504, 5577.944220557904, 5588.636738611977, 5598.1322894951345, 5619.438056194348, 5145.716985565829, 5382.542483888913, 5440.156775699773, 5448.237246785374, 5492.5605951524585], "value": 4255.567610762673, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [793.361344117985, 804.2882049386293, 858.9527575983323, 867.7830542364409, 870.5342641686691, 14653.12081275123, 15000.5499835005, 15011.399544018226, 15018.474353397633, 15054.623634409132, 14957.626059348522, 15019.699606007873, 15032.774508382356, 15044.849551504481, 15045.473408430707, 694.1392673085388, 826.1903334731936, 829.050736906242, 839.1776059461731, 858.4634603372892, 841.9789505262356, 851.0893344121761, 851.1403482482675, 851.6210286422513, 851.7402192331336, 871.507598207011, 879.7976465412959, 880.3529405886668, 880.6697488441835, 881.3962435731512, 715.0668377767012, 734.6473692627516, 735.3639102176579, 859.1709000814182, 883.4478450968113, 633.0788702437987, 633.6673246545554, 635.0125554762343, 635.5614625908108, 637.8373514753755, 13730.794038089436, 13909.374078166507, 13920.0, 13944.372503237277, 13955.372008259652, 14029.929850350683, 14441.277936103153, 14472.131672099602, 14479.42082316706, 14528.854711452961, 11400.543978240861, 11615.361155136465, 11716.88283117175, 11919.106067045006, 12302.01583873288, 3867.651911327994, 3889.183271512986, 3969.6625786807867, 3998.820053097618, 4003.83984640614, 62363.37636623666, 63069.0, 63222.367776322106, 63643.0, 64673.3532664672, 11128.833067503994, 11256.437178141061, 11270.830937535944, 11343.546258149581, 11409.771804564029, 21674.458138546346, 21698.891505542688, 21716.0, 21718.565628687338, 21729.56540869174, 8273.875891861628, 8550.78623034429, 8820.426672266281, 8891.0, 9009.23421509166, 4901.09329773993, 4923.286123512143, 4937.950620493821, 4977.601791856643, 5033.672811267256, 3384.323135372935, 3430.8970730878113, 3451.413259745799, 3459.584849818038, 3545.5745310562897, 646.3536463536464, 649.0297005976001, 656.2617055812211, 657.6777379084215, 662.6819126819154, 742.6138408027796, 749.1983577571946, 765.9195784442664, 771.8842173673994, 803.8472690188845, 9068.455892646462, 9371.203447707021, 9469.242460603135, 9482.857757133648, 9528.523573821281, 764.1327093748524, 766.3830616353889, 767.370755980091, 788.168482251219, 802.7752229375784, 4300.648076875338, 4400.537943515885, 4512.481064677539, 4554.476235232924, 4558.020025694492, 63107.0, 64120.67939660272, 64950.350496495375, 65155.674221628586, 65670.0, 56220.15669764957, 56716.43283567111, 57399.71300143473, 58250.339972802074, 59814.401855981756, 49232.261516077284, 50843.491565084616, 53406.19890701643, 53611.73194134004, 54128.18807717887, 8745.431546949429, 8784.472931624123, 8823.161799629024, 8888.333374996771, 8922.509261990654, 35005.124871878405, 35094.82452587721, 35265.64734352624, 35539.11152221215, 36100.81949590235, 45764.0, 46298.0, 46704.7664761674, 47041.355037394365, 47769.0, 11795.646130616095, 11833.704157396134, 11979.460924258603, 11999.940000300292, 12266.693332666755, 11784.882151178379, 11837.763244734884, 11955.163138580216, 12018.158728888893, 12256.38718064111, 11686.691289413366, 11768.0, 11901.880981190077, 11958.222715523463, 12312.630621081023, 12088.75822483563, 12098.0, 12164.939175304067, 12302.938485307515, 12496.437660305126, 12642.115051946275, 12802.74394512086, 12842.935785321013, 13008.544700935421, 13099.541516046893, 10705.357678539312, 11273.887261127284, 11493.367864767519, 11500.539978401104, 11608.30350178992, 9192.54037298119, 9411.482368469526, 9526.121288379542, 9845.556949937127, 11357.204995650225], "value": 6916.750314893899, "unit": "score"}], "name": "dromaeo_css", "value": 7179.108802203516, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 108.0, 109.0, 111.0, 111.0, 99.0, 109.0, 110.0, 107.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 128.0, 153.0, 178.0, 128.0, 154.0, 157.0, 132.0, 186.0, 135.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 160.0, 161.0, 161.0, 162.0, 161.0, 162.0, 163.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 106.0, 114.0, 76.0, 73.0, 77.0, 109.0, 103.0, 72.0], "value": 88.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 154.0, 93.0, 93.0, 92.0, 151.0, 92.0, 92.0, 153.0], "value": 110.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 118.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 146.0, 147.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 57.0, 56.0, 57.0, 55.0, 57.0, 72.0, 53.0, 53.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 58.0, 60.0, 59.0, 58.0, 58.0, 58.0, 58.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 76.0, 85.0, 76.0, 77.0, 77.0, 76.0, 76.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 123.0, 123.0, 136.0, 122.0, 121.0, 121.0, 123.0, 155.0, 122.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 169.0, 172.0, 166.0, 170.0, 171.0, 170.0, 168.0, 171.0, 168.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 68.0, 68.0, 68.0, 69.0, 67.0, 67.0, 67.0, 67.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1532.6000000000001, "alertThreshold": 2.0}]} 14:47:23 INFO - Return code: 0 14:47:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:47:23 ERROR - # TBPL SUCCESS # 14:47:23 INFO - Running post-action listener: _resource_record_post_action 14:47:23 INFO - Running post-run listener: _resource_record_post_run 14:47:24 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 290136064; Read time: 0; Write time: 213644 14:47:24 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1175552; Read time: 0; Write time: 36 14:47:24 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 286732288; Read time: 0; Write time: 213508 14:47:24 INFO - Running post-run listener: _upload_blobber_files 14:47:24 INFO - Blob upload gear active. 14:47:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:47:24 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 14:47:24 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:47:24 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:47:24 INFO - (blobuploader) - INFO - Open directory for files ... 14:47:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:47:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:47:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:47:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:47:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:47:25 INFO - (blobuploader) - INFO - Done attempting. 14:47:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:47:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:47:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:47:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:47:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:47:26 INFO - (blobuploader) - INFO - Done attempting. 14:47:26 INFO - (blobuploader) - INFO - Iteration through files over. 14:47:26 INFO - Return code: 0 14:47:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:47:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:47:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d2ba7b775c24169f6ce1e61780b74d3edf1c5d1cb4e5ed6bdd90bbfd83233cbd2f73e87562023edae210ce57a10252266b97b97b59f301f686dd543a230f3a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05e832dc915500b5b57353e7f67d2d44e16e8899ec38c462c51eebe05ec0e86ffd41450ba81adaadf9d8955b689e9fb59bd0945deaa1f5d6ad9e82722aeb7080"} 14:47:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:47:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:47:26 INFO - Contents: 14:47:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d2ba7b775c24169f6ce1e61780b74d3edf1c5d1cb4e5ed6bdd90bbfd83233cbd2f73e87562023edae210ce57a10252266b97b97b59f301f686dd543a230f3a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05e832dc915500b5b57353e7f67d2d44e16e8899ec38c462c51eebe05ec0e86ffd41450ba81adaadf9d8955b689e9fb59bd0945deaa1f5d6ad9e82722aeb7080"} 14:47:26 INFO - Running post-run listener: copy_logs_to_upload_dir 14:47:26 INFO - Copying logs to upload dir... 14:47:26 INFO - mkdir: /builds/slave/test/build/upload/logs 14:47:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.449103 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-05 14:47:26.492000) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 14:47:26.495111) ========= 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=03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d2ba7b775c24169f6ce1e61780b74d3edf1c5d1cb4e5ed6bdd90bbfd83233cbd2f73e87562023edae210ce57a10252266b97b97b59f301f686dd543a230f3a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05e832dc915500b5b57353e7f67d2d44e16e8899ec38c462c51eebe05ec0e86ffd41450ba81adaadf9d8955b689e9fb59bd0945deaa1f5d6ad9e82722aeb7080"} build_url:https://queue.taskcluster.net/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011210 build_url: 'https://queue.taskcluster.net/v1/task/Ug0Ol-DFSq6tbPDjVIt1tA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d2ba7b775c24169f6ce1e61780b74d3edf1c5d1cb4e5ed6bdd90bbfd83233cbd2f73e87562023edae210ce57a10252266b97b97b59f301f686dd543a230f3a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05e832dc915500b5b57353e7f67d2d44e16e8899ec38c462c51eebe05ec0e86ffd41450ba81adaadf9d8955b689e9fb59bd0945deaa1f5d6ad9e82722aeb7080"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 14:47:26.522781) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:47:26.523168) ========= 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=03627c79f6bb3d1578c4a402000001ba-1462483262.630222-1670092517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004367 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:47:26.603568) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 14:47:26.606970) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 14:47:26.607650) ========= ========= Total master_lag: 0.17 =========