builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-028 starttime: 1485300550.36 results: success (0) revision: 48f7caa80dfc6cafc778269b12e9e69379111c56 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 15:29:10.357232) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 15:29:10.357683) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 15:29:10.357957) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 15:29:10.372138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 15:29:10.372399) ========= 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=836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-24 15:29:10-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.0M=0s 2017-01-24 15:29:10 (47.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113460 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 15:29:10.499318) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 15:29:10.499663) ========= 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=836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020613 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 15:29:10.549167) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 mins, 26 secs) (at 2017-01-24 15:29:10.549499) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 48f7caa80dfc6cafc778269b12e9e69379111c56 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 48f7caa80dfc6cafc778269b12e9e69379111c56 --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=836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-24 15:29:10,711 truncating revision to first 12 chars 2017-01-24 15:29:10,711 Setting DEBUG logging. 2017-01-24 15:29:10,711 attempt 1/10 2017-01-24 15:29:10,711 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/48f7caa80dfc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-24 15:29:11,509 attempt 1/10 2017-01-24 15:29:11,752 current task status: no status available at this point. state: PENDING 2017-01-24 15:29:11,752 sleeping for 10.00s (attempt 1/10) 2017-01-24 15:29:21,762 attempt 2/10 2017-01-24 15:29:21,977 current task status: no status available at this point. state: PENDING 2017-01-24 15:29:21,977 sleeping for 16.00s (attempt 2/10) 2017-01-24 15:29:37,994 attempt 3/10 2017-01-24 15:29:38,209 current task status: no status available at this point. state: PENDING 2017-01-24 15:29:38,209 sleeping for 25.00s (attempt 3/10) 2017-01-24 15:30:03,235 attempt 4/10 2017-01-24 15:30:03,710 current task status: no status available at this point. state: PENDING 2017-01-24 15:30:03,710 sleeping for 37.50s (attempt 4/10) 2017-01-24 15:30:41,248 attempt 5/10 2017-01-24 15:30:41,485 current task status: no status available at this point. state: PENDING 2017-01-24 15:30:41,485 sleeping for 55.25s (attempt 5/10) 2017-01-24 15:31:36,791 attempt 6/10 2017-01-24 15:31:36,847 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-01-24 15:31:37,068 unpacking tar archive at: mozilla-aurora-48f7caa80dfc/testing/mozharness/ program finished with exit code 0 elapsedTime=146.648158 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 mins, 26 secs) (at 2017-01-24 15:31:37.207994) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 15:31:37.208366) ========= script_repo_revision: 48f7caa80dfc6cafc778269b12e9e69379111c56 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 15:31:37.208827) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 15:31:37.209091) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 15:31:37.217526) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-01-24 15:31:37.217966) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:31:37 INFO - MultiFileLogger online at 20170124 15:31:37 in /builds/slave/test 15:31:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 15:31:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:31:37 INFO - {'append_to_log': False, 15:31:37 INFO - 'base_work_dir': '/builds/slave/test', 15:31:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 15:31:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:31:37 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 15:31:37 INFO - 'buildbot_json_path': 'buildprops.json', 15:31:37 INFO - 'config_files': ('talos/linux_config.py',), 15:31:37 INFO - 'default_actions': ('clobber', 15:31:37 INFO - 'read-buildbot-config', 15:31:37 INFO - 'download-and-extract', 15:31:37 INFO - 'populate-webroot', 15:31:37 INFO - 'create-virtualenv', 15:31:37 INFO - 'install', 15:31:37 INFO - 'run-tests'), 15:31:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:31:37 INFO - 'download_minidump_stackwalk': True, 15:31:37 INFO - 'download_symbols': 'ondemand', 15:31:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:31:37 INFO - 'tooltool.py': '/tools/tooltool.py', 15:31:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:31:37 INFO - '/tools/misc-python/virtualenv.py')}, 15:31:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:31:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:31:37 INFO - 'installer_path': 'installer.exe', 15:31:37 INFO - 'log_level': 'info', 15:31:37 INFO - 'log_name': 'talos', 15:31:37 INFO - 'log_to_console': True, 15:31:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:31:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:31:37 INFO - 'opt_config_files': (), 15:31:37 INFO - 'pip_index': False, 15:31:37 INFO - 'sps_profile': False, 15:31:37 INFO - 'sps_profile_interval': 0, 15:31:37 INFO - 'suite': 'dromaeojs-e10s', 15:31:37 INFO - 'system_bits': '32', 15:31:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:31:37 INFO - 'title': 'talos-linux64-ix-028', 15:31:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:31:37 INFO - 'use_talos_json': True, 15:31:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:31:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:31:37 INFO - 'work_dir': 'build'} 15:31:37 INFO - [mozharness: 2017-01-24 23:31:37.477169Z] Running clobber step. 15:31:37 INFO - Running pre-action listener: _resource_record_pre_action 15:31:37 INFO - Running main action method: clobber 15:31:37 INFO - rmtree: /builds/slave/test/build 15:31:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:31:37 INFO - Running post-action listener: _resource_record_post_action 15:31:37 INFO - [mozharness: 2017-01-24 23:31:37.936329Z] Finished clobber step (success) 15:31:37 INFO - [mozharness: 2017-01-24 23:31:37.936429Z] Running read-buildbot-config step. 15:31:37 INFO - Running pre-action listener: _resource_record_pre_action 15:31:37 INFO - Running main action method: read_buildbot_config 15:31:37 INFO - Using buildbot properties: 15:31:37 INFO - { 15:31:37 INFO - "project": "", 15:31:37 INFO - "product": "firefox", 15:31:37 INFO - "who": "asasaki@mozilla.com", 15:31:37 INFO - "installer_path": "public/build/target.tar.bz2", 15:31:37 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 15:31:37 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 15:31:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs-e10s", 15:31:37 INFO - "stage_platform": "linux64", 15:31:37 INFO - "basedir": "/builds/slave/test", 15:31:37 INFO - "buildnumber": 5, 15:31:37 INFO - "platform": "ubuntu64_hw", 15:31:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:31:37 INFO - "slavebuilddir": "test", 15:31:37 INFO - "taskId": "TyzT3cFKQUmDiMnatZQqNg", 15:31:37 INFO - "branch": "mozilla-aurora", 15:31:37 INFO - "script_repo_revision": "production", 15:31:37 INFO - "revision": "48f7caa80dfc6cafc778269b12e9e69379111c56", 15:31:37 INFO - "slavename": "talos-linux64-ix-028", 15:31:37 INFO - "repo_path": "releases/mozilla-aurora" 15:31:37 INFO - } 15:31:37 INFO - Finding installer, test and symbols from parent task. 15:31:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TyzT3cFKQUmDiMnatZQqNg'}, attempt #1 15:31:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TyzT3cFKQUmDiMnatZQqNg'}, attempt #1 15:31:38 INFO - Task dependencies: KEkvJDICSmuozoKh-0IeWQ 15:31:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ'}, attempt #1 15:31:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/target.tar.bz2 15:31:39 INFO - Set test_url: https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/test_packages.json 15:31:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/target.crashreporter-symbols.zip 15:31:39 INFO - Running post-action listener: _resource_record_post_action 15:31:39 INFO - [mozharness: 2017-01-24 23:31:39.330954Z] Finished read-buildbot-config step (success) 15:31:39 INFO - [mozharness: 2017-01-24 23:31:39.331172Z] Running download-and-extract step. 15:31:39 INFO - Running pre-action listener: _resource_record_pre_action 15:31:39 INFO - Running main action method: download_and_extract 15:31:39 INFO - mkdir: /builds/slave/test/build/tests 15:31:39 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:39 INFO - trying https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/target.test_packages.json 15:31:39 INFO - Downloading https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:31:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:31:39 INFO - Downloaded 896 bytes. 15:31:39 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:31:39 INFO - Using the following test package requirements: 15:31:39 INFO - {u'common': [u'target.common.tests.zip'], 15:31:39 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:31:39 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:31:39 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:31:39 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:31:39 INFO - u'mozbase': [u'target.common.tests.zip'], 15:31:39 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:31:39 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:31:39 INFO - u'web-platform': [u'target.common.tests.zip', 15:31:39 INFO - u'target.web-platform.tests.zip'], 15:31:39 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:31:39 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:31:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/target.common.tests.zip 15:31:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:31:39 INFO - Fetch https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/target.common.tests.zip into memory 15:31:40 INFO - Expected file size: 21847832 15:31:40 INFO - Obtained file size: 21847832 15:31:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:31:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/target.common.tests.zip 15:31:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:31:44 INFO - Fetch https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/target.common.tests.zip into memory 15:31:45 INFO - Expected file size: 21847832 15:31:45 INFO - Obtained file size: 21847832 15:31:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/target.talos.tests.zip 15:31:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:31:49 INFO - Fetch https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/target.talos.tests.zip into memory 15:31:50 INFO - Expected file size: 14403485 15:31:50 INFO - Obtained file size: 14403485 15:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:50 INFO - trying https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/target.tar.bz2 15:31:50 INFO - Downloading https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:31:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:31:52 INFO - Downloaded 65981160 bytes. 15:31:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/target.tar.bz2 15:31:52 INFO - mkdir: /builds/slave/test/properties 15:31:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:31:52 INFO - Writing to file /builds/slave/test/properties/build_url 15:31:52 INFO - Contents: 15:31:52 INFO - build_url:https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/target.tar.bz2 15:31:52 INFO - Running post-action listener: _resource_record_post_action 15:31:52 INFO - Running post-action listener: set_extra_try_arguments 15:31:52 INFO - [mozharness: 2017-01-24 23:31:52.174341Z] Finished download-and-extract step (success) 15:31:52 INFO - [mozharness: 2017-01-24 23:31:52.174439Z] Running populate-webroot step. 15:31:52 INFO - Running pre-action listener: _resource_record_pre_action 15:31:52 INFO - Running main action method: populate_webroot 15:31:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:31:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:31:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:31:52 INFO - '--tppagecycles', 15:31:52 INFO - '7'], 15:31:52 INFO - 'tests': ['tsvgm']}}, 15:31:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:31:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:31:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:31:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:31:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:31:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:31:52 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:31:52 INFO - 'talos_options': ['--disable-e10s'], 15:31:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:31:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:31:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:31:52 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:31:52 INFO - 'talos_options': ['--disable-e10s'], 15:31:52 INFO - 'tests': ['damp', 'tps']}, 15:31:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:31:52 INFO - 'tests': ['damp', 'tps']}, 15:31:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:31:52 INFO - 'tests': ['dromaeo_dom']}, 15:31:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:31:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:31:52 INFO - 'tests': ['basic_compositor_video']}, 15:31:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:31:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:31:52 INFO - 'tests': ['a11yr', 15:31:52 INFO - 'ts_paint', 15:31:52 INFO - 'tpaint', 15:31:52 INFO - 'sessionrestore', 15:31:52 INFO - 'sessionrestore_no_auto_restore', 15:31:52 INFO - 'tabpaint']}, 15:31:52 INFO - 'other-e10s': {'tests': ['a11yr', 15:31:52 INFO - 'ts_paint', 15:31:52 INFO - 'tpaint', 15:31:52 INFO - 'sessionrestore', 15:31:52 INFO - 'sessionrestore_no_auto_restore', 15:31:52 INFO - 'tabpaint']}, 15:31:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:31:52 INFO - 'ts_paint', 15:31:52 INFO - 'tpaint', 15:31:52 INFO - 'sessionrestore', 15:31:52 INFO - 'sessionrestore_no_auto_restore', 15:31:52 INFO - 'tabpaint']}, 15:31:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:31:52 INFO - 'ts_paint', 15:31:52 INFO - 'tpaint', 15:31:52 INFO - 'sessionrestore', 15:31:52 INFO - 'sessionrestore_no_auto_restore', 15:31:52 INFO - 'tabpaint']}, 15:31:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:31:52 INFO - 'tests': ['a11yr', 15:31:52 INFO - 'ts_paint', 15:31:52 INFO - 'tpaint', 15:31:52 INFO - 'sessionrestore', 15:31:52 INFO - 'sessionrestore_no_auto_restore', 15:31:52 INFO - 'tabpaint']}, 15:31:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:31:52 INFO - 'tests': ['a11yr', 15:31:52 INFO - 'ts_paint', 15:31:52 INFO - 'tpaint', 15:31:52 INFO - 'sessionrestore', 15:31:52 INFO - 'sessionrestore_no_auto_restore', 15:31:52 INFO - 'tabpaint']}, 15:31:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:31:52 INFO - 'tests': ['tsvgx', 15:31:52 INFO - 'tsvgr_opacity', 15:31:52 INFO - 'tart', 15:31:52 INFO - 'tscrollx', 15:31:52 INFO - 'cart', 15:31:52 INFO - 'tsvg_static']}, 15:31:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:31:52 INFO - 'tsvgr_opacity', 15:31:52 INFO - 'tart', 15:31:52 INFO - 'tscrollx', 15:31:52 INFO - 'cart', 15:31:52 INFO - 'tsvg_static']}, 15:31:52 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:31:52 INFO - 'talos_options': ['--disable-e10s'], 15:31:52 INFO - 'tests': ['tp5o']}, 15:31:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:31:52 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:31:52 INFO - 'talos_options': ['--disable-e10s', 15:31:52 INFO - '--xperf_path', 15:31:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:31:52 INFO - 'tests': ['tp5n']}, 15:31:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:31:52 INFO - 'talos_options': ['--xperf_path', 15:31:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:31:52 INFO - 'tests': ['tp5n']}}, 15:31:52 INFO - 'talos.zip': {'path': '', 15:31:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:31:52 INFO - Running post-action listener: _resource_record_post_action 15:31:52 INFO - [mozharness: 2017-01-24 23:31:52.187631Z] Finished populate-webroot step (success) 15:31:52 INFO - [mozharness: 2017-01-24 23:31:52.187722Z] Running create-virtualenv step. 15:31:52 INFO - Running pre-action listener: _resource_record_pre_action 15:31:52 INFO - Running main action method: create_virtualenv 15:31:52 INFO - Creating virtualenv /builds/slave/test/build/venv 15:31:52 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 15:31:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:31:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:31:52 INFO - Using real prefix '/usr' 15:31:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:31:52 INFO - Installing distribute.............................................................................................................................................................................................done. 15:31:54 INFO - Installing pip.................done. 15:31:54 INFO - Return code: 0 15:31:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:31:54 INFO - Reading from file tmpfile_stdout 15:31:54 INFO - Output received: 15:31:54 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:31:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9f980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9cd00>, '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 0x1f9da00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9deb0>, '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': '836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461', '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 15:31:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:31:54 INFO - Using env: {'DISPLAY': ':0', 15:31:54 INFO - 'HOME': '/home/cltbld', 15:31:54 INFO - 'LANG': 'en_US.UTF-8', 15:31:54 INFO - 'LANGUAGE': 'en_US:en', 15:31:54 INFO - 'LOGNAME': 'cltbld', 15:31:54 INFO - 'MAIL': '/var/mail/cltbld', 15:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:54 INFO - 'MOZ_NO_REMOTE': '1', 15:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:54 INFO - 'NO_EM_RESTART': '1', 15:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:54 INFO - 'PWD': '/builds/slave/test', 15:31:54 INFO - 'SHELL': '/bin/bash', 15:31:54 INFO - 'SHLVL': '1', 15:31:54 INFO - 'TERM': 'linux', 15:31:54 INFO - 'TMOUT': '86400', 15:31:54 INFO - 'USER': 'cltbld', 15:31:54 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461', 15:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:54 INFO - '_': '/tools/buildbot/bin/python'} 15:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:55 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 15:31:55 INFO - Cleaning up... 15:31:55 INFO - Return code: 0 15:31:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:31: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9f980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9cd00>, '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 0x1f9da00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9deb0>, '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': '836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461', '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 15:31:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:31:55 INFO - Using env: {'DISPLAY': ':0', 15:31:55 INFO - 'HOME': '/home/cltbld', 15:31:55 INFO - 'LANG': 'en_US.UTF-8', 15:31:55 INFO - 'LANGUAGE': 'en_US:en', 15:31:55 INFO - 'LOGNAME': 'cltbld', 15:31:55 INFO - 'MAIL': '/var/mail/cltbld', 15:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:55 INFO - 'MOZ_NO_REMOTE': '1', 15:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:55 INFO - 'NO_EM_RESTART': '1', 15:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:55 INFO - 'PWD': '/builds/slave/test', 15:31:55 INFO - 'SHELL': '/bin/bash', 15:31:55 INFO - 'SHLVL': '1', 15:31:55 INFO - 'TERM': 'linux', 15:31:55 INFO - 'TMOUT': '86400', 15:31:55 INFO - 'USER': 'cltbld', 15:31:55 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461', 15:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:55 INFO - '_': '/tools/buildbot/bin/python'} 15:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:55 INFO - Downloading/unpacking psutil>=3.1.1 15:31:55 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 15:31:55 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 15:31:55 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 15:31:55 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 15:31:55 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 15:31:55 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 15:31:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:31:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:31:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:31:57 INFO - Installing collected packages: psutil 15:31:57 INFO - Running setup.py install for psutil 15:31:57 INFO - building 'psutil._psutil_linux' extension 15:31:57 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 15:31:57 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 15:31:57 INFO - building 'psutil._psutil_posix' extension 15:31:57 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 15:31:57 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 15:31:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:31:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:31:57 INFO - Successfully installed psutil 15:31:57 INFO - Cleaning up... 15:31:58 INFO - Return code: 0 15:31:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:31: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9f980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9cd00>, '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 0x1f9da00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9deb0>, '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': '836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461', '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 15:31:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:31:58 INFO - Using env: {'DISPLAY': ':0', 15:31:58 INFO - 'HOME': '/home/cltbld', 15:31:58 INFO - 'LANG': 'en_US.UTF-8', 15:31:58 INFO - 'LANGUAGE': 'en_US:en', 15:31:58 INFO - 'LOGNAME': 'cltbld', 15:31:58 INFO - 'MAIL': '/var/mail/cltbld', 15:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:58 INFO - 'MOZ_NO_REMOTE': '1', 15:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:58 INFO - 'NO_EM_RESTART': '1', 15:31:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:58 INFO - 'PWD': '/builds/slave/test', 15:31:58 INFO - 'SHELL': '/bin/bash', 15:31:58 INFO - 'SHLVL': '1', 15:31:58 INFO - 'TERM': 'linux', 15:31:58 INFO - 'TMOUT': '86400', 15:31:58 INFO - 'USER': 'cltbld', 15:31:58 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461', 15:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:58 INFO - '_': '/tools/buildbot/bin/python'} 15:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:32:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:32:00 INFO - Installing collected packages: mozsystemmonitor 15:32:00 INFO - Running setup.py install for mozsystemmonitor 15:32:00 INFO - Successfully installed mozsystemmonitor 15:32:00 INFO - Cleaning up... 15:32:00 INFO - Return code: 0 15:32:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:00 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9f980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9cd00>, '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 0x1f9da00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9deb0>, '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': '836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461', '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 15:32:00 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==2.5.1'] in /builds/slave/test/build 15:32:00 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==2.5.1 15:32:00 INFO - Using env: {'DISPLAY': ':0', 15:32:00 INFO - 'HOME': '/home/cltbld', 15:32:00 INFO - 'LANG': 'en_US.UTF-8', 15:32:00 INFO - 'LANGUAGE': 'en_US:en', 15:32:00 INFO - 'LOGNAME': 'cltbld', 15:32:00 INFO - 'MAIL': '/var/mail/cltbld', 15:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:00 INFO - 'MOZ_NO_REMOTE': '1', 15:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:00 INFO - 'NO_EM_RESTART': '1', 15:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:00 INFO - 'PWD': '/builds/slave/test', 15:32:00 INFO - 'SHELL': '/bin/bash', 15:32:00 INFO - 'SHLVL': '1', 15:32:00 INFO - 'TERM': 'linux', 15:32:00 INFO - 'TMOUT': '86400', 15:32:00 INFO - 'USER': 'cltbld', 15:32:00 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461', 15:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:00 INFO - '_': '/tools/buildbot/bin/python'} 15:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:00 INFO - Downloading/unpacking jsonschema==2.5.1 15:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:32:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:02 INFO - Downloading functools32-3.2.3-2.tar.gz 15:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:32:02 INFO - warning: no files found matching '*.txt' 15:32:02 INFO - no previously-included directories found matching 'build' 15:32:02 INFO - no previously-included directories found matching 'dist' 15:32:02 INFO - no previously-included directories found matching '.git*' 15:32:02 INFO - Installing collected packages: jsonschema, functools32 15:32:02 INFO - Running setup.py install for functools32 15:32:03 INFO - warning: no files found matching '*.txt' 15:32:03 INFO - no previously-included directories found matching 'build' 15:32:03 INFO - no previously-included directories found matching 'dist' 15:32:03 INFO - no previously-included directories found matching '.git*' 15:32:03 INFO - Successfully installed jsonschema functools32 15:32:03 INFO - Cleaning up... 15:32:03 INFO - Return code: 0 15:32:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:03 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9f980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9cd00>, '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 0x1f9da00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9deb0>, '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': '836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461', '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 15:32:03 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:32:03 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 functools32==3.2.3-2 15:32:03 INFO - Using env: {'DISPLAY': ':0', 15:32:03 INFO - 'HOME': '/home/cltbld', 15:32:03 INFO - 'LANG': 'en_US.UTF-8', 15:32:03 INFO - 'LANGUAGE': 'en_US:en', 15:32:03 INFO - 'LOGNAME': 'cltbld', 15:32:03 INFO - 'MAIL': '/var/mail/cltbld', 15:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:03 INFO - 'MOZ_NO_REMOTE': '1', 15:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:03 INFO - 'NO_EM_RESTART': '1', 15:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:03 INFO - 'PWD': '/builds/slave/test', 15:32:03 INFO - 'SHELL': '/bin/bash', 15:32:03 INFO - 'SHLVL': '1', 15:32:03 INFO - 'TERM': 'linux', 15:32:03 INFO - 'TMOUT': '86400', 15:32:03 INFO - 'USER': 'cltbld', 15:32:03 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461', 15:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:03 INFO - '_': '/tools/buildbot/bin/python'} 15:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:32:03 INFO - Cleaning up... 15:32:03 INFO - Return code: 0 15:32:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:03 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 0x1c2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9f980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9cd00>, '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 0x1f9da00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9deb0>, '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': '836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461', '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 15:32:03 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 15:32:03 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 15:32:03 INFO - Using env: {'DISPLAY': ':0', 15:32:03 INFO - 'HOME': '/home/cltbld', 15:32:03 INFO - 'LANG': 'en_US.UTF-8', 15:32:03 INFO - 'LANGUAGE': 'en_US:en', 15:32:03 INFO - 'LOGNAME': 'cltbld', 15:32:03 INFO - 'MAIL': '/var/mail/cltbld', 15:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:03 INFO - 'MOZ_NO_REMOTE': '1', 15:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:03 INFO - 'NO_EM_RESTART': '1', 15:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:03 INFO - 'PWD': '/builds/slave/test', 15:32:03 INFO - 'SHELL': '/bin/bash', 15:32:03 INFO - 'SHLVL': '1', 15:32:03 INFO - 'TERM': 'linux', 15:32:03 INFO - 'TMOUT': '86400', 15:32:03 INFO - 'USER': 'cltbld', 15:32:03 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461', 15:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:03 INFO - '_': '/tools/buildbot/bin/python'} 15:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:03 INFO - Downloading/unpacking blobuploader==1.2.4 15:32:03 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 15:32:03 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 15:32:03 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 15:32:03 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 15:32:03 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 15:32:03 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 15:32:05 INFO - Downloading blobuploader-1.2.4.tar.gz 15:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:32:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:32:05 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 15:32:05 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 15:32:05 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 15:32:05 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 15:32:05 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 15:32:05 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 15:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:32:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:32:06 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 15:32:06 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 15:32:06 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 15:32:06 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 15:32:06 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 15:32:06 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 15:32:06 INFO - Downloading docopt-0.6.1.tar.gz 15:32:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:32:06 INFO - Installing collected packages: blobuploader, requests, docopt 15:32:06 INFO - Running setup.py install for blobuploader 15:32:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:32:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:32:06 INFO - Running setup.py install for requests 15:32:06 INFO - Running setup.py install for docopt 15:32:06 INFO - Successfully installed blobuploader requests docopt 15:32:06 INFO - Cleaning up... 15:32:06 INFO - Return code: 0 15:32:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:32:06 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:06 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:07 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 0x1c2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9f980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9cd00>, '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 0x1f9da00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9deb0>, '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': '836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461', '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 15:32:07 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 15:32:07 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 15:32:07 INFO - Using env: {'DISPLAY': ':0', 15:32:07 INFO - 'HOME': '/home/cltbld', 15:32:07 INFO - 'LANG': 'en_US.UTF-8', 15:32:07 INFO - 'LANGUAGE': 'en_US:en', 15:32:07 INFO - 'LOGNAME': 'cltbld', 15:32:07 INFO - 'MAIL': '/var/mail/cltbld', 15:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:07 INFO - 'MOZ_NO_REMOTE': '1', 15:32:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:07 INFO - 'NO_EM_RESTART': '1', 15:32:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:07 INFO - 'PWD': '/builds/slave/test', 15:32:07 INFO - 'SHELL': '/bin/bash', 15:32:07 INFO - 'SHLVL': '1', 15:32:07 INFO - 'TERM': 'linux', 15:32:07 INFO - 'TMOUT': '86400', 15:32:07 INFO - 'USER': 'cltbld', 15:32:07 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461', 15:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:07 INFO - '_': '/tools/buildbot/bin/python'} 15:32:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:32:07 INFO - Running setup.py (path:/tmp/pip-7TIc4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:32:07 INFO - Running setup.py (path:/tmp/pip-s4ZX4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:32:07 INFO - Running setup.py (path:/tmp/pip-zDhqcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:32:07 INFO - Running setup.py (path:/tmp/pip-q8fmIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:32:07 INFO - Running setup.py (path:/tmp/pip-upbFG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:32:07 INFO - Running setup.py (path:/tmp/pip-LVf_5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:32:07 INFO - Running setup.py (path:/tmp/pip-U4Bv17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:32:07 INFO - Running setup.py (path:/tmp/pip-PwAGpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:32:07 INFO - Running setup.py (path:/tmp/pip-K_QoGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:32:07 INFO - Running setup.py (path:/tmp/pip-dZhB1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:32:07 INFO - Running setup.py (path:/tmp/pip-G7R8H4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:32:08 INFO - Running setup.py (path:/tmp/pip-nfNoNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:32:08 INFO - Running setup.py (path:/tmp/pip-u5Ze0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:32:08 INFO - Running setup.py (path:/tmp/pip-6VtMmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:32:08 INFO - Running setup.py (path:/tmp/pip-6sQbSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:32:08 INFO - Running setup.py (path:/tmp/pip-jEJmFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:32:08 INFO - Running setup.py (path:/tmp/pip-e7VPpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:32:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:32:08 INFO - Running setup.py install for manifestparser 15:32:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:32:08 INFO - Running setup.py install for mozcrash 15:32:08 INFO - Running setup.py install for mozdebug 15:32:08 INFO - Running setup.py install for mozdevice 15:32:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:32:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:32:08 INFO - Running setup.py install for mozfile 15:32:08 INFO - Running setup.py install for mozhttpd 15:32:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:32:09 INFO - Running setup.py install for mozinfo 15:32:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:32:09 INFO - Running setup.py install for mozInstall 15:32:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:32:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:32:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:32:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:32:09 INFO - Running setup.py install for mozleak 15:32:09 INFO - Running setup.py install for mozlog 15:32:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:32:09 INFO - Running setup.py install for moznetwork 15:32:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:32:09 INFO - Running setup.py install for mozprocess 15:32:09 INFO - Running setup.py install for mozprofile 15:32:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:32:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:32:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:32:09 INFO - Running setup.py install for mozrunner 15:32:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:32:09 INFO - Running setup.py install for mozscreenshot 15:32:10 INFO - Running setup.py install for moztest 15:32:10 INFO - Running setup.py install for mozversion 15:32:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:32:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:32:10 INFO - Cleaning up... 15:32:10 INFO - Return code: 0 15:32:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:32:10 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:10 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:10 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 0x1c2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9f980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9cd00>, '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 0x1f9da00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9deb0>, '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': '836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461', '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 15:32:10 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 15:32:10 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 15:32:10 INFO - Using env: {'DISPLAY': ':0', 15:32:10 INFO - 'HOME': '/home/cltbld', 15:32:10 INFO - 'LANG': 'en_US.UTF-8', 15:32:10 INFO - 'LANGUAGE': 'en_US:en', 15:32:10 INFO - 'LOGNAME': 'cltbld', 15:32:10 INFO - 'MAIL': '/var/mail/cltbld', 15:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:10 INFO - 'MOZ_NO_REMOTE': '1', 15:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:10 INFO - 'NO_EM_RESTART': '1', 15:32:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:10 INFO - 'PWD': '/builds/slave/test', 15:32:10 INFO - 'SHELL': '/bin/bash', 15:32:10 INFO - 'SHLVL': '1', 15:32:10 INFO - 'TERM': 'linux', 15:32:10 INFO - 'TMOUT': '86400', 15:32:10 INFO - 'USER': 'cltbld', 15:32:10 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461', 15:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:10 INFO - '_': '/tools/buildbot/bin/python'} 15:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:32:10 INFO - Running setup.py (path:/tmp/pip-S4M1Ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:32:10 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)) 15:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:32:10 INFO - Running setup.py (path:/tmp/pip-SKrsCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 15:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:32:10 INFO - Running setup.py (path:/tmp/pip-i_DNRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:32:10 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)) 15:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:32:10 INFO - Running setup.py (path:/tmp/pip-n0qbwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 15:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:32:10 INFO - Running setup.py (path:/tmp/pip-jjeca3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:32:10 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)) 15:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:32:10 INFO - Running setup.py (path:/tmp/pip-Zr90cf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:32:10 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)) 15:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:32:10 INFO - Running setup.py (path:/tmp/pip-3r2lDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:32:10 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)) 15:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:32:10 INFO - Running setup.py (path:/tmp/pip-0ShbBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:32:11 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)) 15:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:32:11 INFO - Running setup.py (path:/tmp/pip-Cpfkmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:32:11 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)) 15:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:32:11 INFO - Running setup.py (path:/tmp/pip-RNPu_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 15:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:32:11 INFO - Running setup.py (path:/tmp/pip-GDlOZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:32:11 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)) 15:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:32:11 INFO - Running setup.py (path:/tmp/pip-ROQy4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 15:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:32:11 INFO - Running setup.py (path:/tmp/pip-6CNatj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:32:11 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)) 15:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:32:11 INFO - Running setup.py (path:/tmp/pip-z7HsqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 15:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:32:11 INFO - Running setup.py (path:/tmp/pip-EjIB9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:32:11 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)) 15:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:32:11 INFO - Running setup.py (path:/tmp/pip-AjQMD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 15:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:32:11 INFO - Running setup.py (path:/tmp/pip-mSejxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:32:11 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)) 15:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:32:11 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)) 15:32:11 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:32:11 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:32:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:13 INFO - Downloading blessings-1.6.tar.gz 15:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:32:13 INFO - Installing collected packages: blessings 15:32:13 INFO - Running setup.py install for blessings 15:32:13 INFO - Successfully installed blessings 15:32:13 INFO - Cleaning up... 15:32:13 INFO - Return code: 0 15:32:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:32:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:32:14 INFO - Reading from file tmpfile_stdout 15:32:14 INFO - Current package versions: 15:32:14 INFO - argparse == 1.2.1 15:32:14 INFO - blessings == 1.6 15:32:14 INFO - blobuploader == 1.2.4 15:32:14 INFO - docopt == 0.6.1 15:32:14 INFO - functools32 == 3.2.3-2 15:32:14 INFO - jsonschema == 2.5.1 15:32:14 INFO - manifestparser == 1.1 15:32:14 INFO - mozInstall == 1.12 15:32:14 INFO - mozcrash == 1.0 15:32:14 INFO - mozdebug == 0.1 15:32:14 INFO - mozdevice == 0.49 15:32:14 INFO - mozfile == 1.2 15:32:14 INFO - mozhttpd == 0.7 15:32:14 INFO - mozinfo == 0.9 15:32:14 INFO - mozleak == 0.1 15:32:14 INFO - mozlog == 3.4 15:32:14 INFO - moznetwork == 0.27 15:32:14 INFO - mozprocess == 0.24 15:32:14 INFO - mozprofile == 0.28 15:32:14 INFO - mozrunner == 6.13 15:32:14 INFO - mozscreenshot == 0.1 15:32:14 INFO - mozsystemmonitor == 0.3 15:32:14 INFO - moztest == 0.8 15:32:14 INFO - mozversion == 1.4 15:32:14 INFO - psutil == 3.1.1 15:32:14 INFO - requests == 1.2.3 15:32:14 INFO - wsgiref == 0.1.2 15:32:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:32: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:14 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 0x1c2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9f980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9cd00>, '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 0x1f9da00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9deb0>, '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': '836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461', '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 15:32:14 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 15:32:14 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 15:32:14 INFO - Using env: {'DISPLAY': ':0', 15:32:14 INFO - 'HOME': '/home/cltbld', 15:32:14 INFO - 'LANG': 'en_US.UTF-8', 15:32:14 INFO - 'LANGUAGE': 'en_US:en', 15:32:14 INFO - 'LOGNAME': 'cltbld', 15:32:14 INFO - 'MAIL': '/var/mail/cltbld', 15:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:14 INFO - 'MOZ_NO_REMOTE': '1', 15:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:14 INFO - 'NO_EM_RESTART': '1', 15:32:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:14 INFO - 'PWD': '/builds/slave/test', 15:32:14 INFO - 'SHELL': '/bin/bash', 15:32:14 INFO - 'SHLVL': '1', 15:32:14 INFO - 'TERM': 'linux', 15:32:14 INFO - 'TMOUT': '86400', 15:32:14 INFO - 'USER': 'cltbld', 15:32:14 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461', 15:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:14 INFO - '_': '/tools/buildbot/bin/python'} 15:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:14 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)) 15:32:14 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)) 15:32:14 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)) 15:32:14 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)) 15:32:14 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)) 15:32:14 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)) 15:32:14 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)) 15:32:14 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)) 15:32:14 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)) 15:32:14 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)) 15:32:14 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)) 15:32:14 INFO - Cleaning up... 15:32:14 INFO - Return code: 0 15:32:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:32: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9f980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9cd00>, '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 0x1f9da00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9deb0>, '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': '836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461', '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 15:32: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', 'jsonschema'] in /builds/slave/test/build 15:32: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 jsonschema 15:32:14 INFO - Using env: {'DISPLAY': ':0', 15:32:14 INFO - 'HOME': '/home/cltbld', 15:32:14 INFO - 'LANG': 'en_US.UTF-8', 15:32:14 INFO - 'LANGUAGE': 'en_US:en', 15:32:14 INFO - 'LOGNAME': 'cltbld', 15:32:14 INFO - 'MAIL': '/var/mail/cltbld', 15:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:14 INFO - 'MOZ_NO_REMOTE': '1', 15:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:14 INFO - 'NO_EM_RESTART': '1', 15:32:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:14 INFO - 'PWD': '/builds/slave/test', 15:32:14 INFO - 'SHELL': '/bin/bash', 15:32:14 INFO - 'SHLVL': '1', 15:32:14 INFO - 'TERM': 'linux', 15:32:14 INFO - 'TMOUT': '86400', 15:32:14 INFO - 'USER': 'cltbld', 15:32:14 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461', 15:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:14 INFO - '_': '/tools/buildbot/bin/python'} 15:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:32:14 INFO - Cleaning up... 15:32:14 INFO - Return code: 0 15:32:14 INFO - Running post-action listener: _resource_record_post_action 15:32:14 INFO - Running post-action listener: _start_resource_monitoring 15:32:14 INFO - Starting resource monitoring. 15:32:14 INFO - [mozharness: 2017-01-24 23:32:14.691882Z] Finished create-virtualenv step (success) 15:32:14 INFO - [mozharness: 2017-01-24 23:32:14.692381Z] Running install step. 15:32:14 INFO - Running pre-action listener: _resource_record_pre_action 15:32:14 INFO - Running main action method: install 15:32:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:32:14 INFO - Reading from file tmpfile_stdout 15:32:14 INFO - Detecting whether we're running mozinstall >=1.0... 15:32:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:32:14 INFO - Reading from file tmpfile_stdout 15:32:14 INFO - Output received: 15:32:14 INFO - Usage: mozinstall [options] installer 15:32:14 INFO - Options: 15:32:14 INFO - -h, --help show this help message and exit 15:32:14 INFO - -d DEST, --destination=DEST 15:32:14 INFO - Directory to install application into. [default: 15:32:14 INFO - "/builds/slave/test"] 15:32:14 INFO - --app=APP Application being installed. [default: firefox] 15:32:14 INFO - mkdir: /builds/slave/test/build/application 15:32:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:32:31 INFO - Reading from file tmpfile_stdout 15:32:31 INFO - Output received: 15:32:31 INFO - /builds/slave/test/build/application/firefox/firefox 15:32:31 INFO - Running post-action listener: _resource_record_post_action 15:32:31 INFO - [mozharness: 2017-01-24 23:32:31.415127Z] Finished install step (success) 15:32:31 INFO - [mozharness: 2017-01-24 23:32:31.415400Z] Running run-tests step. 15:32:31 INFO - Running pre-action listener: _resource_record_pre_action 15:32:31 INFO - Running main action method: run_tests 15:32:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:32:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:32:31 INFO - Python 2.7.3 15:32:31 INFO - Return code: 0 15:32:31 INFO - grabbing minidump binary from tooltool 15:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:31 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9cd00>, '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 0x1f9da00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f9deb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:32:31 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 15:32:31 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 15:32:31 INFO - Calling ['/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'] with output_timeout 600 15:32:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:32:31 INFO - Return code: 0 15:32:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:32:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:32:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:32:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:32:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:32:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:32:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:32:31 INFO - Using env: {'DISPLAY': ':0', 15:32:31 INFO - 'HOME': '/home/cltbld', 15:32:31 INFO - 'LANG': 'en_US.UTF-8', 15:32:31 INFO - 'LANGUAGE': 'en_US:en', 15:32:31 INFO - 'LOGNAME': 'cltbld', 15:32:31 INFO - 'MAIL': '/var/mail/cltbld', 15:32:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:32:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:32:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:31 INFO - 'MOZ_NO_REMOTE': '1', 15:32:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:32:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:31 INFO - 'NO_EM_RESTART': '1', 15:32:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:31 INFO - 'PWD': '/builds/slave/test', 15:32:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:32:31 INFO - 'SHELL': '/bin/bash', 15:32:31 INFO - 'SHLVL': '1', 15:32:31 INFO - 'TERM': 'linux', 15:32:31 INFO - 'TMOUT': '86400', 15:32:31 INFO - 'USER': 'cltbld', 15:32:31 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461', 15:32:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:31 INFO - '_': '/tools/buildbot/bin/python'} 15:32:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:32:31 INFO - mozversion application_buildid: 20170124223443 15:32:31 INFO - mozversion application_changeset: 48f7caa80dfc6cafc778269b12e9e69379111c56 15:32:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:32:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:32:31 INFO - mozversion application_name: Firefox 15:32:31 INFO - mozversion application_remotingname: firefox-dev 15:32:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:32:31 INFO - mozversion application_vendor: Mozilla 15:32:31 INFO - mozversion application_version: 53.0a2 15:32:31 INFO - mozversion platform_buildid: 20170124223443 15:32:31 INFO - mozversion platform_changeset: 48f7caa80dfc6cafc778269b12e9e69379111c56 15:32:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:32:31 INFO - mozversion platform_version: 53.0a2 15:32:31 INFO - using testdate: 1485300751 15:32:31 INFO - actual date: 1485300751 15:32:31 INFO - starting webserver on 'localhost:60351' 15:32:31 INFO - SUITE-START | Running 2 tests 15:32:31 INFO - TEST-START | dromaeo_css 15:32:31 INFO - operating with platform_type : linux_ 15:32:31 INFO - Initialising browser for dromaeo_css test... 15:32:31 INFO - TEST-INFO | started process 23532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpljikiE/profile http://localhost:60351/getInfo.html) 15:32:36 INFO - PROCESS | 23532 | __metrics Screen width/height:1600/1200 15:32:36 INFO - PROCESS | 23532 | colorDepth:24 15:32:36 INFO - PROCESS | 23532 | Browser inner width/height: 1024/697 15:32:36 INFO - PROCESS | 23532 | __metrics 15:32:36 INFO - PROCESS | 23532 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 15:32:36 ERROR - PROCESS | 23532 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 15:32:37 INFO - TEST-INFO | 23532: exit 0 15:32:37 INFO - Browser initialized. 15:32:37 INFO - Running cycle 1/1 for dromaeo_css test... 15:32:37 INFO - TEST-INFO | started process 23662 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpljikiE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:32:49 INFO - PROCESS | 23662 | RSS: Main: 144560128 15:32:49 INFO - PROCESS | 23662 | 15:35:48 INFO - PROCESS | 23662 | Cycle 1(1): loaded http://localhost:60351/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60351/tests/dromaeo/cssquery-ext.html) 15:35:49 INFO - PROCESS | 23662 | RSS: Main: 154701824 15:35:49 INFO - PROCESS | 23662 | 15:37:38 INFO - PROCESS | 23662 | ************************* 15:37:38 INFO - PROCESS | 23662 | A coding exception was thrown and uncaught in a Task. 15:37:38 INFO - PROCESS | 23662 | 15:37:38 ERROR - PROCESS | 23662 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:37:38 INFO - PROCESS | 23662 | Full stack: 15:37:38 INFO - PROCESS | 23662 | ************************* 15:38:51 INFO - PROCESS | 23662 | Cycle 1(1): loaded http://localhost:60351/tests/dromaeo/cssquery-ext.html (next: http://localhost:60351/tests/dromaeo/cssquery-jquery.html) 15:38:52 INFO - PROCESS | 23662 | RSS: Main: 149766144 15:38:52 INFO - PROCESS | 23662 | 15:41:54 INFO - PROCESS | 23662 | Cycle 1(1): loaded http://localhost:60351/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60351/tests/dromaeo/cssquery-mootools.html) 15:41:54 INFO - PROCESS | 23662 | RSS: Main: 155467776 15:41:54 INFO - PROCESS | 23662 | 15:44:56 INFO - PROCESS | 23662 | Cycle 1(1): loaded http://localhost:60351/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60351/tests/dromaeo/cssquery-prototype.html) 15:44:57 INFO - PROCESS | 23662 | RSS: Main: 152309760 15:44:57 INFO - PROCESS | 23662 | 15:47:59 INFO - PROCESS | 23662 | Cycle 1(1): loaded http://localhost:60351/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60351/tests/dromaeo/cssquery-yui.html) 15:48:00 INFO - PROCESS | 23662 | RSS: Main: 155164672 15:48:00 INFO - PROCESS | 23662 | 15:51:02 INFO - PROCESS | 23662 | Cycle 1(1): loaded http://localhost:60351/tests/dromaeo/cssquery-yui.html (next: http://localhost:60351/tests/dromaeo/cssquery-dojo.html) 15:51:02 INFO - PROCESS | 23662 | RSS: Main: 154185728 15:51:02 INFO - PROCESS | 23662 | 15:51:02 INFO - PROCESS | 23662 | __start_tp_report 15:51:02 INFO - PROCESS | 23662 | _x_x_mozilla_page_load 15:51:02 INFO - PROCESS | 23662 | _x_x_mozilla_page_load_details 15:51:02 INFO - PROCESS | 23662 | |i|pagename|runs| 15:51:02 INFO - PROCESS | 23662 | |0;dojo.html;3328.4508056170735;3344.4147274227003;3360.8823691170815;3363.0583436637744;3370.6292307846134;5405.972970135153;5455.754491047913;5495.862603434916;5516.813885014726;5569.470900264479;5595.356533998592;5629.943700563003;5648.124540696188;5673.177389278552;5673.461021202989;5111.258867464216;5145.974270128644;5188.6367954243215;5191;5226.7647955841885;5226.425093239741;5238.240455134003;5240.397354304266;5245.973770131144;5251.711155886424;4939.777710003059;4999.825006124786;5229.111051121299;5240.34495688039;5240.397354304266;5105.336306280178;5108.978204359106;5151.201563757623;5177.016366890279;5270.4729527047375;5106.514881086328;5198.090334191501;5203.713795741232;5204.271402003723;5217.765200565984;5641.210230567724;5641.633293835887;5687.857803554903;5715.028445164332;5724.169995350692;5763.279590051244;5815.796447124372;5851.38560451155;5876.764929402819;5881.264841894763;6023.939760602381;6026.126211699279;6030.396960303979;6030.698465076729;6059.697015149225;5579;5601.047821870292;5622.8313150605545;5623;5625.634333768333;5839.854003649858;5842.503387212049;5857.677827719431;5903.527717782567;6107.938920610737;5735.569832262597;5743.741531631086;5751.683657398883;5767.509761670221;5815.185873977646;5836.941630583725;5886.8822623547285;5896.498797602166;5896.882062358729;5914.0241860093465;5766.769329226868;5793.797217097382;5800.6809625471005;5818.6217895836635;5819.709014549256;5855.355910849803;5951.9107213391835;5955.910661340084;5975.223220981332;5980.401959804072;4145.54399016108;4164.9583504165175;4165.562615925345;4182.121754431603;4191.7275377100395;3731.906702332409;3741.5510138782975;3797.3354662933875;3804.866829661004;3808.333541630204;5726.9713651431475;5732.6847023413275;5738.971305143447;5760.884782304414;5779.133130030445;5895.882082358329;5932.228810254725;5958.582899197101;5966.254218222723;5981.222441082631;5594.272744543265;5619.044762390404;5671.035923892948;5688.232088667977;5716.371199168088;5070.062038522885;5071.923921141186;5110.8466745997675;5116.667416617908;5123.769430375568;6224;6240;6241.188645476059;6242.469390101802;6246.750129994749;5868.413158684269;5896.705164741831;5897.823065308047;5953.136795164591;6004.549658775697;6129.511613758974;6191.473724733448;6195.256569211723;6200.255969283715;6236.220472440945;5818.94181058184;5864.296284445893;5878.794242201502;5894.823155305347;5907.616004959664;5775.1914731938405;5804;6015.097735339734;6034.064719968412;6041.728122234598;5810.128480727924;5842.211301474416;5871.03127983895;5925.762969481172;5948.851278717893;5898.616589921641;5911.349751527243;5917.763289468545;5922.378150294157;5926.2295901532525;5622.156676498558;5888.263967004124;5893.793717219876;5902.321233058254;5906.557008224315;5690.459406356389;5792.623479473821;5885.146653735099;5906.379830117776;5921.940780592139;5685.715714214355;5711.371749107512;5726.513246373938;5743.368229494668;5744.971275143597 15:51:02 INFO - PROCESS | 23662 | |1;ext.html;575.6200907401117;592.703648175912;613.4601550635441;692.5740669488266;696.9407600353969;49050.75474622627;49839.50160498398;50077.74961125189;50092;50321.24518132231;50518;51309;51369.48630513694;51637.74181129089;51896.22155667668;9298.95350523248;10828.40443775592;11214.831777523344;11247.437628118601;11459.942700286487;10908.945455272753;11073;11129.165312601588;11130.49912753928;11157.609483668073;11261.155413343991;11272.323660580392;11274.323540587591;11349.716257093598;11372.317660940329;11173.273737207137;11204.439778011067;11211.215214934959;11246;11298.378589177591;11138.053265472363;11185.608503702331;11208.775824483546;11227.607033753779;11248.887511124865;43149;43921;43927;43940.78029609864;44041.559584404065;4517.819287228507;4519.796609152596;4567.383403240553;4647.37260469839;4663.183942809995;31515;31664;32164.195895102577;32652.02043938662;33010.504842427385;4344;4474.082813023322;4526;4557.270836666151;4560.543945605446;373579;377870;378024;378180;379987;65632.67183664147;65786.67106664531;65991.67004165045;66012;66454.33545664579;66510.66744666343;67116.328836711;67271.66364168246;67465.32534674689;67615;18345.266189352544;18408.17163227658;18842.62314753697;18929.242830286636;18974.335898243495;14250.144991300554;14364.928175359057;14409;14453.132812031312;14628.926855365655;20164.596708065757;20586.382408527767;20669.379918602466;20811.68782468264;20839;7442.553446793209;7573.46985710995;7597.886031709529;7699.574633990275;7821.256980586835;1021.070825548747;1030.3302853145365;1037.8910214427528;1040.9739756506149;1041.0422411381546;34078.82960585181;34920.65079349225;35087.29825403477;35421.822890885895;35456.822715886774;1075.5858994287255;1130.7455822439886;1133.3766428464312;1140.4183866228284;1144.2733863996423;18216.817831821776;18286.45140645783;18337.908310458628;18362.449126526226;18506.167222475022;573593;575438;575636;575696;577392;71010;71015.2898471019;71740;71927.28072719206;72031.27968720351;1530.556138719781;1555.968880622404;1558.3532833874042;1577.1404584501474;1598.7442009278693;33230.66769332276;33715.662843371254;33768.662313377536;33952;34032.829835850665;60641.69679151753;61434;61472.38527614667;61517;61620.07569886545;419626;421295;427834;428065;429698;29844.253893652833;30064.549031764105;30132;32382.83808580942;32872.50691239585;48646.37901387617;48834.755826220644;49048;49638;50280;40974.90754759151;42462.78768606137;42899.84754426791;43004.35493467538;43190;41992.16015679608;42238.985699074015;42497.78751106225;42621.78689106535;42633.147337053706;41642;42281.365779512715;42418.78790606027;43096;43185.78407107944;33891.152721181184;35661.82169089138;35811;36272.637273626926;36413.27173456463;27853.582196266667;27873.581896271167;27969.300767480974;28117;28163.71836281611 15:51:02 INFO - PROCESS | 23662 | |2;jquery.html;431.67408606502084;431.7862657984297;443.5675216663755;451.8666993236995;454.3661592079048;20757.896210518964;21784.346469605898;22078;22111.778882211172;22721.54556908861;22782.54434911305;23122.768772312273;23295.3011409658;24138.517229655397;24365.512689746196;6064.3026052003925;6138.232720909887;6315.873682526347;6360.491160707155;6364.968175159118;6030.969845150768;6299.307076221612;6339.334369891164;6345;6346.936530634704;6341.11224428578;6434.646094464802;6442.93557064428;6444.774432894849;6454.838629034265;6333.904991425109;6399.072134540489;6437.356264373572;6457.6448295343735;6480.254770701383;6344.7462101515885;6348.587341822767;6358.078078678565;6361.3638636136475;6368.745250189987;15674.764878526832;15815.288312025987;22839.77160228393;26437.33906652349;26817.195484135507;3061.9693803062128;3185.6177258728867;3219.2917558137174;3295.8681652733862;3319.2531680371962;11501.482433290439;11676.357800320979;11707.648770536813;11717;11755.88244117565;1970.6846904495355;2013.7885522020124;2033.5831154613418;2039.775624681284;2046.7134601155851;100365.49817250867;102900;107040;110043.44978275057;110776.4461177689;12792.360381980863;12945.935270323587;12962.157459765274;13035.739285214433;13217.273049982343;18409.447716568524;18487.352942646943;18609.06954652262;18624.813751862577;18642.81357186438;9335.626574937063;9412;9544.618215271312;9571.425714457155;9642;8897.555122243863;8944.118965848604;8957.238634715992;9001.234895033995;9164.129407706258;5459.890802183934;5512.097235984491;5532.336119665666;5559.416261292506;5657.179708942181;1897.7058555923854;2255.142151479184;2304.5621331946877;2305.1240528599023;2313.5141620259933;955.6082006377352;967.1682353176262;977.2084611464594;985.0006729508664;996.5465713100522;21660.241891534035;21883.67174492384;21927.780722192892;22013.11947522113;22026.88986555057;975.8975307592742;977.9070988256104;986.7286496213599;992.3103443106971;1009.4700282351824;11599.478023488964;12014.63956081319;12251.877481225252;12364.381780910919;12386.62840114798;614461;633128;661511;664981.0252846212;666369;113802.43098784453;114568;114969;115553.42223288998;116085;1031.3605564550028;1043.6190790361463;1052.2529004406804;1060.5757696921294;1063.3619828103076;18452.35416760407;18656.626867462302;18903.243870245034;18923.526911827314;18946;47153;48130.75934620304;48967.51032489629;49012.509874900796;49235.50764492309;66036.66981665253;67165;68044.31955680579;68250.3174968244;68569.3143068563;5594.720263986866;5734.455226753452;8487.811706360992;8642.092580279232;8948.373613847229;10758.892411075789;13568.660783480493;13716.177029378268;13924.234167120905;14073.577792666236;12243.32661703615;12247.69380765488;12274.815877761663;12656.43046062911;13059.804102938653;11245.325280483197;11658.6502404928;11813.940930295294;12265.325407102695;12352.691182720144;9389.38968967015;11981.341026243641;12108.878911210775;12814.487420503076;13181.406836692564;9741.9025809741;9899.703008909744;9996.250281229082;10039.04629060238;10056.396616203052;6664.266930637529;10955.849635788127;11359.375234362189;11500.884991149982;13269.734605308033 15:51:02 INFO - PROCESS | 23662 | |3;mootools.html;1451.223595376474;1503.7368460519406;1508.5248146833749;1515.6286709756112;1529.2812378182255;8307.709230176944;8613.181747733955;8768.868466973001;8816.955915220424;8929.642814287437;8874.29005679544;9014.819703605925;9031.187193152615;9045.502497362642;9047.14052165045;2494.713107992581;2501.949181343831;2519.659845920805;2522.041624182808;2523.129520315488;2473.962890556634;2548.719640839506;2551.4259291659414;2554.5274124286975;2558.60341647045;2458.6926634170727;2491.0658503061354;2494.7006359236916;2507.7868381187623;2509.498100379922;2362.3621622162004;2392.1627430399394;2395.365228214507;2398.640203969401;2410.7227668818136;2410.1684918703018;2423.7455067217866;2425.34515680767;2455.9508809823706;2469.592517234654;8852.645894164225;8901.599428025755;8930.598123084477;8937.329700272441;8941.105889411007;5290;5425.213344065089;5427.538659213971;5428.67427954324;5432.511074003359;3274.1650879025697;3274.492453669685;3317.4692049272244;3462.7229821614465;3576.624454432299;1357.7895426208954;1374.216696483005;1394.8605139486071;1394.9372278247504;1432.2122832442114;11953.342566158857;12045.39773011346;12102.152849300552;12106.152569320151;12199.93900030503;4790.329353890458;4948.752562371939;5010.3737032870895;5013.974930125399;5016.949830501649;9459.432434053979;9466.100720431548;9469;9485.430874147572;9510.714678559654;5418.322709661293;5420.268263784417;5440.564754819605;5444.945550544444;5448.945510544923;5023.447420783711;5061.417936937226;5070.797168113308;5099.5410413063;5120.61595380348;3866.4200369944733;3945.940810887839;3974.463447434617;4023.4166045923175;4045.8786236412957;1177.4760231696985;1184.6386852010219;1192.2846292224597;1193.0992100963717;1194.0745921910416;873.6068769053824;883.3507372081515;893.8257039877292;927.4759760735298;949.3212353167519;5903.707198371134;5955.642661440327;5968.910466343008;6103.298120716175;6151.384861513813;1056.4084112896803;1101.8898110189077;1104.3925840787535;1108.0470795116355;1145.032447581792;4329.2640251156745;4408.272635015251;4460.219461594208;4462.196804575207;4471.709338892962;10155.136813370946;10235.692929212135;10309.587616495406;10413.219008574388;10568.207384446197;10221.795564088825;10266.743331416774;10289.84565231507;10316.690499285034;10364.222683298633;8140.552269625109;8312.5428101455;8431.451955622864;8442.662293508314;8447.704330348408;6035.577509574287;6125.203723515914;6131.478824299985;6142.692865356625;6212.565120441525;9469.715908522756;9876.209903207582;9890.505474726378;9900.306978511435;9994.250431217542;9001.909980900107;9294.488803115893;9316.906830931875;10032.398056116364;10083.647072352433;7112.893306600508;7292.854142917218;7374.778756637309;7386.852262954818;7505.061867266591;8358.916410835815;8364.330853531581;8374.455660382057;8407.915920840958;8444.240018398374;7473.8878916817375;7527.774166775005;7554.244575542401;7558.848823023619;7713.807154821175;7463.253674632493;7465.402767778456;7465.888011679937;7549.962250188714;7562.508436951581;6501.51238657112;6642.97033959737;6651.401373876374;6651.7006734698025;6654.966725166343;5212.322398088376;5225.503577160163;5252.553532949589;5298.125809241432;5378.946210537844;5317.069512835161;5327.09439395296;5329.680219186861;5387.649802762965;5387.865303367447 15:51:02 INFO - PROCESS | 23662 | |4;prototype.html;387.66467006039784;399.43081109419074;404.1855660843401;406.4817357868715;410.44179915315146;5378.46215378462;5424.582513016804;5659.490645841874;5686.800961966327;5692.914606280904;5401.540869026137;5505.311836020497;5581.534772182258;5603.3836278009385;5623.240862483563;4543.863684089482;4554.407926969506;4566.680332376735;4575.29082992135;4591.563801438858;4475.641948644101;4503.977480112611;4508.413906192191;4570.565796249351;4595.96590767078;4515.864524064284;4518.8418405355815;4523.778579783473;4528.25283828168;4533.863984080483;4532.116237333721;4542.591166794988;4547.8635640930825;4553.840615578439;4568.497465278817;3939.803009849496;4154.148399578079;4165.291900376913;4174.269502837022;4176.415301857743;5471.863203419906;5493.450654934514;5521.613487055908;5531.834044978657;5533.667979921218;5179.818706345298;5212.609054320941;5214.374275087014;5236.240745091978;5294.338207724035;5718.970585294645;5885.676287804169;5926.140709597084;5929.169916211734;5933.525317974551;4492.371068050443;4507.121111383249;4509.323601459774;4532.526928748137;4534.342520334533;6103;6174.567780255384;6184.175668177898;6200.7519699211525;6222.844428889269;4370.978145109254;4624.676272660949;4644.419447569054;4645.465771436328;4697.459792123881;4743.66794324394;4743.857684269477;4750.287456881495;4771.188897887368;4793.161196790547;5248.6325957182635;5261.000819688494;5288.418273989858;5291.322530841106;5305.151175811929;5878.617889837147;5935.2877654681715;5952.880942381128;5968.522518198533;6016.037434010537;1541.175471122944;1575.3462313140149;1581.8926751274155;1583.3508261612683;1604.4196466480507;1107.5514416661265;1136.63059505661;1140.0163715135604;1143.4340001699045;1154.0363796230242;5518.310211223597;5524.1217985885;5604.663720176803;5661.575381846378;5700.657960522299;5884.911726324109;5889.823305300848;5907.911381329283;5946.226990491208;5949.345571987078;5350.384705758887;5546.584006199551;5554.08357620988;5567.220589117527;5586.636868603528;3100.3334283129234;3130.358276553301;3130.88853457024;3131.65551789303;3135.6864313568462;5908.763649454059;6042.12389203563;6065.120557519223;6092.51259899207;6134.9693251534345;5845.561582881301;5904.852378690567;5910.734016969247;5920;5981.491573216325;6063.664479896895;6079.8480037998515;6100.267967843887;6109.205803245639;6120.908186377119;5692.914606280826;5811.024251754424;6043.8186854394435;6046.153538504701;6059.3637668045985;5969.7313620888035;5997.820065398045;6026.578139530191;6031.396860313934;6051.7579296827635;6147.907781383194;6217.207503422999;6228.408301211559;6328;6335.809925702236;4356.651467882625;4376.562343765598;4378.649708023287;4385.342198670225;4415.145638831763;5928.762849485972;6007.639541627516;6142.4336794119;6145.84635384119;6147.784827531015;5814.970925145347;5823.709604073685;5839.824805255849;5860.179574859609;5866.823995280149;5816.476517113311;5869.649980504422;5897.734601943009;5918.644881307136;5938.168656388023;5705.543556515552;5808.896309701143;5816.3892791258;5848.707564621837;5896.321922978912;5904.261967254093;5957.76168953237;5957.851053723692;5959.493443057216;5959.642421454727;5685.289338832646;5694.946434909555;5734.799282025109;5813.709314534171;5826.135636596248 15:51:02 INFO - PROCESS | 23662 | |5;yui.html;835.9582020898954;852.5779739029182;860.1312674199057;889.7197382824411;923.4505469245798;14808.03747756395;15437.45968891089;16978.320867165316;17927.820721792777;18152.455426337197;15551.844481555181;15598.688026239468;15672;16675.332986680547;16757.053682896378;793.111714879336;807.7899746066036;810.8013536683492;811.4482152136545;812.1431889356755;790.6758229126059;792.4611264340247;793.9841203175962;819.9139090395482;822.0546371672565;835.732565579012;842.8019415437398;843.5065486690294;845.4842546046906;847.0513025411517;842.0821304777791;842.7176895739934;844.9873251901226;845.0408786027872;845.7885528617845;613.2365205319406;615.7598536570741;616.5006344860633;618.6968385491122;621.8321053315625;16522.2564984576;16716.665666686597;17480.21339039746;18133.54666133344;18193.454196373998;15020.17389043602;15313;15370;15418.383264669399;15784.131872746995;13350;13636.727265454734;13706.657333566642;13875;14123.435062597484;3951.723379363446;3982.482277303961;4003.2393845169327;4032.5564187939303;4135.6898232632675;76875;78356.21643783546;78520;79832.20167798306;80041.59979200125;12235.204711693712;12286.139970202;12368.690782730504;12438.564650237198;12600.684982875502;24010.87994560016;24271.63592546113;24445.511089778105;24468.510629787306;24599.385015374402;8146.796330091676;8316.792080197922;8375.790605234917;8492.320614350838;8652.178043085896;4692.1554120258;4776.068666609977;4836.226203807374;4840.056189043103;4849.321095046696;3994.400839874042;4047.1298670785923;4059;4068.9796551017057;4134.421181034658;646.731606383355;649.8407890066869;662.4104546953215;664.0935123556311;664.4916638771343;733.7798660401858;759.6961215513838;772.2277722277722;792.5522080024767;804.6861723927673;10211.948940255399;10529.684109476728;10710.625128120479;10770.94614526938;10858.2399232053;781.2500000000064;798.3294033012181;808.5391326943586;813.9308158806449;855.4097672605882;4745.454272758608;5356.276902618175;5362.195670649434;5384;5503.257060296809;67638;70671;74080.62959685166;83933;85884.14115858762;64225.35774642287;66827.66586167038;67824.6608766953;68144.6592767033;68869.65565172142;55672.72163639156;59923.700381497816;60555.394446055856;62655;64409.35590644128;11122.666320010412;11247.381394023407;11295.887041129812;11301.491432885705;11467.4266286687;42586.36120458258;42694;42790.57209427866;43276.783616082976;43508.347374790035;53152.73423632857;55960.72019639876;56005;56414.71792641011;56832.43167568437;13990.860091398956;14000.859991399955;14287.714245715235;15051.1721855299;15142.54572362831;14558.708825823636;15078.472253471515;15948.840511594735;16573.50279491617;16714.498565043068;15111.168885711391;15441.768373474632;15471.5358539244;16215.513534593982;16698.24857881374;14217.218053007184;14350.784738229144;14568.854311457173;15060.849391505944;15452.690946181237;15001.249937502864;15228.314725837143;15293.464728734441;15541.222938852787;16025.599360016093;11866.40667966581;12121.27272363661;12286.508539658671;12573.182743121668;12774.552890648783;11535.884641153481;11626.57162657156;11628.302301861915;11668.244084682441;11762.470688818852 15:51:02 INFO - PROCESS | 23662 | __end_tp_report 15:51:02 INFO - PROCESS | 23662 | __start_cc_report 15:51:02 INFO - PROCESS | 23662 | _x_x_mozilla_cycle_collect,299 15:51:02 INFO - PROCESS | 23662 | __end_cc_report 15:51:02 INFO - PROCESS | 23662 | __startTimestamp1485301862773__endTimestamp 15:51:02 INFO - PROCESS | 23662 | 15:51:02 INFO - PROCESS | 23662 | ------- Summary: start ------- 15:51:02 INFO - PROCESS | 23662 | Number of tests: 6 15:51:02 INFO - PROCESS | 23662 | 15:51:02 INFO - PROCESS | 23662 | [#0] dojo.html Cycles:165 Average:5533.41 Median:5751.68 stddev:644.88 (11.2%) stddev-sans-first:623.23 15:51:02 INFO - PROCESS | 23662 | Values: 3328.5 3344.4 3360.9 3363.1 3370.6 5406.0 5455.8 5495.9 5516.8 5569.5 5595.4 5629.9 5648.1 5673.2 5673.5 5111.3 5146.0 5188.6 5191.0 5226.8 5226.4 5238.2 5240.4 5246.0 5251.7 4939.8 4999.8 5229.1 5240.3 5240.4 5105.3 5109.0 5151.2 5177.0 5270.5 5106.5 5198.1 5203.7 5204.3 5217.8 5641.2 5641.6 5687.9 5715.0 5724.2 5763.3 5815.8 5851.4 5876.8 5881.3 6023.9 6026.1 6030.4 6030.7 6059.7 5579.0 5601.0 5622.8 5623.0 5625.6 5839.9 5842.5 5857.7 5903.5 6107.9 5735.6 5743.7 5751.7 5767.5 5815.2 5836.9 5886.9 5896.5 5896.9 5914.0 5766.8 5793.8 5800.7 5818.6 5819.7 5855.4 5951.9 5955.9 5975.2 5980.4 4145.5 4165.0 4165.6 4182.1 4191.7 3731.9 3741.6 3797.3 3804.9 3808.3 5727.0 5732.7 5739.0 5760.9 5779.1 5895.9 5932.2 5958.6 5966.3 5981.2 5594.3 5619.0 5671.0 5688.2 5716.4 5070.1 5071.9 5110.8 5116.7 5123.8 6224.0 6240.0 6241.2 6242.5 6246.8 5868.4 5896.7 5897.8 5953.1 6004.5 6129.5 6191.5 6195.3 6200.3 6236.2 5818.9 5864.3 5878.8 5894.8 5907.6 5775.2 5804.0 6015.1 6034.1 6041.7 5810.1 5842.2 5871.0 5925.8 5948.9 5898.6 5911.3 5917.8 5922.4 5926.2 5622.2 5888.3 5893.8 5902.3 5906.6 5690.5 5792.6 5885.1 5906.4 5921.9 5685.7 5711.4 5726.5 5743.4 5745.0 15:51:02 INFO - PROCESS | 23662 | 15:51:02 INFO - PROCESS | 23662 | [#1] ext.html Cycles:180 Average:64181.43 Median:377947.00 stddev:123665.72 (32.7%) stddev-sans-first:123920.43 15:51:02 INFO - PROCESS | 23662 | Values: 575.6 592.7 613.5 692.6 696.9 49050.8 49839.5 50077.7 50092.0 50321.2 50518.0 51309.0 51369.5 51637.7 51896.2 9299.0 10828.4 11214.8 11247.4 11459.9 10908.9 11073.0 11129.2 11130.5 11157.6 11261.2 11272.3 11274.3 11349.7 11372.3 11173.3 11204.4 11211.2 11246.0 11298.4 11138.1 11185.6 11208.8 11227.6 11248.9 43149.0 43921.0 43927.0 43940.8 44041.6 4517.8 4519.8 4567.4 4647.4 4663.2 31515.0 31664.0 32164.2 32652.0 33010.5 4344.0 4474.1 4526.0 4557.3 4560.5 373579.0 377870.0 378024.0 378180.0 379987.0 65632.7 65786.7 65991.7 66012.0 66454.3 66510.7 67116.3 67271.7 67465.3 67615.0 18345.3 18408.2 18842.6 18929.2 18974.3 14250.1 14364.9 14409.0 14453.1 14628.9 20164.6 20586.4 20669.4 20811.7 20839.0 7442.6 7573.5 7597.9 7699.6 7821.3 1021.1 1030.3 1037.9 1041.0 1041.0 34078.8 34920.7 35087.3 35421.8 35456.8 1075.6 1130.7 1133.4 1140.4 1144.3 18216.8 18286.5 18337.9 18362.4 18506.2 573593.0 575438.0 575636.0 575696.0 577392.0 71010.0 71015.3 71740.0 71927.3 72031.3 1530.6 1556.0 1558.4 1577.1 1598.7 33230.7 33715.7 33768.7 33952.0 34032.8 60641.7 61434.0 61472.4 61517.0 61620.1 419626.0 421295.0 427834.0 428065.0 429698.0 29844.3 30064.5 30132.0 32382.8 32872.5 48646.4 48834.8 49048.0 49638.0 50280.0 40974.9 42462.8 42899.8 43004.4 43190.0 41992.2 42239.0 42497.8 42621.8 42633.1 41642.0 42281.4 42418.8 43096.0 43185.8 33891.2 35661.8 35811.0 36272.6 36413.3 27853.6 27873.6 27969.3 28117.0 28163.7 15:51:02 INFO - PROCESS | 23662 | 15:51:02 INFO - PROCESS | 23662 | [#2] jquery.html Cycles:180 Average:35908.54 Median:12804.41 stddev:107010.15 (835.7%) stddev-sans-first:107277.18 15:51:02 INFO - PROCESS | 23662 | Values: 431.7 431.8 443.6 451.9 454.4 20757.9 21784.3 22078.0 22111.8 22721.5 22782.5 23122.8 23295.3 24138.5 24365.5 6064.3 6138.2 6315.9 6360.5 6365.0 6031.0 6299.3 6339.3 6345.0 6346.9 6341.1 6434.6 6442.9 6444.8 6454.8 6333.9 6399.1 6437.4 6457.6 6480.3 6344.7 6348.6 6358.1 6361.4 6368.7 15674.8 15815.3 22839.8 26437.3 26817.2 3062.0 3185.6 3219.3 3295.9 3319.3 11501.5 11676.4 11707.6 11717.0 11755.9 1970.7 2013.8 2033.6 2039.8 2046.7 100365.5 102900.0 107040.0 110043.4 110776.4 12792.4 12945.9 12962.2 13035.7 13217.3 18409.4 18487.4 18609.1 18624.8 18642.8 9335.6 9412.0 9544.6 9571.4 9642.0 8897.6 8944.1 8957.2 9001.2 9164.1 5459.9 5512.1 5532.3 5559.4 5657.2 1897.7 2255.1 2304.6 2305.1 2313.5 955.6 967.2 977.2 985.0 996.5 21660.2 21883.7 21927.8 22013.1 22026.9 975.9 977.9 986.7 992.3 1009.5 11599.5 12014.6 12251.9 12364.4 12386.6 614461.0 633128.0 661511.0 664981.0 666369.0 113802.4 114568.0 114969.0 115553.4 116085.0 1031.4 1043.6 1052.3 1060.6 1063.4 18452.4 18656.6 18903.2 18923.5 18946.0 47153.0 48130.8 48967.5 49012.5 49235.5 66036.7 67165.0 68044.3 68250.3 68569.3 5594.7 5734.5 8487.8 8642.1 8948.4 10758.9 13568.7 13716.2 13924.2 14073.6 12243.3 12247.7 12274.8 12656.4 13059.8 11245.3 11658.7 11813.9 12265.3 12352.7 9389.4 11981.3 12108.9 12814.5 13181.4 9741.9 9899.7 9996.3 10039.0 10056.4 6664.3 10955.8 11359.4 11500.9 13269.7 15:51:02 INFO - PROCESS | 23662 | 15:51:02 INFO - PROCESS | 23662 | [#3] mootools.html Cycles:180 Average:5772.35 Median:5294.06 stddev:3120.85 (59.0%) stddev-sans-first:3112.71 15:51:02 INFO - PROCESS | 23662 | Values: 1451.2 1503.7 1508.5 1515.6 1529.3 8307.7 8613.2 8768.9 8817.0 8929.6 8874.3 9014.8 9031.2 9045.5 9047.1 2494.7 2501.9 2519.7 2522.0 2523.1 2474.0 2548.7 2551.4 2554.5 2558.6 2458.7 2491.1 2494.7 2507.8 2509.5 2362.4 2392.2 2395.4 2398.6 2410.7 2410.2 2423.7 2425.3 2456.0 2469.6 8852.6 8901.6 8930.6 8937.3 8941.1 5290.0 5425.2 5427.5 5428.7 5432.5 3274.2 3274.5 3317.5 3462.7 3576.6 1357.8 1374.2 1394.9 1394.9 1432.2 11953.3 12045.4 12102.2 12106.2 12199.9 4790.3 4948.8 5010.4 5014.0 5016.9 9459.4 9466.1 9469.0 9485.4 9510.7 5418.3 5420.3 5440.6 5444.9 5448.9 5023.4 5061.4 5070.8 5099.5 5120.6 3866.4 3945.9 3974.5 4023.4 4045.9 1177.5 1184.6 1192.3 1193.1 1194.1 873.6 883.4 893.8 927.5 949.3 5903.7 5955.6 5968.9 6103.3 6151.4 1056.4 1101.9 1104.4 1108.0 1145.0 4329.3 4408.3 4460.2 4462.2 4471.7 10155.1 10235.7 10309.6 10413.2 10568.2 10221.8 10266.7 10289.8 10316.7 10364.2 8140.6 8312.5 8431.5 8442.7 8447.7 6035.6 6125.2 6131.5 6142.7 6212.6 9469.7 9876.2 9890.5 9900.3 9994.3 9001.9 9294.5 9316.9 10032.4 10083.6 7112.9 7292.9 7374.8 7386.9 7505.1 8358.9 8364.3 8374.5 8407.9 8444.2 7473.9 7527.8 7554.2 7558.8 7713.8 7463.3 7465.4 7465.9 7550.0 7562.5 6501.5 6643.0 6651.4 6651.7 6655.0 5212.3 5225.5 5252.6 5298.1 5378.9 5317.1 5327.1 5329.7 5387.6 5387.9 15:51:02 INFO - PROCESS | 23662 | 15:51:02 INFO - PROCESS | 23662 | [#4] prototype.html Cycles:180 Average:5014.78 Median:5584.09 stddev:1406.13 (25.2%) stddev-sans-first:1366.51 15:51:02 INFO - PROCESS | 23662 | Values: 387.7 399.4 404.2 406.5 410.4 5378.5 5424.6 5659.5 5686.8 5692.9 5401.5 5505.3 5581.5 5603.4 5623.2 4543.9 4554.4 4566.7 4575.3 4591.6 4475.6 4504.0 4508.4 4570.6 4596.0 4515.9 4518.8 4523.8 4528.3 4533.9 4532.1 4542.6 4547.9 4553.8 4568.5 3939.8 4154.1 4165.3 4174.3 4176.4 5471.9 5493.5 5521.6 5531.8 5533.7 5179.8 5212.6 5214.4 5236.2 5294.3 5719.0 5885.7 5926.1 5929.2 5933.5 4492.4 4507.1 4509.3 4532.5 4534.3 6103.0 6174.6 6184.2 6200.8 6222.8 4371.0 4624.7 4644.4 4645.5 4697.5 4743.7 4743.9 4750.3 4771.2 4793.2 5248.6 5261.0 5288.4 5291.3 5305.2 5878.6 5935.3 5952.9 5968.5 6016.0 1541.2 1575.3 1581.9 1583.4 1604.4 1107.6 1136.6 1140.0 1143.4 1154.0 5518.3 5524.1 5604.7 5661.6 5700.7 5884.9 5889.8 5907.9 5946.2 5949.3 5350.4 5546.6 5554.1 5567.2 5586.6 3100.3 3130.4 3130.9 3131.7 3135.7 5908.8 6042.1 6065.1 6092.5 6135.0 5845.6 5904.9 5910.7 5920.0 5981.5 6063.7 6079.8 6100.3 6109.2 6120.9 5692.9 5811.0 6043.8 6046.2 6059.4 5969.7 5997.8 6026.6 6031.4 6051.8 6147.9 6217.2 6228.4 6328.0 6335.8 4356.7 4376.6 4378.6 4385.3 4415.1 5928.8 6007.6 6142.4 6145.8 6147.8 5815.0 5823.7 5839.8 5860.2 5866.8 5816.5 5869.6 5897.7 5918.6 5938.2 5705.5 5808.9 5816.4 5848.7 5896.3 5904.3 5957.8 5957.9 5959.5 5959.6 5685.3 5694.9 5734.8 5813.7 5826.1 15:51:02 INFO - PROCESS | 23662 | 15:51:02 INFO - PROCESS | 23662 | [#5] yui.html Cycles:180 Average:18146.44 Median:42640.18 stddev:21953.93 (51.5%) stddev-sans-first:21977.03 15:51:02 INFO - PROCESS | 23662 | Values: 836.0 852.6 860.1 889.7 923.5 14808.0 15437.5 16978.3 17927.8 18152.5 15551.8 15598.7 15672.0 16675.3 16757.1 793.1 807.8 810.8 811.4 812.1 790.7 792.5 794.0 819.9 822.1 835.7 842.8 843.5 845.5 847.1 842.1 842.7 845.0 845.0 845.8 613.2 615.8 616.5 618.7 621.8 16522.3 16716.7 17480.2 18133.5 18193.5 15020.2 15313.0 15370.0 15418.4 15784.1 13350.0 13636.7 13706.7 13875.0 14123.4 3951.7 3982.5 4003.2 4032.6 4135.7 76875.0 78356.2 78520.0 79832.2 80041.6 12235.2 12286.1 12368.7 12438.6 12600.7 24010.9 24271.6 24445.5 24468.5 24599.4 8146.8 8316.8 8375.8 8492.3 8652.2 4692.2 4776.1 4836.2 4840.1 4849.3 3994.4 4047.1 4059.0 4069.0 4134.4 646.7 649.8 662.4 664.1 664.5 733.8 759.7 772.2 792.6 804.7 10211.9 10529.7 10710.6 10770.9 10858.2 781.3 798.3 808.5 813.9 855.4 4745.5 5356.3 5362.2 5384.0 5503.3 67638.0 70671.0 74080.6 83933.0 85884.1 64225.4 66827.7 67824.7 68144.7 68869.7 55672.7 59923.7 60555.4 62655.0 64409.4 11122.7 11247.4 11295.9 11301.5 11467.4 42586.4 42694.0 42790.6 43276.8 43508.3 53152.7 55960.7 56005.0 56414.7 56832.4 13990.9 14000.9 14287.7 15051.2 15142.5 14558.7 15078.5 15948.8 16573.5 16714.5 15111.2 15441.8 15471.5 16215.5 16698.2 14217.2 14350.8 14568.9 15060.8 15452.7 15001.2 15228.3 15293.5 15541.2 16025.6 11866.4 12121.3 12286.5 12573.2 12774.6 11535.9 11626.6 11628.3 11668.2 11762.5 15:51:02 INFO - PROCESS | 23662 | -------- Summary: end -------- 15:51:02 INFO - PROCESS | 23662 | 15:51:03 INFO - TEST-INFO | 23662: exit 0 15:51:03 INFO - TEST-OK | dromaeo_css | took 1111826ms 15:51:03 INFO - TEST-START | kraken 15:51:03 INFO - operating with platform_type : linux_ 15:51:03 INFO - Initialising browser for kraken test... 15:51:03 INFO - TEST-INFO | started process 24027 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbVVrmV/profile http://localhost:60351/getInfo.html) 15:51:07 INFO - PROCESS | 24027 | __metrics Screen width/height:1600/1200 15:51:07 INFO - PROCESS | 24027 | colorDepth:24 15:51:07 INFO - PROCESS | 24027 | Browser inner width/height: 1024/697 15:51:07 INFO - PROCESS | 24027 | __metrics 15:51:08 INFO - PROCESS | 24027 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 15:51:08 ERROR - PROCESS | 24027 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 15:51:09 INFO - TEST-INFO | 24027: exit 0 15:51:09 INFO - Browser initialized. 15:51:09 INFO - Running cycle 1/1 for kraken test... 15:51:09 INFO - TEST-INFO | started process 24153 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbVVrmV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:51:21 INFO - PROCESS | 24153 | RSS: Main: 144601088 15:51:21 INFO - PROCESS | 24153 | 15:51:23 INFO - PROCESS | 24153 | Cycle 1(1): loaded http://localhost:60351/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60351/tests/kraken/driver.html?testName=audio-beat-detection) 15:51:24 INFO - PROCESS | 24153 | RSS: Main: 151257088 15:51:24 INFO - PROCESS | 24153 | 15:51:27 INFO - PROCESS | 24153 | Cycle 1(1): loaded http://localhost:60351/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60351/tests/kraken/driver.html?testName=audio-dft) 15:51:27 INFO - PROCESS | 24153 | RSS: Main: 150179840 15:51:27 INFO - PROCESS | 24153 | 15:51:30 INFO - PROCESS | 24153 | Cycle 1(1): loaded http://localhost:60351/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60351/tests/kraken/driver.html?testName=audio-fft) 15:51:31 INFO - PROCESS | 24153 | RSS: Main: 149889024 15:51:31 INFO - PROCESS | 24153 | 15:51:33 INFO - PROCESS | 24153 | Cycle 1(1): loaded http://localhost:60351/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60351/tests/kraken/driver.html?testName=audio-oscillator) 15:51:33 INFO - PROCESS | 24153 | RSS: Main: 149319680 15:51:33 INFO - PROCESS | 24153 | 15:51:35 INFO - PROCESS | 24153 | Cycle 1(1): loaded http://localhost:60351/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60351/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:51:36 INFO - PROCESS | 24153 | RSS: Main: 149938176 15:51:36 INFO - PROCESS | 24153 | 15:51:39 INFO - PROCESS | 24153 | Cycle 1(1): loaded http://localhost:60351/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60351/tests/kraken/driver.html?testName=imaging-darkroom) 15:51:40 INFO - PROCESS | 24153 | RSS: Main: 152739840 15:51:40 INFO - PROCESS | 24153 | 15:51:43 INFO - PROCESS | 24153 | Cycle 1(1): loaded http://localhost:60351/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60351/tests/kraken/driver.html?testName=imaging-desaturate) 15:51:44 INFO - PROCESS | 24153 | RSS: Main: 153604096 15:51:44 INFO - PROCESS | 24153 | 15:51:47 INFO - PROCESS | 24153 | Cycle 1(1): loaded http://localhost:60351/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60351/tests/kraken/driver.html?testName=json-parse-financial) 15:51:47 INFO - PROCESS | 24153 | RSS: Main: 153104384 15:51:47 INFO - PROCESS | 24153 | 15:51:49 INFO - PROCESS | 24153 | Cycle 1(1): loaded http://localhost:60351/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60351/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:51:49 INFO - PROCESS | 24153 | RSS: Main: 152309760 15:51:49 INFO - PROCESS | 24153 | 15:51:51 INFO - PROCESS | 24153 | Cycle 1(1): loaded http://localhost:60351/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60351/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:51:52 INFO - PROCESS | 24153 | RSS: Main: 152330240 15:51:52 INFO - PROCESS | 24153 | 15:51:54 INFO - PROCESS | 24153 | Cycle 1(1): loaded http://localhost:60351/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60351/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:51:54 INFO - PROCESS | 24153 | RSS: Main: 152432640 15:51:54 INFO - PROCESS | 24153 | 15:51:57 INFO - PROCESS | 24153 | Cycle 1(1): loaded http://localhost:60351/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60351/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:51:58 INFO - PROCESS | 24153 | RSS: Main: 152494080 15:51:58 INFO - PROCESS | 24153 | 15:52:00 INFO - PROCESS | 24153 | Cycle 1(1): loaded http://localhost:60351/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60351/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:52:01 INFO - PROCESS | 24153 | RSS: Main: 153067520 15:52:01 INFO - PROCESS | 24153 | 15:52:03 INFO - PROCESS | 24153 | Cycle 1(1): loaded http://localhost:60351/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60351/tests/kraken/driver.html?testName=ai-astar) 15:52:03 INFO - PROCESS | 24153 | RSS: Main: 154660864 15:52:03 INFO - PROCESS | 24153 | 15:52:03 INFO - PROCESS | 24153 | __start_tp_report 15:52:03 INFO - PROCESS | 24153 | _x_x_mozilla_page_load 15:52:03 INFO - PROCESS | 24153 | _x_x_mozilla_page_load_details 15:52:03 INFO - PROCESS | 24153 | |i|pagename|runs| 15:52:03 INFO - PROCESS | 24153 | |0;ai-astar;105;118;113;114;112;113;113;113;112;112 15:52:03 INFO - PROCESS | 24153 | |1;audio-beat-detection;139;118;119;163;118;121;118;120;136;119 15:52:03 INFO - PROCESS | 24153 | |2;audio-dft;162;162;163;162;161;161;161;163;162;162 15:52:03 INFO - PROCESS | 24153 | |3;audio-fft;78;76;75;113;77;77;77;76;94;75 15:52:03 INFO - PROCESS | 24153 | |4;audio-oscillator;83;82;101;84;83;83;92;83;83;104 15:52:03 INFO - PROCESS | 24153 | |5;imaging-gaussian-blur;118;118;117;118;117;118;118;118;118;119 15:52:03 INFO - PROCESS | 24153 | |6;imaging-darkroom;148;148;148;148;148;147;148;147;148;148 15:52:03 INFO - PROCESS | 24153 | |7;imaging-desaturate;96;96;96;97;95;96;96;95;96;95 15:52:03 INFO - PROCESS | 24153 | |8;json-parse-financial;55;55;58;58;55;58;56;58;59;57 15:52:03 INFO - PROCESS | 24153 | |9;json-stringify-tinderbox;64;63;64;64;65;65;64;65;64;65 15:52:03 INFO - PROCESS | 24153 | |10;stanford-crypto-aes;78;77;85;77;76;78;76;76;84;79 15:52:03 INFO - PROCESS | 24153 | |11;stanford-crypto-ccm;122;131;125;120;124;120;121;137;163;122 15:52:03 INFO - PROCESS | 24153 | |12;stanford-crypto-pbkdf2;162;160;158;162;164;158;163;159;158;162 15:52:03 INFO - PROCESS | 24153 | |13;stanford-crypto-sha256-iterative;62;60;64;63;60;63;64;60;59;63 15:52:03 INFO - PROCESS | 24153 | __end_tp_report 15:52:03 INFO - PROCESS | 24153 | __start_cc_report 15:52:03 INFO - PROCESS | 24153 | _x_x_mozilla_cycle_collect,716 15:52:03 INFO - PROCESS | 24153 | __end_cc_report 15:52:03 INFO - PROCESS | 24153 | __startTimestamp1485301923424__endTimestamp 15:52:03 INFO - PROCESS | 24153 | 15:52:03 INFO - PROCESS | 24153 | ------- Summary: start ------- 15:52:03 INFO - PROCESS | 24153 | Number of tests: 14 15:52:03 INFO - PROCESS | 24153 | 15:52:03 INFO - PROCESS | 24153 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:3.17 (2.8%) stddev-sans-first:1.87 15:52:03 INFO - PROCESS | 24153 | Values: 105.0 118.0 113.0 114.0 112.0 113.0 113.0 113.0 112.0 112.0 15:52:03 INFO - PROCESS | 24153 | 15:52:03 INFO - PROCESS | 24153 | [#1] audio-beat-detection Cycles:10 Average:127.10 Median:120.50 stddev:14.82 (12.3%) stddev-sans-first:15.08 15:52:03 INFO - PROCESS | 24153 | Values: 139.0 118.0 119.0 163.0 118.0 121.0 118.0 120.0 136.0 119.0 15:52:03 INFO - PROCESS | 24153 | 15:52:03 INFO - PROCESS | 24153 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 15:52:03 INFO - PROCESS | 24153 | Values: 162.0 162.0 163.0 162.0 161.0 161.0 161.0 163.0 162.0 162.0 15:52:03 INFO - PROCESS | 24153 | 15:52:03 INFO - PROCESS | 24153 | [#3] audio-fft Cycles:10 Average:81.80 Median:77.00 stddev:12.32 (16.0%) stddev-sans-first:12.99 15:52:03 INFO - PROCESS | 24153 | Values: 78.0 76.0 75.0 113.0 77.0 77.0 77.0 76.0 94.0 75.0 15:52:03 INFO - PROCESS | 24153 | 15:52:03 INFO - PROCESS | 24153 | [#4] audio-oscillator Cycles:10 Average:87.80 Median:83.00 stddev:8.28 (10.0%) stddev-sans-first:8.60 15:52:03 INFO - PROCESS | 24153 | Values: 83.0 82.0 101.0 84.0 83.0 83.0 92.0 83.0 83.0 104.0 15:52:03 INFO - PROCESS | 24153 | 15:52:03 INFO - PROCESS | 24153 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 15:52:03 INFO - PROCESS | 24153 | Values: 118.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 118.0 119.0 15:52:03 INFO - PROCESS | 24153 | 15:52:03 INFO - PROCESS | 24153 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 15:52:03 INFO - PROCESS | 24153 | Values: 148.0 148.0 148.0 148.0 148.0 147.0 148.0 147.0 148.0 148.0 15:52:03 INFO - PROCESS | 24153 | 15:52:03 INFO - PROCESS | 24153 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 15:52:03 INFO - PROCESS | 24153 | Values: 96.0 96.0 96.0 97.0 95.0 96.0 96.0 95.0 96.0 95.0 15:52:03 INFO - PROCESS | 24153 | 15:52:03 INFO - PROCESS | 24153 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:58.00 stddev:1.52 (2.6%) stddev-sans-first:1.45 15:52:03 INFO - PROCESS | 24153 | Values: 55.0 55.0 58.0 58.0 55.0 58.0 56.0 58.0 59.0 57.0 15:52:03 INFO - PROCESS | 24153 | 15:52:03 INFO - PROCESS | 24153 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 15:52:03 INFO - PROCESS | 24153 | Values: 64.0 63.0 64.0 64.0 65.0 65.0 64.0 65.0 64.0 65.0 15:52:03 INFO - PROCESS | 24153 | 15:52:03 INFO - PROCESS | 24153 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:78.00 stddev:3.27 (4.2%) stddev-sans-first:3.46 15:52:03 INFO - PROCESS | 24153 | Values: 78.0 77.0 85.0 77.0 76.0 78.0 76.0 76.0 84.0 79.0 15:52:03 INFO - PROCESS | 24153 | 15:52:03 INFO - PROCESS | 24153 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:124.50 stddev:13.28 (10.7%) stddev-sans-first:13.87 15:52:03 INFO - PROCESS | 24153 | Values: 122.0 131.0 125.0 120.0 124.0 120.0 121.0 137.0 163.0 122.0 15:52:03 INFO - PROCESS | 24153 | 15:52:03 INFO - PROCESS | 24153 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:162.00 stddev:2.27 (1.4%) stddev-sans-first:2.35 15:52:03 INFO - PROCESS | 24153 | Values: 162.0 160.0 158.0 162.0 164.0 158.0 163.0 159.0 158.0 162.0 15:52:03 INFO - PROCESS | 24153 | 15:52:03 INFO - PROCESS | 24153 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:63.00 stddev:1.87 (3.0%) stddev-sans-first:1.99 15:52:03 INFO - PROCESS | 24153 | Values: 62.0 60.0 64.0 63.0 60.0 63.0 64.0 60.0 59.0 63.0 15:52:03 INFO - PROCESS | 24153 | -------- Summary: end -------- 15:52:03 INFO - PROCESS | 24153 | 15:52:04 INFO - TEST-INFO | 24153: exit 0 15:52:04 INFO - TEST-OK | kraken | took 60909ms 15:52:04 INFO - SUITE-END | took 1172s 15:52:04 INFO - Completed test suite (00:19:32) 15:52:04 INFO - javascript benchmark 15:52:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7694.250698480233, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3328.4508056170735, 3344.4147274227003, 3360.8823691170815, 3363.0583436637744, 3370.6292307846134, 5405.972970135153, 5455.754491047913, 5495.862603434916, 5516.813885014726, 5569.470900264479, 5595.356533998592, 5629.943700563003, 5648.124540696188, 5673.177389278552, 5673.461021202989, 5111.258867464216, 5145.974270128644, 5188.6367954243215, 5191.0, 5226.7647955841885, 5226.425093239741, 5238.240455134003, 5240.397354304266, 5245.973770131144, 5251.711155886424, 4939.777710003059, 4999.825006124786, 5229.111051121299, 5240.34495688039, 5240.397354304266, 5105.336306280178, 5108.978204359106, 5151.201563757623, 5177.016366890279, 5270.4729527047375, 5106.514881086328, 5198.090334191501, 5203.713795741232, 5204.271402003723, 5217.765200565984, 5641.210230567724, 5641.633293835887, 5687.857803554903, 5715.028445164332, 5724.169995350692, 5763.279590051244, 5815.796447124372, 5851.38560451155, 5876.764929402819, 5881.264841894763, 6023.939760602381, 6026.126211699279, 6030.396960303979, 6030.698465076729, 6059.697015149225, 5579.0, 5601.047821870292, 5622.8313150605545, 5623.0, 5625.634333768333, 5839.854003649858, 5842.503387212049, 5857.677827719431, 5903.527717782567, 6107.938920610737, 5735.569832262597, 5743.741531631086, 5751.683657398883, 5767.509761670221, 5815.185873977646, 5836.941630583725, 5886.8822623547285, 5896.498797602166, 5896.882062358729, 5914.0241860093465, 5766.769329226868, 5793.797217097382, 5800.6809625471005, 5818.6217895836635, 5819.709014549256, 5855.355910849803, 5951.9107213391835, 5955.910661340084, 5975.223220981332, 5980.401959804072, 4145.54399016108, 4164.9583504165175, 4165.562615925345, 4182.121754431603, 4191.7275377100395, 3731.906702332409, 3741.5510138782975, 3797.3354662933875, 3804.866829661004, 3808.333541630204, 5726.9713651431475, 5732.6847023413275, 5738.971305143447, 5760.884782304414, 5779.133130030445, 5895.882082358329, 5932.228810254725, 5958.582899197101, 5966.254218222723, 5981.222441082631, 5594.272744543265, 5619.044762390404, 5671.035923892948, 5688.232088667977, 5716.371199168088, 5070.062038522885, 5071.923921141186, 5110.8466745997675, 5116.667416617908, 5123.769430375568, 6224.0, 6240.0, 6241.188645476059, 6242.469390101802, 6246.750129994749, 5868.413158684269, 5896.705164741831, 5897.823065308047, 5953.136795164591, 6004.549658775697, 6129.511613758974, 6191.473724733448, 6195.256569211723, 6200.255969283715, 6236.220472440945, 5818.94181058184, 5864.296284445893, 5878.794242201502, 5894.823155305347, 5907.616004959664, 5775.1914731938405, 5804.0, 6015.097735339734, 6034.064719968412, 6041.728122234598, 5810.128480727924, 5842.211301474416, 5871.03127983895, 5925.762969481172, 5948.851278717893, 5898.616589921641, 5911.349751527243, 5917.763289468545, 5922.378150294157, 5926.2295901532525, 5622.156676498558, 5888.263967004124, 5893.793717219876, 5902.321233058254, 5906.557008224315, 5690.459406356389, 5792.623479473821, 5885.146653735099, 5906.379830117776, 5921.940780592139, 5685.715714214355, 5711.371749107512, 5726.513246373938, 5743.368229494668, 5744.971275143597], "value": 5488.5396920212315, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.6200907401117, 592.703648175912, 613.4601550635441, 692.5740669488266, 696.9407600353969, 49050.75474622627, 49839.50160498398, 50077.74961125189, 50092.0, 50321.24518132231, 50518.0, 51309.0, 51369.48630513694, 51637.74181129089, 51896.22155667668, 9298.95350523248, 10828.40443775592, 11214.831777523344, 11247.437628118601, 11459.942700286487, 10908.945455272753, 11073.0, 11129.165312601588, 11130.49912753928, 11157.609483668073, 11261.155413343991, 11272.323660580392, 11274.323540587591, 11349.716257093598, 11372.317660940329, 11173.273737207137, 11204.439778011067, 11211.215214934959, 11246.0, 11298.378589177591, 11138.053265472363, 11185.608503702331, 11208.775824483546, 11227.607033753779, 11248.887511124865, 43149.0, 43921.0, 43927.0, 43940.78029609864, 44041.559584404065, 4517.819287228507, 4519.796609152596, 4567.383403240553, 4647.37260469839, 4663.183942809995, 31515.0, 31664.0, 32164.195895102577, 32652.02043938662, 33010.504842427385, 4344.0, 4474.082813023322, 4526.0, 4557.270836666151, 4560.543945605446, 373579.0, 377870.0, 378024.0, 378180.0, 379987.0, 65632.67183664147, 65786.67106664531, 65991.67004165045, 66012.0, 66454.33545664579, 66510.66744666343, 67116.328836711, 67271.66364168246, 67465.32534674689, 67615.0, 18345.266189352544, 18408.17163227658, 18842.62314753697, 18929.242830286636, 18974.335898243495, 14250.144991300554, 14364.928175359057, 14409.0, 14453.132812031312, 14628.926855365655, 20164.596708065757, 20586.382408527767, 20669.379918602466, 20811.68782468264, 20839.0, 7442.553446793209, 7573.46985710995, 7597.886031709529, 7699.574633990275, 7821.256980586835, 1021.070825548747, 1030.3302853145365, 1037.8910214427528, 1040.9739756506149, 1041.0422411381546, 34078.82960585181, 34920.65079349225, 35087.29825403477, 35421.822890885895, 35456.822715886774, 1075.5858994287255, 1130.7455822439886, 1133.3766428464312, 1140.4183866228284, 1144.2733863996423, 18216.817831821776, 18286.45140645783, 18337.908310458628, 18362.449126526226, 18506.167222475022, 573593.0, 575438.0, 575636.0, 575696.0, 577392.0, 71010.0, 71015.2898471019, 71740.0, 71927.28072719206, 72031.27968720351, 1530.556138719781, 1555.968880622404, 1558.3532833874042, 1577.1404584501474, 1598.7442009278693, 33230.66769332276, 33715.662843371254, 33768.662313377536, 33952.0, 34032.829835850665, 60641.69679151753, 61434.0, 61472.38527614667, 61517.0, 61620.07569886545, 419626.0, 421295.0, 427834.0, 428065.0, 429698.0, 29844.253893652833, 30064.549031764105, 30132.0, 32382.83808580942, 32872.50691239585, 48646.37901387617, 48834.755826220644, 49048.0, 49638.0, 50280.0, 40974.90754759151, 42462.78768606137, 42899.84754426791, 43004.35493467538, 43190.0, 41992.16015679608, 42238.985699074015, 42497.78751106225, 42621.78689106535, 42633.147337053706, 41642.0, 42281.365779512715, 42418.78790606027, 43096.0, 43185.78407107944, 33891.152721181184, 35661.82169089138, 35811.0, 36272.637273626926, 36413.27173456463, 27853.582196266667, 27873.581896271167, 27969.300767480974, 28117.0, 28163.71836281611], "value": 22176.756441610218, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.67408606502084, 431.7862657984297, 443.5675216663755, 451.8666993236995, 454.3661592079048, 20757.896210518964, 21784.346469605898, 22078.0, 22111.778882211172, 22721.54556908861, 22782.54434911305, 23122.768772312273, 23295.3011409658, 24138.517229655397, 24365.512689746196, 6064.3026052003925, 6138.232720909887, 6315.873682526347, 6360.491160707155, 6364.968175159118, 6030.969845150768, 6299.307076221612, 6339.334369891164, 6345.0, 6346.936530634704, 6341.11224428578, 6434.646094464802, 6442.93557064428, 6444.774432894849, 6454.838629034265, 6333.904991425109, 6399.072134540489, 6437.356264373572, 6457.6448295343735, 6480.254770701383, 6344.7462101515885, 6348.587341822767, 6358.078078678565, 6361.3638636136475, 6368.745250189987, 15674.764878526832, 15815.288312025987, 22839.77160228393, 26437.33906652349, 26817.195484135507, 3061.9693803062128, 3185.6177258728867, 3219.2917558137174, 3295.8681652733862, 3319.2531680371962, 11501.482433290439, 11676.357800320979, 11707.648770536813, 11717.0, 11755.88244117565, 1970.6846904495355, 2013.7885522020124, 2033.5831154613418, 2039.775624681284, 2046.7134601155851, 100365.49817250867, 102900.0, 107040.0, 110043.44978275057, 110776.4461177689, 12792.360381980863, 12945.935270323587, 12962.157459765274, 13035.739285214433, 13217.273049982343, 18409.447716568524, 18487.352942646943, 18609.06954652262, 18624.813751862577, 18642.81357186438, 9335.626574937063, 9412.0, 9544.618215271312, 9571.425714457155, 9642.0, 8897.555122243863, 8944.118965848604, 8957.238634715992, 9001.234895033995, 9164.129407706258, 5459.890802183934, 5512.097235984491, 5532.336119665666, 5559.416261292506, 5657.179708942181, 1897.7058555923854, 2255.142151479184, 2304.5621331946877, 2305.1240528599023, 2313.5141620259933, 955.6082006377352, 967.1682353176262, 977.2084611464594, 985.0006729508664, 996.5465713100522, 21660.241891534035, 21883.67174492384, 21927.780722192892, 22013.11947522113, 22026.88986555057, 975.8975307592742, 977.9070988256104, 986.7286496213599, 992.3103443106971, 1009.4700282351824, 11599.478023488964, 12014.63956081319, 12251.877481225252, 12364.381780910919, 12386.62840114798, 614461.0, 633128.0, 661511.0, 664981.0252846212, 666369.0, 113802.43098784453, 114568.0, 114969.0, 115553.42223288998, 116085.0, 1031.3605564550028, 1043.6190790361463, 1052.2529004406804, 1060.5757696921294, 1063.3619828103076, 18452.35416760407, 18656.626867462302, 18903.243870245034, 18923.526911827314, 18946.0, 47153.0, 48130.75934620304, 48967.51032489629, 49012.509874900796, 49235.50764492309, 66036.66981665253, 67165.0, 68044.31955680579, 68250.3174968244, 68569.3143068563, 5594.720263986866, 5734.455226753452, 8487.811706360992, 8642.092580279232, 8948.373613847229, 10758.892411075789, 13568.660783480493, 13716.177029378268, 13924.234167120905, 14073.577792666236, 12243.32661703615, 12247.69380765488, 12274.815877761663, 12656.43046062911, 13059.804102938653, 11245.325280483197, 11658.6502404928, 11813.940930295294, 12265.325407102695, 12352.691182720144, 9389.38968967015, 11981.341026243641, 12108.878911210775, 12814.487420503076, 13181.406836692564, 9741.9025809741, 9899.703008909744, 9996.250281229082, 10039.04629060238, 10056.396616203052, 6664.266930637529, 10955.849635788127, 11359.375234362189, 11500.884991149982, 13269.734605308033], "value": 10243.727988571773, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1451.223595376474, 1503.7368460519406, 1508.5248146833749, 1515.6286709756112, 1529.2812378182255, 8307.709230176944, 8613.181747733955, 8768.868466973001, 8816.955915220424, 8929.642814287437, 8874.29005679544, 9014.819703605925, 9031.187193152615, 9045.502497362642, 9047.14052165045, 2494.713107992581, 2501.949181343831, 2519.659845920805, 2522.041624182808, 2523.129520315488, 2473.962890556634, 2548.719640839506, 2551.4259291659414, 2554.5274124286975, 2558.60341647045, 2458.6926634170727, 2491.0658503061354, 2494.7006359236916, 2507.7868381187623, 2509.498100379922, 2362.3621622162004, 2392.1627430399394, 2395.365228214507, 2398.640203969401, 2410.7227668818136, 2410.1684918703018, 2423.7455067217866, 2425.34515680767, 2455.9508809823706, 2469.592517234654, 8852.645894164225, 8901.599428025755, 8930.598123084477, 8937.329700272441, 8941.105889411007, 5290.0, 5425.213344065089, 5427.538659213971, 5428.67427954324, 5432.511074003359, 3274.1650879025697, 3274.492453669685, 3317.4692049272244, 3462.7229821614465, 3576.624454432299, 1357.7895426208954, 1374.216696483005, 1394.8605139486071, 1394.9372278247504, 1432.2122832442114, 11953.342566158857, 12045.39773011346, 12102.152849300552, 12106.152569320151, 12199.93900030503, 4790.329353890458, 4948.752562371939, 5010.3737032870895, 5013.974930125399, 5016.949830501649, 9459.432434053979, 9466.100720431548, 9469.0, 9485.430874147572, 9510.714678559654, 5418.322709661293, 5420.268263784417, 5440.564754819605, 5444.945550544444, 5448.945510544923, 5023.447420783711, 5061.417936937226, 5070.797168113308, 5099.5410413063, 5120.61595380348, 3866.4200369944733, 3945.940810887839, 3974.463447434617, 4023.4166045923175, 4045.8786236412957, 1177.4760231696985, 1184.6386852010219, 1192.2846292224597, 1193.0992100963717, 1194.0745921910416, 873.6068769053824, 883.3507372081515, 893.8257039877292, 927.4759760735298, 949.3212353167519, 5903.707198371134, 5955.642661440327, 5968.910466343008, 6103.298120716175, 6151.384861513813, 1056.4084112896803, 1101.8898110189077, 1104.3925840787535, 1108.0470795116355, 1145.032447581792, 4329.2640251156745, 4408.272635015251, 4460.219461594208, 4462.196804575207, 4471.709338892962, 10155.136813370946, 10235.692929212135, 10309.587616495406, 10413.219008574388, 10568.207384446197, 10221.795564088825, 10266.743331416774, 10289.84565231507, 10316.690499285034, 10364.222683298633, 8140.552269625109, 8312.5428101455, 8431.451955622864, 8442.662293508314, 8447.704330348408, 6035.577509574287, 6125.203723515914, 6131.478824299985, 6142.692865356625, 6212.565120441525, 9469.715908522756, 9876.209903207582, 9890.505474726378, 9900.306978511435, 9994.250431217542, 9001.909980900107, 9294.488803115893, 9316.906830931875, 10032.398056116364, 10083.647072352433, 7112.893306600508, 7292.854142917218, 7374.778756637309, 7386.852262954818, 7505.061867266591, 8358.916410835815, 8364.330853531581, 8374.455660382057, 8407.915920840958, 8444.240018398374, 7473.8878916817375, 7527.774166775005, 7554.244575542401, 7558.848823023619, 7713.807154821175, 7463.253674632493, 7465.402767778456, 7465.888011679937, 7549.962250188714, 7562.508436951581, 6501.51238657112, 6642.97033959737, 6651.401373876374, 6651.7006734698025, 6654.966725166343, 5212.322398088376, 5225.503577160163, 5252.553532949589, 5298.125809241432, 5378.946210537844, 5317.069512835161, 5327.09439395296, 5329.680219186861, 5387.649802762965, 5387.865303367447], "value": 4703.950745478731, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.66467006039784, 399.43081109419074, 404.1855660843401, 406.4817357868715, 410.44179915315146, 5378.46215378462, 5424.582513016804, 5659.490645841874, 5686.800961966327, 5692.914606280904, 5401.540869026137, 5505.311836020497, 5581.534772182258, 5603.3836278009385, 5623.240862483563, 4543.863684089482, 4554.407926969506, 4566.680332376735, 4575.29082992135, 4591.563801438858, 4475.641948644101, 4503.977480112611, 4508.413906192191, 4570.565796249351, 4595.96590767078, 4515.864524064284, 4518.8418405355815, 4523.778579783473, 4528.25283828168, 4533.863984080483, 4532.116237333721, 4542.591166794988, 4547.8635640930825, 4553.840615578439, 4568.497465278817, 3939.803009849496, 4154.148399578079, 4165.291900376913, 4174.269502837022, 4176.415301857743, 5471.863203419906, 5493.450654934514, 5521.613487055908, 5531.834044978657, 5533.667979921218, 5179.818706345298, 5212.609054320941, 5214.374275087014, 5236.240745091978, 5294.338207724035, 5718.970585294645, 5885.676287804169, 5926.140709597084, 5929.169916211734, 5933.525317974551, 4492.371068050443, 4507.121111383249, 4509.323601459774, 4532.526928748137, 4534.342520334533, 6103.0, 6174.567780255384, 6184.175668177898, 6200.7519699211525, 6222.844428889269, 4370.978145109254, 4624.676272660949, 4644.419447569054, 4645.465771436328, 4697.459792123881, 4743.66794324394, 4743.857684269477, 4750.287456881495, 4771.188897887368, 4793.161196790547, 5248.6325957182635, 5261.000819688494, 5288.418273989858, 5291.322530841106, 5305.151175811929, 5878.617889837147, 5935.2877654681715, 5952.880942381128, 5968.522518198533, 6016.037434010537, 1541.175471122944, 1575.3462313140149, 1581.8926751274155, 1583.3508261612683, 1604.4196466480507, 1107.5514416661265, 1136.63059505661, 1140.0163715135604, 1143.4340001699045, 1154.0363796230242, 5518.310211223597, 5524.1217985885, 5604.663720176803, 5661.575381846378, 5700.657960522299, 5884.911726324109, 5889.823305300848, 5907.911381329283, 5946.226990491208, 5949.345571987078, 5350.384705758887, 5546.584006199551, 5554.08357620988, 5567.220589117527, 5586.636868603528, 3100.3334283129234, 3130.358276553301, 3130.88853457024, 3131.65551789303, 3135.6864313568462, 5908.763649454059, 6042.12389203563, 6065.120557519223, 6092.51259899207, 6134.9693251534345, 5845.561582881301, 5904.852378690567, 5910.734016969247, 5920.0, 5981.491573216325, 6063.664479896895, 6079.8480037998515, 6100.267967843887, 6109.205803245639, 6120.908186377119, 5692.914606280826, 5811.024251754424, 6043.8186854394435, 6046.153538504701, 6059.3637668045985, 5969.7313620888035, 5997.820065398045, 6026.578139530191, 6031.396860313934, 6051.7579296827635, 6147.907781383194, 6217.207503422999, 6228.408301211559, 6328.0, 6335.809925702236, 4356.651467882625, 4376.562343765598, 4378.649708023287, 4385.342198670225, 4415.145638831763, 5928.762849485972, 6007.639541627516, 6142.4336794119, 6145.84635384119, 6147.784827531015, 5814.970925145347, 5823.709604073685, 5839.824805255849, 5860.179574859609, 5866.823995280149, 5816.476517113311, 5869.649980504422, 5897.734601943009, 5918.644881307136, 5938.168656388023, 5705.543556515552, 5808.896309701143, 5816.3892791258, 5848.707564621837, 5896.321922978912, 5904.261967254093, 5957.76168953237, 5957.851053723692, 5959.493443057216, 5959.642421454727, 5685.289338832646, 5694.946434909555, 5734.799282025109, 5813.709314534171, 5826.135636596248], "value": 4584.903159372813, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.9582020898954, 852.5779739029182, 860.1312674199057, 889.7197382824411, 923.4505469245798, 14808.03747756395, 15437.45968891089, 16978.320867165316, 17927.820721792777, 18152.455426337197, 15551.844481555181, 15598.688026239468, 15672.0, 16675.332986680547, 16757.053682896378, 793.111714879336, 807.7899746066036, 810.8013536683492, 811.4482152136545, 812.1431889356755, 790.6758229126059, 792.4611264340247, 793.9841203175962, 819.9139090395482, 822.0546371672565, 835.732565579012, 842.8019415437398, 843.5065486690294, 845.4842546046906, 847.0513025411517, 842.0821304777791, 842.7176895739934, 844.9873251901226, 845.0408786027872, 845.7885528617845, 613.2365205319406, 615.7598536570741, 616.5006344860633, 618.6968385491122, 621.8321053315625, 16522.2564984576, 16716.665666686597, 17480.21339039746, 18133.54666133344, 18193.454196373998, 15020.17389043602, 15313.0, 15370.0, 15418.383264669399, 15784.131872746995, 13350.0, 13636.727265454734, 13706.657333566642, 13875.0, 14123.435062597484, 3951.723379363446, 3982.482277303961, 4003.2393845169327, 4032.5564187939303, 4135.6898232632675, 76875.0, 78356.21643783546, 78520.0, 79832.20167798306, 80041.59979200125, 12235.204711693712, 12286.139970202, 12368.690782730504, 12438.564650237198, 12600.684982875502, 24010.87994560016, 24271.63592546113, 24445.511089778105, 24468.510629787306, 24599.385015374402, 8146.796330091676, 8316.792080197922, 8375.790605234917, 8492.320614350838, 8652.178043085896, 4692.1554120258, 4776.068666609977, 4836.226203807374, 4840.056189043103, 4849.321095046696, 3994.400839874042, 4047.1298670785923, 4059.0, 4068.9796551017057, 4134.421181034658, 646.731606383355, 649.8407890066869, 662.4104546953215, 664.0935123556311, 664.4916638771343, 733.7798660401858, 759.6961215513838, 772.2277722277722, 792.5522080024767, 804.6861723927673, 10211.948940255399, 10529.684109476728, 10710.625128120479, 10770.94614526938, 10858.2399232053, 781.2500000000064, 798.3294033012181, 808.5391326943586, 813.9308158806449, 855.4097672605882, 4745.454272758608, 5356.276902618175, 5362.195670649434, 5384.0, 5503.257060296809, 67638.0, 70671.0, 74080.62959685166, 83933.0, 85884.14115858762, 64225.35774642287, 66827.66586167038, 67824.6608766953, 68144.6592767033, 68869.65565172142, 55672.72163639156, 59923.700381497816, 60555.394446055856, 62655.0, 64409.35590644128, 11122.666320010412, 11247.381394023407, 11295.887041129812, 11301.491432885705, 11467.4266286687, 42586.36120458258, 42694.0, 42790.57209427866, 43276.783616082976, 43508.347374790035, 53152.73423632857, 55960.72019639876, 56005.0, 56414.71792641011, 56832.43167568437, 13990.860091398956, 14000.859991399955, 14287.714245715235, 15051.1721855299, 15142.54572362831, 14558.708825823636, 15078.472253471515, 15948.840511594735, 16573.50279491617, 16714.498565043068, 15111.168885711391, 15441.768373474632, 15471.5358539244, 16215.513534593982, 16698.24857881374, 14217.218053007184, 14350.784738229144, 14568.854311457173, 15060.849391505944, 15452.690946181237, 15001.249937502864, 15228.314725837143, 15293.464728734441, 15541.222938852787, 16025.599360016093, 11866.40667966581, 12121.27272363661, 12286.508539658671, 12573.182743121668, 12774.552890648783, 11535.884641153481, 11626.57162657156, 11628.302301861915, 11668.244084682441, 11762.470688818852], "value": 7715.186324125766, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1483.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 118.0, 113.0, 114.0, 112.0, 113.0, 113.0, 113.0, 112.0, 112.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 118.0, 119.0, 163.0, 118.0, 121.0, 118.0, 120.0, 136.0, 119.0], "value": 127.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 161.0, 161.0, 161.0, 163.0, 162.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 75.0, 113.0, 77.0, 77.0, 77.0, 76.0, 94.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 101.0, 84.0, 83.0, 83.0, 92.0, 83.0, 83.0, 104.0], "value": 87.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 119.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 147.0, 148.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 97.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 58.0, 58.0, 55.0, 58.0, 56.0, 58.0, 59.0, 57.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 65.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 85.0, 77.0, 76.0, 78.0, 76.0, 76.0, 84.0, 79.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 131.0, 125.0, 120.0, 124.0, 120.0, 121.0, 137.0, 163.0, 122.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 158.0, 162.0, 164.0, 158.0, 163.0, 159.0, 158.0, 162.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 64.0, 63.0, 60.0, 63.0, 64.0, 60.0, 59.0, 63.0], "value": 61.8, "unit": "score"}]}]} 15:52:04 INFO - Return code: 0 15:52:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:52:04 ERROR - # TBPL SUCCESS # 15:52:04 INFO - Running post-action listener: _resource_record_post_action 15:52:04 INFO - [mozharness: 2017-01-24 23:52:04.739771Z] Finished run-tests step (success) 15:52:04 INFO - Running post-run listener: _resource_record_post_run 15:52:04 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 282624; Write bytes: 373157888; Read time: 76; Write time: 263220 15:52:04 INFO - TinderboxPrint: CPU usage
13.3% 15:52:04 INFO - TinderboxPrint: I/O read bytes / time
282,624 / 76 15:52:04 INFO - TinderboxPrint: I/O write bytes / time
373,157,888 / 263,220 15:52:04 INFO - TinderboxPrint: CPU idle
8,222.3 (86.7%) 15:52:04 INFO - TinderboxPrint: CPU user
1,207.2 (12.7%) 15:52:04 INFO - TinderboxPrint: Swap in / out
0 / 0 15:52:04 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120623104; Read time: 0; Write time: 88384 15:52:04 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 282624; Write bytes: 252534784; Read time: 76; Write time: 174836 15:52:05 INFO - Running post-run listener: _upload_blobber_files 15:52:05 INFO - Blob upload gear active. 15:52:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:52:05 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 15:52:05 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', 'Mozilla-Aurora-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:52:05 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 Mozilla-Aurora-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:52:05 INFO - (blobuploader) - INFO - Open directory for files ... 15:52:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:52:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:52:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:52:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:52:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:52:06 INFO - (blobuploader) - INFO - Done attempting. 15:52:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:52:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:52:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:52:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:52:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:52:07 INFO - (blobuploader) - INFO - Done attempting. 15:52:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:52:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:52:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:52:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:52:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:52:10 INFO - (blobuploader) - INFO - Done attempting. 15:52:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:52:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:52:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:52:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:52:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:52:11 INFO - (blobuploader) - INFO - Done attempting. 15:52:11 INFO - (blobuploader) - INFO - Iteration through files over. 15:52:11 INFO - Return code: 0 15:52:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:52:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:52:11 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f9795a32dc57c6e3987d3bc2562a5c071fa11e45ddf66ab57650430bb27d3458e91dcd247e3bedc5a98cd37240e21996656b507e9917326ae21533805dd1d554", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/590cdaa849a5e1c1efb48eb5a451afde8a538c7dd6754d20bfc37af9f11d916d5ab0b4646e8998a5d8c685055811ff2b9cf07ae0c9bb97048464f6a0e0bc0dd4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/7d99a87461d8aa0c6d0d377e08b0fff4f27a5e2ee2a345471a74efd2878a81d94e7edf09e137e12d3c347e1e68513fc925558d1c30722d7856458fc29e07ff8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/615259d900d44acb103398d215b310dcf572b3aaf55cefcf030aaad3c01aaf5a61ba4485b90347c6153eab8c07873ae2474484f056623027aec20ac3d95c1d43"} 15:52:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:52:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:52:11 INFO - Contents: 15:52:11 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f9795a32dc57c6e3987d3bc2562a5c071fa11e45ddf66ab57650430bb27d3458e91dcd247e3bedc5a98cd37240e21996656b507e9917326ae21533805dd1d554", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/590cdaa849a5e1c1efb48eb5a451afde8a538c7dd6754d20bfc37af9f11d916d5ab0b4646e8998a5d8c685055811ff2b9cf07ae0c9bb97048464f6a0e0bc0dd4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/7d99a87461d8aa0c6d0d377e08b0fff4f27a5e2ee2a345471a74efd2878a81d94e7edf09e137e12d3c347e1e68513fc925558d1c30722d7856458fc29e07ff8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/615259d900d44acb103398d215b310dcf572b3aaf55cefcf030aaad3c01aaf5a61ba4485b90347c6153eab8c07873ae2474484f056623027aec20ac3d95c1d43"} 15:52:11 INFO - Running post-run listener: copy_logs_to_upload_dir 15:52:11 INFO - Copying logs to upload dir... 15:52:11 INFO - mkdir: /builds/slave/test/build/upload/logs 15:52:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.866166 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-01-24 15:52:11.095357) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 15:52:11.098994) ========= 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=836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f9795a32dc57c6e3987d3bc2562a5c071fa11e45ddf66ab57650430bb27d3458e91dcd247e3bedc5a98cd37240e21996656b507e9917326ae21533805dd1d554", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/590cdaa849a5e1c1efb48eb5a451afde8a538c7dd6754d20bfc37af9f11d916d5ab0b4646e8998a5d8c685055811ff2b9cf07ae0c9bb97048464f6a0e0bc0dd4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/7d99a87461d8aa0c6d0d377e08b0fff4f27a5e2ee2a345471a74efd2878a81d94e7edf09e137e12d3c347e1e68513fc925558d1c30722d7856458fc29e07ff8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/615259d900d44acb103398d215b310dcf572b3aaf55cefcf030aaad3c01aaf5a61ba4485b90347c6153eab8c07873ae2474484f056623027aec20ac3d95c1d43"} build_url:https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011301 build_url: 'https://queue.taskcluster.net/v1/task/KEkvJDICSmuozoKh-0IeWQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f9795a32dc57c6e3987d3bc2562a5c071fa11e45ddf66ab57650430bb27d3458e91dcd247e3bedc5a98cd37240e21996656b507e9917326ae21533805dd1d554", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/590cdaa849a5e1c1efb48eb5a451afde8a538c7dd6754d20bfc37af9f11d916d5ab0b4646e8998a5d8c685055811ff2b9cf07ae0c9bb97048464f6a0e0bc0dd4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/7d99a87461d8aa0c6d0d377e08b0fff4f27a5e2ee2a345471a74efd2878a81d94e7edf09e137e12d3c347e1e68513fc925558d1c30722d7856458fc29e07ff8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/615259d900d44acb103398d215b310dcf572b3aaf55cefcf030aaad3c01aaf5a61ba4485b90347c6153eab8c07873ae2474484f056623027aec20ac3d95c1d43"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 15:52:11.124089) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 15:52:11.124412) ========= 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=836cfdc75598d54cb747368e000001a9-1485300549.899791-310916461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 15:52:11.209627) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 15:52:11.209955) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 15:52:11.210261) ========= ========= Total master_lag: 0.16 =========